builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1463507537.79 results: success (0) buildid: 20160517004009 builduid: ef91a013044b49f4abd91345e579e6b6 revision: 17724486e1591858eea09dc327475a25883854a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.786153) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.786830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.787196) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.825702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.825970) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 10:52:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.3M=0s 2016-05-17 10:52:17 (89.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081139 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.925352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.926057) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017647 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.977910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.978332) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 17724486e1591858eea09dc327475a25883854a4 --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-aurora --rev 17724486e1591858eea09dc327475a25883854a4 --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=9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 10:52:18,125 truncating revision to first 12 chars 2016-05-17 10:52:18,126 Setting DEBUG logging. 2016-05-17 10:52:18,126 attempt 1/10 2016-05-17 10:52:18,126 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/17724486e159?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 10:52:18,379 unpacking tar archive at: mozilla-aurora-17724486e159/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524200 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:18.516368) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:18.516696) ========= script_repo_revision: 17724486e1591858eea09dc327475a25883854a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:18.517108) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:18.517430) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:18.531048) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-17 10:52:18.531336) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:52:18 INFO - MultiFileLogger online at 20160517 10:52:18 in /builds/slave/test 10:52:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:52:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:52:18 INFO - {'append_to_log': False, 10:52:18 INFO - 'base_work_dir': '/builds/slave/test', 10:52:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:52:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:52:18 INFO - 'branch': 'Mozilla-Aurora', 10:52:18 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:18 INFO - 'config_files': ('talos/linux_config.py',), 10:52:18 INFO - 'default_actions': ('clobber', 10:52:18 INFO - 'read-buildbot-config', 10:52:18 INFO - 'download-and-extract', 10:52:18 INFO - 'populate-webroot', 10:52:18 INFO - 'create-virtualenv', 10:52:18 INFO - 'install', 10:52:18 INFO - 'run-tests'), 10:52:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:18 INFO - 'download_minidump_stackwalk': True, 10:52:18 INFO - 'download_symbols': 'ondemand', 10:52:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:18 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:18 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:18 INFO - 'installer_path': 'installer.exe', 10:52:18 INFO - 'log_level': 'info', 10:52:18 INFO - 'log_name': 'talos', 10:52:18 INFO - 'log_to_console': True, 10:52:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:52:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:52:18 INFO - 'opt_config_files': (), 10:52:18 INFO - 'pip_index': False, 10:52:18 INFO - 'sps_profile': False, 10:52:18 INFO - 'sps_profile_interval': 0, 10:52:18 INFO - 'suite': 'dromaeojs-e10s', 10:52:18 INFO - 'system_bits': '32', 10:52:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:18 INFO - 'title': 'talos-linux64-ix-022', 10:52:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:18 INFO - 'use_talos_json': True, 10:52:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:52:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:18 INFO - 'work_dir': 'build'} 10:52:18 INFO - ##### 10:52:18 INFO - ##### Running clobber step. 10:52:18 INFO - ##### 10:52:18 INFO - Running pre-action listener: _resource_record_pre_action 10:52:18 INFO - Running main action method: clobber 10:52:18 INFO - rmtree: /builds/slave/test/build 10:52:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:19 INFO - Running post-action listener: _resource_record_post_action 10:52:19 INFO - ##### 10:52:19 INFO - ##### Running read-buildbot-config step. 10:52:19 INFO - ##### 10:52:19 INFO - Running pre-action listener: _resource_record_pre_action 10:52:19 INFO - Running main action method: read_buildbot_config 10:52:19 INFO - Using buildbot properties: 10:52:19 INFO - { 10:52:19 INFO - "project": "", 10:52:19 INFO - "product": "firefox", 10:52:19 INFO - "script_repo_revision": "production", 10:52:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:52:19 INFO - "repository": "", 10:52:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:52:19 INFO - "buildid": "20160517004009", 10:52:19 INFO - "stage_platform": "linux64-pgo", 10:52:19 INFO - "basedir": "/builds/slave/test", 10:52:19 INFO - "nightly_build": "True", 10:52:19 INFO - "buildnumber": 272, 10:52:19 INFO - "slavename": "talos-linux64-ix-022", 10:52:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:52:19 INFO - "platform": "ubuntu64_hw", 10:52:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:52:19 INFO - "branch": "mozilla-aurora", 10:52:19 INFO - "repo_path": "releases/mozilla-aurora", 10:52:19 INFO - "revision": "17724486e1591858eea09dc327475a25883854a4", 10:52:19 INFO - "pgo_build": "True", 10:52:19 INFO - "builduid": "ef91a013044b49f4abd91345e579e6b6", 10:52:19 INFO - "slavebuilddir": "test" 10:52:19 INFO - } 10:52:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 10:52:19 INFO - Running post-action listener: _resource_record_post_action 10:52:19 INFO - ##### 10:52:19 INFO - ##### Running download-and-extract step. 10:52:19 INFO - ##### 10:52:19 INFO - Running pre-action listener: _resource_record_pre_action 10:52:19 INFO - Running main action method: download_and_extract 10:52:19 INFO - mkdir: /builds/slave/test/build/tests 10:52: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')]} 10:52:19 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:52:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:52:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:52:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:52:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:52:22 INFO - Downloaded 1361 bytes. 10:52:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:52:22 INFO - Using the following test package requirements: 10:52:22 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:52:22 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:52:22 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:52:22 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:22 INFO - u'jsshell-linux-x86_64.zip'], 10:52:22 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:52:22 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:52:22 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:52:22 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:52:22 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:52:22 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:52:22 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:52:22 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')]} 10:52:22 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:52:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:52:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:52:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:52:23 INFO - Downloaded 23813806 bytes. 10:52:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:52:24 INFO - Return code: 0 10:52:24 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:52:24 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')]} 10:52:24 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:52:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:52:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:52:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:52:26 INFO - Downloaded 23813806 bytes. 10:52:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:52:27 INFO - Return code: 0 10:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:27 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:52:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:52:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:52:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:52:28 INFO - Downloaded 10840145 bytes. 10:52:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:52:28 INFO - Return code: 0 10:52: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')]} 10:52:28 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:52:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:52:31 INFO - Downloaded 62686410 bytes. 10:52:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:31 INFO - mkdir: /builds/slave/test/properties 10:52:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:52:31 INFO - Writing to file /builds/slave/test/properties/build_url 10:52:31 INFO - Contents: 10:52:31 INFO - build_url:https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:32 INFO - Running post-action listener: _resource_record_post_action 10:52:32 INFO - Running post-action listener: set_extra_try_arguments 10:52:32 INFO - ##### 10:52:32 INFO - ##### Running populate-webroot step. 10:52:32 INFO - ##### 10:52:32 INFO - Running pre-action listener: _resource_record_pre_action 10:52:32 INFO - Running main action method: populate_webroot 10:52:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:52:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:52:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:52:32 INFO - '--tppagecycles', 10:52:32 INFO - '7'], 10:52:32 INFO - 'tests': ['tsvgm']}}, 10:52:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:52:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:52:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:52:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:52:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:52:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:52:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'talos_options': ['--disable-e10s'], 10:52:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'talos_options': ['--disable-e10s'], 10:52:32 INFO - 'tests': ['damp', 'tps']}, 10:52:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'tests': ['damp', 'tps']}, 10:52:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:52:32 INFO - 'tests': ['dromaeo_dom']}, 10:52:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:52:32 INFO - 'tests': ['a11yr', 10:52:32 INFO - 'ts_paint', 10:52:32 INFO - 'tpaint', 10:52:32 INFO - 'sessionrestore', 10:52:32 INFO - 'sessionrestore_no_auto_restore', 10:52:32 INFO - 'tabpaint']}, 10:52:32 INFO - 'other-e10s': {'tests': ['a11yr', 10:52:32 INFO - 'ts_paint', 10:52:32 INFO - 'tpaint', 10:52:32 INFO - 'sessionrestore', 10:52:32 INFO - 'sessionrestore_no_auto_restore', 10:52:32 INFO - 'tabpaint']}, 10:52:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:52:32 INFO - 'ts_paint', 10:52:32 INFO - 'tpaint', 10:52:32 INFO - 'sessionrestore', 10:52:32 INFO - 'sessionrestore_no_auto_restore', 10:52:32 INFO - 'tabpaint']}, 10:52:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:52:32 INFO - 'ts_paint', 10:52:32 INFO - 'tpaint', 10:52:32 INFO - 'sessionrestore', 10:52:32 INFO - 'sessionrestore_no_auto_restore', 10:52:32 INFO - 'tabpaint']}, 10:52:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:52:32 INFO - 'tests': ['a11yr', 10:52:32 INFO - 'ts_paint', 10:52:32 INFO - 'tpaint', 10:52:32 INFO - 'sessionrestore', 10:52:32 INFO - 'sessionrestore_no_auto_restore', 10:52:32 INFO - 'tabpaint']}, 10:52:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:52:32 INFO - 'tests': ['a11yr', 10:52:32 INFO - 'ts_paint', 10:52:32 INFO - 'tpaint', 10:52:32 INFO - 'sessionrestore', 10:52:32 INFO - 'sessionrestore_no_auto_restore', 10:52:32 INFO - 'tabpaint']}, 10:52:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:52:32 INFO - 'tests': ['tsvgx', 10:52:32 INFO - 'tsvgr_opacity', 10:52:32 INFO - 'tart', 10:52:32 INFO - 'tscrollx', 10:52:32 INFO - 'cart']}, 10:52:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:52:32 INFO - 'tsvgr_opacity', 10:52:32 INFO - 'tart', 10:52:32 INFO - 'tscrollx', 10:52:32 INFO - 'cart']}, 10:52:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'talos_options': ['--disable-e10s'], 10:52:32 INFO - 'tests': ['tp5o']}, 10:52:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'tests': ['tp5o']}, 10:52:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'talos_options': ['--disable-e10s', 10:52:32 INFO - '--xperf_path', 10:52:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:32 INFO - 'tests': ['tp5n']}, 10:52:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'talos_options': ['--xperf_path', 10:52:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:32 INFO - 'tests': ['tp5n']}}, 10:52:32 INFO - 'talos.zip': {'path': '', 10:52:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:52:32 INFO - Running post-action listener: _resource_record_post_action 10:52:32 INFO - ##### 10:52:32 INFO - ##### Running create-virtualenv step. 10:52:32 INFO - ##### 10:52:32 INFO - Running pre-action listener: _resource_record_pre_action 10:52:32 INFO - Running main action method: create_virtualenv 10:52:32 INFO - Creating virtualenv /builds/slave/test/build/venv 10:52:32 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 10:52:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:52:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:32 INFO - Using real prefix '/usr' 10:52:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:52:33 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:35 INFO - Installing pip.................done. 10:52:35 INFO - Return code: 0 10:52:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:35 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 0x7f385b81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1224410>, '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 0x1225310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12257a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', '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 10:52:35 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 10:52:35 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 10:52:35 INFO - Using env: {'DISPLAY': ':0', 10:52:35 INFO - 'HOME': '/home/cltbld', 10:52:35 INFO - 'LANG': 'en_US.UTF-8', 10:52:35 INFO - 'LANGUAGE': 'en_US:en', 10:52:35 INFO - 'LOGNAME': 'cltbld', 10:52:35 INFO - 'MAIL': '/var/mail/cltbld', 10:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:35 INFO - 'MOZ_NO_REMOTE': '1', 10:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:35 INFO - 'NO_EM_RESTART': '1', 10:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:35 INFO - 'PWD': '/builds/slave/test', 10:52:35 INFO - 'SHELL': '/bin/bash', 10:52:35 INFO - 'SHLVL': '1', 10:52:35 INFO - 'TERM': 'linux', 10:52:35 INFO - 'TMOUT': '86400', 10:52:35 INFO - 'USER': 'cltbld', 10:52:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', 10:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:35 INFO - '_': '/tools/buildbot/bin/python'} 10:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:35 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 10:52:35 INFO - Cleaning up... 10:52:35 INFO - Return code: 0 10:52:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:35 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 0x7f385b81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1224410>, '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 0x1225310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12257a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', '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 10:52:35 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 10:52:35 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 10:52:35 INFO - Using env: {'DISPLAY': ':0', 10:52:35 INFO - 'HOME': '/home/cltbld', 10:52:35 INFO - 'LANG': 'en_US.UTF-8', 10:52:35 INFO - 'LANGUAGE': 'en_US:en', 10:52:35 INFO - 'LOGNAME': 'cltbld', 10:52:35 INFO - 'MAIL': '/var/mail/cltbld', 10:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:35 INFO - 'MOZ_NO_REMOTE': '1', 10:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:35 INFO - 'NO_EM_RESTART': '1', 10:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:35 INFO - 'PWD': '/builds/slave/test', 10:52:35 INFO - 'SHELL': '/bin/bash', 10:52:35 INFO - 'SHLVL': '1', 10:52:35 INFO - 'TERM': 'linux', 10:52:35 INFO - 'TMOUT': '86400', 10:52:35 INFO - 'USER': 'cltbld', 10:52:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', 10:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:35 INFO - '_': '/tools/buildbot/bin/python'} 10:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:35 INFO - Downloading/unpacking psutil>=0.7.1 10:52:35 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 10:52:35 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 10:52:35 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 10:52:35 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 10:52:35 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 10:52:35 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 10:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:37 INFO - Installing collected packages: psutil 10:52:37 INFO - Running setup.py install for psutil 10:52:37 INFO - building 'psutil._psutil_linux' extension 10:52:37 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 10:52:38 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 10:52:38 INFO - building 'psutil._psutil_posix' extension 10:52:38 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 10:52:38 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 10:52:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:38 INFO - Successfully installed psutil 10:52:38 INFO - Cleaning up... 10:52:40 INFO - Return code: 0 10:52:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f385b81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1224410>, '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 0x1225310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12257a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', '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 10:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:52:40 INFO - Using env: {'DISPLAY': ':0', 10:52:40 INFO - 'HOME': '/home/cltbld', 10:52:40 INFO - 'LANG': 'en_US.UTF-8', 10:52:40 INFO - 'LANGUAGE': 'en_US:en', 10:52:40 INFO - 'LOGNAME': 'cltbld', 10:52:40 INFO - 'MAIL': '/var/mail/cltbld', 10:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:40 INFO - 'MOZ_NO_REMOTE': '1', 10:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:40 INFO - 'NO_EM_RESTART': '1', 10:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:40 INFO - 'PWD': '/builds/slave/test', 10:52:40 INFO - 'SHELL': '/bin/bash', 10:52:40 INFO - 'SHLVL': '1', 10:52:40 INFO - 'TERM': 'linux', 10:52:40 INFO - 'TMOUT': '86400', 10:52:40 INFO - 'USER': 'cltbld', 10:52:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', 10:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:40 INFO - '_': '/tools/buildbot/bin/python'} 10:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:52:42 INFO - Installing collected packages: mozsystemmonitor 10:52:42 INFO - Running setup.py install for mozsystemmonitor 10:52:42 INFO - Successfully installed mozsystemmonitor 10:52:42 INFO - Cleaning up... 10:52:42 INFO - Return code: 0 10:52:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f385b81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1224410>, '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 0x1225310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12257a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', '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 10:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:52:42 INFO - Using env: {'DISPLAY': ':0', 10:52:42 INFO - 'HOME': '/home/cltbld', 10:52:42 INFO - 'LANG': 'en_US.UTF-8', 10:52:42 INFO - 'LANGUAGE': 'en_US:en', 10:52:42 INFO - 'LOGNAME': 'cltbld', 10:52:42 INFO - 'MAIL': '/var/mail/cltbld', 10:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:42 INFO - 'MOZ_NO_REMOTE': '1', 10:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:42 INFO - 'NO_EM_RESTART': '1', 10:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:42 INFO - 'PWD': '/builds/slave/test', 10:52:42 INFO - 'SHELL': '/bin/bash', 10:52:42 INFO - 'SHLVL': '1', 10:52:42 INFO - 'TERM': 'linux', 10:52:42 INFO - 'TMOUT': '86400', 10:52:42 INFO - 'USER': 'cltbld', 10:52:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', 10:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:42 INFO - '_': '/tools/buildbot/bin/python'} 10:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:52:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:52:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:45 INFO - Downloading docopt-0.6.1.tar.gz 10:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:52:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:52:45 INFO - Running setup.py install for blobuploader 10:52:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:52:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:52:45 INFO - Running setup.py install for requests 10:52:46 INFO - Running setup.py install for docopt 10:52:46 INFO - Successfully installed blobuploader requests docopt 10:52:46 INFO - Cleaning up... 10:52:46 INFO - Return code: 0 10:52:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:46 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 0x7f385b81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1224410>, '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 0x1225310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12257a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', '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 10:52:46 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 10:52:46 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 10:52:46 INFO - Using env: {'DISPLAY': ':0', 10:52:46 INFO - 'HOME': '/home/cltbld', 10:52:46 INFO - 'LANG': 'en_US.UTF-8', 10:52:46 INFO - 'LANGUAGE': 'en_US:en', 10:52:46 INFO - 'LOGNAME': 'cltbld', 10:52:46 INFO - 'MAIL': '/var/mail/cltbld', 10:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:46 INFO - 'MOZ_NO_REMOTE': '1', 10:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:46 INFO - 'NO_EM_RESTART': '1', 10:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:46 INFO - 'PWD': '/builds/slave/test', 10:52:46 INFO - 'SHELL': '/bin/bash', 10:52:46 INFO - 'SHLVL': '1', 10:52:46 INFO - 'TERM': 'linux', 10:52:46 INFO - 'TMOUT': '86400', 10:52:46 INFO - 'USER': 'cltbld', 10:52:46 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', 10:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:46 INFO - '_': '/tools/buildbot/bin/python'} 10:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:46 INFO - Running setup.py (path:/tmp/pip-cerZOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:46 INFO - Running setup.py (path:/tmp/pip-prUtDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:46 INFO - Running setup.py (path:/tmp/pip-9TtvM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:46 INFO - Running setup.py (path:/tmp/pip-oKTBGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:46 INFO - Running setup.py (path:/tmp/pip-OgSmnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:46 INFO - Running setup.py (path:/tmp/pip-MzIhps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:46 INFO - Running setup.py (path:/tmp/pip-JZcWOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:46 INFO - Running setup.py (path:/tmp/pip-GF9WUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:47 INFO - Running setup.py (path:/tmp/pip-14wqDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:47 INFO - Running setup.py (path:/tmp/pip-clFPGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:47 INFO - Running setup.py (path:/tmp/pip-FsNtKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:47 INFO - Running setup.py (path:/tmp/pip-8CdQzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:47 INFO - Running setup.py (path:/tmp/pip-d8DE_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:47 INFO - Running setup.py (path:/tmp/pip-cp8mQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:47 INFO - Running setup.py (path:/tmp/pip-reC6qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:47 INFO - Running setup.py (path:/tmp/pip-7Q3zaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:47 INFO - Running setup.py (path:/tmp/pip-K3PpB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:52:47 INFO - Running setup.py install for manifestparser 10:52:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:52:47 INFO - Running setup.py install for mozcrash 10:52:47 INFO - Running setup.py install for mozdebug 10:52:47 INFO - Running setup.py install for mozdevice 10:52:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:52:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:52:48 INFO - Running setup.py install for mozfile 10:52:48 INFO - Running setup.py install for mozhttpd 10:52:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:52:48 INFO - Running setup.py install for mozinfo 10:52:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:52:48 INFO - Running setup.py install for mozInstall 10:52:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:52:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:52:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:52:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:52:48 INFO - Running setup.py install for mozleak 10:52:48 INFO - Running setup.py install for mozlog 10:52:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:52:48 INFO - Running setup.py install for moznetwork 10:52:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:52:48 INFO - Running setup.py install for mozprocess 10:52:48 INFO - Running setup.py install for mozprofile 10:52:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Running setup.py install for mozrunner 10:52:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Running setup.py install for mozscreenshot 10:52:49 INFO - Running setup.py install for moztest 10:52:49 INFO - Running setup.py install for mozversion 10:52:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:52:49 INFO - Cleaning up... 10:52:49 INFO - Return code: 0 10:52:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:49 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 0x7f385b81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1224410>, '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 0x1225310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12257a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', '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 10:52:49 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 10:52:49 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 10:52:49 INFO - Using env: {'DISPLAY': ':0', 10:52:49 INFO - 'HOME': '/home/cltbld', 10:52:49 INFO - 'LANG': 'en_US.UTF-8', 10:52:49 INFO - 'LANGUAGE': 'en_US:en', 10:52:49 INFO - 'LOGNAME': 'cltbld', 10:52:49 INFO - 'MAIL': '/var/mail/cltbld', 10:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:49 INFO - 'MOZ_NO_REMOTE': '1', 10:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:49 INFO - 'NO_EM_RESTART': '1', 10:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:49 INFO - 'PWD': '/builds/slave/test', 10:52:49 INFO - 'SHELL': '/bin/bash', 10:52:49 INFO - 'SHLVL': '1', 10:52:49 INFO - 'TERM': 'linux', 10:52:49 INFO - 'TMOUT': '86400', 10:52:49 INFO - 'USER': 'cltbld', 10:52:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', 10:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:49 INFO - '_': '/tools/buildbot/bin/python'} 10:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:49 INFO - Running setup.py (path:/tmp/pip-7vEG8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:49 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)) 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:49 INFO - Running setup.py (path:/tmp/pip-zxC0_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:49 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)) 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:49 INFO - Running setup.py (path:/tmp/pip-uODyvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:49 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)) 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:49 INFO - Running setup.py (path:/tmp/pip-chUNSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:49 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)) 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:49 INFO - Running setup.py (path:/tmp/pip-AkuPTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:50 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)) 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:50 INFO - Running setup.py (path:/tmp/pip-mPH6pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:50 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)) 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:50 INFO - Running setup.py (path:/tmp/pip-HiIxS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:50 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)) 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:50 INFO - Running setup.py (path:/tmp/pip-f3PIDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:50 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)) 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:50 INFO - Running setup.py (path:/tmp/pip-8B5RiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:50 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)) 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:50 INFO - Running setup.py (path:/tmp/pip-UzxA1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:50 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)) 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:50 INFO - Running setup.py (path:/tmp/pip-muUzWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:50 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)) 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:50 INFO - Running setup.py (path:/tmp/pip-b5WiDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:50 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)) 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:50 INFO - Running setup.py (path:/tmp/pip-p689fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:50 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)) 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:50 INFO - Running setup.py (path:/tmp/pip-8wMouo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:50 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)) 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:50 INFO - Running setup.py (path:/tmp/pip-5Nt_mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:50 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)) 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:50 INFO - Running setup.py (path:/tmp/pip-CvGlJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:50 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)) 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:50 INFO - Running setup.py (path:/tmp/pip-IoG55x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:50 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)) 10:52:50 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)) 10:52:50 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)) 10:52:50 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)) 10:52:50 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)) 10:52:50 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)) 10:52:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52:52 INFO - Downloading blessings-1.6.tar.gz 10:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:52 INFO - Installing collected packages: blessings 10:52:52 INFO - Running setup.py install for blessings 10:52:52 INFO - Successfully installed blessings 10:52:52 INFO - Cleaning up... 10:52:53 INFO - Return code: 0 10:52:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:53 INFO - Reading from file tmpfile_stdout 10:52:53 INFO - Current package versions: 10:52:53 INFO - argparse == 1.2.1 10:52:53 INFO - blessings == 1.6 10:52:53 INFO - blobuploader == 1.2.4 10:52:53 INFO - docopt == 0.6.1 10:52:53 INFO - manifestparser == 1.1 10:52:53 INFO - mozInstall == 1.12 10:52:53 INFO - mozcrash == 0.17 10:52:53 INFO - mozdebug == 0.1 10:52:53 INFO - mozdevice == 0.48 10:52:53 INFO - mozfile == 1.2 10:52:53 INFO - mozhttpd == 0.7 10:52:53 INFO - mozinfo == 0.9 10:52:53 INFO - mozleak == 0.1 10:52:53 INFO - mozlog == 3.1 10:52:53 INFO - moznetwork == 0.27 10:52:53 INFO - mozprocess == 0.22 10:52:53 INFO - mozprofile == 0.28 10:52:53 INFO - mozrunner == 6.11 10:52:53 INFO - mozscreenshot == 0.1 10:52:53 INFO - mozsystemmonitor == 0.0 10:52:53 INFO - moztest == 0.7 10:52:53 INFO - mozversion == 1.4 10:52:53 INFO - psutil == 3.1.1 10:52:53 INFO - requests == 1.2.3 10:52:53 INFO - wsgiref == 0.1.2 10:52:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:53 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 0x7f385b81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1224410>, '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 0x1225310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12257a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', '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 10:52:53 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 10:52:53 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 10:52:53 INFO - Using env: {'DISPLAY': ':0', 10:52:53 INFO - 'HOME': '/home/cltbld', 10:52:53 INFO - 'LANG': 'en_US.UTF-8', 10:52:53 INFO - 'LANGUAGE': 'en_US:en', 10:52:53 INFO - 'LOGNAME': 'cltbld', 10:52:53 INFO - 'MAIL': '/var/mail/cltbld', 10:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:53 INFO - 'MOZ_NO_REMOTE': '1', 10:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:53 INFO - 'NO_EM_RESTART': '1', 10:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:53 INFO - 'PWD': '/builds/slave/test', 10:52:53 INFO - 'SHELL': '/bin/bash', 10:52:53 INFO - 'SHLVL': '1', 10:52:53 INFO - 'TERM': 'linux', 10:52:53 INFO - 'TMOUT': '86400', 10:52:53 INFO - 'USER': 'cltbld', 10:52:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', 10:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:53 INFO - '_': '/tools/buildbot/bin/python'} 10:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:53 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)) 10:52:53 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)) 10:52:53 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)) 10:52:53 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)) 10:52:53 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)) 10:52:53 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)) 10:52:53 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)) 10:52:53 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)) 10:52:53 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)) 10:52:53 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)) 10:52:53 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)) 10:52:53 INFO - Cleaning up... 10:52:53 INFO - Return code: 0 10:52:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:53 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 0x7f385b81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1224410>, '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 0x1225310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12257a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', '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 10:52:53 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 10:52:53 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 10:52:53 INFO - Using env: {'DISPLAY': ':0', 10:52:53 INFO - 'HOME': '/home/cltbld', 10:52:53 INFO - 'LANG': 'en_US.UTF-8', 10:52:53 INFO - 'LANGUAGE': 'en_US:en', 10:52:53 INFO - 'LOGNAME': 'cltbld', 10:52:53 INFO - 'MAIL': '/var/mail/cltbld', 10:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:53 INFO - 'MOZ_NO_REMOTE': '1', 10:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:53 INFO - 'NO_EM_RESTART': '1', 10:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:53 INFO - 'PWD': '/builds/slave/test', 10:52:53 INFO - 'SHELL': '/bin/bash', 10:52:53 INFO - 'SHLVL': '1', 10:52:53 INFO - 'TERM': 'linux', 10:52:53 INFO - 'TMOUT': '86400', 10:52:53 INFO - 'USER': 'cltbld', 10:52:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', 10:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:53 INFO - '_': '/tools/buildbot/bin/python'} 10:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:53 INFO - Downloading/unpacking jsonschema 10:52:53 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 10:52:53 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 10:52:53 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 10:52:53 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 10:52:53 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 10:52:53 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 10:52:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:52:55 INFO - Downloading/unpacking functools32 (from jsonschema) 10:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:55 INFO - Downloading functools32-3.2.3-2.tar.gz 10:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:52:55 INFO - warning: no files found matching '*.txt' 10:52:55 INFO - no previously-included directories found matching 'build' 10:52:55 INFO - no previously-included directories found matching 'dist' 10:52:55 INFO - no previously-included directories found matching '.git*' 10:52:55 INFO - Installing collected packages: jsonschema, functools32 10:52:55 INFO - Running setup.py install for functools32 10:52:55 INFO - warning: no files found matching '*.txt' 10:52:55 INFO - no previously-included directories found matching 'build' 10:52:55 INFO - no previously-included directories found matching 'dist' 10:52:55 INFO - no previously-included directories found matching '.git*' 10:52:56 INFO - Successfully installed jsonschema functools32 10:52:56 INFO - Cleaning up... 10:52:56 INFO - Return code: 0 10:52:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:56 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 0x7f385b81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1224410>, '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 0x1225310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12257a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', '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 10:52:56 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 10:52:56 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 10:52:56 INFO - Using env: {'DISPLAY': ':0', 10:52:56 INFO - 'HOME': '/home/cltbld', 10:52:56 INFO - 'LANG': 'en_US.UTF-8', 10:52:56 INFO - 'LANGUAGE': 'en_US:en', 10:52:56 INFO - 'LOGNAME': 'cltbld', 10:52:56 INFO - 'MAIL': '/var/mail/cltbld', 10:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:56 INFO - 'MOZ_NO_REMOTE': '1', 10:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:56 INFO - 'NO_EM_RESTART': '1', 10:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:56 INFO - 'PWD': '/builds/slave/test', 10:52:56 INFO - 'SHELL': '/bin/bash', 10:52:56 INFO - 'SHLVL': '1', 10:52:56 INFO - 'TERM': 'linux', 10:52:56 INFO - 'TMOUT': '86400', 10:52:56 INFO - 'USER': 'cltbld', 10:52:56 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', 10:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:56 INFO - '_': '/tools/buildbot/bin/python'} 10:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:56 INFO - Downloading/unpacking flake8 10:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:52:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:52:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:52:58 INFO - no previously-included directories found matching 'docs/_build' 10:52:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:52:58 INFO - Running setup.py install for pep8 10:52:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:52:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:52:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:52:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:52:59 INFO - no previously-included directories found matching 'docs/_build' 10:52:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:52:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:52:59 INFO - Cleaning up... 10:52:59 INFO - Return code: 0 10:52:59 INFO - Running post-action listener: _resource_record_post_action 10:52:59 INFO - Running post-action listener: _start_resource_monitoring 10:52:59 INFO - Starting resource monitoring. 10:52:59 INFO - ##### 10:52:59 INFO - ##### Running install step. 10:52:59 INFO - ##### 10:52:59 INFO - Running pre-action listener: _resource_record_pre_action 10:52:59 INFO - Running main action method: install 10:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:59 INFO - Reading from file tmpfile_stdout 10:52:59 INFO - Detecting whether we're running mozinstall >=1.0... 10:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:52:59 INFO - Reading from file tmpfile_stdout 10:52:59 INFO - Output received: 10:52:59 INFO - Usage: mozinstall [options] installer 10:52:59 INFO - Options: 10:52:59 INFO - -h, --help show this help message and exit 10:52:59 INFO - -d DEST, --destination=DEST 10:52:59 INFO - Directory to install application into. [default: 10:52:59 INFO - "/builds/slave/test"] 10:52:59 INFO - --app=APP Application being installed. [default: firefox] 10:52:59 INFO - mkdir: /builds/slave/test/build/application 10:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:53:15 INFO - Reading from file tmpfile_stdout 10:53:15 INFO - Output received: 10:53:15 INFO - /builds/slave/test/build/application/firefox/firefox 10:53:15 INFO - Running post-action listener: _resource_record_post_action 10:53:15 INFO - ##### 10:53:15 INFO - ##### Running run-tests step. 10:53:15 INFO - ##### 10:53:15 INFO - Running pre-action listener: _resource_record_pre_action 10:53:15 INFO - Running main action method: run_tests 10:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:53:15 INFO - Python 2.7.3 10:53:15 INFO - Return code: 0 10:53:15 INFO - grabbing minidump binary from tooltool 10:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1224410>, '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 0x1225310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12257a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:53:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:53:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:53:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:15 INFO - Return code: 0 10:53:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:53:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:53:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:53:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:53:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:53:16 INFO - Return code: 0 10:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 10:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 10:53:16 INFO - Using env: {'DISPLAY': ':0', 10:53:16 INFO - 'HOME': '/home/cltbld', 10:53:16 INFO - 'LANG': 'en_US.UTF-8', 10:53:16 INFO - 'LANGUAGE': 'en_US:en', 10:53:16 INFO - 'LOGNAME': 'cltbld', 10:53:16 INFO - 'MAIL': '/var/mail/cltbld', 10:53:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:53:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:16 INFO - 'MOZ_NO_REMOTE': '1', 10:53:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:16 INFO - 'NO_EM_RESTART': '1', 10:53:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:16 INFO - 'PWD': '/builds/slave/test', 10:53:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:53:16 INFO - 'SHELL': '/bin/bash', 10:53:16 INFO - 'SHLVL': '1', 10:53:16 INFO - 'TERM': 'linux', 10:53:16 INFO - 'TMOUT': '86400', 10:53:16 INFO - 'USER': 'cltbld', 10:53:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056', 10:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:16 INFO - '_': '/tools/buildbot/bin/python'} 10:53:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 10:53:16 INFO - mozversion application_buildid: 20160517004009 10:53:16 INFO - mozversion application_changeset: 17724486e1591858eea09dc327475a25883854a4 10:53:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:53:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:16 INFO - mozversion application_name: Firefox 10:53:16 INFO - mozversion application_remotingname: firefox-dev 10:53:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:53:16 INFO - mozversion application_vendor: Mozilla 10:53:16 INFO - mozversion application_version: 48.0a2 10:53:16 INFO - mozversion platform_buildid: 20160517004009 10:53:16 INFO - mozversion platform_changeset: 17724486e1591858eea09dc327475a25883854a4 10:53:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:53:16 INFO - mozversion platform_version: 48.0a2 10:53:16 INFO - using testdate: 1463507596 10:53:16 INFO - actual date: 1463507596 10:53:16 INFO - starting webserver on 'localhost:48606' 10:53:16 INFO - SUITE-START | Running 2 tests 10:53:16 INFO - TEST-START | dromaeo_css 10:53:16 INFO - operating with platform_type : linux_ 10:53:16 INFO - Initialising browser for dromaeo_css test... 10:53:16 INFO - TEST-INFO | started process 10722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplWuySX/profile http://localhost:48606/getInfo.html) 10:53:19 INFO - PROCESS | 10722 | 10:53:19 INFO - PROCESS | 10722 | (process:10800): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:53:20 INFO - PROCESS | 10722 | __metrics Screen width/height:1600/1200 10:53:20 INFO - PROCESS | 10722 | colorDepth:24 10:53:20 INFO - PROCESS | 10722 | Browser inner width/height: 1024/697 10:53:20 INFO - PROCESS | 10722 | __metrics 10:53:21 ERROR - PROCESS | 10722 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 10:53:22 INFO - TEST-INFO | 10722: exit 0 10:53:22 INFO - Browser initialized. 10:53:22 INFO - Running cycle 1/1 for dromaeo_css test... 10:53:22 INFO - TEST-INFO | started process 10851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplWuySX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:24 INFO - PROCESS | 10851 | 10:53:24 INFO - PROCESS | 10851 | (process:10921): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:53:34 INFO - PROCESS | 10851 | RSS: Main: 152408064 10:53:34 INFO - PROCESS | 10851 | 10:54:23 INFO - PROCESS | 10851 | 1463507663871 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] 10:56:31 INFO - PROCESS | 10851 | Cycle 1(1): loaded http://localhost:48606/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48606/tests/dromaeo/cssquery-ext.html) 10:56:32 INFO - PROCESS | 10851 | RSS: Main: 155774976 10:56:32 INFO - PROCESS | 10851 | 10:59:34 INFO - PROCESS | 10851 | Cycle 1(1): loaded http://localhost:48606/tests/dromaeo/cssquery-ext.html (next: http://localhost:48606/tests/dromaeo/cssquery-jquery.html) 10:59:34 INFO - PROCESS | 10851 | RSS: Main: 153452544 10:59:34 INFO - PROCESS | 10851 | 11:02:36 INFO - PROCESS | 10851 | Cycle 1(1): loaded http://localhost:48606/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48606/tests/dromaeo/cssquery-mootools.html) 11:02:37 INFO - PROCESS | 10851 | RSS: Main: 153313280 11:02:37 INFO - PROCESS | 10851 | 11:05:38 INFO - PROCESS | 10851 | Cycle 1(1): loaded http://localhost:48606/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48606/tests/dromaeo/cssquery-prototype.html) 11:05:39 INFO - PROCESS | 10851 | RSS: Main: 153231360 11:05:39 INFO - PROCESS | 10851 | 11:08:41 INFO - PROCESS | 10851 | Cycle 1(1): loaded http://localhost:48606/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48606/tests/dromaeo/cssquery-yui.html) 11:08:42 INFO - PROCESS | 10851 | RSS: Main: 154337280 11:08:42 INFO - PROCESS | 10851 | 11:11:44 INFO - PROCESS | 10851 | Cycle 1(1): loaded http://localhost:48606/tests/dromaeo/cssquery-yui.html (next: http://localhost:48606/tests/dromaeo/cssquery-dojo.html) 11:11:44 INFO - PROCESS | 10851 | RSS: Main: 156110848 11:11:44 INFO - PROCESS | 10851 | 11:11:44 INFO - PROCESS | 10851 | __start_tp_report 11:11:44 INFO - PROCESS | 10851 | _x_x_mozilla_page_load 11:11:44 INFO - PROCESS | 10851 | _x_x_mozilla_page_load_details 11:11:44 INFO - PROCESS | 10851 | |i|pagename|runs| 11:11:44 INFO - PROCESS | 10851 | |0;dojo.html;3347.89956301311;3397.405454045543;3429.6913277805006;3437.2609888873885;3454.55090838191;5473.425290344511;5523.392426833055;5549.19536667183;5552.11166213406;5601.7199140042985;5535.861603459915;5568;5569;5572.4148964358765;5604.719764011804;5009.49905009498;5013.623978201631;5057.974710126463;5095.949040509603;5137.48625137487;5082.51716086973;5123.948760512403;5172.09488339541;5187.896242075156;5190.636655434121;5063.088644044071;5094.7197904115255;5148.253503242027;5214.921776173361;5234.084035293828;5219.973900130513;5247.449017853128;5253.711045892474;5260.289860868791;5261.76322065508;5100.056489549445;5156.458571849977;5211.400688920747;5227.529522343008;5250.422453530108;5501.779928802843;5565.1374037024325;5586.972065139689;5609.242752228479;5626;6082.361352058058;6099.48154406876;6100.389961003864;6102.755889764404;6118.082287656843;5971.0744834550715;6164.198654174974;6167.290761562388;6182.041783523561;6185.16500272462;5689.630174038674;5753.827385178452;5796.449337312991;5796.768129274866;5813.854653633651;6269.874602508015;6278.717457714414;6281.434670879643;6293.622382657055;6307;5984.611000284967;6035.305939816977;6038.607490513103;6050.364711705296;6053.364396738367;6054.757809687651;6085.208922840003;6099.725512351954;6119.685352982159;6138.570300079041;6071.423214794588;6073.423024812636;6073.423024812724;6075.848103797352;6096.878062438726;5830.970845145747;5894.351621321651;5896.1450589664255;5931.940680593225;6083.482903953213;4654.325122857167;4672.159011377985;4673.205555055649;4674.22875225584;4687.414073240845;4174.5616710244985;4205.852795152155;4211.768352740567;4221.430106935586;4248.87253382399;5913.881722365614;5946.286445626466;5974.3726908674835;6016.939830601726;6029.879402412015;5984.850378740566;6147.969260153671;6246.187995560639;6255.874882502325;6262.6868656566985;5779.248697669276;5884.617499862496;5900.76396944126;5919.348871624118;5932.851678707981;5114.130597798383;5156.278121063054;5171.741412929338;5174.301469301671;5201.08980928336;6322;6353.174087368612;6358.554901156875;6365.904511432333;6381.298057213703;5991.101334799815;6113.263474096328;6146.477549408351;6152.107944348134;6180.47465965398;6313.526485513697;6389.93610063912;6402.647854367868;6412.903806442814;6423.004434312689;6047.969760151171;6048.3649216833355;6051.092336149437;6063.545234107548;6096.75612975476;6021.337652858095;6135.969320153371;6184.350643182581;6193.1329613855;6214.689265536796;5995.5803093783015;6042.75828966854;6060.121282414113;6065.727042283196;6070.817875463743;5978.432048955342;6027.698615069141;6045.546584006305;6049.243844519435;6057.121717351048;5794.62334948227;5852.707364631837;5900.940990590039;5988.401159883977;6017.428344307284;6056.636601803906;6067.939320606914;6083.087536869505;6106.1451396803595;6117.449429551361;5940;5944.702764861653;5946.851328716817;5948.643081415129;5962.403759624003 11:11:44 INFO - PROCESS | 10851 | |1;ext.html;613.1875265273513;665.8634979829136;674.780696273711;678.9966050169749;681.4786688183538;33675.326493470144;39981.600183998155;40322.59677403225;40449;40705.38941915874;43574.34638480425;44484.55515444845;44487.110257794906;44569.77715111428;44593;8805.69180078699;8949.95525022374;9039.27685785139;9047.276217902552;9057.637694492245;8669.176428239307;8847.247983921374;8855.335849811258;8873.51195684237;9149.908500914973;9124.133207345325;9144.771380715469;9153.908460915372;9172.807535020438;9195.72412827613;8944.64221431142;9069.455832649996;9070.818583628357;9097.63609455621;9152.771180720469;9068.954655226682;9170.724878253663;9177.08229177077;9179.127982841686;9180.265578753684;43272.56727432717;44038.55961440376;44053.55946440527;44055.779721101186;44218.33672494915;3812.5615554211067;3822;3841.635044670752;3870.883873483772;4114.567970363129;34484.655153448395;34642.48036279458;34698.82650586756;34822.82588587041;34843.825780871186;3936.665383442411;3971.748899096804;4086.9578257544135;4126.401671757609;4161.854335098287;280020;280387;280669;283134;284736;39767;63353.68323158355;63468.36531634717;63724;63945;38456.615433845305;38571;38604;38704.419433708514;38758.80620596879;15813.130277834829;15842.207889605474;15918.681626367408;15970.60073498172;16012.359505619645;13582.660433489043;13588.38852251651;13595.524156654668;13655.795163072562;13662.18026918388;9350.345475816763;9440;9481.525923703788;9486.478243696525;9581.993890641521;3630.618785027587;3648.689861361761;3657.926841463156;3673.651003154696;3674.853005879735;1152.0610702277618;1213.4418167642982;1262.7916393795106;1263.4946021591436;1286.7490839286436;33155.171120722174;33155.66844331574;33625.49561756576;33766.98699039033;34322.31355372879;1214.7145420826098;1226.0926914083514;1290.393515047926;1324.993375033138;1388.3544151969384;17729.024903630423;17761.378351757627;17782.37761678335;17929.37247196368;18065.27738890456;465113;575272;576039;576275;582861;57637;58663.413365865796;58677;58998;59061.70469147627;1562.6718389138182;1573.3627880708102;1575.054967019779;1578.0373971877375;1657.651893102438;31509.36981260316;32231;32898;33318.33363332768;34638.653613463546;55950.44049559615;56545.43454565566;56628;56708.71645641745;57145;411458;413270;413984;414384;415288;31318;31968.52047219247;32002.83998579992;32029;32502.02493925186;52703.73648131735;52823.207651884484;53232.73383633057;55460.445395545525;59348;41918.58081419147;41969.58030419657;42013.57986420219;42288.365674514294;43577.56422435735;40675.79662101671;42024.78987605165;42233.09951052148;42556.36165457459;42700.5729942709;42237.155256895305;42277.36583951182;42397.576024239366;42920.57079429291;43479.56520434755;36553.45169822402;36647.231922940366;36861.81569092137;37528.24943501169;37718;29377.71776899681;29545.852270739368;30061.849690751405;30075.849620752633;30207.69792302137 11:11:44 INFO - PROCESS | 10851 | |2;jquery.html;434.1642338498392;438.57239191788;439.25765456378736;449.7885993583016;450.24002862453176;19157.616847663056;19183.808161918394;19672.11475483603;20792.48018799531;20844.374668759963;19820.702689459635;20185.29351472699;20214.292499762512;20266.392008239738;20528.178872845107;5512.200730894018;5929.051351783715;5948.732307046172;5966.343702192756;5969.22400087988;4442.267025940716;5721.141828725704;5824.592278540504;6344.270408902966;6638.269790323085;6502.219733631947;6555.672216389162;6562.278149403562;6576.6711664416825;6595.53831231814;6408.6475243861805;6421;6584.967075164594;6588.374104460068;6613.27254002057;5839.416058394127;5870.794522191745;5890.1164825276555;5896.086106653475;5902.675352855591;21036.789632103635;22438.663420048713;22465;22643.547129057326;23124.42188945273;2442.4504486490573;2468.8518688878726;2522.9116980905765;2566.358410397401;2803.9439211215868;10491.527881245285;10513.421761803098;10659.893401065967;10684.252102352839;10799.4060326682;2016.3043749906258;2032.674772036482;2068.307117115768;2094.2356040045424;2161.740591129059;71563.28436715619;73399.89900151448;74966.25033749647;78704;79871;10199.643012494527;11047.889521104848;11980.28118312904;12057.939710301393;12135.211211271238;16754.83245167557;16765;16856.07291598974;16931.407400740914;17051.31794728222;8361.289290410383;8529.57352132391;8562.229399353964;8564.74305770828;8589.184027517376;8721.967951977864;8740.21338079576;8761.649534018696;8801.559922004002;8841.204291613785;4491.573300536509;4856.635752318591;4896.706197628082;4957.652964292537;4963.478834722375;2044.4786579422152;2058.536829213445;2142.4750936020773;2189.168116115866;2220.222921977327;1029.5161274201114;1031.9638812641522;1073.9140868730483;1116.0346300450053;1140.5551834784442;17796.288148474174;18036.90981545084;18514.722279165824;18694.158762855703;19026;1094.0372472224392;1135.5798354608683;1138.4763009015946;1147.0880649883363;1168.976620467586;10841;11064.391458469701;11099;11167;11293.713452482616;488075;496030;497308;502404;511090;59802.70098649479;61515;101027;102640;103699.48150259201;1081.6917178604217;1112.8219484882543;1119.216548416112;1121.450489260273;1137.2778285788584;17338;17739.645207095527;17915.641687165924;17962.101894905463;18231.817681823544;26607.60088598634;29527.114186574436;40395.1920961585;40617;40994;59899.10151347646;60230;60642.696786515786;60645.39354606398;60747.392526074174;8727.781805454915;8767.56162191875;8790.516521591373;8801.559922003746;8965.282777377925;7977.00287464067;9996.400215987063;12820.846123848898;13243.608071288838;13640.181589104686;11522;12374.071944604011;12408.379581021094;12538.49846006186;12712.491500339884;11440.82838757436;11770.058395328524;11816.663758941462;11944;12163.939180304042;12048.277103373826;12225.327606981702;12284.754304913673;12379.62861114168;12411.193272437262;8939.284857211278;8966.058563850702;8994.280457563249;9132.132447417485;9147.451152930846;9364.531773411438;11825.34960577142;12112.75774484523;12126.393680316125;12158.088143389457 11:11:44 INFO - PROCESS | 10851 | |3;mootools.html;1577.2429233967696;1577.416355948299;1818.2181661885393;1905.380751255843;1923.0096500302357;7790;8474.576271186446;8513.2338089572;8706.956465217672;8745.65017399304;8488;8544.359173062014;8555.058943516207;8582.957085214564;8609.311255099592;2459.6310553416997;2472.49313890652;2484.503099380131;2485.453200295941;2487.2786891801356;2406.8194885383577;2459.4220358215807;2467.8766061696933;2470.7776300133073;2473.356927198932;2408.8678321189013;2440.6339049142593;2448.608222684371;2451.509698060386;2451.534208500379;2358.1039205102124;2391.5575618510543;2396.9640455393182;2398.3764221302413;2400.099962514057;2407.3139155340646;2431.088341871798;2443.499082688045;2462.1259452894324;2463.802895768334;8876.778080547974;8886.155815197546;8901.065388134282;8920;8939.329550283755;5248.291480650101;5396.244525766396;5408.269883565747;5446.428125046892;5453;3456.585209774818;3471.9132021699406;3518.1732292911147;3577.159367548624;3595.334863050344;1171.4377098992445;1177.911656625748;1207.7946749052683;1231.1689609513542;1265.5064524835323;12485.250884946841;12504;12522.561710340095;12534.122611417204;12590.68523286916;4819.469858315582;4935;4979.278004689299;5044.092063428545;5129.640925135204;10709.036186743075;10715.303505272288;10732;10757.83863242052;10773.299735517166;5309.070912590281;5357.062514060024;5357.196420536873;5378.11261141915;5412.539934105566;4731.101090792738;4895.192293271642;4916.311716359713;4934.037862616827;4980.427250866124;3911.9804400978383;3970.2059588082498;3972.503437070366;4117.176564687014;4174.853880114242;1219.5000049979467;1225.3444407242082;1225.3934302520308;1225.4791713521718;1242.3974372429363;1061.3950048472298;1064.744461329291;1065.4406436620682;1074.8172810622214;1082.3289560472558;6212.502999760009;6344.175257216532;6345.17512723343;6367.713452894538;6389.7763578274535;499.383261671835;500.1996805111792;503.91685371913223;513.0815839647065;514.7091893080473;4257.489101307801;4347.804348804311;4388.495323037828;4483.058557702853;4504.09918016398;10815.729606759895;10902.945485272681;11112.833307500394;11151.163662725328;11172.273802202832;10603.57585696579;10852.94573527143;10906.236563440483;10916.345019298868;10916.945415272872;8260.297874680598;8390.706325278708;8393.664253429917;8439.113893041265;8523.40336176474;6075.088736689532;6205.348438413902;6209;6269.874602507833;6297.149884765498;9726.465044422624;9855.950720246354;9905.059019393146;9954.25343099256;10021.649242276486;9821.263405244777;10123.139533139765;10130.645427410005;10356.792864142826;10362.274640775073;6943.062686537455;7218.494705370574;7241.239669834592;7409.222031686595;7421.443391745533;8159.428839981382;8175.427720059776;8201.179882011751;8217.712380066669;8220.876686849822;7314.08573928259;7526.134494533198;7549.131849837119;7593.8860917085185;7631;7319.4144468443465;7412.295831895961;7434.256574342522;7456.66445009965;7481.738139165321;7056.259092795388;7115.003899454184;7125.28747125304;7150.213476517475;7189.856202876018;5369.4630536946;5425.294711687456;5460.590455715757;5578.135389014709;5586.413426590149;5200.5059519345605;5270.947290527046;5291.391489978548;5332.920006199987;5420.105682562333 11:11:44 INFO - PROCESS | 10851 | |4;prototype.html;351.4429629037975;352.4818516780333;364.27327481674047;381.35741275950045;383.04621492483705;6581.70382332795;6604.570702904308;6683.398494135527;6706.798796036121;6735.595864248148;6689.966550167254;6720.260771315164;6754.324567543244;6756.729730810774;6787.4909381796315;5091.898162036757;5114.156164232897;5118.07874582575;5118.769655365518;5131.230315452684;5110.361204849394;5128.333316668828;5134.024535338273;5141.691498510083;5142.66572672777;5098.082345177866;5098.770555325001;5100.489951004888;5105.361829771278;5122.026814905174;4991.40103187618;5079.79680812767;5092.083424983502;5093.286939828427;5133.948660513384;4449.132419178261;4459.219636563621;4469.061497085616;4475.373447717322;4486.327050942385;6504.5121615879;6535.575187612838;6546.410823025903;6548.410643042149;6550.9344906550805;5925.8814823703715;5984.73068711909;5988.101784732282;5993.430624090704;5995.700214989233;7028.964855175692;7109.537880037781;7119.750808721722;7127.287271272883;7133.25100864407;4924.532169443897;4998.075356059141;5014.448410674823;5016.523430274118;5024.371953505812;7416.22129676387;7461.440391970569;7466.589337586431;7470.925290747077;7479.139898911641;5086.0845047891735;5118.539331460186;5121.53906148441;5128.025710101563;5129.563987061067;5189.922151167735;5194.6104042196985;5199.948000520022;5205.323307970016;5217.50433708797;5950.315713692894;5956.076808094752;5981.431763982415;5983;5989.670568118708;7037.366637002694;7173.139223293134;7192.7122915083855;7205.279472052753;7211.927880721126;1763.6737203617372;1781.118346418531;1786.97319540207;1787.2672204396135;1794.0581194872796;1112.8887111288807;1180.527788884436;1194.235689158939;1195.1036722458157;1202.9819552706717;6777.457803375718;6857.588544687334;6857.588544687334;6866.176058872968;6866.279040700754;7310.976463295143;7314.524555903849;7320.853582928312;7333.339999400079;7333.88999165013;6769.830754231184;6794.524383293122;6809.38715515606;6816.284290149562;6820.590764554143;3914;3920.4707364506;3962.187751510933;3972.940405893914;3991.3613821788376;7561.243875612395;7597.734079307198;7603.353714934182;7613.200613935568;7627.275408836152;7390.7413240536325;7446.7021319146625;7454.589997550187;7468.887966680504;7478.513896596813;7572.356349710226;7572.734954276574;7592.582407967615;7598.430117741081;7608.353289970304;7106.111736032996;7295.671694773854;7310.451716121419;7316.9634151828905;7357.816054598464;7198.856022879409;7208.243134471015;7215.67529461186;7222.96388518075;7245.058142441449;7519.248075192437;7539.547627142389;7564.357029652541;7599.088109426683;7603.543787372775;4933.925991110064;4944.505549445027;4946.3817022872145;4947.6536642434685;4960.181570040902;7177.928220717726;7290;7311.488195826241;7318.780436586911;7334.376577990931;7042.542234754929;7046.189688185924;7101.715931362688;7107.60908150036;7112.928870711226;6984.965075174591;6986.545874518343;7034.261402552658;7060.223375428802;7076;6892.483063770337;6926.376626103674;6942.895856562257;6944.097267355211;6945.965270173617;6995.825104372431;7117.181524124792;7117.928820711727;7252.38354739853;7293.671784769592;6964.756233531802;7046.823829404306;7093.716251349888;7103.644817758988;7105.0408194893025 11:11:44 INFO - PROCESS | 10851 | |5;yui.html;810.3517186250998;823.6828820903952;841.0538144587339;895.7671005538562;907.4555266839895;15225.619359516004;15277.923610381946;15316.387344506235;15394.538163855073;15432.768508472382;12810.871891281084;14112.57662270131;14137.434502619908;14162.575122746308;14254.643633909158;865.6234537975969;886;887.7970350175516;892.3797960417512;897.9987314144747;889.1730690457872;890.8619164029586;892.6563273139856;896.6816780043089;898.874157617934;938.6667732954805;939.891912430069;943.2359788571245;944.7354740672588;945.678469320431;930.9208717259041;938.1931538876561;938.4932136646237;942.185009966381;943.3679434778714;686.4817063117364;686.9003994420831;687.082744536045;690.7409721354492;693.414065114977;13867.583972480841;13869.653258668513;13947.511837085653;13950.302484875818;13959.65100872476;14700.632484187874;14781.408743650241;14856.851431485655;14882.702345953128;15000.24998750069;12039.93980030103;12105.394730263539;12238.08214383916;12322.507099716;12323.383830808423;4006.8998275043064;4025.778582177979;4124.463819703449;4229.957700422987;4247.256730072225;59917;60333.396666033215;60592;61088.08367874441;61138.69430652818;11608.24546404481;11630.88369116315;11632.360220187971;11651.76696466066;11751.118666100077;18783.718244226347;18836.246550138116;18878.15048322801;18885.339013134748;18893.527661808566;8723.869141962876;8837.029473287608;8845.469271843709;8913.451553638562;9278.304127190488;4906.460289368167;4922.803087876445;4948.4309304429735;4959;5026.346574945307;3781.1303400218103;3827.770333779926;3835.4055121456217;3856.8071596420627;3861.38217885137;649.1463725201345;660.5475249454139;662.7282814046314;667.0827612033454;669.2470970158572;625.3256904637796;702.9015937768717;806.2985202873538;821.9630116644646;823.4441751817499;9402.858957115648;9481.4785186814;9667;9701.51492425376;9757.268204884662;670.7518218259178;738.062660421262;773.7407968330559;775.5308038636543;818.3862103422433;4191;4597.563231493003;4608.585227329557;4648.1865673507;4659.58063774262;67254;67736;70079.64960175268;71038.28961710316;71632.28367716256;56053.439465604824;56999.71500142556;57045.714771426705;59026.8303774444;59673;52326.73836630792;52434.47565524296;53559;53586.73206633942;54673.45326546763;9081.046490118442;9105.908940910505;9268.119528644767;9306.115918987685;9367.297452690938;39616.40575391429;40080;40113.799431002655;40781.59218407778;41191.382129268684;48633.85799300362;51525;51668.48331516787;51706.48293517167;52445.73777131242;11066.336019838835;11084.944575277072;11206.7758644825;11271.267367621078;11384.032357249727;12831.679208019874;13021.739565208833;13042.217466952014;13461.730765384442;13801;12166.939165304117;12168.513259469522;12200.328981906081;12425.502979881065;12853.100282980102;11815.527378905092;12141.878581214074;12407.875921240671;12524.436400362189;12551.435185416862;11116.333020018825;11199.776004479701;11629;11869.406529673655;12104.152709310263;9885.55515001841;10130.240231982483;10340.327878687862;10355.593237245146;10849.45752712377;9511.429314241168;9669.27480438984;9735.513224338896;9738.805223895624;9745.561449734638 11:11:44 INFO - PROCESS | 10851 | __end_tp_report 11:11:44 INFO - PROCESS | 10851 | __start_cc_report 11:11:44 INFO - PROCESS | 10851 | _x_x_mozilla_cycle_collect,335 11:11:44 INFO - PROCESS | 10851 | __end_cc_report 11:11:44 INFO - PROCESS | 10851 | __startTimestamp1463508704772__endTimestamp 11:11:44 INFO - PROCESS | 10851 | 11:11:44 INFO - PROCESS | 10851 | ------- Summary: start ------- 11:11:44 INFO - PROCESS | 10851 | Number of tests: 6 11:11:44 INFO - PROCESS | 10851 | 11:11:44 INFO - PROCESS | 10851 | [#0] dojo.html Cycles:165 Average:5682.34 Median:5948.64 stddev:648.11 (10.9%) stddev-sans-first:623.69 11:11:44 INFO - PROCESS | 10851 | Values: 3347.9 3397.4 3429.7 3437.3 3454.6 5473.4 5523.4 5549.2 5552.1 5601.7 5535.9 5568.0 5569.0 5572.4 5604.7 5009.5 5013.6 5058.0 5095.9 5137.5 5082.5 5123.9 5172.1 5187.9 5190.6 5063.1 5094.7 5148.3 5214.9 5234.1 5220.0 5247.4 5253.7 5260.3 5261.8 5100.1 5156.5 5211.4 5227.5 5250.4 5501.8 5565.1 5587.0 5609.2 5626.0 6082.4 6099.5 6100.4 6102.8 6118.1 5971.1 6164.2 6167.3 6182.0 6185.2 5689.6 5753.8 5796.4 5796.8 5813.9 6269.9 6278.7 6281.4 6293.6 6307.0 5984.6 6035.3 6038.6 6050.4 6053.4 6054.8 6085.2 6099.7 6119.7 6138.6 6071.4 6073.4 6073.4 6075.8 6096.9 5831.0 5894.4 5896.1 5931.9 6083.5 4654.3 4672.2 4673.2 4674.2 4687.4 4174.6 4205.9 4211.8 4221.4 4248.9 5913.9 5946.3 5974.4 6016.9 6029.9 5984.9 6148.0 6246.2 6255.9 6262.7 5779.2 5884.6 5900.8 5919.3 5932.9 5114.1 5156.3 5171.7 5174.3 5201.1 6322.0 6353.2 6358.6 6365.9 6381.3 5991.1 6113.3 6146.5 6152.1 6180.5 6313.5 6389.9 6402.6 6412.9 6423.0 6048.0 6048.4 6051.1 6063.5 6096.8 6021.3 6136.0 6184.4 6193.1 6214.7 5995.6 6042.8 6060.1 6065.7 6070.8 5978.4 6027.7 6045.5 6049.2 6057.1 5794.6 5852.7 5900.9 5988.4 6017.4 6056.6 6067.9 6083.1 6106.1 6117.4 5940.0 5944.7 5946.9 5948.6 5962.4 11:11:44 INFO - PROCESS | 10851 | 11:11:44 INFO - PROCESS | 10851 | [#1] ext.html Cycles:180 Average:58080.29 Median:207792.20 stddev:114918.81 (55.3%) stddev-sans-first:115160.19 11:11:44 INFO - PROCESS | 10851 | Values: 613.2 665.9 674.8 679.0 681.5 33675.3 39981.6 40322.6 40449.0 40705.4 43574.3 44484.6 44487.1 44569.8 44593.0 8805.7 8950.0 9039.3 9047.3 9057.6 8669.2 8847.2 8855.3 8873.5 9149.9 9124.1 9144.8 9153.9 9172.8 9195.7 8944.6 9069.5 9070.8 9097.6 9152.8 9069.0 9170.7 9177.1 9179.1 9180.3 43272.6 44038.6 44053.6 44055.8 44218.3 3812.6 3822.0 3841.6 3870.9 4114.6 34484.7 34642.5 34698.8 34822.8 34843.8 3936.7 3971.7 4087.0 4126.4 4161.9 280020.0 280387.0 280669.0 283134.0 284736.0 39767.0 63353.7 63468.4 63724.0 63945.0 38456.6 38571.0 38604.0 38704.4 38758.8 15813.1 15842.2 15918.7 15970.6 16012.4 13582.7 13588.4 13595.5 13655.8 13662.2 9350.3 9440.0 9481.5 9486.5 9582.0 3630.6 3648.7 3657.9 3673.7 3674.9 1152.1 1213.4 1262.8 1263.5 1286.7 33155.2 33155.7 33625.5 33767.0 34322.3 1214.7 1226.1 1290.4 1325.0 1388.4 17729.0 17761.4 17782.4 17929.4 18065.3 465113.0 575272.0 576039.0 576275.0 582861.0 57637.0 58663.4 58677.0 58998.0 59061.7 1562.7 1573.4 1575.1 1578.0 1657.7 31509.4 32231.0 32898.0 33318.3 34638.7 55950.4 56545.4 56628.0 56708.7 57145.0 411458.0 413270.0 413984.0 414384.0 415288.0 31318.0 31968.5 32002.8 32029.0 32502.0 52703.7 52823.2 53232.7 55460.4 59348.0 41918.6 41969.6 42013.6 42288.4 43577.6 40675.8 42024.8 42233.1 42556.4 42700.6 42237.2 42277.4 42397.6 42920.6 43479.6 36553.5 36647.2 36861.8 37528.2 37718.0 29377.7 29545.9 30061.8 30075.8 30207.7 11:11:44 INFO - PROCESS | 10851 | 11:11:44 INFO - PROCESS | 10851 | [#2] jquery.html Cycles:180 Average:29052.21 Median:12329.44 stddev:82047.45 (665.5%) stddev-sans-first:82249.48 11:11:44 INFO - PROCESS | 10851 | Values: 434.2 438.6 439.3 449.8 450.2 19157.6 19183.8 19672.1 20792.5 20844.4 19820.7 20185.3 20214.3 20266.4 20528.2 5512.2 5929.1 5948.7 5966.3 5969.2 4442.3 5721.1 5824.6 6344.3 6638.3 6502.2 6555.7 6562.3 6576.7 6595.5 6408.6 6421.0 6585.0 6588.4 6613.3 5839.4 5870.8 5890.1 5896.1 5902.7 21036.8 22438.7 22465.0 22643.5 23124.4 2442.5 2468.9 2522.9 2566.4 2803.9 10491.5 10513.4 10659.9 10684.3 10799.4 2016.3 2032.7 2068.3 2094.2 2161.7 71563.3 73399.9 74966.3 78704.0 79871.0 10199.6 11047.9 11980.3 12057.9 12135.2 16754.8 16765.0 16856.1 16931.4 17051.3 8361.3 8529.6 8562.2 8564.7 8589.2 8722.0 8740.2 8761.6 8801.6 8841.2 4491.6 4856.6 4896.7 4957.7 4963.5 2044.5 2058.5 2142.5 2189.2 2220.2 1029.5 1032.0 1073.9 1116.0 1140.6 17796.3 18036.9 18514.7 18694.2 19026.0 1094.0 1135.6 1138.5 1147.1 1169.0 10841.0 11064.4 11099.0 11167.0 11293.7 488075.0 496030.0 497308.0 502404.0 511090.0 59802.7 61515.0 101027.0 102640.0 103699.5 1081.7 1112.8 1119.2 1121.5 1137.3 17338.0 17739.6 17915.6 17962.1 18231.8 26607.6 29527.1 40395.2 40617.0 40994.0 59899.1 60230.0 60642.7 60645.4 60747.4 8727.8 8767.6 8790.5 8801.6 8965.3 7977.0 9996.4 12820.8 13243.6 13640.2 11522.0 12374.1 12408.4 12538.5 12712.5 11440.8 11770.1 11816.7 11944.0 12163.9 12048.3 12225.3 12284.8 12379.6 12411.2 8939.3 8966.1 8994.3 9132.1 9147.5 9364.5 11825.3 12112.8 12126.4 12158.1 11:11:44 INFO - PROCESS | 10851 | 11:11:44 INFO - PROCESS | 10851 | [#3] mootools.html Cycles:180 Average:5858.11 Median:4957.14 stddev:3269.19 (65.9%) stddev-sans-first:3262.53 11:11:44 INFO - PROCESS | 10851 | Values: 1577.2 1577.4 1818.2 1905.4 1923.0 7790.0 8474.6 8513.2 8707.0 8745.7 8488.0 8544.4 8555.1 8583.0 8609.3 2459.6 2472.5 2484.5 2485.5 2487.3 2406.8 2459.4 2467.9 2470.8 2473.4 2408.9 2440.6 2448.6 2451.5 2451.5 2358.1 2391.6 2397.0 2398.4 2400.1 2407.3 2431.1 2443.5 2462.1 2463.8 8876.8 8886.2 8901.1 8920.0 8939.3 5248.3 5396.2 5408.3 5446.4 5453.0 3456.6 3471.9 3518.2 3577.2 3595.3 1171.4 1177.9 1207.8 1231.2 1265.5 12485.3 12504.0 12522.6 12534.1 12590.7 4819.5 4935.0 4979.3 5044.1 5129.6 10709.0 10715.3 10732.0 10757.8 10773.3 5309.1 5357.1 5357.2 5378.1 5412.5 4731.1 4895.2 4916.3 4934.0 4980.4 3912.0 3970.2 3972.5 4117.2 4174.9 1219.5 1225.3 1225.4 1225.5 1242.4 1061.4 1064.7 1065.4 1074.8 1082.3 6212.5 6344.2 6345.2 6367.7 6389.8 499.4 500.2 503.9 513.1 514.7 4257.5 4347.8 4388.5 4483.1 4504.1 10815.7 10902.9 11112.8 11151.2 11172.3 10603.6 10852.9 10906.2 10916.3 10916.9 8260.3 8390.7 8393.7 8439.1 8523.4 6075.1 6205.3 6209.0 6269.9 6297.1 9726.5 9856.0 9905.1 9954.3 10021.6 9821.3 10123.1 10130.6 10356.8 10362.3 6943.1 7218.5 7241.2 7409.2 7421.4 8159.4 8175.4 8201.2 8217.7 8220.9 7314.1 7526.1 7549.1 7593.9 7631.0 7319.4 7412.3 7434.3 7456.7 7481.7 7056.3 7115.0 7125.3 7150.2 7189.9 5369.5 5425.3 5460.6 5578.1 5586.4 5200.5 5270.9 5291.4 5332.9 5420.1 11:11:44 INFO - PROCESS | 10851 | 11:11:44 INFO - PROCESS | 10851 | [#4] prototype.html Cycles:180 Average:5951.87 Median:6782.47 stddev:1792.80 (26.4%) stddev-sans-first:1747.86 11:11:44 INFO - PROCESS | 10851 | Values: 351.4 352.5 364.3 381.4 383.0 6581.7 6604.6 6683.4 6706.8 6735.6 6690.0 6720.3 6754.3 6756.7 6787.5 5091.9 5114.2 5118.1 5118.8 5131.2 5110.4 5128.3 5134.0 5141.7 5142.7 5098.1 5098.8 5100.5 5105.4 5122.0 4991.4 5079.8 5092.1 5093.3 5133.9 4449.1 4459.2 4469.1 4475.4 4486.3 6504.5 6535.6 6546.4 6548.4 6550.9 5925.9 5984.7 5988.1 5993.4 5995.7 7029.0 7109.5 7119.8 7127.3 7133.3 4924.5 4998.1 5014.4 5016.5 5024.4 7416.2 7461.4 7466.6 7470.9 7479.1 5086.1 5118.5 5121.5 5128.0 5129.6 5189.9 5194.6 5199.9 5205.3 5217.5 5950.3 5956.1 5981.4 5983.0 5989.7 7037.4 7173.1 7192.7 7205.3 7211.9 1763.7 1781.1 1787.0 1787.3 1794.1 1112.9 1180.5 1194.2 1195.1 1203.0 6777.5 6857.6 6857.6 6866.2 6866.3 7311.0 7314.5 7320.9 7333.3 7333.9 6769.8 6794.5 6809.4 6816.3 6820.6 3914.0 3920.5 3962.2 3972.9 3991.4 7561.2 7597.7 7603.4 7613.2 7627.3 7390.7 7446.7 7454.6 7468.9 7478.5 7572.4 7572.7 7592.6 7598.4 7608.4 7106.1 7295.7 7310.5 7317.0 7357.8 7198.9 7208.2 7215.7 7223.0 7245.1 7519.2 7539.5 7564.4 7599.1 7603.5 4933.9 4944.5 4946.4 4947.7 4960.2 7177.9 7290.0 7311.5 7318.8 7334.4 7042.5 7046.2 7101.7 7107.6 7112.9 6985.0 6986.5 7034.3 7060.2 7076.0 6892.5 6926.4 6942.9 6944.1 6946.0 6995.8 7117.2 7117.9 7252.4 7293.7 6964.8 7046.8 7093.7 7103.6 7105.0 11:11:44 INFO - PROCESS | 10851 | 11:11:44 INFO - PROCESS | 10851 | [#5] yui.html Cycles:180 Average:15742.64 Median:51596.74 stddev:18899.56 (36.6%) stddev-sans-first:18919.31 11:11:44 INFO - PROCESS | 10851 | Values: 810.4 823.7 841.1 895.8 907.5 15225.6 15277.9 15316.4 15394.5 15432.8 12810.9 14112.6 14137.4 14162.6 14254.6 865.6 886.0 887.8 892.4 898.0 889.2 890.9 892.7 896.7 898.9 938.7 939.9 943.2 944.7 945.7 930.9 938.2 938.5 942.2 943.4 686.5 686.9 687.1 690.7 693.4 13867.6 13869.7 13947.5 13950.3 13959.7 14700.6 14781.4 14856.9 14882.7 15000.2 12039.9 12105.4 12238.1 12322.5 12323.4 4006.9 4025.8 4124.5 4230.0 4247.3 59917.0 60333.4 60592.0 61088.1 61138.7 11608.2 11630.9 11632.4 11651.8 11751.1 18783.7 18836.2 18878.2 18885.3 18893.5 8723.9 8837.0 8845.5 8913.5 9278.3 4906.5 4922.8 4948.4 4959.0 5026.3 3781.1 3827.8 3835.4 3856.8 3861.4 649.1 660.5 662.7 667.1 669.2 625.3 702.9 806.3 822.0 823.4 9402.9 9481.5 9667.0 9701.5 9757.3 670.8 738.1 773.7 775.5 818.4 4191.0 4597.6 4608.6 4648.2 4659.6 67254.0 67736.0 70079.6 71038.3 71632.3 56053.4 56999.7 57045.7 59026.8 59673.0 52326.7 52434.5 53559.0 53586.7 54673.5 9081.0 9105.9 9268.1 9306.1 9367.3 39616.4 40080.0 40113.8 40781.6 41191.4 48633.9 51525.0 51668.5 51706.5 52445.7 11066.3 11084.9 11206.8 11271.3 11384.0 12831.7 13021.7 13042.2 13461.7 13801.0 12166.9 12168.5 12200.3 12425.5 12853.1 11815.5 12141.9 12407.9 12524.4 12551.4 11116.3 11199.8 11629.0 11869.4 12104.2 9885.6 10130.2 10340.3 10355.6 10849.5 9511.4 9669.3 9735.5 9738.8 9745.6 11:11:44 INFO - PROCESS | 10851 | -------- Summary: end -------- 11:11:44 INFO - PROCESS | 10851 | 11:11:45 INFO - TEST-INFO | 10851: exit 0 11:11:45 INFO - TEST-OK | dromaeo_css | took 1109278ms 11:11:45 INFO - TEST-START | kraken 11:11:45 INFO - operating with platform_type : linux_ 11:11:45 INFO - Initialising browser for kraken test... 11:11:45 INFO - TEST-INFO | started process 11098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd5hZrd/profile http://localhost:48606/getInfo.html) 11:11:48 INFO - PROCESS | 11098 | 11:11:48 INFO - PROCESS | 11098 | (process:11177): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:11:49 INFO - PROCESS | 11098 | __metrics Screen width/height:1600/1200 11:11:49 INFO - PROCESS | 11098 | colorDepth:24 11:11:49 INFO - PROCESS | 11098 | Browser inner width/height: 1024/697 11:11:49 INFO - PROCESS | 11098 | __metrics 11:11:50 ERROR - PROCESS | 11098 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:11:51 INFO - TEST-INFO | 11098: exit 0 11:11:51 INFO - Browser initialized. 11:11:51 INFO - Running cycle 1/1 for kraken test... 11:11:51 INFO - TEST-INFO | started process 11228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd5hZrd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:53 INFO - PROCESS | 11228 | 11:11:53 INFO - PROCESS | 11228 | (process:11295): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:12:03 INFO - PROCESS | 11228 | RSS: Main: 152666112 11:12:03 INFO - PROCESS | 11228 | 11:12:05 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48606/tests/kraken/driver.html?testName=audio-beat-detection) 11:12:06 INFO - PROCESS | 11228 | RSS: Main: 157265920 11:12:06 INFO - PROCESS | 11228 | 11:12:09 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48606/tests/kraken/driver.html?testName=audio-dft) 11:12:09 INFO - PROCESS | 11228 | RSS: Main: 157143040 11:12:09 INFO - PROCESS | 11228 | 11:12:12 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48606/tests/kraken/driver.html?testName=audio-fft) 11:12:13 INFO - PROCESS | 11228 | RSS: Main: 157384704 11:12:13 INFO - PROCESS | 11228 | 11:12:15 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48606/tests/kraken/driver.html?testName=audio-oscillator) 11:12:15 INFO - PROCESS | 11228 | RSS: Main: 157360128 11:12:15 INFO - PROCESS | 11228 | 11:12:18 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48606/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:12:18 INFO - PROCESS | 11228 | RSS: Main: 157237248 11:12:18 INFO - PROCESS | 11228 | 11:12:21 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48606/tests/kraken/driver.html?testName=imaging-darkroom) 11:12:22 INFO - PROCESS | 11228 | RSS: Main: 157093888 11:12:22 INFO - PROCESS | 11228 | 11:12:25 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48606/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:26 INFO - PROCESS | 11228 | RSS: Main: 157548544 11:12:26 INFO - PROCESS | 11228 | 11:12:29 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48606/tests/kraken/driver.html?testName=json-parse-financial) 11:12:29 INFO - PROCESS | 11228 | RSS: Main: 157122560 11:12:29 INFO - PROCESS | 11228 | 11:12:31 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48606/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:31 INFO - PROCESS | 11228 | RSS: Main: 157536256 11:12:31 INFO - PROCESS | 11228 | 11:12:33 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48606/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:34 INFO - PROCESS | 11228 | RSS: Main: 157474816 11:12:34 INFO - PROCESS | 11228 | 11:12:36 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48606/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:36 INFO - PROCESS | 11228 | RSS: Main: 158306304 11:12:36 INFO - PROCESS | 11228 | 11:12:39 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:39 INFO - PROCESS | 11228 | RSS: Main: 158228480 11:12:39 INFO - PROCESS | 11228 | 11:12:42 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:43 INFO - PROCESS | 11228 | RSS: Main: 158097408 11:12:43 INFO - PROCESS | 11228 | 11:12:44 INFO - PROCESS | 11228 | Cycle 1(1): loaded http://localhost:48606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48606/tests/kraken/driver.html?testName=ai-astar) 11:12:45 INFO - PROCESS | 11228 | RSS: Main: 159989760 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | __start_tp_report 11:12:45 INFO - PROCESS | 11228 | _x_x_mozilla_page_load 11:12:45 INFO - PROCESS | 11228 | _x_x_mozilla_page_load_details 11:12:45 INFO - PROCESS | 11228 | |i|pagename|runs| 11:12:45 INFO - PROCESS | 11228 | |0;ai-astar;109;111;105;110;112;111;102;110;111;110 11:12:45 INFO - PROCESS | 11228 | |1;audio-beat-detection;149;126;145;173;128;152;157;131;178;129 11:12:45 INFO - PROCESS | 11228 | |2;audio-dft;162;162;161;163;161;160;162;162;160;161 11:12:45 INFO - PROCESS | 11228 | |3;audio-fft;76;75;74;178;76;76;77;76;161;76 11:12:45 INFO - PROCESS | 11228 | |4;audio-oscillator;93;92;157;92;93;92;144;93;93;150 11:12:45 INFO - PROCESS | 11228 | |5;imaging-gaussian-blur;117;117;119;118;118;117;117;118;118;117 11:12:45 INFO - PROCESS | 11228 | |6;imaging-darkroom;148;147;146;146;146;146;147;146;147;147 11:12:45 INFO - PROCESS | 11228 | |7;imaging-desaturate;96;95;96;97;95;96;95;96;95;96 11:12:45 INFO - PROCESS | 11228 | |8;json-parse-financial;57;56;57;55;56;56;55;70;54;54 11:12:45 INFO - PROCESS | 11228 | |9;json-stringify-tinderbox;57;57;57;57;58;57;57;59;60;58 11:12:45 INFO - PROCESS | 11228 | |10;stanford-crypto-aes;74;73;74;73;75;74;75;74;75;74 11:12:45 INFO - PROCESS | 11228 | |11;stanford-crypto-ccm;128;116;120;113;116;112;118;115;140;129 11:12:45 INFO - PROCESS | 11228 | |12;stanford-crypto-pbkdf2;159;162;160;161;164;159;164;156;164;156 11:12:45 INFO - PROCESS | 11228 | |13;stanford-crypto-sha256-iterative;68;67;68;71;67;69;66;65;65;67 11:12:45 INFO - PROCESS | 11228 | __end_tp_report 11:12:45 INFO - PROCESS | 11228 | __start_cc_report 11:12:45 INFO - PROCESS | 11228 | _x_x_mozilla_cycle_collect,844 11:12:45 INFO - PROCESS | 11228 | __end_cc_report 11:12:45 INFO - PROCESS | 11228 | __startTimestamp1463508765124__endTimestamp 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | ------- Summary: start ------- 11:12:45 INFO - PROCESS | 11228 | Number of tests: 14 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.14 (2.8%) stddev-sans-first:3.33 11:12:45 INFO - PROCESS | 11228 | Values: 109.0 111.0 105.0 110.0 112.0 111.0 102.0 110.0 111.0 110.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:150.50 stddev:18.71 (12.4%) stddev-sans-first:19.83 11:12:45 INFO - PROCESS | 11228 | Values: 149.0 126.0 145.0 173.0 128.0 152.0 157.0 131.0 178.0 129.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 11:12:45 INFO - PROCESS | 11228 | Values: 162.0 162.0 161.0 163.0 161.0 160.0 162.0 162.0 160.0 161.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:39.74 (52.3%) stddev-sans-first:41.58 11:12:45 INFO - PROCESS | 11228 | Values: 76.0 75.0 74.0 178.0 76.0 76.0 77.0 76.0 161.0 76.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.50 stddev:28.07 (30.3%) stddev-sans-first:29.10 11:12:45 INFO - PROCESS | 11228 | Values: 93.0 92.0 157.0 92.0 93.0 92.0 144.0 93.0 93.0 150.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 11:12:45 INFO - PROCESS | 11228 | Values: 117.0 117.0 119.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 11:12:45 INFO - PROCESS | 11228 | Values: 148.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:12:45 INFO - PROCESS | 11228 | Values: 96.0 95.0 96.0 97.0 95.0 96.0 95.0 96.0 95.0 96.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.00 stddev:4.69 (8.4%) stddev-sans-first:4.97 11:12:45 INFO - PROCESS | 11228 | Values: 57.0 56.0 57.0 55.0 56.0 56.0 55.0 70.0 54.0 54.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:57.50 stddev:1.06 (1.8%) stddev-sans-first:1.09 11:12:45 INFO - PROCESS | 11228 | Values: 57.0 57.0 57.0 57.0 58.0 57.0 57.0 59.0 60.0 58.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 11:12:45 INFO - PROCESS | 11228 | Values: 74.0 73.0 74.0 73.0 75.0 74.0 75.0 74.0 75.0 74.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:119.00 stddev:8.91 (7.5%) stddev-sans-first:9.05 11:12:45 INFO - PROCESS | 11228 | Values: 128.0 116.0 120.0 113.0 116.0 112.0 118.0 115.0 140.0 129.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.50 stddev:3.06 (1.9%) stddev-sans-first:3.20 11:12:45 INFO - PROCESS | 11228 | Values: 159.0 162.0 160.0 161.0 164.0 159.0 164.0 156.0 164.0 156.0 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - PROCESS | 11228 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.83 (2.7%) stddev-sans-first:1.92 11:12:45 INFO - PROCESS | 11228 | Values: 68.0 67.0 68.0 71.0 67.0 69.0 66.0 65.0 65.0 67.0 11:12:45 INFO - PROCESS | 11228 | -------- Summary: end -------- 11:12:45 INFO - PROCESS | 11228 | 11:12:45 INFO - TEST-INFO | 11228: exit 0 11:12:46 INFO - TEST-OK | kraken | took 60509ms 11:12:46 INFO - SUITE-END | took 1169s 11:12:46 INFO - Completed test suite (00:19:30) 11:12:46 INFO - javascript benchmark 11:12:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3347.89956301311, 3397.405454045543, 3429.6913277805006, 3437.2609888873885, 3454.55090838191, 5473.425290344511, 5523.392426833055, 5549.19536667183, 5552.11166213406, 5601.7199140042985, 5535.861603459915, 5568.0, 5569.0, 5572.4148964358765, 5604.719764011804, 5009.49905009498, 5013.623978201631, 5057.974710126463, 5095.949040509603, 5137.48625137487, 5082.51716086973, 5123.948760512403, 5172.09488339541, 5187.896242075156, 5190.636655434121, 5063.088644044071, 5094.7197904115255, 5148.253503242027, 5214.921776173361, 5234.084035293828, 5219.973900130513, 5247.449017853128, 5253.711045892474, 5260.289860868791, 5261.76322065508, 5100.056489549445, 5156.458571849977, 5211.400688920747, 5227.529522343008, 5250.422453530108, 5501.779928802843, 5565.1374037024325, 5586.972065139689, 5609.242752228479, 5626.0, 6082.361352058058, 6099.48154406876, 6100.389961003864, 6102.755889764404, 6118.082287656843, 5971.0744834550715, 6164.198654174974, 6167.290761562388, 6182.041783523561, 6185.16500272462, 5689.630174038674, 5753.827385178452, 5796.449337312991, 5796.768129274866, 5813.854653633651, 6269.874602508015, 6278.717457714414, 6281.434670879643, 6293.622382657055, 6307.0, 5984.611000284967, 6035.305939816977, 6038.607490513103, 6050.364711705296, 6053.364396738367, 6054.757809687651, 6085.208922840003, 6099.725512351954, 6119.685352982159, 6138.570300079041, 6071.423214794588, 6073.423024812636, 6073.423024812724, 6075.848103797352, 6096.878062438726, 5830.970845145747, 5894.351621321651, 5896.1450589664255, 5931.940680593225, 6083.482903953213, 4654.325122857167, 4672.159011377985, 4673.205555055649, 4674.22875225584, 4687.414073240845, 4174.5616710244985, 4205.852795152155, 4211.768352740567, 4221.430106935586, 4248.87253382399, 5913.881722365614, 5946.286445626466, 5974.3726908674835, 6016.939830601726, 6029.879402412015, 5984.850378740566, 6147.969260153671, 6246.187995560639, 6255.874882502325, 6262.6868656566985, 5779.248697669276, 5884.617499862496, 5900.76396944126, 5919.348871624118, 5932.851678707981, 5114.130597798383, 5156.278121063054, 5171.741412929338, 5174.301469301671, 5201.08980928336, 6322.0, 6353.174087368612, 6358.554901156875, 6365.904511432333, 6381.298057213703, 5991.101334799815, 6113.263474096328, 6146.477549408351, 6152.107944348134, 6180.47465965398, 6313.526485513697, 6389.93610063912, 6402.647854367868, 6412.903806442814, 6423.004434312689, 6047.969760151171, 6048.3649216833355, 6051.092336149437, 6063.545234107548, 6096.75612975476, 6021.337652858095, 6135.969320153371, 6184.350643182581, 6193.1329613855, 6214.689265536796, 5995.5803093783015, 6042.75828966854, 6060.121282414113, 6065.727042283196, 6070.817875463743, 5978.432048955342, 6027.698615069141, 6045.546584006305, 6049.243844519435, 6057.121717351048, 5794.62334948227, 5852.707364631837, 5900.940990590039, 5988.401159883977, 6017.428344307284, 6056.636601803906, 6067.939320606914, 6083.087536869505, 6106.1451396803595, 6117.449429551361, 5940.0, 5944.702764861653, 5946.851328716817, 5948.643081415129, 5962.403759624003], "value": 5639.3147885994085, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.1875265273513, 665.8634979829136, 674.780696273711, 678.9966050169749, 681.4786688183538, 33675.326493470144, 39981.600183998155, 40322.59677403225, 40449.0, 40705.38941915874, 43574.34638480425, 44484.55515444845, 44487.110257794906, 44569.77715111428, 44593.0, 8805.69180078699, 8949.95525022374, 9039.27685785139, 9047.276217902552, 9057.637694492245, 8669.176428239307, 8847.247983921374, 8855.335849811258, 8873.51195684237, 9149.908500914973, 9124.133207345325, 9144.771380715469, 9153.908460915372, 9172.807535020438, 9195.72412827613, 8944.64221431142, 9069.455832649996, 9070.818583628357, 9097.63609455621, 9152.771180720469, 9068.954655226682, 9170.724878253663, 9177.08229177077, 9179.127982841686, 9180.265578753684, 43272.56727432717, 44038.55961440376, 44053.55946440527, 44055.779721101186, 44218.33672494915, 3812.5615554211067, 3822.0, 3841.635044670752, 3870.883873483772, 4114.567970363129, 34484.655153448395, 34642.48036279458, 34698.82650586756, 34822.82588587041, 34843.825780871186, 3936.665383442411, 3971.748899096804, 4086.9578257544135, 4126.401671757609, 4161.854335098287, 280020.0, 280387.0, 280669.0, 283134.0, 284736.0, 39767.0, 63353.68323158355, 63468.36531634717, 63724.0, 63945.0, 38456.615433845305, 38571.0, 38604.0, 38704.419433708514, 38758.80620596879, 15813.130277834829, 15842.207889605474, 15918.681626367408, 15970.60073498172, 16012.359505619645, 13582.660433489043, 13588.38852251651, 13595.524156654668, 13655.795163072562, 13662.18026918388, 9350.345475816763, 9440.0, 9481.525923703788, 9486.478243696525, 9581.993890641521, 3630.618785027587, 3648.689861361761, 3657.926841463156, 3673.651003154696, 3674.853005879735, 1152.0610702277618, 1213.4418167642982, 1262.7916393795106, 1263.4946021591436, 1286.7490839286436, 33155.171120722174, 33155.66844331574, 33625.49561756576, 33766.98699039033, 34322.31355372879, 1214.7145420826098, 1226.0926914083514, 1290.393515047926, 1324.993375033138, 1388.3544151969384, 17729.024903630423, 17761.378351757627, 17782.37761678335, 17929.37247196368, 18065.27738890456, 465113.0, 575272.0, 576039.0, 576275.0, 582861.0, 57637.0, 58663.413365865796, 58677.0, 58998.0, 59061.70469147627, 1562.6718389138182, 1573.3627880708102, 1575.054967019779, 1578.0373971877375, 1657.651893102438, 31509.36981260316, 32231.0, 32898.0, 33318.33363332768, 34638.653613463546, 55950.44049559615, 56545.43454565566, 56628.0, 56708.71645641745, 57145.0, 411458.0, 413270.0, 413984.0, 414384.0, 415288.0, 31318.0, 31968.52047219247, 32002.83998579992, 32029.0, 32502.02493925186, 52703.73648131735, 52823.207651884484, 53232.73383633057, 55460.445395545525, 59348.0, 41918.58081419147, 41969.58030419657, 42013.57986420219, 42288.365674514294, 43577.56422435735, 40675.79662101671, 42024.78987605165, 42233.09951052148, 42556.36165457459, 42700.5729942709, 42237.155256895305, 42277.36583951182, 42397.576024239366, 42920.57079429291, 43479.56520434755, 36553.45169822402, 36647.231922940366, 36861.81569092137, 37528.24943501169, 37718.0, 29377.71776899681, 29545.852270739368, 30061.849690751405, 30075.849620752633, 30207.69792302137], "value": 19768.41747669218, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.1642338498392, 438.57239191788, 439.25765456378736, 449.7885993583016, 450.24002862453176, 19157.616847663056, 19183.808161918394, 19672.11475483603, 20792.48018799531, 20844.374668759963, 19820.702689459635, 20185.29351472699, 20214.292499762512, 20266.392008239738, 20528.178872845107, 5512.200730894018, 5929.051351783715, 5948.732307046172, 5966.343702192756, 5969.22400087988, 4442.267025940716, 5721.141828725704, 5824.592278540504, 6344.270408902966, 6638.269790323085, 6502.219733631947, 6555.672216389162, 6562.278149403562, 6576.6711664416825, 6595.53831231814, 6408.6475243861805, 6421.0, 6584.967075164594, 6588.374104460068, 6613.27254002057, 5839.416058394127, 5870.794522191745, 5890.1164825276555, 5896.086106653475, 5902.675352855591, 21036.789632103635, 22438.663420048713, 22465.0, 22643.547129057326, 23124.42188945273, 2442.4504486490573, 2468.8518688878726, 2522.9116980905765, 2566.358410397401, 2803.9439211215868, 10491.527881245285, 10513.421761803098, 10659.893401065967, 10684.252102352839, 10799.4060326682, 2016.3043749906258, 2032.674772036482, 2068.307117115768, 2094.2356040045424, 2161.740591129059, 71563.28436715619, 73399.89900151448, 74966.25033749647, 78704.0, 79871.0, 10199.643012494527, 11047.889521104848, 11980.28118312904, 12057.939710301393, 12135.211211271238, 16754.83245167557, 16765.0, 16856.07291598974, 16931.407400740914, 17051.31794728222, 8361.289290410383, 8529.57352132391, 8562.229399353964, 8564.74305770828, 8589.184027517376, 8721.967951977864, 8740.21338079576, 8761.649534018696, 8801.559922004002, 8841.204291613785, 4491.573300536509, 4856.635752318591, 4896.706197628082, 4957.652964292537, 4963.478834722375, 2044.4786579422152, 2058.536829213445, 2142.4750936020773, 2189.168116115866, 2220.222921977327, 1029.5161274201114, 1031.9638812641522, 1073.9140868730483, 1116.0346300450053, 1140.5551834784442, 17796.288148474174, 18036.90981545084, 18514.722279165824, 18694.158762855703, 19026.0, 1094.0372472224392, 1135.5798354608683, 1138.4763009015946, 1147.0880649883363, 1168.976620467586, 10841.0, 11064.391458469701, 11099.0, 11167.0, 11293.713452482616, 488075.0, 496030.0, 497308.0, 502404.0, 511090.0, 59802.70098649479, 61515.0, 101027.0, 102640.0, 103699.48150259201, 1081.6917178604217, 1112.8219484882543, 1119.216548416112, 1121.450489260273, 1137.2778285788584, 17338.0, 17739.645207095527, 17915.641687165924, 17962.101894905463, 18231.817681823544, 26607.60088598634, 29527.114186574436, 40395.1920961585, 40617.0, 40994.0, 59899.10151347646, 60230.0, 60642.696786515786, 60645.39354606398, 60747.392526074174, 8727.781805454915, 8767.56162191875, 8790.516521591373, 8801.559922003746, 8965.282777377925, 7977.00287464067, 9996.400215987063, 12820.846123848898, 13243.608071288838, 13640.181589104686, 11522.0, 12374.071944604011, 12408.379581021094, 12538.49846006186, 12712.491500339884, 11440.82838757436, 11770.058395328524, 11816.663758941462, 11944.0, 12163.939180304042, 12048.277103373826, 12225.327606981702, 12284.754304913673, 12379.62861114168, 12411.193272437262, 8939.284857211278, 8966.058563850702, 8994.280457563249, 9132.132447417485, 9147.451152930846, 9364.531773411438, 11825.34960577142, 12112.75774484523, 12126.393680316125, 12158.088143389457], "value": 9547.75571882951, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1577.2429233967696, 1577.416355948299, 1818.2181661885393, 1905.380751255843, 1923.0096500302357, 7790.0, 8474.576271186446, 8513.2338089572, 8706.956465217672, 8745.65017399304, 8488.0, 8544.359173062014, 8555.058943516207, 8582.957085214564, 8609.311255099592, 2459.6310553416997, 2472.49313890652, 2484.503099380131, 2485.453200295941, 2487.2786891801356, 2406.8194885383577, 2459.4220358215807, 2467.8766061696933, 2470.7776300133073, 2473.356927198932, 2408.8678321189013, 2440.6339049142593, 2448.608222684371, 2451.509698060386, 2451.534208500379, 2358.1039205102124, 2391.5575618510543, 2396.9640455393182, 2398.3764221302413, 2400.099962514057, 2407.3139155340646, 2431.088341871798, 2443.499082688045, 2462.1259452894324, 2463.802895768334, 8876.778080547974, 8886.155815197546, 8901.065388134282, 8920.0, 8939.329550283755, 5248.291480650101, 5396.244525766396, 5408.269883565747, 5446.428125046892, 5453.0, 3456.585209774818, 3471.9132021699406, 3518.1732292911147, 3577.159367548624, 3595.334863050344, 1171.4377098992445, 1177.911656625748, 1207.7946749052683, 1231.1689609513542, 1265.5064524835323, 12485.250884946841, 12504.0, 12522.561710340095, 12534.122611417204, 12590.68523286916, 4819.469858315582, 4935.0, 4979.278004689299, 5044.092063428545, 5129.640925135204, 10709.036186743075, 10715.303505272288, 10732.0, 10757.83863242052, 10773.299735517166, 5309.070912590281, 5357.062514060024, 5357.196420536873, 5378.11261141915, 5412.539934105566, 4731.101090792738, 4895.192293271642, 4916.311716359713, 4934.037862616827, 4980.427250866124, 3911.9804400978383, 3970.2059588082498, 3972.503437070366, 4117.176564687014, 4174.853880114242, 1219.5000049979467, 1225.3444407242082, 1225.3934302520308, 1225.4791713521718, 1242.3974372429363, 1061.3950048472298, 1064.744461329291, 1065.4406436620682, 1074.8172810622214, 1082.3289560472558, 6212.502999760009, 6344.175257216532, 6345.17512723343, 6367.713452894538, 6389.7763578274535, 499.383261671835, 500.1996805111792, 503.91685371913223, 513.0815839647065, 514.7091893080473, 4257.489101307801, 4347.804348804311, 4388.495323037828, 4483.058557702853, 4504.09918016398, 10815.729606759895, 10902.945485272681, 11112.833307500394, 11151.163662725328, 11172.273802202832, 10603.57585696579, 10852.94573527143, 10906.236563440483, 10916.345019298868, 10916.945415272872, 8260.297874680598, 8390.706325278708, 8393.664253429917, 8439.113893041265, 8523.40336176474, 6075.088736689532, 6205.348438413902, 6209.0, 6269.874602507833, 6297.149884765498, 9726.465044422624, 9855.950720246354, 9905.059019393146, 9954.25343099256, 10021.649242276486, 9821.263405244777, 10123.139533139765, 10130.645427410005, 10356.792864142826, 10362.274640775073, 6943.062686537455, 7218.494705370574, 7241.239669834592, 7409.222031686595, 7421.443391745533, 8159.428839981382, 8175.427720059776, 8201.179882011751, 8217.712380066669, 8220.876686849822, 7314.08573928259, 7526.134494533198, 7549.131849837119, 7593.8860917085185, 7631.0, 7319.4144468443465, 7412.295831895961, 7434.256574342522, 7456.66445009965, 7481.738139165321, 7056.259092795388, 7115.003899454184, 7125.28747125304, 7150.213476517475, 7189.856202876018, 5369.4630536946, 5425.294711687456, 5460.590455715757, 5578.135389014709, 5586.413426590149, 5200.5059519345605, 5270.947290527046, 5291.391489978548, 5332.920006199987, 5420.105682562333], "value": 4673.385795119896, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.4429629037975, 352.4818516780333, 364.27327481674047, 381.35741275950045, 383.04621492483705, 6581.70382332795, 6604.570702904308, 6683.398494135527, 6706.798796036121, 6735.595864248148, 6689.966550167254, 6720.260771315164, 6754.324567543244, 6756.729730810774, 6787.4909381796315, 5091.898162036757, 5114.156164232897, 5118.07874582575, 5118.769655365518, 5131.230315452684, 5110.361204849394, 5128.333316668828, 5134.024535338273, 5141.691498510083, 5142.66572672777, 5098.082345177866, 5098.770555325001, 5100.489951004888, 5105.361829771278, 5122.026814905174, 4991.40103187618, 5079.79680812767, 5092.083424983502, 5093.286939828427, 5133.948660513384, 4449.132419178261, 4459.219636563621, 4469.061497085616, 4475.373447717322, 4486.327050942385, 6504.5121615879, 6535.575187612838, 6546.410823025903, 6548.410643042149, 6550.9344906550805, 5925.8814823703715, 5984.73068711909, 5988.101784732282, 5993.430624090704, 5995.700214989233, 7028.964855175692, 7109.537880037781, 7119.750808721722, 7127.287271272883, 7133.25100864407, 4924.532169443897, 4998.075356059141, 5014.448410674823, 5016.523430274118, 5024.371953505812, 7416.22129676387, 7461.440391970569, 7466.589337586431, 7470.925290747077, 7479.139898911641, 5086.0845047891735, 5118.539331460186, 5121.53906148441, 5128.025710101563, 5129.563987061067, 5189.922151167735, 5194.6104042196985, 5199.948000520022, 5205.323307970016, 5217.50433708797, 5950.315713692894, 5956.076808094752, 5981.431763982415, 5983.0, 5989.670568118708, 7037.366637002694, 7173.139223293134, 7192.7122915083855, 7205.279472052753, 7211.927880721126, 1763.6737203617372, 1781.118346418531, 1786.97319540207, 1787.2672204396135, 1794.0581194872796, 1112.8887111288807, 1180.527788884436, 1194.235689158939, 1195.1036722458157, 1202.9819552706717, 6777.457803375718, 6857.588544687334, 6857.588544687334, 6866.176058872968, 6866.279040700754, 7310.976463295143, 7314.524555903849, 7320.853582928312, 7333.339999400079, 7333.88999165013, 6769.830754231184, 6794.524383293122, 6809.38715515606, 6816.284290149562, 6820.590764554143, 3914.0, 3920.4707364506, 3962.187751510933, 3972.940405893914, 3991.3613821788376, 7561.243875612395, 7597.734079307198, 7603.353714934182, 7613.200613935568, 7627.275408836152, 7390.7413240536325, 7446.7021319146625, 7454.589997550187, 7468.887966680504, 7478.513896596813, 7572.356349710226, 7572.734954276574, 7592.582407967615, 7598.430117741081, 7608.353289970304, 7106.111736032996, 7295.671694773854, 7310.451716121419, 7316.9634151828905, 7357.816054598464, 7198.856022879409, 7208.243134471015, 7215.67529461186, 7222.96388518075, 7245.058142441449, 7519.248075192437, 7539.547627142389, 7564.357029652541, 7599.088109426683, 7603.543787372775, 4933.925991110064, 4944.505549445027, 4946.3817022872145, 4947.6536642434685, 4960.181570040902, 7177.928220717726, 7290.0, 7311.488195826241, 7318.780436586911, 7334.376577990931, 7042.542234754929, 7046.189688185924, 7101.715931362688, 7107.60908150036, 7112.928870711226, 6984.965075174591, 6986.545874518343, 7034.261402552658, 7060.223375428802, 7076.0, 6892.483063770337, 6926.376626103674, 6942.895856562257, 6944.097267355211, 6945.965270173617, 6995.825104372431, 7117.181524124792, 7117.928820711727, 7252.38354739853, 7293.671784769592, 6964.756233531802, 7046.823829404306, 7093.716251349888, 7103.644817758988, 7105.0408194893025], "value": 5361.2341460748985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.3517186250998, 823.6828820903952, 841.0538144587339, 895.7671005538562, 907.4555266839895, 15225.619359516004, 15277.923610381946, 15316.387344506235, 15394.538163855073, 15432.768508472382, 12810.871891281084, 14112.57662270131, 14137.434502619908, 14162.575122746308, 14254.643633909158, 865.6234537975969, 886.0, 887.7970350175516, 892.3797960417512, 897.9987314144747, 889.1730690457872, 890.8619164029586, 892.6563273139856, 896.6816780043089, 898.874157617934, 938.6667732954805, 939.891912430069, 943.2359788571245, 944.7354740672588, 945.678469320431, 930.9208717259041, 938.1931538876561, 938.4932136646237, 942.185009966381, 943.3679434778714, 686.4817063117364, 686.9003994420831, 687.082744536045, 690.7409721354492, 693.414065114977, 13867.583972480841, 13869.653258668513, 13947.511837085653, 13950.302484875818, 13959.65100872476, 14700.632484187874, 14781.408743650241, 14856.851431485655, 14882.702345953128, 15000.24998750069, 12039.93980030103, 12105.394730263539, 12238.08214383916, 12322.507099716, 12323.383830808423, 4006.8998275043064, 4025.778582177979, 4124.463819703449, 4229.957700422987, 4247.256730072225, 59917.0, 60333.396666033215, 60592.0, 61088.08367874441, 61138.69430652818, 11608.24546404481, 11630.88369116315, 11632.360220187971, 11651.76696466066, 11751.118666100077, 18783.718244226347, 18836.246550138116, 18878.15048322801, 18885.339013134748, 18893.527661808566, 8723.869141962876, 8837.029473287608, 8845.469271843709, 8913.451553638562, 9278.304127190488, 4906.460289368167, 4922.803087876445, 4948.4309304429735, 4959.0, 5026.346574945307, 3781.1303400218103, 3827.770333779926, 3835.4055121456217, 3856.8071596420627, 3861.38217885137, 649.1463725201345, 660.5475249454139, 662.7282814046314, 667.0827612033454, 669.2470970158572, 625.3256904637796, 702.9015937768717, 806.2985202873538, 821.9630116644646, 823.4441751817499, 9402.858957115648, 9481.4785186814, 9667.0, 9701.51492425376, 9757.268204884662, 670.7518218259178, 738.062660421262, 773.7407968330559, 775.5308038636543, 818.3862103422433, 4191.0, 4597.563231493003, 4608.585227329557, 4648.1865673507, 4659.58063774262, 67254.0, 67736.0, 70079.64960175268, 71038.28961710316, 71632.28367716256, 56053.439465604824, 56999.71500142556, 57045.714771426705, 59026.8303774444, 59673.0, 52326.73836630792, 52434.47565524296, 53559.0, 53586.73206633942, 54673.45326546763, 9081.046490118442, 9105.908940910505, 9268.119528644767, 9306.115918987685, 9367.297452690938, 39616.40575391429, 40080.0, 40113.799431002655, 40781.59218407778, 41191.382129268684, 48633.85799300362, 51525.0, 51668.48331516787, 51706.48293517167, 52445.73777131242, 11066.336019838835, 11084.944575277072, 11206.7758644825, 11271.267367621078, 11384.032357249727, 12831.679208019874, 13021.739565208833, 13042.217466952014, 13461.730765384442, 13801.0, 12166.939165304117, 12168.513259469522, 12200.328981906081, 12425.502979881065, 12853.100282980102, 11815.527378905092, 12141.878581214074, 12407.875921240671, 12524.436400362189, 12551.435185416862, 11116.333020018825, 11199.776004479701, 11629.0, 11869.406529673655, 12104.152709310263, 9885.55515001841, 10130.240231982483, 10340.327878687862, 10355.593237245146, 10849.45752712377, 9511.429314241168, 9669.27480438984, 9735.513224338896, 9738.805223895624, 9745.561449734638], "value": 7062.193780497456, "unit": "score"}], "name": "dromaeo_css", "value": 7571.150570648233, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 105.0, 110.0, 112.0, 111.0, 102.0, 110.0, 111.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 145.0, 173.0, 128.0, 152.0, 157.0, 131.0, 178.0, 129.0], "value": 146.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 161.0, 160.0, 162.0, 162.0, 160.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 178.0, 76.0, 76.0, 77.0, 76.0, 161.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 157.0, 92.0, 93.0, 92.0, 144.0, 93.0, 93.0, 150.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 97.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 55.0, 56.0, 56.0, 55.0, 70.0, 54.0, 54.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 57.0, 59.0, 60.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 73.0, 75.0, 74.0, 75.0, 74.0, 75.0, 74.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 116.0, 120.0, 113.0, 116.0, 112.0, 118.0, 115.0, 140.0, 129.0], "value": 120.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 160.0, 161.0, 164.0, 159.0, 164.0, 156.0, 164.0, 156.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 71.0, 67.0, 69.0, 66.0, 65.0, 65.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1518.9, "alertThreshold": 2.0}]} 11:12:46 INFO - Return code: 0 11:12:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:12:46 ERROR - # TBPL SUCCESS # 11:12:46 INFO - Running post-action listener: _resource_record_post_action 11:12:46 INFO - Running post-run listener: _resource_record_post_run 11:12:47 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 385024; Write bytes: 256409600; Read time: 68; Write time: 261244 11:12:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 6942720; Read time: 0; Write time: 488 11:12:47 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 385024; Write bytes: 249466880; Read time: 68; Write time: 260756 11:12:47 INFO - Running post-run listener: _upload_blobber_files 11:12:47 INFO - Blob upload gear active. 11:12:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:12:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:12:47 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:12:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:12:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:48 INFO - (blobuploader) - INFO - Done attempting. 11:12:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:12:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:12:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:50 INFO - (blobuploader) - INFO - Done attempting. 11:12:50 INFO - (blobuploader) - INFO - Iteration through files over. 11:12:50 INFO - Return code: 0 11:12:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:12:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:12:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6aebc84f91cd5324513d48a344d9f7bffefbed2a17dbad3e9a95f0f96ea28e4c96f7df645e25e5d03074e9752335f2131a3fc2e389cae01027125f8bd543fdc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7405096775b2da73cd5371667fe34a634203bf27ad58a985c4acee3d9870fb18d36021d900f770d879a31da7368d1bb6a38e3923de73dd92b545427b2c9cd529"} 11:12:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:12:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:12:50 INFO - Contents: 11:12:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6aebc84f91cd5324513d48a344d9f7bffefbed2a17dbad3e9a95f0f96ea28e4c96f7df645e25e5d03074e9752335f2131a3fc2e389cae01027125f8bd543fdc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7405096775b2da73cd5371667fe34a634203bf27ad58a985c4acee3d9870fb18d36021d900f770d879a31da7368d1bb6a38e3923de73dd92b545427b2c9cd529"} 11:12:50 INFO - Running post-run listener: copy_logs_to_upload_dir 11:12:50 INFO - Copying logs to upload dir... 11:12:50 INFO - mkdir: /builds/slave/test/build/upload/logs 11:12:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.489312 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-17 11:12:50.052308) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:50.056907) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056 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-Aurora/sha512/6aebc84f91cd5324513d48a344d9f7bffefbed2a17dbad3e9a95f0f96ea28e4c96f7df645e25e5d03074e9752335f2131a3fc2e389cae01027125f8bd543fdc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7405096775b2da73cd5371667fe34a634203bf27ad58a985c4acee3d9870fb18d36021d900f770d879a31da7368d1bb6a38e3923de73dd92b545427b2c9cd529"} build_url:https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6aebc84f91cd5324513d48a344d9f7bffefbed2a17dbad3e9a95f0f96ea28e4c96f7df645e25e5d03074e9752335f2131a3fc2e389cae01027125f8bd543fdc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7405096775b2da73cd5371667fe34a634203bf27ad58a985c4acee3d9870fb18d36021d900f770d879a31da7368d1bb6a38e3923de73dd92b545427b2c9cd529"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:50.084682) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:50.085036) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1463506498.653242-1016605056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:50.166393) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:12:50.169745) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:12:50.170074) ========= ========= Total master_lag: 0.19 =========