builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1466747605.42 results: success (0) buildid: 20160623200357 builduid: 48b2abe674764200b7cc847833de78c8 revision: f751465bac6aac4ffba8318060817e907088e2fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:25.415871) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:25.416381) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:25.416733) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:25.438659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:25.439047) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 22:53:25-- 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% 39.5M=0s 2016-06-23 22:53:25 (39.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075781 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:25.537000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:25.537324) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020275 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:25.588153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 22:53:25.588742) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f751465bac6aac4ffba8318060817e907088e2fd --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 f751465bac6aac4ffba8318060817e907088e2fd --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=9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 22:53:25,797 truncating revision to first 12 chars 2016-06-23 22:53:25,797 Setting DEBUG logging. 2016-06-23 22:53:25,797 attempt 1/10 2016-06-23 22:53:25,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f751465bac6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 22:53:26,867 unpacking tar archive at: mozilla-beta-f751465bac6a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.407691 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 22:53:27.011248) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:27.011629) ========= script_repo_revision: f751465bac6aac4ffba8318060817e907088e2fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:27.012090) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:27.012462) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:27.022252) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-23 22:53:27.022620) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:27 INFO - MultiFileLogger online at 20160623 22:53:27 in /builds/slave/test 22:53:27 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 22:53:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:53:27 INFO - {'append_to_log': False, 22:53:27 INFO - 'base_work_dir': '/builds/slave/test', 22:53:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:53:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:53:27 INFO - 'branch': 'Mozilla-Beta', 22:53:27 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:27 INFO - 'config_files': ('talos/linux_config.py',), 22:53:27 INFO - 'default_actions': ('clobber', 22:53:27 INFO - 'read-buildbot-config', 22:53:27 INFO - 'download-and-extract', 22:53:27 INFO - 'populate-webroot', 22:53:27 INFO - 'create-virtualenv', 22:53:27 INFO - 'install', 22:53:27 INFO - 'run-tests'), 22:53:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:27 INFO - 'download_minidump_stackwalk': True, 22:53:27 INFO - 'download_symbols': 'ondemand', 22:53:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:27 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:27 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:27 INFO - 'installer_path': 'installer.exe', 22:53:27 INFO - 'log_level': 'info', 22:53:27 INFO - 'log_name': 'talos', 22:53:27 INFO - 'log_to_console': True, 22:53:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:27 INFO - 'opt_config_files': (), 22:53:27 INFO - 'pip_index': False, 22:53:27 INFO - 'sps_profile': False, 22:53:27 INFO - 'sps_profile_interval': 0, 22:53:27 INFO - 'suite': 'dromaeojs-e10s', 22:53:27 INFO - 'system_bits': '32', 22:53:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:27 INFO - 'title': 'talos-linux64-ix-040', 22:53:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:27 INFO - 'use_talos_json': True, 22:53:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:53:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:27 INFO - 'work_dir': 'build'} 22:53:27 INFO - ##### 22:53:27 INFO - ##### Running clobber step. 22:53:27 INFO - ##### 22:53:27 INFO - Running pre-action listener: _resource_record_pre_action 22:53:27 INFO - Running main action method: clobber 22:53:27 INFO - rmtree: /builds/slave/test/build 22:53:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:53:28 INFO - Running post-action listener: _resource_record_post_action 22:53:28 INFO - ##### 22:53:28 INFO - ##### Running read-buildbot-config step. 22:53:28 INFO - ##### 22:53:28 INFO - Running pre-action listener: _resource_record_pre_action 22:53:28 INFO - Running main action method: read_buildbot_config 22:53:28 INFO - Using buildbot properties: 22:53:28 INFO - { 22:53:28 INFO - "project": "", 22:53:28 INFO - "product": "firefox", 22:53:28 INFO - "script_repo_revision": "production", 22:53:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 22:53:28 INFO - "repository": "", 22:53:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 22:53:28 INFO - "buildid": "20160623200357", 22:53:28 INFO - "pgo_build": "True", 22:53:28 INFO - "basedir": "/builds/slave/test", 22:53:28 INFO - "buildnumber": 58, 22:53:28 INFO - "slavename": "talos-linux64-ix-040", 22:53:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:53:28 INFO - "platform": "ubuntu64_hw", 22:53:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 22:53:28 INFO - "branch": "mozilla-beta", 22:53:28 INFO - "repo_path": "releases/mozilla-beta", 22:53:28 INFO - "revision": "f751465bac6aac4ffba8318060817e907088e2fd", 22:53:28 INFO - "stage_platform": "linux64-pgo", 22:53:28 INFO - "builduid": "48b2abe674764200b7cc847833de78c8", 22:53:28 INFO - "slavebuilddir": "test" 22:53:28 INFO - } 22:53:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 22:53:28 INFO - Running post-action listener: _resource_record_post_action 22:53:28 INFO - ##### 22:53:28 INFO - ##### Running download-and-extract step. 22:53:28 INFO - ##### 22:53:28 INFO - Running pre-action listener: _resource_record_pre_action 22:53:28 INFO - Running main action method: download_and_extract 22:53:28 INFO - mkdir: /builds/slave/test/build/tests 22:53:28 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')]} 22:53:28 INFO - https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:53:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:53:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:53:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:53:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:53:32 INFO - Downloaded 1327 bytes. 22:53:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:53:32 INFO - Using the following test package requirements: 22:53:32 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 22:53:32 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:32 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 22:53:32 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'jsshell-linux-x86_64.zip'], 22:53:32 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:32 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 22:53:32 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 22:53:32 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 22:53:32 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:32 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:32 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:32 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53:32 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')]} 22:53:32 INFO - https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:53:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:53:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:53:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:53:33 INFO - Downloaded 24229886 bytes. 22:53:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:53:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:53:34 INFO - Return code: 0 22:53:34 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:34 INFO - https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:53:36 INFO - Downloaded 24229886 bytes. 22:53:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:53:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:53:37 INFO - Return code: 0 22:53: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')]} 22:53:37 INFO - https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 22:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 22:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 22:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:53:39 INFO - Downloaded 10840145 bytes. 22:53:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:53:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:53:39 INFO - Return code: 0 22:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:39 INFO - https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:53:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:53:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:53:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:53:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:53:40 INFO - Downloaded 56025715 bytes. 22:53:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:53:40 INFO - mkdir: /builds/slave/test/properties 22:53:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:53:40 INFO - Writing to file /builds/slave/test/properties/build_url 22:53:40 INFO - Contents: 22:53:40 INFO - build_url:https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:53:41 INFO - Running post-action listener: _resource_record_post_action 22:53:41 INFO - Running post-action listener: set_extra_try_arguments 22:53:41 INFO - ##### 22:53:41 INFO - ##### Running populate-webroot step. 22:53:41 INFO - ##### 22:53:41 INFO - Running pre-action listener: _resource_record_pre_action 22:53:41 INFO - Running main action method: populate_webroot 22:53:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:53:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:53:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:53:41 INFO - '--tppagecycles', 22:53:41 INFO - '7'], 22:53:41 INFO - 'tests': ['tsvgm']}}, 22:53:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:53:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:53:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:53:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:53:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:53:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:53:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:41 INFO - 'talos_options': ['--disable-e10s'], 22:53:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:41 INFO - 'talos_options': ['--disable-e10s'], 22:53:41 INFO - 'tests': ['damp', 'tps']}, 22:53:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:41 INFO - 'tests': ['damp', 'tps']}, 22:53:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:53:41 INFO - 'tests': ['dromaeo_dom']}, 22:53:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:53:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:53:41 INFO - 'tests': ['a11yr', 22:53:41 INFO - 'ts_paint', 22:53:41 INFO - 'tpaint', 22:53:41 INFO - 'sessionrestore', 22:53:41 INFO - 'sessionrestore_no_auto_restore', 22:53:41 INFO - 'tabpaint']}, 22:53:41 INFO - 'other-e10s': {'tests': ['a11yr', 22:53:41 INFO - 'ts_paint', 22:53:41 INFO - 'tpaint', 22:53:41 INFO - 'sessionrestore', 22:53:41 INFO - 'sessionrestore_no_auto_restore', 22:53:41 INFO - 'tabpaint']}, 22:53:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:53:41 INFO - 'ts_paint', 22:53:41 INFO - 'tpaint', 22:53:41 INFO - 'sessionrestore', 22:53:41 INFO - 'sessionrestore_no_auto_restore', 22:53:41 INFO - 'tabpaint']}, 22:53:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:53:41 INFO - 'ts_paint', 22:53:41 INFO - 'tpaint', 22:53:41 INFO - 'sessionrestore', 22:53:41 INFO - 'sessionrestore_no_auto_restore', 22:53:41 INFO - 'tabpaint']}, 22:53:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:53:41 INFO - 'tests': ['a11yr', 22:53:41 INFO - 'ts_paint', 22:53:41 INFO - 'tpaint', 22:53:41 INFO - 'sessionrestore', 22:53:41 INFO - 'sessionrestore_no_auto_restore', 22:53:41 INFO - 'tabpaint']}, 22:53:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:53:41 INFO - 'tests': ['a11yr', 22:53:41 INFO - 'ts_paint', 22:53:41 INFO - 'tpaint', 22:53:41 INFO - 'sessionrestore', 22:53:41 INFO - 'sessionrestore_no_auto_restore', 22:53:41 INFO - 'tabpaint']}, 22:53:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:53:41 INFO - 'tests': ['tsvgx', 22:53:41 INFO - 'tsvgr_opacity', 22:53:41 INFO - 'tart', 22:53:41 INFO - 'tscrollx', 22:53:41 INFO - 'cart']}, 22:53:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:53:41 INFO - 'tsvgr_opacity', 22:53:41 INFO - 'tart', 22:53:41 INFO - 'tscrollx', 22:53:41 INFO - 'cart']}, 22:53:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:41 INFO - 'talos_options': ['--disable-e10s'], 22:53:41 INFO - 'tests': ['tp5o']}, 22:53:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:41 INFO - 'tests': ['tp5o']}, 22:53:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:41 INFO - 'talos_options': ['--disable-e10s', 22:53:41 INFO - '--xperf_path', 22:53:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:41 INFO - 'tests': ['tp5n']}, 22:53:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:41 INFO - 'talos_options': ['--xperf_path', 22:53:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:41 INFO - 'tests': ['tp5n']}}, 22:53:41 INFO - 'talos.zip': {'path': '', 22:53:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:53:41 INFO - Running post-action listener: _resource_record_post_action 22:53:41 INFO - ##### 22:53:41 INFO - ##### Running create-virtualenv step. 22:53:41 INFO - ##### 22:53:41 INFO - Running pre-action listener: _resource_record_pre_action 22:53:41 INFO - Running main action method: create_virtualenv 22:53:41 INFO - Creating virtualenv /builds/slave/test/build/venv 22:53:41 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 22:53:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:53:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:53:41 INFO - Using real prefix '/usr' 22:53:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:53:41 INFO - Installing distribute.............................................................................................................................................................................................done. 22:53:43 INFO - Installing pip.................done. 22:53:43 INFO - Return code: 0 22:53:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9f0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3410>, '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 0x1da4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da47a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', '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 22:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:53:43 INFO - Using env: {'DISPLAY': ':0', 22:53:43 INFO - 'HOME': '/home/cltbld', 22:53:43 INFO - 'LANG': 'en_US.UTF-8', 22:53:43 INFO - 'LANGUAGE': 'en_US:en', 22:53:43 INFO - 'LOGNAME': 'cltbld', 22:53:43 INFO - 'MAIL': '/var/mail/cltbld', 22:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:43 INFO - 'MOZ_NO_REMOTE': '1', 22:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:43 INFO - 'NO_EM_RESTART': '1', 22:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:43 INFO - 'PWD': '/builds/slave/test', 22:53:43 INFO - 'SHELL': '/bin/bash', 22:53:43 INFO - 'SHLVL': '1', 22:53:43 INFO - 'TERM': 'linux', 22:53:43 INFO - 'TMOUT': '86400', 22:53:43 INFO - 'USER': 'cltbld', 22:53:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', 22:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:43 INFO - '_': '/tools/buildbot/bin/python'} 22:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:44 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 22:53:44 INFO - Cleaning up... 22:53:44 INFO - Return code: 0 22:53:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:53:44 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')]} 22:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:44 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')]} 22:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:44 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 0x7ff9f0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3410>, '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 0x1da4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da47a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', '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 22:53:44 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 22:53:44 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 22:53:44 INFO - Using env: {'DISPLAY': ':0', 22:53:44 INFO - 'HOME': '/home/cltbld', 22:53:44 INFO - 'LANG': 'en_US.UTF-8', 22:53:44 INFO - 'LANGUAGE': 'en_US:en', 22:53:44 INFO - 'LOGNAME': 'cltbld', 22:53:44 INFO - 'MAIL': '/var/mail/cltbld', 22:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:44 INFO - 'MOZ_NO_REMOTE': '1', 22:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:44 INFO - 'NO_EM_RESTART': '1', 22:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:44 INFO - 'PWD': '/builds/slave/test', 22:53:44 INFO - 'SHELL': '/bin/bash', 22:53:44 INFO - 'SHLVL': '1', 22:53:44 INFO - 'TERM': 'linux', 22:53:44 INFO - 'TMOUT': '86400', 22:53:44 INFO - 'USER': 'cltbld', 22:53:44 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', 22:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:44 INFO - '_': '/tools/buildbot/bin/python'} 22:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:44 INFO - Downloading/unpacking psutil>=0.7.1 22:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:53:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:46 INFO - Installing collected packages: psutil 22:53:46 INFO - Running setup.py install for psutil 22:53:46 INFO - building 'psutil._psutil_linux' extension 22:53:46 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 22:53:46 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 22:53:46 INFO - building 'psutil._psutil_posix' extension 22:53:46 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 22:53:46 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 22:53:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:46 INFO - Successfully installed psutil 22:53:46 INFO - Cleaning up... 22:53:46 INFO - Return code: 0 22:53:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:53:46 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')]} 22:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:46 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')]} 22:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:46 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 0x7ff9f0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3410>, '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 0x1da4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da47a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', '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 22:53:46 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 22:53:46 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 22:53:46 INFO - Using env: {'DISPLAY': ':0', 22:53:46 INFO - 'HOME': '/home/cltbld', 22:53:46 INFO - 'LANG': 'en_US.UTF-8', 22:53:46 INFO - 'LANGUAGE': 'en_US:en', 22:53:46 INFO - 'LOGNAME': 'cltbld', 22:53:46 INFO - 'MAIL': '/var/mail/cltbld', 22:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:46 INFO - 'MOZ_NO_REMOTE': '1', 22:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:46 INFO - 'NO_EM_RESTART': '1', 22:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:46 INFO - 'PWD': '/builds/slave/test', 22:53:46 INFO - 'SHELL': '/bin/bash', 22:53:46 INFO - 'SHLVL': '1', 22:53:46 INFO - 'TERM': 'linux', 22:53:46 INFO - 'TMOUT': '86400', 22:53:46 INFO - 'USER': 'cltbld', 22:53:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', 22:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:46 INFO - '_': '/tools/buildbot/bin/python'} 22:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:53:46 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 22:53:46 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 22:53:46 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 22:53:46 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 22:53:46 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 22:53: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 22:53:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:53:49 INFO - Installing collected packages: mozsystemmonitor 22:53:49 INFO - Running setup.py install for mozsystemmonitor 22:53:50 INFO - Successfully installed mozsystemmonitor 22:53:50 INFO - Cleaning up... 22:53:50 INFO - Return code: 0 22:53:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:53:50 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')]} 22:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:50 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')]} 22:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:50 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 0x7ff9f0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3410>, '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 0x1da4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da47a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', '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 22:53:50 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 22:53:50 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 22:53:50 INFO - Using env: {'DISPLAY': ':0', 22:53:50 INFO - 'HOME': '/home/cltbld', 22:53:50 INFO - 'LANG': 'en_US.UTF-8', 22:53:50 INFO - 'LANGUAGE': 'en_US:en', 22:53:50 INFO - 'LOGNAME': 'cltbld', 22:53:50 INFO - 'MAIL': '/var/mail/cltbld', 22:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:50 INFO - 'MOZ_NO_REMOTE': '1', 22:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:50 INFO - 'NO_EM_RESTART': '1', 22:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:50 INFO - 'PWD': '/builds/slave/test', 22:53:50 INFO - 'SHELL': '/bin/bash', 22:53:50 INFO - 'SHLVL': '1', 22:53:50 INFO - 'TERM': 'linux', 22:53:50 INFO - 'TMOUT': '86400', 22:53:50 INFO - 'USER': 'cltbld', 22:53:50 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', 22:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:50 INFO - '_': '/tools/buildbot/bin/python'} 22:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:50 INFO - Downloading/unpacking blobuploader==1.2.4 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:52 INFO - Downloading blobuploader-1.2.4.tar.gz 22:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:53:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:53:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:52 INFO - Downloading docopt-0.6.1.tar.gz 22:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:53:52 INFO - Installing collected packages: blobuploader, requests, docopt 22:53:52 INFO - Running setup.py install for blobuploader 22:53:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:53:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:53:53 INFO - Running setup.py install for requests 22:53:53 INFO - Running setup.py install for docopt 22:53:53 INFO - Successfully installed blobuploader requests docopt 22:53:53 INFO - Cleaning up... 22:53:53 INFO - Return code: 0 22:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:53 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 0x7ff9f0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3410>, '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 0x1da4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da47a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', '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 22:53:53 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 22:53:53 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 22:53:53 INFO - Using env: {'DISPLAY': ':0', 22:53:53 INFO - 'HOME': '/home/cltbld', 22:53:53 INFO - 'LANG': 'en_US.UTF-8', 22:53:53 INFO - 'LANGUAGE': 'en_US:en', 22:53:53 INFO - 'LOGNAME': 'cltbld', 22:53:53 INFO - 'MAIL': '/var/mail/cltbld', 22:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:53 INFO - 'MOZ_NO_REMOTE': '1', 22:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:53 INFO - 'NO_EM_RESTART': '1', 22:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:53 INFO - 'PWD': '/builds/slave/test', 22:53:53 INFO - 'SHELL': '/bin/bash', 22:53:53 INFO - 'SHLVL': '1', 22:53:53 INFO - 'TERM': 'linux', 22:53:53 INFO - 'TMOUT': '86400', 22:53:53 INFO - 'USER': 'cltbld', 22:53:53 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', 22:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:53 INFO - '_': '/tools/buildbot/bin/python'} 22:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:53:53 INFO - Running setup.py (path:/tmp/pip-wLk0Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:53:53 INFO - Running setup.py (path:/tmp/pip-bSVxxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:53:53 INFO - Running setup.py (path:/tmp/pip-PW3IqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:53:53 INFO - Running setup.py (path:/tmp/pip-PK88OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:53:54 INFO - Running setup.py (path:/tmp/pip-PWeiNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:53:54 INFO - Running setup.py (path:/tmp/pip-tdIhEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:53:54 INFO - Running setup.py (path:/tmp/pip-aDzD61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:53:54 INFO - Running setup.py (path:/tmp/pip-LGgJ72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:53:54 INFO - Running setup.py (path:/tmp/pip-FomzBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:53:54 INFO - Running setup.py (path:/tmp/pip-3kLO31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:53:54 INFO - Running setup.py (path:/tmp/pip-xAwm4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:53:54 INFO - Running setup.py (path:/tmp/pip-4sF7Ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:53:54 INFO - Running setup.py (path:/tmp/pip-Acdj0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:53:54 INFO - Running setup.py (path:/tmp/pip-0LfBpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:53:54 INFO - Running setup.py (path:/tmp/pip-dyCaEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:53:54 INFO - Running setup.py (path:/tmp/pip-TD3i86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:53:54 INFO - Running setup.py (path:/tmp/pip-byyLyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:53:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:53:54 INFO - Running setup.py install for manifestparser 22:53:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:53:55 INFO - Running setup.py install for mozcrash 22:53:55 INFO - Running setup.py install for mozdebug 22:53:55 INFO - Running setup.py install for mozdevice 22:53:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:53:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:53:55 INFO - Running setup.py install for mozfile 22:53:55 INFO - Running setup.py install for mozhttpd 22:53:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:53:55 INFO - Running setup.py install for mozinfo 22:53:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:53:55 INFO - Running setup.py install for mozInstall 22:53:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:53:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:53:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:53:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:53:55 INFO - Running setup.py install for mozleak 22:53:55 INFO - Running setup.py install for mozlog 22:53:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:53:55 INFO - Running setup.py install for moznetwork 22:53:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:53:56 INFO - Running setup.py install for mozprocess 22:53:56 INFO - Running setup.py install for mozprofile 22:53:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:53:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:53:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:53:56 INFO - Running setup.py install for mozrunner 22:53:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:53:56 INFO - Running setup.py install for mozscreenshot 22:53:56 INFO - Running setup.py install for moztest 22:53:56 INFO - Running setup.py install for mozversion 22:53:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:53:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:53:56 INFO - Cleaning up... 22:53:56 INFO - Return code: 0 22:53:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:53:56 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')]} 22:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:56 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')]} 22:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:56 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 0x7ff9f0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3410>, '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 0x1da4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da47a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', '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 22:53:56 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 22:53:56 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 22:53:56 INFO - Using env: {'DISPLAY': ':0', 22:53:56 INFO - 'HOME': '/home/cltbld', 22:53:56 INFO - 'LANG': 'en_US.UTF-8', 22:53:56 INFO - 'LANGUAGE': 'en_US:en', 22:53:56 INFO - 'LOGNAME': 'cltbld', 22:53:56 INFO - 'MAIL': '/var/mail/cltbld', 22:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:56 INFO - 'MOZ_NO_REMOTE': '1', 22:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:56 INFO - 'NO_EM_RESTART': '1', 22:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:56 INFO - 'PWD': '/builds/slave/test', 22:53:56 INFO - 'SHELL': '/bin/bash', 22:53:56 INFO - 'SHLVL': '1', 22:53:56 INFO - 'TERM': 'linux', 22:53:56 INFO - 'TMOUT': '86400', 22:53:56 INFO - 'USER': 'cltbld', 22:53:56 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', 22:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:56 INFO - '_': '/tools/buildbot/bin/python'} 22:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:53:56 INFO - Running setup.py (path:/tmp/pip-ky9bnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:53:57 INFO - Running setup.py (path:/tmp/pip-ZykgDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:53:57 INFO - Running setup.py (path:/tmp/pip-dqcKZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:53:57 INFO - Running setup.py (path:/tmp/pip-fB0Vkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:53:57 INFO - Running setup.py (path:/tmp/pip-XUqWI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:53:57 INFO - Running setup.py (path:/tmp/pip-8c9Jg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:53:57 INFO - Running setup.py (path:/tmp/pip-pxM_OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:53:57 INFO - Running setup.py (path:/tmp/pip-0CzNA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:53:57 INFO - Running setup.py (path:/tmp/pip-dkn5iP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:53:57 INFO - Running setup.py (path:/tmp/pip-3zvET3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:53:57 INFO - Running setup.py (path:/tmp/pip-2E6zY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:53:57 INFO - Running setup.py (path:/tmp/pip-dpIp7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:53:57 INFO - Running setup.py (path:/tmp/pip-HzRGK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:53:57 INFO - Running setup.py (path:/tmp/pip-h6N5Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:53:57 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)) 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:53:57 INFO - Running setup.py (path:/tmp/pip-hPFwIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:53:58 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)) 22:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:53:58 INFO - Running setup.py (path:/tmp/pip-2fCjt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:53:58 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)) 22:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:53:58 INFO - Running setup.py (path:/tmp/pip-QWAaNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 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)) 22:53:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:54:00 INFO - Downloading blessings-1.6.tar.gz 22:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:54:00 INFO - Installing collected packages: blessings 22:54:00 INFO - Running setup.py install for blessings 22:54:00 INFO - Successfully installed blessings 22:54:00 INFO - Cleaning up... 22:54:00 INFO - Return code: 0 22:54:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:54:00 INFO - Reading from file tmpfile_stdout 22:54:00 INFO - Current package versions: 22:54:00 INFO - argparse == 1.2.1 22:54:00 INFO - blessings == 1.6 22:54:00 INFO - blobuploader == 1.2.4 22:54:00 INFO - docopt == 0.6.1 22:54:00 INFO - manifestparser == 1.1 22:54:00 INFO - mozInstall == 1.12 22:54:00 INFO - mozcrash == 0.17 22:54:00 INFO - mozdebug == 0.1 22:54:00 INFO - mozdevice == 0.48 22:54:00 INFO - mozfile == 1.2 22:54:00 INFO - mozhttpd == 0.7 22:54:00 INFO - mozinfo == 0.9 22:54:00 INFO - mozleak == 0.1 22:54:00 INFO - mozlog == 3.1 22:54:00 INFO - moznetwork == 0.27 22:54:00 INFO - mozprocess == 0.22 22:54:00 INFO - mozprofile == 0.28 22:54:00 INFO - mozrunner == 6.11 22:54:00 INFO - mozscreenshot == 0.1 22:54:00 INFO - mozsystemmonitor == 0.0 22:54:00 INFO - moztest == 0.7 22:54:00 INFO - mozversion == 1.4 22:54:00 INFO - psutil == 3.1.1 22:54:00 INFO - requests == 1.2.3 22:54:00 INFO - wsgiref == 0.1.2 22:54:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:00 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 0x7ff9f0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3410>, '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 0x1da4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da47a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', '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 22:54:00 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 22:54:00 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 22:54:00 INFO - Using env: {'DISPLAY': ':0', 22:54:00 INFO - 'HOME': '/home/cltbld', 22:54:00 INFO - 'LANG': 'en_US.UTF-8', 22:54:00 INFO - 'LANGUAGE': 'en_US:en', 22:54:00 INFO - 'LOGNAME': 'cltbld', 22:54:00 INFO - 'MAIL': '/var/mail/cltbld', 22:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:00 INFO - 'MOZ_NO_REMOTE': '1', 22:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:00 INFO - 'NO_EM_RESTART': '1', 22:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:00 INFO - 'PWD': '/builds/slave/test', 22:54:00 INFO - 'SHELL': '/bin/bash', 22:54:00 INFO - 'SHLVL': '1', 22:54:00 INFO - 'TERM': 'linux', 22:54:00 INFO - 'TMOUT': '86400', 22:54:00 INFO - 'USER': 'cltbld', 22:54:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', 22:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:00 INFO - '_': '/tools/buildbot/bin/python'} 22:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:00 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)) 22:54:00 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)) 22:54:00 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)) 22:54:00 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)) 22:54:00 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)) 22:54:00 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)) 22:54:00 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)) 22:54:00 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)) 22:54:00 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)) 22:54:00 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)) 22:54:00 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)) 22:54:00 INFO - Cleaning up... 22:54:00 INFO - Return code: 0 22:54:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:00 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 0x7ff9f0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3410>, '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 0x1da4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da47a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', '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 22:54:00 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 22:54:00 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 22:54:00 INFO - Using env: {'DISPLAY': ':0', 22:54:00 INFO - 'HOME': '/home/cltbld', 22:54:00 INFO - 'LANG': 'en_US.UTF-8', 22:54:00 INFO - 'LANGUAGE': 'en_US:en', 22:54:00 INFO - 'LOGNAME': 'cltbld', 22:54:00 INFO - 'MAIL': '/var/mail/cltbld', 22:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:00 INFO - 'MOZ_NO_REMOTE': '1', 22:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:00 INFO - 'NO_EM_RESTART': '1', 22:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:00 INFO - 'PWD': '/builds/slave/test', 22:54:00 INFO - 'SHELL': '/bin/bash', 22:54:00 INFO - 'SHLVL': '1', 22:54:00 INFO - 'TERM': 'linux', 22:54:00 INFO - 'TMOUT': '86400', 22:54:00 INFO - 'USER': 'cltbld', 22:54:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', 22:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:00 INFO - '_': '/tools/buildbot/bin/python'} 22:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:00 INFO - Downloading/unpacking jsonschema 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:54:02 INFO - Downloading/unpacking functools32 (from jsonschema) 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:03 INFO - Downloading functools32-3.2.3-2.tar.gz 22:54:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:54:03 INFO - warning: no files found matching '*.txt' 22:54:03 INFO - no previously-included directories found matching 'build' 22:54:03 INFO - no previously-included directories found matching 'dist' 22:54:03 INFO - no previously-included directories found matching '.git*' 22:54:03 INFO - Installing collected packages: jsonschema, functools32 22:54:03 INFO - Running setup.py install for functools32 22:54:03 INFO - warning: no files found matching '*.txt' 22:54:03 INFO - no previously-included directories found matching 'build' 22:54:03 INFO - no previously-included directories found matching 'dist' 22:54:03 INFO - no previously-included directories found matching '.git*' 22:54:03 INFO - Successfully installed jsonschema functools32 22:54:03 INFO - Cleaning up... 22:54:03 INFO - Return code: 0 22:54:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:03 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 0x7ff9f0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da3410>, '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 0x1da4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da47a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', '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 22:54:03 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 22:54:03 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 22:54:03 INFO - Using env: {'DISPLAY': ':0', 22:54:03 INFO - 'HOME': '/home/cltbld', 22:54:03 INFO - 'LANG': 'en_US.UTF-8', 22:54:03 INFO - 'LANGUAGE': 'en_US:en', 22:54:03 INFO - 'LOGNAME': 'cltbld', 22:54:03 INFO - 'MAIL': '/var/mail/cltbld', 22:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:03 INFO - 'MOZ_NO_REMOTE': '1', 22:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:03 INFO - 'NO_EM_RESTART': '1', 22:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:03 INFO - 'PWD': '/builds/slave/test', 22:54:03 INFO - 'SHELL': '/bin/bash', 22:54:03 INFO - 'SHLVL': '1', 22:54:03 INFO - 'TERM': 'linux', 22:54:03 INFO - 'TMOUT': '86400', 22:54:03 INFO - 'USER': 'cltbld', 22:54:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', 22:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:03 INFO - '_': '/tools/buildbot/bin/python'} 22:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:03 INFO - Downloading/unpacking flake8 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:54:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:54:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 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 22:54:05 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 22:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:06 INFO - no previously-included directories found matching 'docs/_build' 22:54:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:54:06 INFO - Running setup.py install for pep8 22:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:06 INFO - no previously-included directories found matching 'docs/_build' 22:54:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:54:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:54:06 INFO - Cleaning up... 22:54:06 INFO - Return code: 0 22:54:06 INFO - Running post-action listener: _resource_record_post_action 22:54:06 INFO - Running post-action listener: _start_resource_monitoring 22:54:06 INFO - Starting resource monitoring. 22:54:06 INFO - ##### 22:54:06 INFO - ##### Running install step. 22:54:06 INFO - ##### 22:54:06 INFO - Running pre-action listener: _resource_record_pre_action 22:54:06 INFO - Running main action method: install 22:54:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:54:06 INFO - Reading from file tmpfile_stdout 22:54:06 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:54:06 INFO - Reading from file tmpfile_stdout 22:54:06 INFO - Output received: 22:54:06 INFO - Usage: mozinstall [options] installer 22:54:06 INFO - Options: 22:54:06 INFO - -h, --help show this help message and exit 22:54:06 INFO - -d DEST, --destination=DEST 22:54:06 INFO - Directory to install application into. [default: 22:54:06 INFO - "/builds/slave/test"] 22:54:06 INFO - --app=APP Application being installed. [default: firefox] 22:54:06 INFO - mkdir: /builds/slave/test/build/application 22:54:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:54:19 INFO - Reading from file tmpfile_stdout 22:54:19 INFO - Output received: 22:54:19 INFO - /builds/slave/test/build/application/firefox/firefox 22:54:19 INFO - Running post-action listener: _resource_record_post_action 22:54:19 INFO - ##### 22:54:19 INFO - ##### Running run-tests step. 22:54:19 INFO - ##### 22:54:19 INFO - Running pre-action listener: _resource_record_pre_action 22:54:19 INFO - Running main action method: run_tests 22:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:54:19 INFO - Python 2.7.3 22:54:19 INFO - Return code: 0 22:54:19 INFO - grabbing minidump binary from tooltool 22:54:19 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')]} 22:54:19 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 0x1da3410>, '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 0x1da4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:54:19 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 22:54:19 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 22:54:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:54:20 INFO - Return code: 0 22:54:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:54:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:54:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:54:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:54:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:54:20 INFO - Return code: 0 22:54:20 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/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 22:54:20 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/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 22:54:20 INFO - Using env: {'DISPLAY': ':0', 22:54:20 INFO - 'HOME': '/home/cltbld', 22:54:20 INFO - 'LANG': 'en_US.UTF-8', 22:54:20 INFO - 'LANGUAGE': 'en_US:en', 22:54:20 INFO - 'LOGNAME': 'cltbld', 22:54:20 INFO - 'MAIL': '/var/mail/cltbld', 22:54:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:54:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:20 INFO - 'MOZ_NO_REMOTE': '1', 22:54:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:20 INFO - 'NO_EM_RESTART': '1', 22:54:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:20 INFO - 'PWD': '/builds/slave/test', 22:54:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:54:20 INFO - 'SHELL': '/bin/bash', 22:54:20 INFO - 'SHLVL': '1', 22:54:20 INFO - 'TERM': 'linux', 22:54:20 INFO - 'TMOUT': '86400', 22:54:20 INFO - 'USER': 'cltbld', 22:54:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271', 22:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:20 INFO - '_': '/tools/buildbot/bin/python'} 22:54:20 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/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 22:54:21 INFO - mozversion application_buildid: 20160623200357 22:54:21 INFO - mozversion application_changeset: f751465bac6aac4ffba8318060817e907088e2fd 22:54:21 INFO - mozversion application_display_name: Firefox 22:54:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:54:21 INFO - mozversion application_name: Firefox 22:54:21 INFO - mozversion application_remotingname: firefox 22:54:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:54:21 INFO - mozversion application_vendor: Mozilla 22:54:21 INFO - mozversion application_version: 48.0 22:54:21 INFO - mozversion platform_buildid: 20160623200357 22:54:21 INFO - mozversion platform_changeset: f751465bac6aac4ffba8318060817e907088e2fd 22:54:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:54:21 INFO - mozversion platform_version: 48.0 22:54:21 INFO - using testdate: 1466747661 22:54:21 INFO - actual date: 1466747661 22:54:21 INFO - starting webserver on 'localhost:42149' 22:54:21 INFO - SUITE-START | Running 2 tests 22:54:21 INFO - TEST-START | dromaeo_css 22:54:21 INFO - operating with platform_type : linux_ 22:54:21 INFO - Initialising browser for dromaeo_css test... 22:54:21 INFO - TEST-INFO | started process 12034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3TxtDL/profile http://localhost:42149/getInfo.html) 22:54:24 INFO - PROCESS | 12034 | 22:54:24 INFO - PROCESS | 12034 | (process:12110): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:54:25 INFO - PROCESS | 12034 | __metrics Screen width/height:1600/1200 22:54:25 INFO - PROCESS | 12034 | colorDepth:24 22:54:25 INFO - PROCESS | 12034 | Browser inner width/height: 1024/697 22:54:25 INFO - PROCESS | 12034 | __metrics 22:54:26 ERROR - PROCESS | 12034 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 22:54:27 INFO - TEST-INFO | 12034: exit 0 22:54:27 INFO - Browser initialized. 22:54:27 INFO - Running cycle 1/1 for dromaeo_css test... 22:54:27 INFO - TEST-INFO | started process 12160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3TxtDL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:54:28 INFO - PROCESS | 12160 | 22:54:28 INFO - PROCESS | 12160 | (process:12228): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:54:38 INFO - PROCESS | 12160 | RSS: Main: 150990848 22:54:38 INFO - PROCESS | 12160 | 22:55:28 INFO - PROCESS | 12160 | 1466747728361 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] 22:57:35 INFO - PROCESS | 12160 | Cycle 1(1): loaded http://localhost:42149/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42149/tests/dromaeo/cssquery-ext.html) 22:57:36 INFO - PROCESS | 12160 | RSS: Main: 154341376 22:57:36 INFO - PROCESS | 12160 | 23:00:38 INFO - PROCESS | 12160 | Cycle 1(1): loaded http://localhost:42149/tests/dromaeo/cssquery-ext.html (next: http://localhost:42149/tests/dromaeo/cssquery-jquery.html) 23:00:39 INFO - PROCESS | 12160 | RSS: Main: 152715264 23:00:39 INFO - PROCESS | 12160 | 23:03:40 INFO - PROCESS | 12160 | Cycle 1(1): loaded http://localhost:42149/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42149/tests/dromaeo/cssquery-mootools.html) 23:03:41 INFO - PROCESS | 12160 | RSS: Main: 152891392 23:03:41 INFO - PROCESS | 12160 | 23:06:43 INFO - PROCESS | 12160 | Cycle 1(1): loaded http://localhost:42149/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42149/tests/dromaeo/cssquery-prototype.html) 23:06:43 INFO - PROCESS | 12160 | RSS: Main: 153464832 23:06:43 INFO - PROCESS | 12160 | 23:09:46 INFO - PROCESS | 12160 | Cycle 1(1): loaded http://localhost:42149/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42149/tests/dromaeo/cssquery-yui.html) 23:09:46 INFO - PROCESS | 12160 | RSS: Main: 151678976 23:09:46 INFO - PROCESS | 12160 | 23:12:48 INFO - PROCESS | 12160 | Cycle 1(1): loaded http://localhost:42149/tests/dromaeo/cssquery-yui.html (next: http://localhost:42149/tests/dromaeo/cssquery-dojo.html) 23:12:49 INFO - PROCESS | 12160 | RSS: Main: 155529216 23:12:49 INFO - PROCESS | 12160 | 23:12:49 INFO - PROCESS | 12160 | __start_tp_report 23:12:49 INFO - PROCESS | 12160 | _x_x_mozilla_page_load 23:12:49 INFO - PROCESS | 12160 | _x_x_mozilla_page_load_details 23:12:49 INFO - PROCESS | 12160 | |i|pagename|runs| 23:12:49 INFO - PROCESS | 12160 | |0;dojo.html;3268.5424040634307;3353.698167164958;3368.141124013376;3422.435298175801;3423.4009048416538;5496.422875598065;5524.4199359067325;5527.4472552744755;5535.806246781363;5537.418571050037;5484.561235101192;5537.529310008644;5545.085060964946;5553.666779993203;5553.805616803413;5053.292539044518;5053.671511351759;5088.135017047092;5100.591952643779;5171.50870667286;5006.874828129307;5067.163917953551;5130.02529519392;5173.327467429229;5192.143296356116;5000.274960130797;5051.166557518023;5080.79676812927;5106.7701953412;5107.565856902168;5039.067772462106;5079.161938280179;5086.593072554187;5087.414947281054;5136.563392111675;4846.806127754886;5011.599072074226;5011.749412529395;5044.192929131358;5074.264231686422;5320.068987927098;5347.59893008022;5386.784528618889;5394.838154855361;5429.647072940285;5798.7390567424145;5844.736986835603;5846.269216347957;5855.882882342329;5865.032269675498;5740.138979153118;5795.681237531934;5898.734556944948;5914.378990206053;5914.733836977346;5479.671219726789;5486.807961721321;5489.972550137224;5492.368377636543;5527.778888844482;5928.140419639129;5939.465448109604;5944.92991261577;5950.791722289786;5955.851103722442;5642.435756424325;5724.141378793214;5755.395683453261;5774.047282198474;5838.38696936824;5843.620164689281;5850.3564607893095;5850.707464626752;5857.297124345106;5886.411358864079;5747.850429914034;5771.047777116729;5791.305043394819;5818.272715910512;5832.650040997553;5755.971220143872;5758.280214973129;5859.882802343929;5926.140709597171;5943.851403714942;4484.641228701696;4487.371767952489;4491.483479399845;4494.505604383515;4510.887227819265;4030.0730831908827;4043.251998380309;4052.63526282636;4079.1841631673783;4083.3466645336603;5553;5586.273784408001;5589.413111623302;5710;5720.942790572124;5746.080627099644;5866.1494083357675;5883.382244864228;5890.734916928748;5913.2608423947;5581.748821303051;5595.0208713475795;5610.691411972381;5613.522850557748;5661.971690141523;4971.5028497150715;4994.600431965507;5060.51925067118;5067.898642027212;5087.033463641897;6052.636841789418;6060.090986352083;6080.543959203077;6083.361247069082;6087.817365479043;5783.161441590862;5845.210896528914;5855.2095467113095;5871;5873.442023007808;6061.212042434456;6116.663583502772;6121.3809739783;6128.750654727687;6150.35421280777;5780.190773291826;5796.275465566804;5799.188113664006;5800.593958423039;5804.332501762183;5831.35855055952;5857.9121313179485;5867.6772777497645;5886.264216972879;5891.793787217598;5658.207850900795;5685.34618518859;5721.628094173865;5725;5731.598788084794;5611.6352437091455;5678.290213723285;5685.34618518859;5691.7438715257085;5708;5586.441355864381;5626.2967129108865;5631.493165615114;5644.322681278273;5713.514351280188;5710.2576665033275;5747.166660834239;5771.192033115283;5779.2775903012125;5791.420857914343;5636.070048441961;5647.378788333198;5664;5668.7165641718575;5683.175939488834 23:12:49 INFO - PROCESS | 12160 | |1;ext.html;596.4065754574199;657.3919124809556;658.2528829778201;662.7315937045498;671.0739179931692;39534.40698389523;40207.195856082864;40366.79816600913;40530.392044119326;40591.59408405919;41865;42172.578274217245;42396;42434.78782606091;42594.361084583754;8772.078931712174;9023.503707296097;9027;9030.819383612325;9056.501892395949;8797.73606791794;8840.690575829847;8883.95558022209;8887.466751994869;8889.155530224618;9158.587863546156;9219.907800922005;9231.123043310874;9266.073392660748;9271.397359171666;9075.591598378089;9095.545222738836;9104.999999999967;9116.726498205064;9187.908120918772;9090.63637454501;9169.908300916972;9183.173514383738;9203.769905752342;9205.539723013822;43843.56156438459;44236.77881610604;44275.33586996198;44353.334699979525;44426;3923.3330333843314;4006.258842114189;4469.396631454744;4545.772711364451;4666.160091183586;33317.66682333194;33571.32857342839;33863;33951.32097358039;34916.12709682253;4524.11779702958;4524.6380289576755;4560.087982403499;4561.863144105649;4579.977100114512;314732;314816;315058;315059;316792;39142.80428597839;39841.40237896434;60559;60611;60941;36641.633583664356;37219.06952326159;37317.253654926746;37319.62680373162;37404.81297593495;16182.19089045543;16230.756538651929;16315.184240787914;16364.099974501516;16382.918085409498;13787.86212137886;13840.30798460073;13864.376103075387;13868.583942481742;13924.37340319688;9357.157855792875;9403.43579385239;9428.669996550088;9432.151106400457;9456.148946594702;3538.876139335111;3610.115521697201;3631.2555926035097;3649.5620525536574;3722.40441529354;1135.4606561883204;1160.3675996581883;1208.528673817212;1252.8872401483727;1271.377025257617;32786.67213327836;32999;33183;33400.498992514644;33634;1224.2165014390796;1266.7339858629607;1290.1742884553894;1308.2281453942219;1310.5871650430274;16693;17094.316227351017;17184;17397.391091311998;17488.737668934977;448323;455298;570833;572385;577454;62764.37235627585;63663;63830.36169638337;63907.36092639014;64393.67803160954;1506.7815166800754;1516.3934426229375;1537.7308970930042;1542;1632.2573229180693;33046.33907321792;33970.8301458501;34090.82954585211;34118.31763364768;34367.14082147966;53806.46193538171;54487;54549.727251365075;54616;54699.45300546943;433114;434576;436461;436590;438987;30921.381572368875;31458;31682.207944801565;31813.8409307952;31852.04443866688;49446.50553494419;49450.25824612706;49979.50020499894;51148.488515114375;51288.74355628198;41897.58102418937;42876.78561607172;43083.78458107689;43793.12413751643;44166.77916610397;42021.78989105157;42362.36456453094;42459.363109554;43471;43916.560834391246;43511.347329789445;45278.54721452743;45387.54612453965;45512.54487455083;46376.768116159205;32883.67116328806;33491.66508334885;33727.3254534903;36224.27551449009;36367.818160909024;28995.85502072476;29389.412211756073;29540.113796586138;29777.404451910406;29796 23:12:49 INFO - PROCESS | 12160 | |2;jquery.html;413.4067612975381;425.52978958251134;433.67257720421077;434.2595874034771;435.7690424075239;18916.527086822836;19638.803611963893;19647.214111435544;20796.376108716762;21836.126554937822;13555.796663050061;13614.659633509142;13643.113197642171;18360.26558937641;20040.59918801623;5460.34475862897;5513.393526712059;5642.943570564283;5643.379228284885;5650.802221922234;5967.970160149193;5982.3120341160675;6071.3625069367745;6073.058675905219;6083.574149809515;5783.508401785833;5999.640021598696;6008.279006519224;6021.698915054251;6033.758649654009;5935.317438494585;6027.306859711145;6036.094585812141;6047.244094488189;6047.909281360761;5465.863353416196;5482.0406428874785;5491.560675145979;5495.890082198333;5505.642133261325;14755.55733328002;14979.625509362244;14983.475578354706;14991;19202.903985479985;2430.538197742423;2438.7805097541304;2440.5118976204653;2565.4612531368434;2631.302704783234;10830.891691083067;11104.44477776108;12850.971922246197;13923.651908702364;14680.632984175374;2014.4863059919626;2038.4801875521796;2068.9482762930897;2072.0986370928545;2188.5732282204976;63537;76121.61939190324;76494.61752691257;84134.15865841325;85458.57270713669;11225.326480411202;11974.401279935968;12225.69435764113;12247.877521224851;12283.69290767738;16836;16990.150492475328;16994.235259413355;17020.659586808193;17085.743713844302;8788.736337909873;9084.545772711337;9120.087991200828;9123.81752364949;9157.175854173023;8839.823203535892;8903.910960890438;8961.462312261285;8963.955180224188;8990.370674052754;5006.621854619027;5221.947780522146;5238.580913526908;5249.107651699221;5252;2076.9376918692465;2101.726775519173;2160.7528170702294;2187.73747150343;2205.5856905903925;952.4808979106404;1050.1808589300358;1119.227732864321;1175.9470823812949;1179.6343133628602;17130.48608541746;19274.71087933682;19752.30866919651;19788.20847166097;20203.191872324944;1074.5970261152067;1109.4840898981852;1129.6836885672026;1138.6640940922448;1154.809456439695;10961.287516311415;11126.554937802397;11243.66269011931;11249.887501125047;11270.549178032787;481379;484689;491421;496579;500823;75147;97763.51118244363;99253;99429;99643;1103.8896110388896;1146.1690274550883;1167.8365028895962;1204.5362535423924;1205.9879401205876;16514.917425412797;18125.096864829004;18260.726089108408;18557.628847422708;18971.24115035383;40892.59107408888;41807.37288940608;42932.570674294104;43840.342394863466;44048;55501.722491387285;55879;59922.10116848338;61672.38327616666;62557.374426255155;8688.52213128284;8874.733757987271;8941.46351218929;9042;9349.75777441858;9742.269329800152;13038.804417933929;13542.187468751907;13764.380602873094;14187.361568729639;11396.94301528487;11435.59975400857;11737.471813768572;11753.529858805552;12402.875971240172;11296.983271505604;11586.304821710724;11815.350155741517;11860.347680877634;12296.938515307724;11225.775484490428;11478.483468244116;11522.078233741448;11613;12493.25040497573;8895.777605559913;9101.089891010846;9106.544672766468;9132.40639358466;9223.16991470744;11666.883331166919;11904;12152.635420937386;12160.270383777002;12174.45214965311 23:12:49 INFO - PROCESS | 12160 | |3;mootools.html;1551.1701239836686;1566.749320108782;1766.9823301766978;1848.5101448116243;1863.748393966814;7506.96246518768;8107.837843243132;8370.497770133796;8536.359773017026;8555.486670799748;8261.710840120597;8357.414980951336;8442.324614030878;8465.576721163949;8468.491890486559;2348.38941875112;2367.9052837886466;2374.4657452073234;2376.964345534818;2381.5117900830287;2259.2883241778786;2261.4685548895995;2319.373769082355;2320.524292520029;2332.253678822769;2376.5484557933937;2379.4884099918513;2409.939751506218;2427.5509030829353;2433.0511100670665;2339.1111377676375;2349.142562964514;2358.0685629176464;2363.1847012780477;2371.5494056129282;2334.8832558372014;2353.388119089032;2358.41039740065;2359.64605309205;2360.256519196465;8548.358873084544;8597.785055373666;8617.396782225247;8618.439801412951;8640.740777776677;5168.5865130789825;5238.633295669305;5245.082110630662;5279.841604751864;5300.602454815904;3381.7801842880135;3395.8811441599423;3431.125063108916;3438.157651375404;3515;1072.1958531101673;1089.934603923767;1096.819024860897;1106.0487980336984;1107.9944600276947;11950.103742219282;12042.578509752204;12068.758624827455;12079.396030198543;12101.152919295653;4451.977740111279;4480.865574032719;4528.388667529907;4571.954280457219;4621.075784843045;10304.948475257726;10316.690499285034;10319.535620897077;10321.690349289533;10336.689899303034;5224.686518808883;5225.843224703265;5258.579313654898;5282.022825777243;5290.338707661543;4600.97699511507;4779.545943135397;4785.258284965836;4808.35087263215;4829;3768.5477742671055;3828.444875493038;3829.0810205550465;3871.1483473635753;3902.2195560887935;1134.1777211521746;1135.0635725526474;1138.7608602193466;1145.6734830573246;1186.7211205366732;1017.7811770469384;1032.5147180825;1038.200585549123;1046.5238316565944;1047.0524175621076;5888.411158884163;5914.8817023659285;5940.79207227745;6051.606645568024;6064;478.4808482796205;486.0716032378141;486.5961252160698;508.03219866155035;510.2295533744073;4132.8140233689555;4133.545310015896;4150.958490415057;4151.4395556599475;4176.352665336878;10211.029952154533;10559.736006599744;10621.150307975344;10634.787304253872;10661.093807026335;10344.637937672145;10427.739306517245;10451.425171615634;10459.320144190755;10474.47627618616;7960.681572737026;8026.799330016679;8202.302804261586;8215.09633940266;8220.671173153127;5984;5994.940050599613;5998.550108741774;6093.48205402528;6108.992016317258;9155.13026262504;9391.248700104112;9396.154346108882;9410.764730881783;9467.053294670754;9013.63945442175;9016;9045.77385565366;9194.862077068716;9221.815563688822;7483.550986940801;7557.35762460197;7602.391808655405;7820.804479888048;7827;8221;8303.875441868257;8362.247397734232;8365.038020627706;8393.202645748644;7399.963000184965;7624.27569380908;7649.61751912391;7705.922940770521;7777.144514103331;7479.551226926402;7508.812279693051;7564.8487030260185;7569.848603028019;7640.503367281109;6887.173539175331;6901.723931042702;6935.6878940446795;6936.826579335557;6943.618101004493;5014.423341315795;5088.185890257541;5130.743462826918;5178.197379406198;5211.765470553758;5172.793088276427;5214.765335559833;5298.655587386807;5301.549368303583;5321.7339133042415 23:12:49 INFO - PROCESS | 12160 | |4;prototype.html;328.93092450585374;372.8247723569922;374.59543692811764;374.9512563366762;376.0335936642827;6430.742770289183;6446.355364463551;6466.870662586745;6567.146270984771;6570.934290657092;6549.050387693782;6594.769183078593;6605.636689982061;6606.2072551293795;6616.768413105542;4917.737840593331;4938.38270216223;4958.975205123969;4961.4790447003;4977.975110124445;4985.850424487271;4991.900161996776;4996.675216110959;4998.925016124761;5001.99960007998;4950.801967921278;4953.653244272902;4961.503849615027;4963.7021778693215;4966.726830024347;4706.599939005188;4847.3698419205275;4955.05853887762;4961.082199793032;4964.180910149839;4204.579542045802;4219.873403797891;4221.050263690676;4225;4243.342281946303;6131.47882429994;6139.78510752126;6141.416565426277;6146.231721034871;6146.416090471398;5595.552355811526;5662.037453632893;5736.139579063132;5755.625884317506;5756.597038207327;6849.41779948705;6865.622390768505;6868.244493105754;6870.725170993154;6878.621675807829;4756.191447453941;4758.762061896891;4762.976185119087;4765.737884416356;4776.832810851638;7038.401735852459;7152.606606636581;7175.354218120394;7179.964100179465;7192.2807719228185;4787.042591481718;4795.448523419782;4795.712257264575;4804.303376010459;4809.711417314972;4807.158747219292;4933.963867587775;4935.580475659609;4948.777305021283;4953.281774142729;5665.716714164275;5680.204771332017;5712.057510510802;5724.284464441945;5725.541956643458;6901.240863505011;6902.482313826383;6905.309469053054;6910.170779506491;6922.307769223037;1688.2234172280644;1689.7549855270918;1691.2981112838281;1695.118538360046;1704.207543492282;1109.5617231193633;1128.15388458656;1142.6743378137357;1150.7295785490403;1170.268582136165;6620.768273110418;6632.872411690024;6665.466762658975;6672.165979252593;6677.732890684415;7032.226455089936;7038.788836334918;7059.89410158848;7084.716611335592;7094.822629434306;6614.933850661528;6622.8013159604325;6623.30455302196;6627.734890604418;6639.136912201383;3807.276617442677;3835.0795809006195;3838.481804956351;3838.7120965927666;3841.0781412461365;7274.709011639581;7433.665485053186;7446.069241344832;7484.625768711543;7547.396208303323;7322.96338518304;7344.265573442613;7351.558906465629;7374.299441553044;7383.963080184565;7525.285097915689;7526.134494533089;7528.247175282428;7531.397488200931;7532.472726909174;7014.508984371249;7178.246284140299;7180.210176880434;7184.6048467334795;7185.676644550903;7044.647767611496;7097.822554435974;7101.644917754195;7128.928710712827;7134.500584959211;7488.737894173678;7499.137599175946;7508.511946723445;7537.585432801248;7543.47195696318;4768.9523104768505;4780.49804770508;4800.303955926302;4803.711777293373;4810.831620893252;7004.334588214111;7127.501074924706;7130;7153.177384600629;7202.819929501804;6963.338482844122;6969.233384327821;6972.337627925339;6978.162620485574;6985.755498557526;6914.0320355149315;6941.791746247621;6952.478564107611;6958.095447591781;6963.338482844122;6845.965770171118;6856.485763567653;6857.074294970115;6864.48516361265;6867.2102708189195;6807.285235050248;7000.649967501503;7003.089598352181;7038.190608080136;7038.225795162631;6696.59820410777;6842.213145488333;6861.519693621399;6866.931330686629;6877.6217308048535 23:12:49 INFO - PROCESS | 12160 | |5;yui.html;900.79281765194;902.9232515236205;908.532105965428;911.2254583603942;917.9403338782979;15228.1624510652;15580.766288505667;15588.766168507482;17073.82926170738;17487.562810929703;15917.44288949887;16043.679126417494;16050.59873503163;16051.357945682159;16067.758983615255;865.6191275838627;877.1097336203758;887.2768693514797;888.5868071346855;907.0068275238604;891.0777345447464;891.8617614269766;893.8882639670041;894.4275663575316;894.4901406198469;937.030173770148;938.2775263047449;944.914957653811;945.0502245243555;949.4066208619613;927.4342650982895;938.8310104181245;939.2439086535336;940.1961323068814;942.5899733615864;688.0814113158939;688.3048121397375;689.8654762321349;689.9896501552481;692.3664846665296;15900.920495397564;15980.280887360097;16030.679386412206;16070.839291607168;16086.276117574736;14482.927585362111;14589.562313130624;14646.780298295535;14800.629984250372;14859.777103343351;11849.644510664693;12003.099767517471;12068.215565988183;12106.334151621657;12365.07261955357;4066.8373265069363;4167.52073511547;4228.281192197333;4256.361545768129;4258.08451182994;56460.153097703565;57964.42035579633;58142.12786808201;58155;58213;11618.983239557005;11999.400029998465;12067.456964436622;12313.876861231272;12457.688557786129;20487.69268460974;20523.794762052486;20561;20564;20683;8905.599248033854;8993.14565116313;9221.308401869886;9237.769055773659;9290.256779457628;5033.949660503348;5114.156164232934;5163.896722065538;5167.715775632301;5184.533391994739;3644.890653280406;3718.981405092957;3733.9253214935547;3736.6637002669345;3744.475773391727;625.5927628219172;685.3215316836296;691.7129391302553;693.2928413018693;707.3209718670134;737.6717360774404;746.9738559150404;757.9886301705479;770.310572038034;771.2788542712582;9612.279079069098;9989.60041598328;10095.293329467013;10157.542910569042;10228.698542827804;642.9646369449632;661.4609093588709;756.5347311403448;806.5965220516259;822.6133717152928;4719.646026548023;4829.589484893823;4861.913523002864;4878.609711223165;4886.53577910098;60002.69998650066;61299.69350153221;61349.38650613526;61773.69113154405;61780;55545.72227138838;56458.43541564614;56520;56844.71577642085;57105.714471427375;52704.47295527072;53001.46998530043;53071.73464132655;53216.46783532193;53784.19323710069;9497.715068547956;9648.469334186688;9708.271879608916;9720.708378748648;9729.70810875675;36158.63841361658;36529.45205821968;36858.8157059213;37737.245255095295;38123.618763813116;43057.56942430661;45166.77416612896;47815.76092119517;48309;49057.50942490672;12054.819177712518;12098.697532561404;12146.635600931986;12168.513259469877;12538.561150359694;12608.180468269533;12747.808782868078;12976.35118244065;13259.867401325862;13351.132176408502;11881.465334060162;12007.459664315302;12015.579454719043;12164.2701437914;12223.57217497419;12565.308908009782;12689.4289756963;12698.111132221025;12707.428165732748;12935.353232338533;12261.417605065564;12748.936255318664;13507.638307207577;13532.255725935169;13899.583012509642;11686.298822070703;11713.1800773945;11775.352355620524;11891.464884080064;12413.689657758629;11688.064954803425;11804;11852.229605075643;12180.451879665614;12259.938700306442 23:12:49 INFO - PROCESS | 12160 | __end_tp_report 23:12:49 INFO - PROCESS | 12160 | __start_cc_report 23:12:49 INFO - PROCESS | 12160 | _x_x_mozilla_cycle_collect,336 23:12:49 INFO - PROCESS | 12160 | __end_cc_report 23:12:49 INFO - PROCESS | 12160 | __startTimestamp1466748769237__endTimestamp 23:12:49 INFO - PROCESS | 12160 | 23:12:49 INFO - PROCESS | 12160 | ------- Summary: start ------- 23:12:49 INFO - PROCESS | 12160 | Number of tests: 6 23:12:49 INFO - PROCESS | 12160 | 23:12:49 INFO - PROCESS | 12160 | [#0] dojo.html Cycles:165 Average:5465.79 Median:5664.00 stddev:580.28 (10.2%) stddev-sans-first:555.87 23:12:49 INFO - PROCESS | 12160 | Values: 3268.5 3353.7 3368.1 3422.4 3423.4 5496.4 5524.4 5527.4 5535.8 5537.4 5484.6 5537.5 5545.1 5553.7 5553.8 5053.3 5053.7 5088.1 5100.6 5171.5 5006.9 5067.2 5130.0 5173.3 5192.1 5000.3 5051.2 5080.8 5106.8 5107.6 5039.1 5079.2 5086.6 5087.4 5136.6 4846.8 5011.6 5011.7 5044.2 5074.3 5320.1 5347.6 5386.8 5394.8 5429.6 5798.7 5844.7 5846.3 5855.9 5865.0 5740.1 5795.7 5898.7 5914.4 5914.7 5479.7 5486.8 5490.0 5492.4 5527.8 5928.1 5939.5 5944.9 5950.8 5955.9 5642.4 5724.1 5755.4 5774.0 5838.4 5843.6 5850.4 5850.7 5857.3 5886.4 5747.9 5771.0 5791.3 5818.3 5832.7 5756.0 5758.3 5859.9 5926.1 5943.9 4484.6 4487.4 4491.5 4494.5 4510.9 4030.1 4043.3 4052.6 4079.2 4083.3 5553.0 5586.3 5589.4 5710.0 5720.9 5746.1 5866.1 5883.4 5890.7 5913.3 5581.7 5595.0 5610.7 5613.5 5662.0 4971.5 4994.6 5060.5 5067.9 5087.0 6052.6 6060.1 6080.5 6083.4 6087.8 5783.2 5845.2 5855.2 5871.0 5873.4 6061.2 6116.7 6121.4 6128.8 6150.4 5780.2 5796.3 5799.2 5800.6 5804.3 5831.4 5857.9 5867.7 5886.3 5891.8 5658.2 5685.3 5721.6 5725.0 5731.6 5611.6 5678.3 5685.3 5691.7 5708.0 5586.4 5626.3 5631.5 5644.3 5713.5 5710.3 5747.2 5771.2 5779.3 5791.4 5636.1 5647.4 5664.0 5668.7 5683.2 23:12:49 INFO - PROCESS | 12160 | 23:12:49 INFO - PROCESS | 12160 | [#1] ext.html Cycles:180 Average:58549.98 Median:42447.08 stddev:115520.00 (272.2%) stddev-sans-first:115762.12 23:12:49 INFO - PROCESS | 12160 | Values: 596.4 657.4 658.3 662.7 671.1 39534.4 40207.2 40366.8 40530.4 40591.6 41865.0 42172.6 42396.0 42434.8 42594.4 8772.1 9023.5 9027.0 9030.8 9056.5 8797.7 8840.7 8884.0 8887.5 8889.2 9158.6 9219.9 9231.1 9266.1 9271.4 9075.6 9095.5 9105.0 9116.7 9187.9 9090.6 9169.9 9183.2 9203.8 9205.5 43843.6 44236.8 44275.3 44353.3 44426.0 3923.3 4006.3 4469.4 4545.8 4666.2 33317.7 33571.3 33863.0 33951.3 34916.1 4524.1 4524.6 4560.1 4561.9 4580.0 314732.0 314816.0 315058.0 315059.0 316792.0 39142.8 39841.4 60559.0 60611.0 60941.0 36641.6 37219.1 37317.3 37319.6 37404.8 16182.2 16230.8 16315.2 16364.1 16382.9 13787.9 13840.3 13864.4 13868.6 13924.4 9357.2 9403.4 9428.7 9432.2 9456.1 3538.9 3610.1 3631.3 3649.6 3722.4 1135.5 1160.4 1208.5 1252.9 1271.4 32786.7 32999.0 33183.0 33400.5 33634.0 1224.2 1266.7 1290.2 1308.2 1310.6 16693.0 17094.3 17184.0 17397.4 17488.7 448323.0 455298.0 570833.0 572385.0 577454.0 62764.4 63663.0 63830.4 63907.4 64393.7 1506.8 1516.4 1537.7 1542.0 1632.3 33046.3 33970.8 34090.8 34118.3 34367.1 53806.5 54487.0 54549.7 54616.0 54699.5 433114.0 434576.0 436461.0 436590.0 438987.0 30921.4 31458.0 31682.2 31813.8 31852.0 49446.5 49450.3 49979.5 51148.5 51288.7 41897.6 42876.8 43083.8 43793.1 44166.8 42021.8 42362.4 42459.4 43471.0 43916.6 43511.3 45278.5 45387.5 45512.5 46376.8 32883.7 33491.7 33727.3 36224.3 36367.8 28995.9 29389.4 29540.1 29777.4 29796.0 23:12:49 INFO - PROCESS | 12160 | 23:12:49 INFO - PROCESS | 12160 | [#2] jquery.html Cycles:180 Average:29084.71 Median:2188.16 stddev:80947.00 (3699.3%) stddev-sans-first:81145.45 23:12:49 INFO - PROCESS | 12160 | Values: 413.4 425.5 433.7 434.3 435.8 18916.5 19638.8 19647.2 20796.4 21836.1 13555.8 13614.7 13643.1 18360.3 20040.6 5460.3 5513.4 5642.9 5643.4 5650.8 5968.0 5982.3 6071.4 6073.1 6083.6 5783.5 5999.6 6008.3 6021.7 6033.8 5935.3 6027.3 6036.1 6047.2 6047.9 5465.9 5482.0 5491.6 5495.9 5505.6 14755.6 14979.6 14983.5 14991.0 19202.9 2430.5 2438.8 2440.5 2565.5 2631.3 10830.9 11104.4 12851.0 13923.7 14680.6 2014.5 2038.5 2068.9 2072.1 2188.6 63537.0 76121.6 76494.6 84134.2 85458.6 11225.3 11974.4 12225.7 12247.9 12283.7 16836.0 16990.2 16994.2 17020.7 17085.7 8788.7 9084.5 9120.1 9123.8 9157.2 8839.8 8903.9 8961.5 8964.0 8990.4 5006.6 5221.9 5238.6 5249.1 5252.0 2076.9 2101.7 2160.8 2187.7 2205.6 952.5 1050.2 1119.2 1175.9 1179.6 17130.5 19274.7 19752.3 19788.2 20203.2 1074.6 1109.5 1129.7 1138.7 1154.8 10961.3 11126.6 11243.7 11249.9 11270.5 481379.0 484689.0 491421.0 496579.0 500823.0 75147.0 97763.5 99253.0 99429.0 99643.0 1103.9 1146.2 1167.8 1204.5 1206.0 16514.9 18125.1 18260.7 18557.6 18971.2 40892.6 41807.4 42932.6 43840.3 44048.0 55501.7 55879.0 59922.1 61672.4 62557.4 8688.5 8874.7 8941.5 9042.0 9349.8 9742.3 13038.8 13542.2 13764.4 14187.4 11396.9 11435.6 11737.5 11753.5 12402.9 11297.0 11586.3 11815.4 11860.3 12296.9 11225.8 11478.5 11522.1 11613.0 12493.3 8895.8 9101.1 9106.5 9132.4 9223.2 11666.9 11904.0 12152.6 12160.3 12174.5 23:12:49 INFO - PROCESS | 12160 | 23:12:49 INFO - PROCESS | 12160 | [#3] mootools.html Cycles:180 Average:5670.06 Median:2657.54 stddev:3157.51 (118.8%) stddev-sans-first:3151.20 23:12:49 INFO - PROCESS | 12160 | Values: 1551.2 1566.7 1767.0 1848.5 1863.7 7507.0 8107.8 8370.5 8536.4 8555.5 8261.7 8357.4 8442.3 8465.6 8468.5 2348.4 2367.9 2374.5 2377.0 2381.5 2259.3 2261.5 2319.4 2320.5 2332.3 2376.5 2379.5 2409.9 2427.6 2433.1 2339.1 2349.1 2358.1 2363.2 2371.5 2334.9 2353.4 2358.4 2359.6 2360.3 8548.4 8597.8 8617.4 8618.4 8640.7 5168.6 5238.6 5245.1 5279.8 5300.6 3381.8 3395.9 3431.1 3438.2 3515.0 1072.2 1089.9 1096.8 1106.0 1108.0 11950.1 12042.6 12068.8 12079.4 12101.2 4452.0 4480.9 4528.4 4572.0 4621.1 10304.9 10316.7 10319.5 10321.7 10336.7 5224.7 5225.8 5258.6 5282.0 5290.3 4601.0 4779.5 4785.3 4808.4 4829.0 3768.5 3828.4 3829.1 3871.1 3902.2 1134.2 1135.1 1138.8 1145.7 1186.7 1017.8 1032.5 1038.2 1046.5 1047.1 5888.4 5914.9 5940.8 6051.6 6064.0 478.5 486.1 486.6 508.0 510.2 4132.8 4133.5 4151.0 4151.4 4176.4 10211.0 10559.7 10621.2 10634.8 10661.1 10344.6 10427.7 10451.4 10459.3 10474.5 7960.7 8026.8 8202.3 8215.1 8220.7 5984.0 5994.9 5998.6 6093.5 6109.0 9155.1 9391.2 9396.2 9410.8 9467.1 9013.6 9016.0 9045.8 9194.9 9221.8 7483.6 7557.4 7602.4 7820.8 7827.0 8221.0 8303.9 8362.2 8365.0 8393.2 7400.0 7624.3 7649.6 7705.9 7777.1 7479.6 7508.8 7564.8 7569.8 7640.5 6887.2 6901.7 6935.7 6936.8 6943.6 5014.4 5088.2 5130.7 5178.2 5211.8 5172.8 5214.8 5298.7 5301.5 5321.7 23:12:49 INFO - PROCESS | 12160 | 23:12:49 INFO - PROCESS | 12160 | [#4] prototype.html Cycles:180 Average:5778.09 Median:6618.77 stddev:1770.99 (26.8%) stddev-sans-first:1728.08 23:12:49 INFO - PROCESS | 12160 | Values: 328.9 372.8 374.6 375.0 376.0 6430.7 6446.4 6466.9 6567.1 6570.9 6549.1 6594.8 6605.6 6606.2 6616.8 4917.7 4938.4 4959.0 4961.5 4978.0 4985.9 4991.9 4996.7 4998.9 5002.0 4950.8 4953.7 4961.5 4963.7 4966.7 4706.6 4847.4 4955.1 4961.1 4964.2 4204.6 4219.9 4221.1 4225.0 4243.3 6131.5 6139.8 6141.4 6146.2 6146.4 5595.6 5662.0 5736.1 5755.6 5756.6 6849.4 6865.6 6868.2 6870.7 6878.6 4756.2 4758.8 4763.0 4765.7 4776.8 7038.4 7152.6 7175.4 7180.0 7192.3 4787.0 4795.4 4795.7 4804.3 4809.7 4807.2 4934.0 4935.6 4948.8 4953.3 5665.7 5680.2 5712.1 5724.3 5725.5 6901.2 6902.5 6905.3 6910.2 6922.3 1688.2 1689.8 1691.3 1695.1 1704.2 1109.6 1128.2 1142.7 1150.7 1170.3 6620.8 6632.9 6665.5 6672.2 6677.7 7032.2 7038.8 7059.9 7084.7 7094.8 6614.9 6622.8 6623.3 6627.7 6639.1 3807.3 3835.1 3838.5 3838.7 3841.1 7274.7 7433.7 7446.1 7484.6 7547.4 7323.0 7344.3 7351.6 7374.3 7384.0 7525.3 7526.1 7528.2 7531.4 7532.5 7014.5 7178.2 7180.2 7184.6 7185.7 7044.6 7097.8 7101.6 7128.9 7134.5 7488.7 7499.1 7508.5 7537.6 7543.5 4769.0 4780.5 4800.3 4803.7 4810.8 7004.3 7127.5 7130.0 7153.2 7202.8 6963.3 6969.2 6972.3 6978.2 6985.8 6914.0 6941.8 6952.5 6958.1 6963.3 6846.0 6856.5 6857.1 6864.5 6867.2 6807.3 7000.6 7003.1 7038.2 7038.2 6696.6 6842.2 6861.5 6866.9 6877.6 23:12:49 INFO - PROCESS | 12160 | 23:12:49 INFO - PROCESS | 12160 | [#5] yui.html Cycles:180 Average:15589.24 Median:26267.70 stddev:17587.95 (67.0%) stddev-sans-first:17602.70 23:12:49 INFO - PROCESS | 12160 | Values: 900.8 902.9 908.5 911.2 917.9 15228.2 15580.8 15588.8 17073.8 17487.6 15917.4 16043.7 16050.6 16051.4 16067.8 865.6 877.1 887.3 888.6 907.0 891.1 891.9 893.9 894.4 894.5 937.0 938.3 944.9 945.1 949.4 927.4 938.8 939.2 940.2 942.6 688.1 688.3 689.9 690.0 692.4 15900.9 15980.3 16030.7 16070.8 16086.3 14482.9 14589.6 14646.8 14800.6 14859.8 11849.6 12003.1 12068.2 12106.3 12365.1 4066.8 4167.5 4228.3 4256.4 4258.1 56460.2 57964.4 58142.1 58155.0 58213.0 11619.0 11999.4 12067.5 12313.9 12457.7 20487.7 20523.8 20561.0 20564.0 20683.0 8905.6 8993.1 9221.3 9237.8 9290.3 5033.9 5114.2 5163.9 5167.7 5184.5 3644.9 3719.0 3733.9 3736.7 3744.5 625.6 685.3 691.7 693.3 707.3 737.7 747.0 758.0 770.3 771.3 9612.3 9989.6 10095.3 10157.5 10228.7 643.0 661.5 756.5 806.6 822.6 4719.6 4829.6 4861.9 4878.6 4886.5 60002.7 61299.7 61349.4 61773.7 61780.0 55545.7 56458.4 56520.0 56844.7 57105.7 52704.5 53001.5 53071.7 53216.5 53784.2 9497.7 9648.5 9708.3 9720.7 9729.7 36158.6 36529.5 36858.8 37737.2 38123.6 43057.6 45166.8 47815.8 48309.0 49057.5 12054.8 12098.7 12146.6 12168.5 12538.6 12608.2 12747.8 12976.4 13259.9 13351.1 11881.5 12007.5 12015.6 12164.3 12223.6 12565.3 12689.4 12698.1 12707.4 12935.4 12261.4 12748.9 13507.6 13532.3 13899.6 11686.3 11713.2 11775.4 11891.5 12413.7 11688.1 11804.0 11852.2 12180.5 12259.9 23:12:49 INFO - PROCESS | 12160 | -------- Summary: end -------- 23:12:49 INFO - PROCESS | 12160 | 23:12:49 INFO - TEST-INFO | 12160: exit 0 23:12:49 INFO - TEST-OK | dromaeo_css | took 1108763ms 23:12:49 INFO - TEST-START | kraken 23:12:49 INFO - operating with platform_type : linux_ 23:12:49 INFO - Initialising browser for kraken test... 23:12:49 INFO - TEST-INFO | started process 12402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzpYEcA/profile http://localhost:42149/getInfo.html) 23:12:53 INFO - PROCESS | 12402 | 23:12:53 INFO - PROCESS | 12402 | (process:12478): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:12:54 INFO - PROCESS | 12402 | __metrics Screen width/height:1600/1200 23:12:54 INFO - PROCESS | 12402 | colorDepth:24 23:12:54 INFO - PROCESS | 12402 | Browser inner width/height: 1024/697 23:12:54 INFO - PROCESS | 12402 | __metrics 23:12:54 ERROR - PROCESS | 12402 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:12:55 INFO - TEST-INFO | 12402: exit 0 23:12:55 INFO - Browser initialized. 23:12:55 INFO - Running cycle 1/1 for kraken test... 23:12:55 INFO - TEST-INFO | started process 12528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzpYEcA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:12:57 INFO - PROCESS | 12528 | 23:12:57 INFO - PROCESS | 12528 | (process:12596): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:13:07 INFO - PROCESS | 12528 | RSS: Main: 150642688 23:13:07 INFO - PROCESS | 12528 | 23:13:09 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42149/tests/kraken/driver.html?testName=audio-beat-detection) 23:13:10 INFO - PROCESS | 12528 | RSS: Main: 155811840 23:13:10 INFO - PROCESS | 12528 | 23:13:13 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42149/tests/kraken/driver.html?testName=audio-dft) 23:13:14 INFO - PROCESS | 12528 | RSS: Main: 155934720 23:13:14 INFO - PROCESS | 12528 | 23:13:16 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42149/tests/kraken/driver.html?testName=audio-fft) 23:13:17 INFO - PROCESS | 12528 | RSS: Main: 155648000 23:13:17 INFO - PROCESS | 12528 | 23:13:19 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42149/tests/kraken/driver.html?testName=audio-oscillator) 23:13:20 INFO - PROCESS | 12528 | RSS: Main: 155410432 23:13:20 INFO - PROCESS | 12528 | 23:13:22 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42149/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:13:23 INFO - PROCESS | 12528 | RSS: Main: 155451392 23:13:23 INFO - PROCESS | 12528 | 23:13:26 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42149/tests/kraken/driver.html?testName=imaging-darkroom) 23:13:26 INFO - PROCESS | 12528 | RSS: Main: 156196864 23:13:26 INFO - PROCESS | 12528 | 23:13:30 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42149/tests/kraken/driver.html?testName=imaging-desaturate) 23:13:30 INFO - PROCESS | 12528 | RSS: Main: 156360704 23:13:30 INFO - PROCESS | 12528 | 23:13:33 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42149/tests/kraken/driver.html?testName=json-parse-financial) 23:13:34 INFO - PROCESS | 12528 | RSS: Main: 156553216 23:13:34 INFO - PROCESS | 12528 | 23:13:35 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42149/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:13:36 INFO - PROCESS | 12528 | RSS: Main: 156172288 23:13:36 INFO - PROCESS | 12528 | 23:13:37 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42149/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:13:38 INFO - PROCESS | 12528 | RSS: Main: 156262400 23:13:38 INFO - PROCESS | 12528 | 23:13:40 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42149/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:13:41 INFO - PROCESS | 12528 | RSS: Main: 156332032 23:13:41 INFO - PROCESS | 12528 | 23:13:43 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:13:44 INFO - PROCESS | 12528 | RSS: Main: 156659712 23:13:44 INFO - PROCESS | 12528 | 23:13:46 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:13:47 INFO - PROCESS | 12528 | RSS: Main: 156688384 23:13:47 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:42149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42149/tests/kraken/driver.html?testName=ai-astar) 23:13:49 INFO - PROCESS | 12528 | RSS: Main: 157618176 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | __start_tp_report 23:13:49 INFO - PROCESS | 12528 | _x_x_mozilla_page_load 23:13:49 INFO - PROCESS | 12528 | _x_x_mozilla_page_load_details 23:13:49 INFO - PROCESS | 12528 | |i|pagename|runs| 23:13:49 INFO - PROCESS | 12528 | |0;ai-astar;109;113;105;111;112;111;102;110;111;111 23:13:49 INFO - PROCESS | 12528 | |1;audio-beat-detection;162;135;152;180;127;149;147;129;183;127 23:13:49 INFO - PROCESS | 12528 | |2;audio-dft;161;161;163;161;163;161;162;163;161;161 23:13:49 INFO - PROCESS | 12528 | |3;audio-fft;81;76;77;172;74;76;76;82;179;76 23:13:49 INFO - PROCESS | 12528 | |4;audio-oscillator;93;92;145;92;93;92;149;92;92;149 23:13:49 INFO - PROCESS | 12528 | |5;imaging-gaussian-blur;117;117;118;117;117;117;116;118;117;117 23:13:49 INFO - PROCESS | 12528 | |6;imaging-darkroom;147;147;146;146;146;147;145;146;145;146 23:13:49 INFO - PROCESS | 12528 | |7;imaging-desaturate;95;95;95;97;95;96;95;94;95;96 23:13:49 INFO - PROCESS | 12528 | |8;json-parse-financial;59;55;56;57;55;59;55;70;53;58 23:13:49 INFO - PROCESS | 12528 | |9;json-stringify-tinderbox;59;59;59;58;59;58;60;58;59;58 23:13:49 INFO - PROCESS | 12528 | |10;stanford-crypto-aes;72;73;73;73;73;74;73;74;73;73 23:13:49 INFO - PROCESS | 12528 | |11;stanford-crypto-ccm;123;116;118;112;112;114;112;112;127;125 23:13:49 INFO - PROCESS | 12528 | |12;stanford-crypto-pbkdf2;165;162;161;161;158;155;161;159;160;163 23:13:49 INFO - PROCESS | 12528 | |13;stanford-crypto-sha256-iterative;68;66;67;69;66;66;67;67;69;67 23:13:49 INFO - PROCESS | 12528 | __end_tp_report 23:13:49 INFO - PROCESS | 12528 | __start_cc_report 23:13:49 INFO - PROCESS | 12528 | _x_x_mozilla_cycle_collect,841 23:13:49 INFO - PROCESS | 12528 | __end_cc_report 23:13:49 INFO - PROCESS | 12528 | __startTimestamp1466748829469__endTimestamp 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | ------- Summary: start ------- 23:13:49 INFO - PROCESS | 12528 | Number of tests: 14 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.41 (3.1%) stddev-sans-first:3.61 23:13:49 INFO - PROCESS | 12528 | Values: 109.0 113.0 105.0 111.0 112.0 111.0 102.0 110.0 111.0 111.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:150.50 stddev:20.72 (13.8%) stddev-sans-first:21.44 23:13:49 INFO - PROCESS | 12528 | Values: 162.0 135.0 152.0 180.0 127.0 149.0 147.0 129.0 183.0 127.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 23:13:49 INFO - PROCESS | 12528 | Values: 161.0 161.0 163.0 161.0 163.0 161.0 162.0 163.0 161.0 161.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#3] audio-fft Cycles:10 Average:96.90 Median:76.00 stddev:41.53 (54.6%) stddev-sans-first:43.65 23:13:49 INFO - PROCESS | 12528 | Values: 81.0 76.0 77.0 172.0 74.0 76.0 76.0 82.0 179.0 76.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.00 stddev:26.78 (29.1%) stddev-sans-first:27.78 23:13:49 INFO - PROCESS | 12528 | Values: 93.0 92.0 145.0 92.0 93.0 92.0 149.0 92.0 92.0 149.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 23:13:49 INFO - PROCESS | 12528 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 23:13:49 INFO - PROCESS | 12528 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 145.0 146.0 145.0 146.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 23:13:49 INFO - PROCESS | 12528 | Values: 95.0 95.0 95.0 97.0 95.0 96.0 95.0 94.0 95.0 96.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:4.74 (8.2%) stddev-sans-first:5.00 23:13:49 INFO - PROCESS | 12528 | Values: 59.0 55.0 56.0 57.0 55.0 59.0 55.0 70.0 53.0 58.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 23:13:49 INFO - PROCESS | 12528 | Values: 59.0 59.0 59.0 58.0 59.0 58.0 60.0 58.0 59.0 58.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.00 stddev:0.57 (0.8%) stddev-sans-first:0.44 23:13:49 INFO - PROCESS | 12528 | Values: 72.0 73.0 73.0 73.0 73.0 74.0 73.0 74.0 73.0 73.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:117.00 stddev:5.88 (5.0%) stddev-sans-first:5.83 23:13:49 INFO - PROCESS | 12528 | Values: 123.0 116.0 118.0 112.0 112.0 114.0 112.0 112.0 127.0 125.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.00 stddev:2.76 (1.7%) stddev-sans-first:2.40 23:13:49 INFO - PROCESS | 12528 | Values: 165.0 162.0 161.0 161.0 158.0 155.0 161.0 159.0 160.0 163.0 23:13:49 INFO - PROCESS | 12528 | 23:13:49 INFO - PROCESS | 12528 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.17 23:13:49 INFO - PROCESS | 12528 | Values: 68.0 66.0 67.0 69.0 66.0 66.0 67.0 67.0 69.0 67.0 23:13:49 INFO - PROCESS | 12528 | -------- Summary: end -------- 23:13:49 INFO - PROCESS | 12528 | 23:13:50 INFO - TEST-INFO | 12528: exit 0 23:13:50 INFO - TEST-OK | kraken | took 60488ms 23:13:50 INFO - SUITE-END | took 1169s 23:13:50 INFO - Completed test suite (00:19:29) 23:13:50 INFO - javascript benchmark 23:13:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3268.5424040634307, 3353.698167164958, 3368.141124013376, 3422.435298175801, 3423.4009048416538, 5496.422875598065, 5524.4199359067325, 5527.4472552744755, 5535.806246781363, 5537.418571050037, 5484.561235101192, 5537.529310008644, 5545.085060964946, 5553.666779993203, 5553.805616803413, 5053.292539044518, 5053.671511351759, 5088.135017047092, 5100.591952643779, 5171.50870667286, 5006.874828129307, 5067.163917953551, 5130.02529519392, 5173.327467429229, 5192.143296356116, 5000.274960130797, 5051.166557518023, 5080.79676812927, 5106.7701953412, 5107.565856902168, 5039.067772462106, 5079.161938280179, 5086.593072554187, 5087.414947281054, 5136.563392111675, 4846.806127754886, 5011.599072074226, 5011.749412529395, 5044.192929131358, 5074.264231686422, 5320.068987927098, 5347.59893008022, 5386.784528618889, 5394.838154855361, 5429.647072940285, 5798.7390567424145, 5844.736986835603, 5846.269216347957, 5855.882882342329, 5865.032269675498, 5740.138979153118, 5795.681237531934, 5898.734556944948, 5914.378990206053, 5914.733836977346, 5479.671219726789, 5486.807961721321, 5489.972550137224, 5492.368377636543, 5527.778888844482, 5928.140419639129, 5939.465448109604, 5944.92991261577, 5950.791722289786, 5955.851103722442, 5642.435756424325, 5724.141378793214, 5755.395683453261, 5774.047282198474, 5838.38696936824, 5843.620164689281, 5850.3564607893095, 5850.707464626752, 5857.297124345106, 5886.411358864079, 5747.850429914034, 5771.047777116729, 5791.305043394819, 5818.272715910512, 5832.650040997553, 5755.971220143872, 5758.280214973129, 5859.882802343929, 5926.140709597171, 5943.851403714942, 4484.641228701696, 4487.371767952489, 4491.483479399845, 4494.505604383515, 4510.887227819265, 4030.0730831908827, 4043.251998380309, 4052.63526282636, 4079.1841631673783, 4083.3466645336603, 5553.0, 5586.273784408001, 5589.413111623302, 5710.0, 5720.942790572124, 5746.080627099644, 5866.1494083357675, 5883.382244864228, 5890.734916928748, 5913.2608423947, 5581.748821303051, 5595.0208713475795, 5610.691411972381, 5613.522850557748, 5661.971690141523, 4971.5028497150715, 4994.600431965507, 5060.51925067118, 5067.898642027212, 5087.033463641897, 6052.636841789418, 6060.090986352083, 6080.543959203077, 6083.361247069082, 6087.817365479043, 5783.161441590862, 5845.210896528914, 5855.2095467113095, 5871.0, 5873.442023007808, 6061.212042434456, 6116.663583502772, 6121.3809739783, 6128.750654727687, 6150.35421280777, 5780.190773291826, 5796.275465566804, 5799.188113664006, 5800.593958423039, 5804.332501762183, 5831.35855055952, 5857.9121313179485, 5867.6772777497645, 5886.264216972879, 5891.793787217598, 5658.207850900795, 5685.34618518859, 5721.628094173865, 5725.0, 5731.598788084794, 5611.6352437091455, 5678.290213723285, 5685.34618518859, 5691.7438715257085, 5708.0, 5586.441355864381, 5626.2967129108865, 5631.493165615114, 5644.322681278273, 5713.514351280188, 5710.2576665033275, 5747.166660834239, 5771.192033115283, 5779.2775903012125, 5791.420857914343, 5636.070048441961, 5647.378788333198, 5664.0, 5668.7165641718575, 5683.175939488834], "value": 5429.725908336506, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.4065754574199, 657.3919124809556, 658.2528829778201, 662.7315937045498, 671.0739179931692, 39534.40698389523, 40207.195856082864, 40366.79816600913, 40530.392044119326, 40591.59408405919, 41865.0, 42172.578274217245, 42396.0, 42434.78782606091, 42594.361084583754, 8772.078931712174, 9023.503707296097, 9027.0, 9030.819383612325, 9056.501892395949, 8797.73606791794, 8840.690575829847, 8883.95558022209, 8887.466751994869, 8889.155530224618, 9158.587863546156, 9219.907800922005, 9231.123043310874, 9266.073392660748, 9271.397359171666, 9075.591598378089, 9095.545222738836, 9104.999999999967, 9116.726498205064, 9187.908120918772, 9090.63637454501, 9169.908300916972, 9183.173514383738, 9203.769905752342, 9205.539723013822, 43843.56156438459, 44236.77881610604, 44275.33586996198, 44353.334699979525, 44426.0, 3923.3330333843314, 4006.258842114189, 4469.396631454744, 4545.772711364451, 4666.160091183586, 33317.66682333194, 33571.32857342839, 33863.0, 33951.32097358039, 34916.12709682253, 4524.11779702958, 4524.6380289576755, 4560.087982403499, 4561.863144105649, 4579.977100114512, 314732.0, 314816.0, 315058.0, 315059.0, 316792.0, 39142.80428597839, 39841.40237896434, 60559.0, 60611.0, 60941.0, 36641.633583664356, 37219.06952326159, 37317.253654926746, 37319.62680373162, 37404.81297593495, 16182.19089045543, 16230.756538651929, 16315.184240787914, 16364.099974501516, 16382.918085409498, 13787.86212137886, 13840.30798460073, 13864.376103075387, 13868.583942481742, 13924.37340319688, 9357.157855792875, 9403.43579385239, 9428.669996550088, 9432.151106400457, 9456.148946594702, 3538.876139335111, 3610.115521697201, 3631.2555926035097, 3649.5620525536574, 3722.40441529354, 1135.4606561883204, 1160.3675996581883, 1208.528673817212, 1252.8872401483727, 1271.377025257617, 32786.67213327836, 32999.0, 33183.0, 33400.498992514644, 33634.0, 1224.2165014390796, 1266.7339858629607, 1290.1742884553894, 1308.2281453942219, 1310.5871650430274, 16693.0, 17094.316227351017, 17184.0, 17397.391091311998, 17488.737668934977, 448323.0, 455298.0, 570833.0, 572385.0, 577454.0, 62764.37235627585, 63663.0, 63830.36169638337, 63907.36092639014, 64393.67803160954, 1506.7815166800754, 1516.3934426229375, 1537.7308970930042, 1542.0, 1632.2573229180693, 33046.33907321792, 33970.8301458501, 34090.82954585211, 34118.31763364768, 34367.14082147966, 53806.46193538171, 54487.0, 54549.727251365075, 54616.0, 54699.45300546943, 433114.0, 434576.0, 436461.0, 436590.0, 438987.0, 30921.381572368875, 31458.0, 31682.207944801565, 31813.8409307952, 31852.04443866688, 49446.50553494419, 49450.25824612706, 49979.50020499894, 51148.488515114375, 51288.74355628198, 41897.58102418937, 42876.78561607172, 43083.78458107689, 43793.12413751643, 44166.77916610397, 42021.78989105157, 42362.36456453094, 42459.363109554, 43471.0, 43916.560834391246, 43511.347329789445, 45278.54721452743, 45387.54612453965, 45512.54487455083, 46376.768116159205, 32883.67116328806, 33491.66508334885, 33727.3254534903, 36224.27551449009, 36367.818160909024, 28995.85502072476, 29389.412211756073, 29540.113796586138, 29777.404451910406, 29796.0], "value": 19790.021129006367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.4067612975381, 425.52978958251134, 433.67257720421077, 434.2595874034771, 435.7690424075239, 18916.527086822836, 19638.803611963893, 19647.214111435544, 20796.376108716762, 21836.126554937822, 13555.796663050061, 13614.659633509142, 13643.113197642171, 18360.26558937641, 20040.59918801623, 5460.34475862897, 5513.393526712059, 5642.943570564283, 5643.379228284885, 5650.802221922234, 5967.970160149193, 5982.3120341160675, 6071.3625069367745, 6073.058675905219, 6083.574149809515, 5783.508401785833, 5999.640021598696, 6008.279006519224, 6021.698915054251, 6033.758649654009, 5935.317438494585, 6027.306859711145, 6036.094585812141, 6047.244094488189, 6047.909281360761, 5465.863353416196, 5482.0406428874785, 5491.560675145979, 5495.890082198333, 5505.642133261325, 14755.55733328002, 14979.625509362244, 14983.475578354706, 14991.0, 19202.903985479985, 2430.538197742423, 2438.7805097541304, 2440.5118976204653, 2565.4612531368434, 2631.302704783234, 10830.891691083067, 11104.44477776108, 12850.971922246197, 13923.651908702364, 14680.632984175374, 2014.4863059919626, 2038.4801875521796, 2068.9482762930897, 2072.0986370928545, 2188.5732282204976, 63537.0, 76121.61939190324, 76494.61752691257, 84134.15865841325, 85458.57270713669, 11225.326480411202, 11974.401279935968, 12225.69435764113, 12247.877521224851, 12283.69290767738, 16836.0, 16990.150492475328, 16994.235259413355, 17020.659586808193, 17085.743713844302, 8788.736337909873, 9084.545772711337, 9120.087991200828, 9123.81752364949, 9157.175854173023, 8839.823203535892, 8903.910960890438, 8961.462312261285, 8963.955180224188, 8990.370674052754, 5006.621854619027, 5221.947780522146, 5238.580913526908, 5249.107651699221, 5252.0, 2076.9376918692465, 2101.726775519173, 2160.7528170702294, 2187.73747150343, 2205.5856905903925, 952.4808979106404, 1050.1808589300358, 1119.227732864321, 1175.9470823812949, 1179.6343133628602, 17130.48608541746, 19274.71087933682, 19752.30866919651, 19788.20847166097, 20203.191872324944, 1074.5970261152067, 1109.4840898981852, 1129.6836885672026, 1138.6640940922448, 1154.809456439695, 10961.287516311415, 11126.554937802397, 11243.66269011931, 11249.887501125047, 11270.549178032787, 481379.0, 484689.0, 491421.0, 496579.0, 500823.0, 75147.0, 97763.51118244363, 99253.0, 99429.0, 99643.0, 1103.8896110388896, 1146.1690274550883, 1167.8365028895962, 1204.5362535423924, 1205.9879401205876, 16514.917425412797, 18125.096864829004, 18260.726089108408, 18557.628847422708, 18971.24115035383, 40892.59107408888, 41807.37288940608, 42932.570674294104, 43840.342394863466, 44048.0, 55501.722491387285, 55879.0, 59922.10116848338, 61672.38327616666, 62557.374426255155, 8688.52213128284, 8874.733757987271, 8941.46351218929, 9042.0, 9349.75777441858, 9742.269329800152, 13038.804417933929, 13542.187468751907, 13764.380602873094, 14187.361568729639, 11396.94301528487, 11435.59975400857, 11737.471813768572, 11753.529858805552, 12402.875971240172, 11296.983271505604, 11586.304821710724, 11815.350155741517, 11860.347680877634, 12296.938515307724, 11225.775484490428, 11478.483468244116, 11522.078233741448, 11613.0, 12493.25040497573, 8895.777605559913, 9101.089891010846, 9106.544672766468, 9132.40639358466, 9223.16991470744, 11666.883331166919, 11904.0, 12152.635420937386, 12160.270383777002, 12174.45214965311], "value": 9531.687035974333, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1551.1701239836686, 1566.749320108782, 1766.9823301766978, 1848.5101448116243, 1863.748393966814, 7506.96246518768, 8107.837843243132, 8370.497770133796, 8536.359773017026, 8555.486670799748, 8261.710840120597, 8357.414980951336, 8442.324614030878, 8465.576721163949, 8468.491890486559, 2348.38941875112, 2367.9052837886466, 2374.4657452073234, 2376.964345534818, 2381.5117900830287, 2259.2883241778786, 2261.4685548895995, 2319.373769082355, 2320.524292520029, 2332.253678822769, 2376.5484557933937, 2379.4884099918513, 2409.939751506218, 2427.5509030829353, 2433.0511100670665, 2339.1111377676375, 2349.142562964514, 2358.0685629176464, 2363.1847012780477, 2371.5494056129282, 2334.8832558372014, 2353.388119089032, 2358.41039740065, 2359.64605309205, 2360.256519196465, 8548.358873084544, 8597.785055373666, 8617.396782225247, 8618.439801412951, 8640.740777776677, 5168.5865130789825, 5238.633295669305, 5245.082110630662, 5279.841604751864, 5300.602454815904, 3381.7801842880135, 3395.8811441599423, 3431.125063108916, 3438.157651375404, 3515.0, 1072.1958531101673, 1089.934603923767, 1096.819024860897, 1106.0487980336984, 1107.9944600276947, 11950.103742219282, 12042.578509752204, 12068.758624827455, 12079.396030198543, 12101.152919295653, 4451.977740111279, 4480.865574032719, 4528.388667529907, 4571.954280457219, 4621.075784843045, 10304.948475257726, 10316.690499285034, 10319.535620897077, 10321.690349289533, 10336.689899303034, 5224.686518808883, 5225.843224703265, 5258.579313654898, 5282.022825777243, 5290.338707661543, 4600.97699511507, 4779.545943135397, 4785.258284965836, 4808.35087263215, 4829.0, 3768.5477742671055, 3828.444875493038, 3829.0810205550465, 3871.1483473635753, 3902.2195560887935, 1134.1777211521746, 1135.0635725526474, 1138.7608602193466, 1145.6734830573246, 1186.7211205366732, 1017.7811770469384, 1032.5147180825, 1038.200585549123, 1046.5238316565944, 1047.0524175621076, 5888.411158884163, 5914.8817023659285, 5940.79207227745, 6051.606645568024, 6064.0, 478.4808482796205, 486.0716032378141, 486.5961252160698, 508.03219866155035, 510.2295533744073, 4132.8140233689555, 4133.545310015896, 4150.958490415057, 4151.4395556599475, 4176.352665336878, 10211.029952154533, 10559.736006599744, 10621.150307975344, 10634.787304253872, 10661.093807026335, 10344.637937672145, 10427.739306517245, 10451.425171615634, 10459.320144190755, 10474.47627618616, 7960.681572737026, 8026.799330016679, 8202.302804261586, 8215.09633940266, 8220.671173153127, 5984.0, 5994.940050599613, 5998.550108741774, 6093.48205402528, 6108.992016317258, 9155.13026262504, 9391.248700104112, 9396.154346108882, 9410.764730881783, 9467.053294670754, 9013.63945442175, 9016.0, 9045.77385565366, 9194.862077068716, 9221.815563688822, 7483.550986940801, 7557.35762460197, 7602.391808655405, 7820.804479888048, 7827.0, 8221.0, 8303.875441868257, 8362.247397734232, 8365.038020627706, 8393.202645748644, 7399.963000184965, 7624.27569380908, 7649.61751912391, 7705.922940770521, 7777.144514103331, 7479.551226926402, 7508.812279693051, 7564.8487030260185, 7569.848603028019, 7640.503367281109, 6887.173539175331, 6901.723931042702, 6935.6878940446795, 6936.826579335557, 6943.618101004493, 5014.423341315795, 5088.185890257541, 5130.743462826918, 5178.197379406198, 5211.765470553758, 5172.793088276427, 5214.765335559833, 5298.655587386807, 5301.549368303583, 5321.7339133042415], "value": 4513.253417768585, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.93092450585374, 372.8247723569922, 374.59543692811764, 374.9512563366762, 376.0335936642827, 6430.742770289183, 6446.355364463551, 6466.870662586745, 6567.146270984771, 6570.934290657092, 6549.050387693782, 6594.769183078593, 6605.636689982061, 6606.2072551293795, 6616.768413105542, 4917.737840593331, 4938.38270216223, 4958.975205123969, 4961.4790447003, 4977.975110124445, 4985.850424487271, 4991.900161996776, 4996.675216110959, 4998.925016124761, 5001.99960007998, 4950.801967921278, 4953.653244272902, 4961.503849615027, 4963.7021778693215, 4966.726830024347, 4706.599939005188, 4847.3698419205275, 4955.05853887762, 4961.082199793032, 4964.180910149839, 4204.579542045802, 4219.873403797891, 4221.050263690676, 4225.0, 4243.342281946303, 6131.47882429994, 6139.78510752126, 6141.416565426277, 6146.231721034871, 6146.416090471398, 5595.552355811526, 5662.037453632893, 5736.139579063132, 5755.625884317506, 5756.597038207327, 6849.41779948705, 6865.622390768505, 6868.244493105754, 6870.725170993154, 6878.621675807829, 4756.191447453941, 4758.762061896891, 4762.976185119087, 4765.737884416356, 4776.832810851638, 7038.401735852459, 7152.606606636581, 7175.354218120394, 7179.964100179465, 7192.2807719228185, 4787.042591481718, 4795.448523419782, 4795.712257264575, 4804.303376010459, 4809.711417314972, 4807.158747219292, 4933.963867587775, 4935.580475659609, 4948.777305021283, 4953.281774142729, 5665.716714164275, 5680.204771332017, 5712.057510510802, 5724.284464441945, 5725.541956643458, 6901.240863505011, 6902.482313826383, 6905.309469053054, 6910.170779506491, 6922.307769223037, 1688.2234172280644, 1689.7549855270918, 1691.2981112838281, 1695.118538360046, 1704.207543492282, 1109.5617231193633, 1128.15388458656, 1142.6743378137357, 1150.7295785490403, 1170.268582136165, 6620.768273110418, 6632.872411690024, 6665.466762658975, 6672.165979252593, 6677.732890684415, 7032.226455089936, 7038.788836334918, 7059.89410158848, 7084.716611335592, 7094.822629434306, 6614.933850661528, 6622.8013159604325, 6623.30455302196, 6627.734890604418, 6639.136912201383, 3807.276617442677, 3835.0795809006195, 3838.481804956351, 3838.7120965927666, 3841.0781412461365, 7274.709011639581, 7433.665485053186, 7446.069241344832, 7484.625768711543, 7547.396208303323, 7322.96338518304, 7344.265573442613, 7351.558906465629, 7374.299441553044, 7383.963080184565, 7525.285097915689, 7526.134494533089, 7528.247175282428, 7531.397488200931, 7532.472726909174, 7014.508984371249, 7178.246284140299, 7180.210176880434, 7184.6048467334795, 7185.676644550903, 7044.647767611496, 7097.822554435974, 7101.644917754195, 7128.928710712827, 7134.500584959211, 7488.737894173678, 7499.137599175946, 7508.511946723445, 7537.585432801248, 7543.47195696318, 4768.9523104768505, 4780.49804770508, 4800.303955926302, 4803.711777293373, 4810.831620893252, 7004.334588214111, 7127.501074924706, 7130.0, 7153.177384600629, 7202.819929501804, 6963.338482844122, 6969.233384327821, 6972.337627925339, 6978.162620485574, 6985.755498557526, 6914.0320355149315, 6941.791746247621, 6952.478564107611, 6958.095447591781, 6963.338482844122, 6845.965770171118, 6856.485763567653, 6857.074294970115, 6864.48516361265, 6867.2102708189195, 6807.285235050248, 7000.649967501503, 7003.089598352181, 7038.190608080136, 7038.225795162631, 6696.59820410777, 6842.213145488333, 6861.519693621399, 6866.931330686629, 6877.6217308048535], "value": 5198.591948216455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.79281765194, 902.9232515236205, 908.532105965428, 911.2254583603942, 917.9403338782979, 15228.1624510652, 15580.766288505667, 15588.766168507482, 17073.82926170738, 17487.562810929703, 15917.44288949887, 16043.679126417494, 16050.59873503163, 16051.357945682159, 16067.758983615255, 865.6191275838627, 877.1097336203758, 887.2768693514797, 888.5868071346855, 907.0068275238604, 891.0777345447464, 891.8617614269766, 893.8882639670041, 894.4275663575316, 894.4901406198469, 937.030173770148, 938.2775263047449, 944.914957653811, 945.0502245243555, 949.4066208619613, 927.4342650982895, 938.8310104181245, 939.2439086535336, 940.1961323068814, 942.5899733615864, 688.0814113158939, 688.3048121397375, 689.8654762321349, 689.9896501552481, 692.3664846665296, 15900.920495397564, 15980.280887360097, 16030.679386412206, 16070.839291607168, 16086.276117574736, 14482.927585362111, 14589.562313130624, 14646.780298295535, 14800.629984250372, 14859.777103343351, 11849.644510664693, 12003.099767517471, 12068.215565988183, 12106.334151621657, 12365.07261955357, 4066.8373265069363, 4167.52073511547, 4228.281192197333, 4256.361545768129, 4258.08451182994, 56460.153097703565, 57964.42035579633, 58142.12786808201, 58155.0, 58213.0, 11618.983239557005, 11999.400029998465, 12067.456964436622, 12313.876861231272, 12457.688557786129, 20487.69268460974, 20523.794762052486, 20561.0, 20564.0, 20683.0, 8905.599248033854, 8993.14565116313, 9221.308401869886, 9237.769055773659, 9290.256779457628, 5033.949660503348, 5114.156164232934, 5163.896722065538, 5167.715775632301, 5184.533391994739, 3644.890653280406, 3718.981405092957, 3733.9253214935547, 3736.6637002669345, 3744.475773391727, 625.5927628219172, 685.3215316836296, 691.7129391302553, 693.2928413018693, 707.3209718670134, 737.6717360774404, 746.9738559150404, 757.9886301705479, 770.310572038034, 771.2788542712582, 9612.279079069098, 9989.60041598328, 10095.293329467013, 10157.542910569042, 10228.698542827804, 642.9646369449632, 661.4609093588709, 756.5347311403448, 806.5965220516259, 822.6133717152928, 4719.646026548023, 4829.589484893823, 4861.913523002864, 4878.609711223165, 4886.53577910098, 60002.69998650066, 61299.69350153221, 61349.38650613526, 61773.69113154405, 61780.0, 55545.72227138838, 56458.43541564614, 56520.0, 56844.71577642085, 57105.714471427375, 52704.47295527072, 53001.46998530043, 53071.73464132655, 53216.46783532193, 53784.19323710069, 9497.715068547956, 9648.469334186688, 9708.271879608916, 9720.708378748648, 9729.70810875675, 36158.63841361658, 36529.45205821968, 36858.8157059213, 37737.245255095295, 38123.618763813116, 43057.56942430661, 45166.77416612896, 47815.76092119517, 48309.0, 49057.50942490672, 12054.819177712518, 12098.697532561404, 12146.635600931986, 12168.513259469877, 12538.561150359694, 12608.180468269533, 12747.808782868078, 12976.35118244065, 13259.867401325862, 13351.132176408502, 11881.465334060162, 12007.459664315302, 12015.579454719043, 12164.2701437914, 12223.57217497419, 12565.308908009782, 12689.4289756963, 12698.111132221025, 12707.428165732748, 12935.353232338533, 12261.417605065564, 12748.936255318664, 13507.638307207577, 13532.255725935169, 13899.583012509642, 11686.298822070703, 11713.1800773945, 11775.352355620524, 11891.464884080064, 12413.689657758629, 11688.064954803425, 11804.0, 11852.229605075643, 12180.451879665614, 12259.938700306442], "value": 7237.587150012472, "unit": "score"}], "name": "dromaeo_css", "value": 7471.370626286613, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 105.0, 111.0, 112.0, 111.0, 102.0, 110.0, 111.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 135.0, 152.0, 180.0, 127.0, 149.0, 147.0, 129.0, 183.0, 127.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 161.0, 163.0, 161.0, 162.0, 163.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 77.0, 172.0, 74.0, 76.0, 76.0, 82.0, 179.0, 76.0], "value": 96.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 145.0, 92.0, 93.0, 92.0, 149.0, 92.0, 92.0, 149.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 94.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 56.0, 57.0, 55.0, 59.0, 55.0, 70.0, 53.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 58.0, 59.0, 58.0, 60.0, 58.0, 59.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 73.0, 73.0, 74.0, 73.0, 74.0, 73.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 116.0, 118.0, 112.0, 112.0, 114.0, 112.0, 112.0, 127.0, 125.0], "value": 117.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 161.0, 161.0, 158.0, 155.0, 161.0, 159.0, 160.0, 163.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 69.0, 66.0, 66.0, 67.0, 67.0, 69.0, 67.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1518.8999999999999, "alertThreshold": 2.0}]} 23:13:50 INFO - Return code: 0 23:13:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:13:50 ERROR - # TBPL SUCCESS # 23:13:50 INFO - Running post-action listener: _resource_record_post_action 23:13:50 INFO - Running post-run listener: _resource_record_post_run 23:13:51 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 463409152; Read time: 12; Write time: 390496 23:13:51 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242507776; Read time: 0; Write time: 275796 23:13:51 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220901376; Read time: 12; Write time: 114700 23:13:51 INFO - Running post-run listener: _upload_blobber_files 23:13:51 INFO - Blob upload gear active. 23:13:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:13:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:13:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:13:52 INFO - (blobuploader) - INFO - Open directory for files ... 23:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:13:52 INFO - (blobuploader) - INFO - Done attempting. 23:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:13:53 INFO - (blobuploader) - INFO - Done attempting. 23:13:53 INFO - (blobuploader) - INFO - Iteration through files over. 23:13:53 INFO - Return code: 0 23:13:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:13:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:13:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3c6e30211e6b855ace01627904ad81c0e16acdf262b4eb1e11bd5a5ada059a13482da7908cb1f045db0b946bd545d3f10087bd82ba19b3857cdfa68d5259fba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b35a4ccd3d1bd203797e81b35559b57809e9239ec7ee4821062b89e5766331aeaff23d938ecc6702b9f0d59147dd60561285a0bf89641f2d39f355bedc2beca5"} 23:13:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:13:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:13:53 INFO - Contents: 23:13:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3c6e30211e6b855ace01627904ad81c0e16acdf262b4eb1e11bd5a5ada059a13482da7908cb1f045db0b946bd545d3f10087bd82ba19b3857cdfa68d5259fba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b35a4ccd3d1bd203797e81b35559b57809e9239ec7ee4821062b89e5766331aeaff23d938ecc6702b9f0d59147dd60561285a0bf89641f2d39f355bedc2beca5"} 23:13:53 INFO - Running post-run listener: copy_logs_to_upload_dir 23:13:53 INFO - Copying logs to upload dir... 23:13:53 INFO - mkdir: /builds/slave/test/build/upload/logs 23:13:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.816947 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-23 23:13:53.861775) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 23:13:53.865186) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271 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/c3c6e30211e6b855ace01627904ad81c0e16acdf262b4eb1e11bd5a5ada059a13482da7908cb1f045db0b946bd545d3f10087bd82ba19b3857cdfa68d5259fba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b35a4ccd3d1bd203797e81b35559b57809e9239ec7ee4821062b89e5766331aeaff23d938ecc6702b9f0d59147dd60561285a0bf89641f2d39f355bedc2beca5"} build_url:https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3c6e30211e6b855ace01627904ad81c0e16acdf262b4eb1e11bd5a5ada059a13482da7908cb1f045db0b946bd545d3f10087bd82ba19b3857cdfa68d5259fba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b35a4ccd3d1bd203797e81b35559b57809e9239ec7ee4821062b89e5766331aeaff23d938ecc6702b9f0d59147dd60561285a0bf89641f2d39f355bedc2beca5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 23:13:53.902060) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 23:13:53.902466) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466747269.869635-985387271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 23:13:53.974661) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 23:13:53.975054) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 23:13:53.975546) ========= ========= Total master_lag: 0.18 =========