builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1463479689.85 results: success (0) buildid: 20160517004009 builduid: ef91a013044b49f4abd91345e579e6b6 revision: 17724486e1591858eea09dc327475a25883854a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:09.849837) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:09.850275) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:09.850613) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:09.867768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:09.868408) ========= 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=ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 03:08:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.4M=0s 2016-05-17 03:08:10 (38.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098717 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:09.982831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:09.983207) ========= 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=ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022485 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:10.036331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:10.037182) ========= 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=ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 03:08:10,213 truncating revision to first 12 chars 2016-05-17 03:08:10,213 Setting DEBUG logging. 2016-05-17 03:08:10,213 attempt 1/10 2016-05-17 03:08:10,213 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 03:08:10,498 unpacking tar archive at: mozilla-aurora-17724486e159/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549606 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:10.606643) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:10.606963) ========= script_repo_revision: 17724486e1591858eea09dc327475a25883854a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:10.607384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:10.607712) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 03:08:10.622054) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-17 03:08:10.622596) ========= /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=ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:08:10 INFO - MultiFileLogger online at 20160517 03:08:10 in /builds/slave/test 03:08:10 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 03:08:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:08:10 INFO - {'append_to_log': False, 03:08:10 INFO - 'base_work_dir': '/builds/slave/test', 03:08:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:08:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:08:10 INFO - 'branch': 'Mozilla-Aurora', 03:08:10 INFO - 'buildbot_json_path': 'buildprops.json', 03:08:10 INFO - 'config_files': ('talos/linux_config.py',), 03:08:10 INFO - 'default_actions': ('clobber', 03:08:10 INFO - 'read-buildbot-config', 03:08:10 INFO - 'download-and-extract', 03:08:10 INFO - 'populate-webroot', 03:08:10 INFO - 'create-virtualenv', 03:08:10 INFO - 'install', 03:08:10 INFO - 'run-tests'), 03:08:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:08:10 INFO - 'download_minidump_stackwalk': True, 03:08:10 INFO - 'download_symbols': 'ondemand', 03:08:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:08:10 INFO - 'tooltool.py': '/tools/tooltool.py', 03:08:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:08:10 INFO - '/tools/misc-python/virtualenv.py')}, 03:08:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:08:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:08:10 INFO - 'installer_path': 'installer.exe', 03:08:10 INFO - 'log_level': 'info', 03:08:10 INFO - 'log_name': 'talos', 03:08:10 INFO - 'log_to_console': True, 03:08:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:08:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:08:10 INFO - 'opt_config_files': (), 03:08:10 INFO - 'pip_index': False, 03:08:10 INFO - 'sps_profile': False, 03:08:10 INFO - 'sps_profile_interval': 0, 03:08:10 INFO - 'suite': 'dromaeojs-e10s', 03:08:10 INFO - 'system_bits': '32', 03:08:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:08:10 INFO - 'title': 'talos-linux64-ix-035', 03:08:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:08:10 INFO - 'use_talos_json': True, 03:08:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:08:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:08:10 INFO - 'work_dir': 'build'} 03:08:10 INFO - ##### 03:08:10 INFO - ##### Running clobber step. 03:08:10 INFO - ##### 03:08:10 INFO - Running pre-action listener: _resource_record_pre_action 03:08:10 INFO - Running main action method: clobber 03:08:10 INFO - rmtree: /builds/slave/test/build 03:08:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:08:11 INFO - Running post-action listener: _resource_record_post_action 03:08:11 INFO - ##### 03:08:11 INFO - ##### Running read-buildbot-config step. 03:08:11 INFO - ##### 03:08:11 INFO - Running pre-action listener: _resource_record_pre_action 03:08:11 INFO - Running main action method: read_buildbot_config 03:08:11 INFO - Using buildbot properties: 03:08:11 INFO - { 03:08:11 INFO - "project": "", 03:08:11 INFO - "product": "firefox", 03:08:11 INFO - "script_repo_revision": "production", 03:08:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:08:11 INFO - "repository": "", 03:08:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:08:11 INFO - "buildid": "20160517004009", 03:08:11 INFO - "stage_platform": "linux64-pgo", 03:08:11 INFO - "basedir": "/builds/slave/test", 03:08:11 INFO - "nightly_build": "True", 03:08:11 INFO - "buildnumber": 271, 03:08:11 INFO - "slavename": "talos-linux64-ix-035", 03:08:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:08:11 INFO - "platform": "ubuntu64_hw", 03:08:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:08:11 INFO - "branch": "mozilla-aurora", 03:08:11 INFO - "repo_path": "releases/mozilla-aurora", 03:08:11 INFO - "revision": "17724486e1591858eea09dc327475a25883854a4", 03:08:11 INFO - "pgo_build": "True", 03:08:11 INFO - "builduid": "ef91a013044b49f4abd91345e579e6b6", 03:08:11 INFO - "slavebuilddir": "test" 03:08:11 INFO - } 03:08:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:08:11 INFO - Running post-action listener: _resource_record_post_action 03:08:11 INFO - ##### 03:08:11 INFO - ##### Running download-and-extract step. 03:08:11 INFO - ##### 03:08:11 INFO - Running pre-action listener: _resource_record_pre_action 03:08:11 INFO - Running main action method: download_and_extract 03:08:11 INFO - mkdir: /builds/slave/test/build/tests 03:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:11 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 03:08:11 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 03:08:11 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 03:08:11 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 03:08:11 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 03:08:14 INFO - Downloaded 1361 bytes. 03:08:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:08:14 INFO - Using the following test package requirements: 03:08:14 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:14 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:14 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:08:14 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:14 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:08:14 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:14 INFO - u'jsshell-linux-x86_64.zip'], 03:08:14 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:14 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:08:14 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:14 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:14 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:08:14 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:14 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:08:14 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:14 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:08:14 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:14 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:08:14 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:14 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 03:08:14 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 03:08:14 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 03:08:14 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 03:08:14 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 03:08:19 INFO - Downloaded 23813806 bytes. 03:08:19 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'] 03:08:19 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 03:08:20 INFO - Return code: 0 03:08:20 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 03:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:20 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 03:08:20 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 03:08:20 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 03:08:20 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 03:08:20 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 03:08:27 INFO - Downloaded 23813806 bytes. 03:08:27 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'] 03:08:27 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 03:08:28 INFO - Return code: 0 03:08: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')]} 03:08:28 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 03:08: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.talos.tests.zip 03:08: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.talos.tests.zip 03:08: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.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:28 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 03:08:29 INFO - Downloaded 10840145 bytes. 03:08:29 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'] 03:08:29 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 03:08:30 INFO - Return code: 0 03:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:30 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 03:08:30 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 03:08:30 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 03:08:30 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 03:08:30 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 03:08:33 INFO - Downloaded 62686410 bytes. 03:08:33 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 03:08:33 INFO - mkdir: /builds/slave/test/properties 03:08:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:08:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:08:33 INFO - Contents: 03:08:33 INFO - build_url:https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:08:34 INFO - Running post-action listener: _resource_record_post_action 03:08:34 INFO - Running post-action listener: set_extra_try_arguments 03:08:34 INFO - ##### 03:08:34 INFO - ##### Running populate-webroot step. 03:08:34 INFO - ##### 03:08:34 INFO - Running pre-action listener: _resource_record_pre_action 03:08:34 INFO - Running main action method: populate_webroot 03:08:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:08:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:08:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:08:34 INFO - '--tppagecycles', 03:08:34 INFO - '7'], 03:08:34 INFO - 'tests': ['tsvgm']}}, 03:08:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:08:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:08:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:08:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:08:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:08:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:08:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:34 INFO - 'talos_options': ['--disable-e10s'], 03:08:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:34 INFO - 'talos_options': ['--disable-e10s'], 03:08:34 INFO - 'tests': ['damp', 'tps']}, 03:08:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:34 INFO - 'tests': ['damp', 'tps']}, 03:08:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:08:34 INFO - 'tests': ['dromaeo_dom']}, 03:08:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:08:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:08:34 INFO - 'tests': ['a11yr', 03:08:34 INFO - 'ts_paint', 03:08:34 INFO - 'tpaint', 03:08:34 INFO - 'sessionrestore', 03:08:34 INFO - 'sessionrestore_no_auto_restore', 03:08:34 INFO - 'tabpaint']}, 03:08:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:08:34 INFO - 'ts_paint', 03:08:34 INFO - 'tpaint', 03:08:34 INFO - 'sessionrestore', 03:08:34 INFO - 'sessionrestore_no_auto_restore', 03:08:34 INFO - 'tabpaint']}, 03:08:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:08:34 INFO - 'ts_paint', 03:08:34 INFO - 'tpaint', 03:08:34 INFO - 'sessionrestore', 03:08:34 INFO - 'sessionrestore_no_auto_restore', 03:08:34 INFO - 'tabpaint']}, 03:08:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:08:34 INFO - 'ts_paint', 03:08:34 INFO - 'tpaint', 03:08:34 INFO - 'sessionrestore', 03:08:34 INFO - 'sessionrestore_no_auto_restore', 03:08:34 INFO - 'tabpaint']}, 03:08:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:08:34 INFO - 'tests': ['a11yr', 03:08:34 INFO - 'ts_paint', 03:08:34 INFO - 'tpaint', 03:08:34 INFO - 'sessionrestore', 03:08:34 INFO - 'sessionrestore_no_auto_restore', 03:08:34 INFO - 'tabpaint']}, 03:08:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:08:34 INFO - 'tests': ['a11yr', 03:08:34 INFO - 'ts_paint', 03:08:34 INFO - 'tpaint', 03:08:34 INFO - 'sessionrestore', 03:08:34 INFO - 'sessionrestore_no_auto_restore', 03:08:34 INFO - 'tabpaint']}, 03:08:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:08:34 INFO - 'tests': ['tsvgx', 03:08:34 INFO - 'tsvgr_opacity', 03:08:34 INFO - 'tart', 03:08:34 INFO - 'tscrollx', 03:08:34 INFO - 'cart']}, 03:08:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:08:34 INFO - 'tsvgr_opacity', 03:08:34 INFO - 'tart', 03:08:34 INFO - 'tscrollx', 03:08:34 INFO - 'cart']}, 03:08:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:34 INFO - 'talos_options': ['--disable-e10s'], 03:08:34 INFO - 'tests': ['tp5o']}, 03:08:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:34 INFO - 'tests': ['tp5o']}, 03:08:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:34 INFO - 'talos_options': ['--disable-e10s', 03:08:34 INFO - '--xperf_path', 03:08:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:34 INFO - 'tests': ['tp5n']}, 03:08:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:34 INFO - 'talos_options': ['--xperf_path', 03:08:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:34 INFO - 'tests': ['tp5n']}}, 03:08:34 INFO - 'talos.zip': {'path': '', 03:08:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:08:34 INFO - Running post-action listener: _resource_record_post_action 03:08:34 INFO - ##### 03:08:34 INFO - ##### Running create-virtualenv step. 03:08:34 INFO - ##### 03:08:34 INFO - Running pre-action listener: _resource_record_pre_action 03:08:34 INFO - Running main action method: create_virtualenv 03:08:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:08:34 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 03:08:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:08:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:08:34 INFO - Using real prefix '/usr' 03:08:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:08:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:08:36 INFO - Installing pip.................done. 03:08:36 INFO - Return code: 0 03:08:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c54df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2533410>, '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 0x2534310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25347a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', '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 03:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:08:36 INFO - Using env: {'DISPLAY': ':0', 03:08:36 INFO - 'HOME': '/home/cltbld', 03:08:36 INFO - 'LANG': 'en_US.UTF-8', 03:08:36 INFO - 'LANGUAGE': 'en_US:en', 03:08:36 INFO - 'LOGNAME': 'cltbld', 03:08:36 INFO - 'MAIL': '/var/mail/cltbld', 03:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:36 INFO - 'MOZ_NO_REMOTE': '1', 03:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:36 INFO - 'NO_EM_RESTART': '1', 03:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:36 INFO - 'PWD': '/builds/slave/test', 03:08:36 INFO - 'SHELL': '/bin/bash', 03:08:36 INFO - 'SHLVL': '1', 03:08:36 INFO - 'TERM': 'linux', 03:08:36 INFO - 'TMOUT': '86400', 03:08:36 INFO - 'USER': 'cltbld', 03:08:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', 03:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:36 INFO - '_': '/tools/buildbot/bin/python'} 03:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:37 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 03:08:37 INFO - Cleaning up... 03:08:37 INFO - Return code: 0 03:08:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:37 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 0x7f2c54df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2533410>, '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 0x2534310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25347a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', '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 03:08:37 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 03:08:37 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 03:08:37 INFO - Using env: {'DISPLAY': ':0', 03:08:37 INFO - 'HOME': '/home/cltbld', 03:08:37 INFO - 'LANG': 'en_US.UTF-8', 03:08:37 INFO - 'LANGUAGE': 'en_US:en', 03:08:37 INFO - 'LOGNAME': 'cltbld', 03:08:37 INFO - 'MAIL': '/var/mail/cltbld', 03:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:37 INFO - 'MOZ_NO_REMOTE': '1', 03:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:37 INFO - 'NO_EM_RESTART': '1', 03:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:37 INFO - 'PWD': '/builds/slave/test', 03:08:37 INFO - 'SHELL': '/bin/bash', 03:08:37 INFO - 'SHLVL': '1', 03:08:37 INFO - 'TERM': 'linux', 03:08:37 INFO - 'TMOUT': '86400', 03:08:37 INFO - 'USER': 'cltbld', 03:08:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', 03:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:37 INFO - '_': '/tools/buildbot/bin/python'} 03:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:37 INFO - Downloading/unpacking psutil>=0.7.1 03:08:37 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 03:08:37 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 03:08:37 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 03:08:37 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 03:08:37 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 03:08:37 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 03:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:08:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:39 INFO - Installing collected packages: psutil 03:08:39 INFO - Running setup.py install for psutil 03:08:39 INFO - building 'psutil._psutil_linux' extension 03:08:39 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 03:08:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:08:39 INFO - building 'psutil._psutil_posix' extension 03:08:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:08:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:08:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:39 INFO - Successfully installed psutil 03:08:39 INFO - Cleaning up... 03:08:39 INFO - Return code: 0 03:08:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c54df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2533410>, '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 0x2534310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25347a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', '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 03:08:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:08:39 INFO - Using env: {'DISPLAY': ':0', 03:08:39 INFO - 'HOME': '/home/cltbld', 03:08:39 INFO - 'LANG': 'en_US.UTF-8', 03:08:39 INFO - 'LANGUAGE': 'en_US:en', 03:08:39 INFO - 'LOGNAME': 'cltbld', 03:08:39 INFO - 'MAIL': '/var/mail/cltbld', 03:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:39 INFO - 'MOZ_NO_REMOTE': '1', 03:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:39 INFO - 'NO_EM_RESTART': '1', 03:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:39 INFO - 'PWD': '/builds/slave/test', 03:08:39 INFO - 'SHELL': '/bin/bash', 03:08:39 INFO - 'SHLVL': '1', 03:08:39 INFO - 'TERM': 'linux', 03:08:39 INFO - 'TMOUT': '86400', 03:08:39 INFO - 'USER': 'cltbld', 03:08:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', 03:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:39 INFO - '_': '/tools/buildbot/bin/python'} 03:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:08: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) 03:08:42 INFO - Installing collected packages: mozsystemmonitor 03:08:42 INFO - Running setup.py install for mozsystemmonitor 03:08:42 INFO - Successfully installed mozsystemmonitor 03:08:42 INFO - Cleaning up... 03:08:42 INFO - Return code: 0 03:08:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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 0x7f2c54df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2533410>, '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 0x2534310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25347a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', '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 03:08: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 03:08: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 03:08:42 INFO - Using env: {'DISPLAY': ':0', 03:08:42 INFO - 'HOME': '/home/cltbld', 03:08:42 INFO - 'LANG': 'en_US.UTF-8', 03:08:42 INFO - 'LANGUAGE': 'en_US:en', 03:08:42 INFO - 'LOGNAME': 'cltbld', 03:08:42 INFO - 'MAIL': '/var/mail/cltbld', 03:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:42 INFO - 'MOZ_NO_REMOTE': '1', 03:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:42 INFO - 'NO_EM_RESTART': '1', 03:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:42 INFO - 'PWD': '/builds/slave/test', 03:08:42 INFO - 'SHELL': '/bin/bash', 03:08:42 INFO - 'SHLVL': '1', 03:08:42 INFO - 'TERM': 'linux', 03:08:42 INFO - 'TMOUT': '86400', 03:08:42 INFO - 'USER': 'cltbld', 03:08:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', 03:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:42 INFO - '_': '/tools/buildbot/bin/python'} 03:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:08:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:08:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08:45 INFO - Downloading docopt-0.6.1.tar.gz 03:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:08:45 INFO - Installing collected packages: blobuploader, requests, docopt 03:08:45 INFO - Running setup.py install for blobuploader 03:08:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:08:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:08:45 INFO - Running setup.py install for requests 03:08:45 INFO - Running setup.py install for docopt 03:08:45 INFO - Successfully installed blobuploader requests docopt 03:08:45 INFO - Cleaning up... 03:08:45 INFO - Return code: 0 03:08:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c54df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2533410>, '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 0x2534310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25347a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', '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 03:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:08:45 INFO - Using env: {'DISPLAY': ':0', 03:08:45 INFO - 'HOME': '/home/cltbld', 03:08:45 INFO - 'LANG': 'en_US.UTF-8', 03:08:45 INFO - 'LANGUAGE': 'en_US:en', 03:08:45 INFO - 'LOGNAME': 'cltbld', 03:08:45 INFO - 'MAIL': '/var/mail/cltbld', 03:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:45 INFO - 'MOZ_NO_REMOTE': '1', 03:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:45 INFO - 'NO_EM_RESTART': '1', 03:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:45 INFO - 'PWD': '/builds/slave/test', 03:08:45 INFO - 'SHELL': '/bin/bash', 03:08:45 INFO - 'SHLVL': '1', 03:08:45 INFO - 'TERM': 'linux', 03:08:45 INFO - 'TMOUT': '86400', 03:08:45 INFO - 'USER': 'cltbld', 03:08:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', 03:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:45 INFO - '_': '/tools/buildbot/bin/python'} 03:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:08:45 INFO - Running setup.py (path:/tmp/pip-rM4ZFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:08:46 INFO - Running setup.py (path:/tmp/pip-kqtFfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:08:46 INFO - Running setup.py (path:/tmp/pip-S7YmtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:08:46 INFO - Running setup.py (path:/tmp/pip-3THILW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:08:46 INFO - Running setup.py (path:/tmp/pip-G2WGfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:08:46 INFO - Running setup.py (path:/tmp/pip-OFJhRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:08:46 INFO - Running setup.py (path:/tmp/pip-l2uGx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:08:46 INFO - Running setup.py (path:/tmp/pip-7_dZPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:08:46 INFO - Running setup.py (path:/tmp/pip-QwydSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:08:46 INFO - Running setup.py (path:/tmp/pip-WdS3VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:08:46 INFO - Running setup.py (path:/tmp/pip-py9Olv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:08:46 INFO - Running setup.py (path:/tmp/pip-qa5cPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:08:46 INFO - Running setup.py (path:/tmp/pip-J1f6tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:08:46 INFO - Running setup.py (path:/tmp/pip-6aOypu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:46 INFO - Running setup.py (path:/tmp/pip-yR307l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:08:47 INFO - Running setup.py (path:/tmp/pip-rxKJN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:08:47 INFO - Running setup.py (path:/tmp/pip-poWI52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:08:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:08:47 INFO - Running setup.py install for manifestparser 03:08:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:08:47 INFO - Running setup.py install for mozcrash 03:08:47 INFO - Running setup.py install for mozdebug 03:08:47 INFO - Running setup.py install for mozdevice 03:08:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:08:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:08:47 INFO - Running setup.py install for mozfile 03:08:47 INFO - Running setup.py install for mozhttpd 03:08:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:08:47 INFO - Running setup.py install for mozinfo 03:08:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:08:47 INFO - Running setup.py install for mozInstall 03:08:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:08:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:08:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:08:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:08:47 INFO - Running setup.py install for mozleak 03:08:48 INFO - Running setup.py install for mozlog 03:08:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:08:48 INFO - Running setup.py install for moznetwork 03:08:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:08:48 INFO - Running setup.py install for mozprocess 03:08:48 INFO - Running setup.py install for mozprofile 03:08:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:08:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:08:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:08:48 INFO - Running setup.py install for mozrunner 03:08:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:08:48 INFO - Running setup.py install for mozscreenshot 03:08:48 INFO - Running setup.py install for moztest 03:08:48 INFO - Running setup.py install for mozversion 03:08:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:08:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:08:48 INFO - Cleaning up... 03:08:48 INFO - Return code: 0 03:08:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c54df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2533410>, '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 0x2534310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25347a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', '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 03:08:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:08:48 INFO - Using env: {'DISPLAY': ':0', 03:08:48 INFO - 'HOME': '/home/cltbld', 03:08:48 INFO - 'LANG': 'en_US.UTF-8', 03:08:48 INFO - 'LANGUAGE': 'en_US:en', 03:08:48 INFO - 'LOGNAME': 'cltbld', 03:08:48 INFO - 'MAIL': '/var/mail/cltbld', 03:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:48 INFO - 'MOZ_NO_REMOTE': '1', 03:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:48 INFO - 'NO_EM_RESTART': '1', 03:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:48 INFO - 'PWD': '/builds/slave/test', 03:08:48 INFO - 'SHELL': '/bin/bash', 03:08:48 INFO - 'SHLVL': '1', 03:08:48 INFO - 'TERM': 'linux', 03:08:48 INFO - 'TMOUT': '86400', 03:08:48 INFO - 'USER': 'cltbld', 03:08:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', 03:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:48 INFO - '_': '/tools/buildbot/bin/python'} 03:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:08:49 INFO - Running setup.py (path:/tmp/pip-9k1HLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:08: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)) 03:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:08:49 INFO - Running setup.py (path:/tmp/pip-kznRZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:08: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)) 03:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:08:49 INFO - Running setup.py (path:/tmp/pip-zk10VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:08: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)) 03:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:08:49 INFO - Running setup.py (path:/tmp/pip-kpHcWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:08: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)) 03:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:08:49 INFO - Running setup.py (path:/tmp/pip-HJmNi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:08:49 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)) 03:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:08:49 INFO - Running setup.py (path:/tmp/pip-IJMdD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:08:49 INFO - Running setup.py (path:/tmp/pip-1KAOMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:08:49 INFO - Running setup.py (path:/tmp/pip-i0q11L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:08:49 INFO - Running setup.py (path:/tmp/pip-UFJhqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:08:49 INFO - Running setup.py (path:/tmp/pip-g8Zbft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:08:49 INFO - Running setup.py (path:/tmp/pip-nSZ2YP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:08:49 INFO - Running setup.py (path:/tmp/pip-BWZRlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:08: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)) 03:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:08:50 INFO - Running setup.py (path:/tmp/pip-HBcaYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:08: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)) 03:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:08:50 INFO - Running setup.py (path:/tmp/pip-GERHXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:08: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)) 03:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:50 INFO - Running setup.py (path:/tmp/pip-R2EZKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:08: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)) 03:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:08:50 INFO - Running setup.py (path:/tmp/pip-qUm4Qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:08: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)) 03:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:08:50 INFO - Running setup.py (path:/tmp/pip-6O6jNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:08: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)) 03:08: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)) 03:08: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)) 03:08: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)) 03:08: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)) 03:08: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)) 03:08:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08:52 INFO - Downloading blessings-1.6.tar.gz 03:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:08:52 INFO - Installing collected packages: blessings 03:08:52 INFO - Running setup.py install for blessings 03:08:52 INFO - Successfully installed blessings 03:08:52 INFO - Cleaning up... 03:08:52 INFO - Return code: 0 03:08:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:08:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:52 INFO - Reading from file tmpfile_stdout 03:08:52 INFO - Current package versions: 03:08:52 INFO - argparse == 1.2.1 03:08:52 INFO - blessings == 1.6 03:08:52 INFO - blobuploader == 1.2.4 03:08:52 INFO - docopt == 0.6.1 03:08:52 INFO - manifestparser == 1.1 03:08:52 INFO - mozInstall == 1.12 03:08:52 INFO - mozcrash == 0.17 03:08:52 INFO - mozdebug == 0.1 03:08:52 INFO - mozdevice == 0.48 03:08:52 INFO - mozfile == 1.2 03:08:52 INFO - mozhttpd == 0.7 03:08:52 INFO - mozinfo == 0.9 03:08:52 INFO - mozleak == 0.1 03:08:52 INFO - mozlog == 3.1 03:08:52 INFO - moznetwork == 0.27 03:08:52 INFO - mozprocess == 0.22 03:08:52 INFO - mozprofile == 0.28 03:08:52 INFO - mozrunner == 6.11 03:08:52 INFO - mozscreenshot == 0.1 03:08:52 INFO - mozsystemmonitor == 0.0 03:08:52 INFO - moztest == 0.7 03:08:52 INFO - mozversion == 1.4 03:08:52 INFO - psutil == 3.1.1 03:08:52 INFO - requests == 1.2.3 03:08:52 INFO - wsgiref == 0.1.2 03:08:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c54df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2533410>, '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 0x2534310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25347a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', '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 03:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:08:52 INFO - Using env: {'DISPLAY': ':0', 03:08:52 INFO - 'HOME': '/home/cltbld', 03:08:52 INFO - 'LANG': 'en_US.UTF-8', 03:08:52 INFO - 'LANGUAGE': 'en_US:en', 03:08:52 INFO - 'LOGNAME': 'cltbld', 03:08:52 INFO - 'MAIL': '/var/mail/cltbld', 03:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:52 INFO - 'MOZ_NO_REMOTE': '1', 03:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:52 INFO - 'NO_EM_RESTART': '1', 03:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:52 INFO - 'PWD': '/builds/slave/test', 03:08:52 INFO - 'SHELL': '/bin/bash', 03:08:52 INFO - 'SHLVL': '1', 03:08:52 INFO - 'TERM': 'linux', 03:08:52 INFO - 'TMOUT': '86400', 03:08:52 INFO - 'USER': 'cltbld', 03:08:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', 03:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:52 INFO - '_': '/tools/buildbot/bin/python'} 03:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:08:52 INFO - Cleaning up... 03:08:52 INFO - Return code: 0 03:08:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c54df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2533410>, '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 0x2534310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25347a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', '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 03:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:08:52 INFO - Using env: {'DISPLAY': ':0', 03:08:52 INFO - 'HOME': '/home/cltbld', 03:08:52 INFO - 'LANG': 'en_US.UTF-8', 03:08:52 INFO - 'LANGUAGE': 'en_US:en', 03:08:52 INFO - 'LOGNAME': 'cltbld', 03:08:52 INFO - 'MAIL': '/var/mail/cltbld', 03:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:52 INFO - 'MOZ_NO_REMOTE': '1', 03:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:52 INFO - 'NO_EM_RESTART': '1', 03:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:52 INFO - 'PWD': '/builds/slave/test', 03:08:52 INFO - 'SHELL': '/bin/bash', 03:08:52 INFO - 'SHLVL': '1', 03:08:52 INFO - 'TERM': 'linux', 03:08:52 INFO - 'TMOUT': '86400', 03:08:52 INFO - 'USER': 'cltbld', 03:08:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', 03:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:52 INFO - '_': '/tools/buildbot/bin/python'} 03:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:53 INFO - Downloading/unpacking jsonschema 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:08:55 INFO - Downloading/unpacking functools32 (from jsonschema) 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:08:55 INFO - warning: no files found matching '*.txt' 03:08:55 INFO - no previously-included directories found matching 'build' 03:08:55 INFO - no previously-included directories found matching 'dist' 03:08:55 INFO - no previously-included directories found matching '.git*' 03:08:55 INFO - Installing collected packages: jsonschema, functools32 03:08:55 INFO - Running setup.py install for functools32 03:08:55 INFO - warning: no files found matching '*.txt' 03:08:55 INFO - no previously-included directories found matching 'build' 03:08:55 INFO - no previously-included directories found matching 'dist' 03:08:55 INFO - no previously-included directories found matching '.git*' 03:08:55 INFO - Successfully installed jsonschema functools32 03:08:55 INFO - Cleaning up... 03:08:55 INFO - Return code: 0 03:08:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c54df5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2533410>, '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 0x2534310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25347a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', '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 03:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:08:55 INFO - Using env: {'DISPLAY': ':0', 03:08:55 INFO - 'HOME': '/home/cltbld', 03:08:55 INFO - 'LANG': 'en_US.UTF-8', 03:08:55 INFO - 'LANGUAGE': 'en_US:en', 03:08:55 INFO - 'LOGNAME': 'cltbld', 03:08:55 INFO - 'MAIL': '/var/mail/cltbld', 03:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:55 INFO - 'MOZ_NO_REMOTE': '1', 03:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:55 INFO - 'NO_EM_RESTART': '1', 03:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:55 INFO - 'PWD': '/builds/slave/test', 03:08:55 INFO - 'SHELL': '/bin/bash', 03:08:55 INFO - 'SHLVL': '1', 03:08:55 INFO - 'TERM': 'linux', 03:08:55 INFO - 'TMOUT': '86400', 03:08:55 INFO - 'USER': 'cltbld', 03:08:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', 03:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:55 INFO - '_': '/tools/buildbot/bin/python'} 03:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:55 INFO - Downloading/unpacking flake8 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:08:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:08:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:08:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:08:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:08:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:08:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:08:58 INFO - no previously-included directories found matching 'docs/_build' 03:08:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:08:58 INFO - Running setup.py install for pep8 03:08:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:08:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:08:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:08:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:08:58 INFO - no previously-included directories found matching 'docs/_build' 03:08:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:08:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:08:58 INFO - Cleaning up... 03:08:58 INFO - Return code: 0 03:08:58 INFO - Running post-action listener: _resource_record_post_action 03:08:58 INFO - Running post-action listener: _start_resource_monitoring 03:08:58 INFO - Starting resource monitoring. 03:08:58 INFO - ##### 03:08:58 INFO - ##### Running install step. 03:08:58 INFO - ##### 03:08:58 INFO - Running pre-action listener: _resource_record_pre_action 03:08:58 INFO - Running main action method: install 03:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:58 INFO - Reading from file tmpfile_stdout 03:08:58 INFO - Detecting whether we're running mozinstall >=1.0... 03:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:08:58 INFO - Reading from file tmpfile_stdout 03:08:58 INFO - Output received: 03:08:58 INFO - Usage: mozinstall [options] installer 03:08:58 INFO - Options: 03:08:58 INFO - -h, --help show this help message and exit 03:08:58 INFO - -d DEST, --destination=DEST 03:08:58 INFO - Directory to install application into. [default: 03:08:58 INFO - "/builds/slave/test"] 03:08:58 INFO - --app=APP Application being installed. [default: firefox] 03:08:58 INFO - mkdir: /builds/slave/test/build/application 03:08:58 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'] 03:08:58 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 03:09:14 INFO - Reading from file tmpfile_stdout 03:09:14 INFO - Output received: 03:09:14 INFO - /builds/slave/test/build/application/firefox/firefox 03:09:14 INFO - Running post-action listener: _resource_record_post_action 03:09:14 INFO - ##### 03:09:14 INFO - ##### Running run-tests step. 03:09:14 INFO - ##### 03:09:14 INFO - Running pre-action listener: _resource_record_pre_action 03:09:14 INFO - Running main action method: run_tests 03:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:09:14 INFO - Python 2.7.3 03:09:14 INFO - Return code: 0 03:09:14 INFO - grabbing minidump binary from tooltool 03:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:14 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 0x2533410>, '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 0x2534310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25347a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:09:14 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 03:09:14 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 03:09:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:09:14 INFO - Return code: 0 03:09:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:09:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:09:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:09:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:09:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:09:15 INFO - Return code: 0 03:09:15 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-035', '--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 03:09:15 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-035 --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 03:09:15 INFO - Using env: {'DISPLAY': ':0', 03:09:15 INFO - 'HOME': '/home/cltbld', 03:09:15 INFO - 'LANG': 'en_US.UTF-8', 03:09:15 INFO - 'LANGUAGE': 'en_US:en', 03:09:15 INFO - 'LOGNAME': 'cltbld', 03:09:15 INFO - 'MAIL': '/var/mail/cltbld', 03:09:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:09:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:15 INFO - 'MOZ_NO_REMOTE': '1', 03:09:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:15 INFO - 'NO_EM_RESTART': '1', 03:09:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:15 INFO - 'PWD': '/builds/slave/test', 03:09:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:09:15 INFO - 'SHELL': '/bin/bash', 03:09:15 INFO - 'SHLVL': '1', 03:09:15 INFO - 'TERM': 'linux', 03:09:15 INFO - 'TMOUT': '86400', 03:09:15 INFO - 'USER': 'cltbld', 03:09:15 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934', 03:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:15 INFO - '_': '/tools/buildbot/bin/python'} 03:09:15 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-035', '--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 03:09:15 INFO - mozversion application_buildid: 20160517004009 03:09:15 INFO - mozversion application_changeset: 17724486e1591858eea09dc327475a25883854a4 03:09:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:09:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:09:15 INFO - mozversion application_name: Firefox 03:09:15 INFO - mozversion application_remotingname: firefox-dev 03:09:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:09:15 INFO - mozversion application_vendor: Mozilla 03:09:15 INFO - mozversion application_version: 48.0a2 03:09:15 INFO - mozversion platform_buildid: 20160517004009 03:09:15 INFO - mozversion platform_changeset: 17724486e1591858eea09dc327475a25883854a4 03:09:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:09:15 INFO - mozversion platform_version: 48.0a2 03:09:15 INFO - using testdate: 1463479755 03:09:15 INFO - actual date: 1463479755 03:09:15 INFO - starting webserver on 'localhost:46420' 03:09:15 INFO - SUITE-START | Running 2 tests 03:09:15 INFO - TEST-START | dromaeo_css 03:09:15 INFO - operating with platform_type : linux_ 03:09:15 INFO - Initialising browser for dromaeo_css test... 03:09:15 INFO - TEST-INFO | started process 9140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU6SdXD/profile http://localhost:46420/getInfo.html) 03:09:19 INFO - PROCESS | 9140 | 03:09:19 INFO - PROCESS | 9140 | (process:9218): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:09:20 INFO - PROCESS | 9140 | __metrics Screen width/height:1600/1200 03:09:20 INFO - PROCESS | 9140 | colorDepth:24 03:09:20 INFO - PROCESS | 9140 | Browser inner width/height: 1024/697 03:09:20 INFO - PROCESS | 9140 | __metrics 03:09:20 ERROR - PROCESS | 9140 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 03:09:21 INFO - TEST-INFO | 9140: exit 0 03:09:21 INFO - Browser initialized. 03:09:21 INFO - Running cycle 1/1 for dromaeo_css test... 03:09:21 INFO - TEST-INFO | started process 9269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU6SdXD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:09:23 INFO - PROCESS | 9269 | 03:09:23 INFO - PROCESS | 9269 | (process:9341): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:09:33 INFO - PROCESS | 9269 | RSS: Main: 151789568 03:09:33 INFO - PROCESS | 9269 | 03:10:22 INFO - PROCESS | 9269 | 1463479822850 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] 03:12:30 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46420/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46420/tests/dromaeo/cssquery-ext.html) 03:12:31 INFO - PROCESS | 9269 | RSS: Main: 155701248 03:12:31 INFO - PROCESS | 9269 | 03:15:33 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46420/tests/dromaeo/cssquery-ext.html (next: http://localhost:46420/tests/dromaeo/cssquery-jquery.html) 03:15:33 INFO - PROCESS | 9269 | RSS: Main: 153927680 03:15:33 INFO - PROCESS | 9269 | 03:18:35 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46420/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46420/tests/dromaeo/cssquery-mootools.html) 03:18:36 INFO - PROCESS | 9269 | RSS: Main: 153104384 03:18:36 INFO - PROCESS | 9269 | 03:21:37 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46420/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46420/tests/dromaeo/cssquery-prototype.html) 03:21:38 INFO - PROCESS | 9269 | RSS: Main: 152584192 03:21:38 INFO - PROCESS | 9269 | 03:24:40 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46420/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46420/tests/dromaeo/cssquery-yui.html) 03:24:41 INFO - PROCESS | 9269 | RSS: Main: 154046464 03:24:41 INFO - PROCESS | 9269 | 03:27:43 INFO - PROCESS | 9269 | Cycle 1(1): loaded http://localhost:46420/tests/dromaeo/cssquery-yui.html (next: http://localhost:46420/tests/dromaeo/cssquery-dojo.html) 03:27:43 INFO - PROCESS | 9269 | RSS: Main: 155258880 03:27:43 INFO - PROCESS | 9269 | 03:27:43 INFO - PROCESS | 9269 | __start_tp_report 03:27:43 INFO - PROCESS | 9269 | _x_x_mozilla_page_load 03:27:43 INFO - PROCESS | 9269 | _x_x_mozilla_page_load_details 03:27:43 INFO - PROCESS | 9269 | |i|pagename|runs| 03:27:43 INFO - PROCESS | 9269 | |0;dojo.html;3355.664433556644;3418.2650730093033;3434.6908778209954;3443.982780086101;3465.8960231193073;5556.666600004002;5627.380988091312;5631.042722737135;5642.097264437691;5655.3779084300695;5547.667139971594;5596.664200147984;5603.159526071081;5638.492535671789;5682.801101961432;5103.591712662978;5110.923336149961;5125.231215317714;5151.536361727443;5190.506901844319;5045.899082018357;5210.2445145453885;5229.60777941654;5233.136532472137;5273.815416460425;5172.172452407615;5182.119039763249;5184.066867963765;5194.0910340690225;5244.501772331622;5187.948120518803;5188.8183913563225;5198.9480105198845;5204.323437953042;5234.345706786652;4952.059108769322;5013.373328333958;5105.744712764384;5142.588592912558;5193.636445448782;5537.529310008654;5571.944280557183;5581.8604534886545;5597.74810133545;5649.152627105926;6034.125051867454;6067.120267561223;6096.085587161917;6097.17688112108;6110.7861224856915;5978.342382337939;6096.451319381233;6097.756089756404;6115.788007244199;6118.235220597426;5632.2678051853;5637.605367624227;5643.407442218549;5652.773889044433;5698.2592263005545;6122;6126.632402055891;6130.63216207029;6145.723442445101;6153.661548614779;5896.911546326808;5903.321118071477;5904.4095590441475;5971.671558064349;6013;6086.2087928569;6087.817365479043;6088;6098.786542470993;6106.542009349317;6031.215941927521;6054.697265136726;6072.271327440735;6082.969585152135;6085.878282434326;5975.611585247032;6064.36324185963;6137.355577664371;6146.231721034871;6154.292256390572;4631.722096674211;4636.35091087248;4638.6752927294765;4648.837290694877;4657.86026419208;4119.237940980928;4170.457840480718;4170.645495132887;4172.666186705056;4192.937105943413;5674.801381951695;5703.9429605704245;5787.826365209051;5820.621659592113;5836.67898265591;6120.722263144302;6127.724252408652;6152.107944348045;6156.938430615636;6175.073738939105;5814.592978491465;5875.794347197828;5876.882462350729;5886.411358864165;5886.941130588725;5188.688678679291;5192.273081768555;5204.869878252998;5216.374035115735;5242.7640756166065;6334.398232167937;6344.777932772331;6356.396142366468;6362.2683391409655;6365.809025729235;6041.697915104315;6076;6155.322914479493;6158.538109641795;6185.257769067741;6192.411720886508;6209.161763161916;6212.192414986023;6236.750529978932;6242.438180563771;5849.61977471463;5872.349735470626;5891.941080589139;5897.469227769521;5917.319508256433;5916;5974.9103763444455;6011.308699499614;6016.217891674054;6024.819255422344;6048.516118710405;6089.421504957022;6106.969465152823;6109.313572000111;6123.8162855114415;6030;6052.818415447544;6060.424259695322;6072.574919755575;6080.3615620361;5830.5627077968475;5834.649921004753;5931.406859314034;5962.70186490665;5972.163897054503;5997.430244126801;6057.333693293822;6060.000099983629;6067.362926892612;6083.939160608515;5836.270466191726;5907.556933229939;5910.970445147918;5921.14143449206;5922.111683247547 03:27:43 INFO - PROCESS | 9269 | |1;ext.html;606.1332294818411;657.7500549791079;662.2185820731535;668.2949488289854;676.9559978601392;37850.62149378505;38179;38637.80681096591;38674.806625966834;38846.41730374043;45306.54693453065;45972.310415343796;46213.53786462134;46217;46413.30380044302;8820.2502787263;9061.637534498612;9080.636774529012;9099.727008189764;9114.45313281202;9052.41159324645;9068.54657267134;9090.181883630472;9147.085291470867;9177.174054335108;9202;9225.769355766093;9230.630774769;9233.95383023084;9244.8613270801;9066.410683305565;9177.908220917805;9216.124468175512;9221.216196623294;9250.814983700322;9009.189172974464;9082.636694532212;9108.817823643556;9141.131592498701;9168.908310916871;41699.7915010426;41927.371089433684;41999.58000420018;42086.57913420888;42114;3930.390789427643;3992.9800350998057;4236.449261596003;4308.655307575386;4579.290210017452;32029.398530073402;32060.358792824012;32252.516212256836;32315.353692926008;34188;4616.884577885546;4685.20351540239;4726.574608285271;4760.095581839474;4849.248366503198;338043;338948;338992;340041.9999999975;341483;39238.60761392407;39773.40339894904;39960.60039399627;59818.700906495185;59985.10022349668;37508.81245593809;37516.81241593775;37566;37709.245815083545;37944.620553794106;15235.16206608625;15300.770488442682;15354.155521446204;15441.845581544265;15458.768118478232;12821.935890320676;12833.743325133632;12870.356482175854;12946.741065178643;12949.805752913713;9359.438433694;9360.859587106199;9395.718128456158;9410.341276110606;9494.145526902474;3645.9453108203397;3672.375696131664;3723.1622884851236;3755.5681096673684;3784.2242340320167;1090.8472813806075;1125.4429057616533;1196.5393323570313;1200.4117982188839;1216.0818581970732;32464;33041;33173.336533269685;33288.50067248993;33953.15117122092;1106.2706927883362;1157.9421028948518;1171.3030746705867;1204.1390405859852;1226.3868065967017;17007.319707211573;17147;17355.392561260294;17377.826221737872;17544.649107017787;459668;550866;562336;563063;829465;61071;61720;62057.68971155115;62477.687611561654;62572;1473.616859616486;1480.3042569992087;1497.9026363286353;1498.2134379450877;1502.068717395222;32734;33152.83423582867;33465.83267083649;33773.49339759856;34169;52831.20753188782;53029;53048.73475632597;53552.73223633857;53624.46375536195;436101;437907;437986;439674;440082;30448.543271850496;30725.53911691371;31004;31251.68748312488;31303.84348078245;48538.75730621324;49286;49424.75287623539;50003.499964999886;50199;41218.38172427356;41256.174876501704;41265.14306856139;41277.38083928683;42398.36402454027;40945.59054409418;40989.38515922323;41582.58417415787;41798.58201417947;42075.57924420839;41566.79216603898;42113.57886421219;43987.56012439835;44962.77518612386;45348.77325613351;32710.34579308353;33028.00915972525;33257.00228993134;33419.33161336711;34052.48921266232;28288.575671364535;28492.43015139727;28636.713632863404;28730.712692872803;29039.274018149714 03:27:43 INFO - PROCESS | 9269 | |2;jquery.html;425.774339600012;441.46803102261777;443.52099732289133;445.5255153261778;455.0739245635131;18449;18564.907175464137;19053.71419428708;19888.90055549724;19942.202311907506;12230.266184028964;12860.421281042352;12910.741785164315;12918.483260669585;12975.221486710803;5291.814786482483;5440.945590544084;5595.468430499096;5841.7955371562;5877.471027607515;5774.2782152230975;5797.5651826113;5804.332501762288;5817;6327.968360158193;6560.147180866505;6610.537262391635;6628.072069910192;6628.867422651544;6630.3701148391065;5873.442023007808;5879.32387775407;6270.561060725729;6576.243731970812;6583.736650533973;5817.941820581782;5819.330776960662;5822.505087067604;5839.941600583982;5853.443922827325;14667.193304368255;20215;23202.76797232023;23546.882265588734;23940.204484663547;2363.1138323128826;2569.2806014315834;2569.6145578163237;2864.613277207592;2949.3806300676883;9880.456574888378;10454.738631534197;10609.628662996758;11089.2237543372;11235.887641123565;2094.413564202026;2103.5792841431776;2106.7682554918947;2133.0401319406174;2144.5174835662006;77047;81745.59127204385;82864.342713146;85916;89375;11723.472443740053;11737.471813768401;11771.529138834521;11856.70358241051;12152.21010634306;16607.50177494677;16796.328146873988;16868.831311686972;16894.40869569559;16993.83006169947;8245.587720614065;8575.185357391038;8743.300535957109;8988.146126118008;9046.954765226132;8146.389020823343;8338.749837504885;8342.541160236246;8348.373871959628;8493.405461617751;5061.746912654353;5104.259882317043;5113.207452844815;5244.056069907453;5272.894542109137;2079.6880467929627;2132.797384248494;2156.9352919412445;2167.349795061475;2197.2419515267206;967.7241986033946;1117.709395557161;1164.6913567904512;1164.8485696859354;1205.7950148474604;19552.706709399372;19755.308564200182;19896.801031989784;19937.501562461053;20446.07992640335;1043.994780026095;1047.6176195688672;1064.8296272596347;1077.6551503518956;1079.5857426770956;11234.15743819217;11324.15068869838;11356.716082097848;11374.601888933848;11377.146713996483;468664;468764;473208;478440;479313;88685;89426;92934;92970;93541;1102.7573933734566;1104.8066588347008;1132.0660455124555;1136.8010598145456;1141.3380239461092;17471;17669;17839.554011149827;18058.81941180624;18089.27642894322;40519;40834;41158.588414115475;41168.79415602903;42256;59561.7021914905;59937.400625993185;60028.69985650044;60557.39442605517;60824.69587652033;9078.45529268246;9266.305027122859;9312.161905428273;9347.719568412958;9517.428954262767;13397.665058373228;13569.86430135686;13625.454981800616;13640.931795341357;13754.862451375358;6122.142899994094;7538;8843.204111629984;11469.655910322703;11723.35521546323;11996.520139194334;12100.697482563006;12351.19717218378;12421.503139874303;12483.812742809047;11843.763124737285;11998.520059197534;12535.24788512692;12573.371331433209;12887.613371598867;8989.7752556184;9197.86203206939;9240.676576320066;9342.392744471588;9398.906010939803;9507.714768556954;12269.447874845475;12298.385080746106;12464.688382790502;12654.683632909251 03:27:43 INFO - PROCESS | 9269 | |3;mootools.html;1588.2455833479098;1592.2277695317769;1819.672458957388;1841.9079046047693;1921.5100149461875;7843.686252549891;8494.787630309245;8610.483370997737;8837.513936733478;8867.201951824343;8629.093945135764;8686.565671716404;8737.956310218457;8771.03518612952;8771.736847894574;2467.050185678513;2491.9626205606933;2494.2018554062706;2499.962515556042;2507.059852555292;2436.987815060922;2446.0460420436043;2461.729209786931;2463.2363967170236;2470.8023358131304;2475.4553998120386;2483.1184929350093;2519.6976362836394;2536.2391282615235;2540.212534114421;2440.1093600835743;2450.803935685141;2451.36264571211;2455.5088982203542;2467.2351571012955;2448.3511869354634;2454.2514533067406;2470.7529247075327;2475.603903375469;2494.675692160026;8855.291576673852;8934.955325223398;8950.955245223797;8952.507612081334;8953;5198.8440346789275;5337.4662533746705;5346.8395948121615;5395.271638328814;5400.810971615974;3533.381658209829;3558.6441355864467;3629.94555081674;3652.8356223969986;3653.5615726113037;1229.2931564350533;1258.735665510244;1293.4826069572152;1303.9543615973491;2233.9218127365625;11656.184067115306;11709;11762.235454695418;11764.058875290042;11772.470238839272;4472.44094488189;4532.342810292489;4573.314002899591;4579.725216486955;4618.468876079227;9512.09635084666;9512.95243523778;9519.286053546011;9542.61829526825;9542.666006689733;5136.383633963948;5151.124308867426;5184.714840683799;5194.168932970782;5206.088934436459;4738.8341408050555;4863.440704318978;4888.120138375127;4896;4920.581750551171;3878.6897048236638;3953.150072734376;4012.8394864205106;4015.5181378234797;4038.353863381845;1165.1785491228663;1168.1881092640704;1168.4333098447246;1182.810750279951;1246.389269258075;872.5768002518773;1061.6178175856685;1072.6192201768415;1076.531708706715;1096.9122470202365;6219;6236.282827474898;6251.3123556408755;6289.213848268966;6438.227412710505;497.3261231031972;505.83054676683724;506.3872714016082;514.5934711577812;514.9021685879671;4036.8183431745642;4064.918701625951;4093.324601440729;4097.651699605507;4149.937750933738;10608.522616482276;10957.452127393599;10982.231243813016;11086.168537359568;11132.777344453065;10766.892331076746;10908.181886358554;10921.672349829518;10989.395583242998;10992.670219893416;8072.8385432291025;8144.063432705315;8226.136255693065;8242.17578242171;8563.229309362063;6152.292486364126;6168.136460895568;6200.3179650237535;6245.812625621239;6367.522435817425;9499.762505937131;9729.805403892024;9738.561764720464;9758.609655613696;9784.315097943361;9671;9765.755856103655;10011.54948027326;10150.796984060426;10197.13324367437;6679.198496180489;7508.136564295176;7513.173550909286;7726.575038372944;7788.8831667526165;8176;8225.054118776417;8243.958780206061;8261.1325810789;8269.875951860606;7413.147488038944;7418.221086786026;7529.209433009455;7543.1325397579985;7749.8837517438415;7362.374198193;7420.109586849612;7474.103107627119;7557.584332861746;7590.506617069873;6994.055802466602;7032.12098487689;7051.612161330971;7093.255208203064;7096.467764917548;4769.833055843029;4989.9251511228085;5007.649464537448;5215.5827533797965;5318.8936221276135;5139.665921715076;5334.813281535127;5347.465253474621;5364.731763411735;5505.559555235652 03:27:43 INFO - PROCESS | 9269 | |4;prototype.html;367.3882984830257;368.52092280035953;373.3988278871019;375.2607363493918;379.1469194312796;6556.836079098025;6583.6708164591755;6610.735570577177;6621.006848972651;6664.5001624878205;6753.729850805962;6765.695543700533;6767.255601883801;6792.796216113512;6800.761973330935;5140.228965655163;5151.330327057477;5154.69071855688;5155.072087024334;5165.664231824938;5123.487651234884;5155.20094385369;5159.458256883029;5161.27742116104;5162.5028741665055;5098.770555325019;5107.361579802525;5114.795408183668;5115.488451154892;5131.923021154686;4799.592034677056;4901.828436004758;4905.583025442842;5084.771185296652;5110.616703747215;4270.338097594847;4274.636655884254;4281.892952676177;4284.550122237151;4286.76422796746;6393.7442502299855;6447.355264473562;6454.290028096905;6465.094886715863;6501.284858665543;5713.114467257582;5885.676287804169;5899.823005309848;5901.557383196277;5928.911066334009;7029.402500787439;7125.39434148098;7129.857402851966;7132.5007249492555;7136.144602403412;4830.058138662962;4833.32333473314;4834.226523756182;4858.489858564871;4859.58693511052;7383.889241661379;7461.216572259943;7475.962620186919;7483.9251607483775;7489.700411983514;4694.1550520905885;4865.659403841697;4976.353074100416;4983.227599722049;4988.6009119270375;4878.95121048792;4890.877728056827;4894.070126675921;4905.141600219948;4923.335349727741;5767.971160144256;5777.971110144506;5780.479756821906;5792.478676919098;5810.82567522975;7125.42996560274;7162.104736907887;7179.461540384492;7190.101237345332;7192.568445893263;1747.3185457671518;1775.2898840463658;1777.9288828446718;1778.6087060846594;1782.7415024821328;1072.6460268111505;1120.6806060272784;1122.2256642916361;1152.2683096233952;1175.7001964498997;6844.28135045823;6845.965770171118;6866.313368663094;6872.10662613857;6882.8623427531165;7326.450516211199;7329.486935914541;7334.66993985272;7345.595992220372;7353.117625884821;6756.966215168893;6788.864222715518;6822.522423430312;6845.726170953106;6851.2806155353965;3908.843646254175;3921.490206273166;3972.880813575597;3988.6210809973004;3995.320795464778;7591.202923692933;7701.961490192625;7708.807279817937;7728;7735.110462296795;7639.579823109782;7673.11759147694;7699.384049276045;7719.266669666373;7731.536107833548;7809;7809.219078092259;7812.296893279632;7812.687492500237;7825.530468171928;7270.127584689871;7424;7429.7399591014055;7464.066991626047;7472.8879066815125;7340.559566426032;7344.96327518359;7355.411567074728;7379.151397589346;7390.113186417664;7770.184130666199;7801.453898227297;7812.375009999073;7856.214378562098;7857.253560911704;4951.331570237971;4997.700137991586;4999.600111968654;5000.449950505369;5004.3994720633755;7290.088738907637;7466.514676546007;7470.103587569526;7471.925280747123;7486.663100160615;7233.095863017123;7259.854802904018;7290.234525374972;7290.270972902667;7300.853982920418;7228.421726261991;7261.164966028974;7315.63421828917;7321.341079302888;7324.816879578053;7073.363397294268;7127.429805615435;7129.215786263403;7130.5365151265005;7142.857142857218;7015.403690686348;7327.926720732725;7347.375473084848;7357.668904899186;7368.59472729005;6931.965340173469;7135.5361901476235;7150;7158.749443769443;7165.964170179324 03:27:43 INFO - PROCESS | 9269 | |5;yui.html;896.7399454158293;904.4121321141257;909.5361365703492;921.1663444582655;930.418488444722;15466.304016319264;15466.767998480032;15542.999999999985;15626.453074142408;15637;13907.165570065803;13973.510927117528;13979.79030314546;14013.369398377072;14023.579292621213;747.8055705516578;864.9740507784777;882.0650110882453;888.1118881118881;890.5458216309664;882.7042940614901;882.8101958079012;885.1944730295432;885.9246964008034;888.5779254853958;945.7541039329755;949.1742184299634;949.586929685589;953.3088510829627;953.9952300238489;941.764558860285;941.929355298352;945.5933948402185;946.5598496699033;949.5537097564134;697.490831692862;697.8639165362756;699.646678427396;700.1038670501766;700.8142842146835;15604.297806598617;15609.921950390175;15653.765193521993;15663.843361566353;15711.92144039284;15051.616381462101;15272.236388180658;15352.923235383863;15542.844571554253;15806.288717007763;11798.233114847508;12071.155019148664;12377.876221237762;12421.93789031058;12527.310997895112;4026.697997650188;4109.773962432065;4135.152293779768;4208.968802643341;4209.34755112958;58207;58232;58788.70605646987;59083;60013.09980350342;10507.369557826554;10732.946335268274;10787.83818242727;10837.566497340176;11928.986036186847;19808.306709265395;19953.301634442723;20029.298974536112;20079.59840803205;20198.899005504878;8316.792080198044;8411.158884111539;8656.78358041054;8707.085755995657;8758.2993360531;5163.586913046947;5194.6104042196985;5206.088934436459;5288.0745869472685;5368.221607866915;3741.5136032315627;3769.7361184716806;3779.1874746928993;3779.9433008504893;3817.122061925717;713.8607971445622;714.3392362065069;716.3338095571065;716.4984510842431;718.9137303523506;735.7057177129191;768.9849398793539;777.2577188784697;780.0288640642323;787.7715462515806;10130.594776209016;10315.948420257851;10332.690019299433;10409.219308551888;10637.574497020187;738.4867517075688;760.3157158557232;821.6138414944967;853.1724227499316;853.4452605806151;4646.279826626811;4732.124556956974;4733.692309999908;4751.311059896296;4798.736069516141;68251.31748682549;68306;68576.31423685799;68933;68987;60692.39307606956;61760;62154.37845621486;62316.065259021154;62917.056244156374;53502.19746703802;54308.18537721937;54697.45302547003;54897.176542351895;55262;9071.773205669648;9081.137291957253;9121.680741174026;9124.224440922331;9391.624335026523;38578.15837275676;38985.41521877231;39108.80445597754;39145;39301.80349098236;47098.52901471079;48799.75600122118;54008.459915400344;54337.72831135977;54409.18386224289;11944.4637554498;12127.939360303142;12251.142420030512;12294;12297.56958506448;12612.49550017989;12662.683432914251;12930.030247731645;13021.934890325489;13095.41070651804;12349.814752778535;12388.62834114978;12646.936765316115;13073.542426015043;13317.866821331663;12475.812862806884;12915.870841291468;13100.213987160801;13312.933435332761;13728.519501817389;12442.253464792142;12445.37773111359;12511.499540018662;12743.617691469271;12748.872511274769;10185.643502477378;10314.638987635397;10607.098396636373;10793.946030269799;10864.619738309122;10517.894821051692;10807.567697292021;10999.890001100206;11000.669979900616;11025.283356581796 03:27:43 INFO - PROCESS | 9269 | __end_tp_report 03:27:43 INFO - PROCESS | 9269 | __start_cc_report 03:27:43 INFO - PROCESS | 9269 | _x_x_mozilla_cycle_collect,326 03:27:43 INFO - PROCESS | 9269 | __end_cc_report 03:27:43 INFO - PROCESS | 9269 | __startTimestamp1463480863735__endTimestamp 03:27:43 INFO - PROCESS | 9269 | 03:27:43 INFO - PROCESS | 9269 | ------- Summary: start ------- 03:27:43 INFO - PROCESS | 9269 | Number of tests: 6 03:27:43 INFO - PROCESS | 9269 | 03:27:43 INFO - PROCESS | 9269 | [#0] dojo.html Cycles:165 Average:5654.09 Median:5897.47 stddev:630.98 (10.7%) stddev-sans-first:606.60 03:27:43 INFO - PROCESS | 9269 | Values: 3355.7 3418.3 3434.7 3444.0 3465.9 5556.7 5627.4 5631.0 5642.1 5655.4 5547.7 5596.7 5603.2 5638.5 5682.8 5103.6 5110.9 5125.2 5151.5 5190.5 5045.9 5210.2 5229.6 5233.1 5273.8 5172.2 5182.1 5184.1 5194.1 5244.5 5187.9 5188.8 5198.9 5204.3 5234.3 4952.1 5013.4 5105.7 5142.6 5193.6 5537.5 5571.9 5581.9 5597.7 5649.2 6034.1 6067.1 6096.1 6097.2 6110.8 5978.3 6096.5 6097.8 6115.8 6118.2 5632.3 5637.6 5643.4 5652.8 5698.3 6122.0 6126.6 6130.6 6145.7 6153.7 5896.9 5903.3 5904.4 5971.7 6013.0 6086.2 6087.8 6088.0 6098.8 6106.5 6031.2 6054.7 6072.3 6083.0 6085.9 5975.6 6064.4 6137.4 6146.2 6154.3 4631.7 4636.4 4638.7 4648.8 4657.9 4119.2 4170.5 4170.6 4172.7 4192.9 5674.8 5703.9 5787.8 5820.6 5836.7 6120.7 6127.7 6152.1 6156.9 6175.1 5814.6 5875.8 5876.9 5886.4 5886.9 5188.7 5192.3 5204.9 5216.4 5242.8 6334.4 6344.8 6356.4 6362.3 6365.8 6041.7 6076.0 6155.3 6158.5 6185.3 6192.4 6209.2 6212.2 6236.8 6242.4 5849.6 5872.3 5891.9 5897.5 5917.3 5916.0 5974.9 6011.3 6016.2 6024.8 6048.5 6089.4 6107.0 6109.3 6123.8 6030.0 6052.8 6060.4 6072.6 6080.4 5830.6 5834.6 5931.4 5962.7 5972.2 5997.4 6057.3 6060.0 6067.4 6083.9 5836.3 5907.6 5911.0 5921.1 5922.1 03:27:43 INFO - PROCESS | 9269 | 03:27:43 INFO - PROCESS | 9269 | [#1] ext.html Cycles:180 Average:60661.85 Median:41422.09 stddev:126535.42 (305.5%) stddev-sans-first:126810.04 03:27:43 INFO - PROCESS | 9269 | Values: 606.1 657.8 662.2 668.3 677.0 37850.6 38179.0 38637.8 38674.8 38846.4 45306.5 45972.3 46213.5 46217.0 46413.3 8820.3 9061.6 9080.6 9099.7 9114.5 9052.4 9068.5 9090.2 9147.1 9177.2 9202.0 9225.8 9230.6 9234.0 9244.9 9066.4 9177.9 9216.1 9221.2 9250.8 9009.2 9082.6 9108.8 9141.1 9168.9 41699.8 41927.4 41999.6 42086.6 42114.0 3930.4 3993.0 4236.4 4308.7 4579.3 32029.4 32060.4 32252.5 32315.4 34188.0 4616.9 4685.2 4726.6 4760.1 4849.2 338043.0 338948.0 338992.0 340042.0 341483.0 39238.6 39773.4 39960.6 59818.7 59985.1 37508.8 37516.8 37566.0 37709.2 37944.6 15235.2 15300.8 15354.2 15441.8 15458.8 12821.9 12833.7 12870.4 12946.7 12949.8 9359.4 9360.9 9395.7 9410.3 9494.1 3645.9 3672.4 3723.2 3755.6 3784.2 1090.8 1125.4 1196.5 1200.4 1216.1 32464.0 33041.0 33173.3 33288.5 33953.2 1106.3 1157.9 1171.3 1204.1 1226.4 17007.3 17147.0 17355.4 17377.8 17544.6 459668.0 550866.0 562336.0 563063.0 829465.0 61071.0 61720.0 62057.7 62477.7 62572.0 1473.6 1480.3 1497.9 1498.2 1502.1 32734.0 33152.8 33465.8 33773.5 34169.0 52831.2 53029.0 53048.7 53552.7 53624.5 436101.0 437907.0 437986.0 439674.0 440082.0 30448.5 30725.5 31004.0 31251.7 31303.8 48538.8 49286.0 49424.8 50003.5 50199.0 41218.4 41256.2 41265.1 41277.4 42398.4 40945.6 40989.4 41582.6 41798.6 42075.6 41566.8 42113.6 43987.6 44962.8 45348.8 32710.3 33028.0 33257.0 33419.3 34052.5 28288.6 28492.4 28636.7 28730.7 29039.3 03:27:43 INFO - PROCESS | 9269 | 03:27:43 INFO - PROCESS | 9269 | [#2] jquery.html Cycles:180 Average:28674.16 Median:2569.45 stddev:78230.43 (3044.6%) stddev-sans-first:78421.14 03:27:43 INFO - PROCESS | 9269 | Values: 425.8 441.5 443.5 445.5 455.1 18449.0 18564.9 19053.7 19888.9 19942.2 12230.3 12860.4 12910.7 12918.5 12975.2 5291.8 5440.9 5595.5 5841.8 5877.5 5774.3 5797.6 5804.3 5817.0 6328.0 6560.1 6610.5 6628.1 6628.9 6630.4 5873.4 5879.3 6270.6 6576.2 6583.7 5817.9 5819.3 5822.5 5839.9 5853.4 14667.2 20215.0 23202.8 23546.9 23940.2 2363.1 2569.3 2569.6 2864.6 2949.4 9880.5 10454.7 10609.6 11089.2 11235.9 2094.4 2103.6 2106.8 2133.0 2144.5 77047.0 81745.6 82864.3 85916.0 89375.0 11723.5 11737.5 11771.5 11856.7 12152.2 16607.5 16796.3 16868.8 16894.4 16993.8 8245.6 8575.2 8743.3 8988.1 9047.0 8146.4 8338.7 8342.5 8348.4 8493.4 5061.7 5104.3 5113.2 5244.1 5272.9 2079.7 2132.8 2156.9 2167.3 2197.2 967.7 1117.7 1164.7 1164.8 1205.8 19552.7 19755.3 19896.8 19937.5 20446.1 1044.0 1047.6 1064.8 1077.7 1079.6 11234.2 11324.2 11356.7 11374.6 11377.1 468664.0 468764.0 473208.0 478440.0 479313.0 88685.0 89426.0 92934.0 92970.0 93541.0 1102.8 1104.8 1132.1 1136.8 1141.3 17471.0 17669.0 17839.6 18058.8 18089.3 40519.0 40834.0 41158.6 41168.8 42256.0 59561.7 59937.4 60028.7 60557.4 60824.7 9078.5 9266.3 9312.2 9347.7 9517.4 13397.7 13569.9 13625.5 13640.9 13754.9 6122.1 7538.0 8843.2 11469.7 11723.4 11996.5 12100.7 12351.2 12421.5 12483.8 11843.8 11998.5 12535.2 12573.4 12887.6 8989.8 9197.9 9240.7 9342.4 9398.9 9507.7 12269.4 12298.4 12464.7 12654.7 03:27:43 INFO - PROCESS | 9269 | 03:27:43 INFO - PROCESS | 9269 | [#3] mootools.html Cycles:180 Average:5772.29 Median:2756.74 stddev:3173.31 (115.1%) stddev-sans-first:3166.64 03:27:43 INFO - PROCESS | 9269 | Values: 1588.2 1592.2 1819.7 1841.9 1921.5 7843.7 8494.8 8610.5 8837.5 8867.2 8629.1 8686.6 8738.0 8771.0 8771.7 2467.1 2492.0 2494.2 2500.0 2507.1 2437.0 2446.0 2461.7 2463.2 2470.8 2475.5 2483.1 2519.7 2536.2 2540.2 2440.1 2450.8 2451.4 2455.5 2467.2 2448.4 2454.3 2470.8 2475.6 2494.7 8855.3 8935.0 8951.0 8952.5 8953.0 5198.8 5337.5 5346.8 5395.3 5400.8 3533.4 3558.6 3629.9 3652.8 3653.6 1229.3 1258.7 1293.5 1304.0 2233.9 11656.2 11709.0 11762.2 11764.1 11772.5 4472.4 4532.3 4573.3 4579.7 4618.5 9512.1 9513.0 9519.3 9542.6 9542.7 5136.4 5151.1 5184.7 5194.2 5206.1 4738.8 4863.4 4888.1 4896.0 4920.6 3878.7 3953.2 4012.8 4015.5 4038.4 1165.2 1168.2 1168.4 1182.8 1246.4 872.6 1061.6 1072.6 1076.5 1096.9 6219.0 6236.3 6251.3 6289.2 6438.2 497.3 505.8 506.4 514.6 514.9 4036.8 4064.9 4093.3 4097.7 4149.9 10608.5 10957.5 10982.2 11086.2 11132.8 10766.9 10908.2 10921.7 10989.4 10992.7 8072.8 8144.1 8226.1 8242.2 8563.2 6152.3 6168.1 6200.3 6245.8 6367.5 9499.8 9729.8 9738.6 9758.6 9784.3 9671.0 9765.8 10011.5 10150.8 10197.1 6679.2 7508.1 7513.2 7726.6 7788.9 8176.0 8225.1 8244.0 8261.1 8269.9 7413.1 7418.2 7529.2 7543.1 7749.9 7362.4 7420.1 7474.1 7557.6 7590.5 6994.1 7032.1 7051.6 7093.3 7096.5 4769.8 4989.9 5007.6 5215.6 5318.9 5139.7 5334.8 5347.5 5364.7 5505.6 03:27:43 INFO - PROCESS | 9269 | 03:27:43 INFO - PROCESS | 9269 | [#4] prototype.html Cycles:180 Average:5974.24 Median:6796.78 stddev:1856.42 (27.3%) stddev-sans-first:1813.30 03:27:43 INFO - PROCESS | 9269 | Values: 367.4 368.5 373.4 375.3 379.1 6556.8 6583.7 6610.7 6621.0 6664.5 6753.7 6765.7 6767.3 6792.8 6800.8 5140.2 5151.3 5154.7 5155.1 5165.7 5123.5 5155.2 5159.5 5161.3 5162.5 5098.8 5107.4 5114.8 5115.5 5131.9 4799.6 4901.8 4905.6 5084.8 5110.6 4270.3 4274.6 4281.9 4284.6 4286.8 6393.7 6447.4 6454.3 6465.1 6501.3 5713.1 5885.7 5899.8 5901.6 5928.9 7029.4 7125.4 7129.9 7132.5 7136.1 4830.1 4833.3 4834.2 4858.5 4859.6 7383.9 7461.2 7476.0 7483.9 7489.7 4694.2 4865.7 4976.4 4983.2 4988.6 4879.0 4890.9 4894.1 4905.1 4923.3 5768.0 5778.0 5780.5 5792.5 5810.8 7125.4 7162.1 7179.5 7190.1 7192.6 1747.3 1775.3 1777.9 1778.6 1782.7 1072.6 1120.7 1122.2 1152.3 1175.7 6844.3 6846.0 6866.3 6872.1 6882.9 7326.5 7329.5 7334.7 7345.6 7353.1 6757.0 6788.9 6822.5 6845.7 6851.3 3908.8 3921.5 3972.9 3988.6 3995.3 7591.2 7702.0 7708.8 7728.0 7735.1 7639.6 7673.1 7699.4 7719.3 7731.5 7809.0 7809.2 7812.3 7812.7 7825.5 7270.1 7424.0 7429.7 7464.1 7472.9 7340.6 7345.0 7355.4 7379.2 7390.1 7770.2 7801.5 7812.4 7856.2 7857.3 4951.3 4997.7 4999.6 5000.4 5004.4 7290.1 7466.5 7470.1 7471.9 7486.7 7233.1 7259.9 7290.2 7290.3 7300.9 7228.4 7261.2 7315.6 7321.3 7324.8 7073.4 7127.4 7129.2 7130.5 7142.9 7015.4 7327.9 7347.4 7357.7 7368.6 6932.0 7135.5 7150.0 7158.7 7166.0 03:27:43 INFO - PROCESS | 9269 | 03:27:43 INFO - PROCESS | 9269 | [#5] yui.html Cycles:180 Average:16026.66 Median:25872.40 stddev:19004.08 (73.5%) stddev-sans-first:19023.43 03:27:43 INFO - PROCESS | 9269 | Values: 896.7 904.4 909.5 921.2 930.4 15466.3 15466.8 15543.0 15626.5 15637.0 13907.2 13973.5 13979.8 14013.4 14023.6 747.8 865.0 882.1 888.1 890.5 882.7 882.8 885.2 885.9 888.6 945.8 949.2 949.6 953.3 954.0 941.8 941.9 945.6 946.6 949.6 697.5 697.9 699.6 700.1 700.8 15604.3 15609.9 15653.8 15663.8 15711.9 15051.6 15272.2 15352.9 15542.8 15806.3 11798.2 12071.2 12377.9 12421.9 12527.3 4026.7 4109.8 4135.2 4209.0 4209.3 58207.0 58232.0 58788.7 59083.0 60013.1 10507.4 10732.9 10787.8 10837.6 11929.0 19808.3 19953.3 20029.3 20079.6 20198.9 8316.8 8411.2 8656.8 8707.1 8758.3 5163.6 5194.6 5206.1 5288.1 5368.2 3741.5 3769.7 3779.2 3779.9 3817.1 713.9 714.3 716.3 716.5 718.9 735.7 769.0 777.3 780.0 787.8 10130.6 10315.9 10332.7 10409.2 10637.6 738.5 760.3 821.6 853.2 853.4 4646.3 4732.1 4733.7 4751.3 4798.7 68251.3 68306.0 68576.3 68933.0 68987.0 60692.4 61760.0 62154.4 62316.1 62917.1 53502.2 54308.2 54697.5 54897.2 55262.0 9071.8 9081.1 9121.7 9124.2 9391.6 38578.2 38985.4 39108.8 39145.0 39301.8 47098.5 48799.8 54008.5 54337.7 54409.2 11944.5 12127.9 12251.1 12294.0 12297.6 12612.5 12662.7 12930.0 13021.9 13095.4 12349.8 12388.6 12646.9 13073.5 13317.9 12475.8 12915.9 13100.2 13312.9 13728.5 12442.3 12445.4 12511.5 12743.6 12748.9 10185.6 10314.6 10607.1 10793.9 10864.6 10517.9 10807.6 10999.9 11000.7 11025.3 03:27:43 INFO - PROCESS | 9269 | -------- Summary: end -------- 03:27:43 INFO - PROCESS | 9269 | 03:27:44 INFO - TEST-INFO | 9269: exit 0 03:27:44 INFO - TEST-OK | dromaeo_css | took 1108617ms 03:27:44 INFO - TEST-START | kraken 03:27:44 INFO - operating with platform_type : linux_ 03:27:44 INFO - Initialising browser for kraken test... 03:27:44 INFO - TEST-INFO | started process 9516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9HFZ2s/profile http://localhost:46420/getInfo.html) 03:27:47 INFO - PROCESS | 9516 | 03:27:47 INFO - PROCESS | 9516 | (process:9594): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:27:48 INFO - PROCESS | 9516 | __metrics Screen width/height:1600/1200 03:27:48 INFO - PROCESS | 9516 | colorDepth:24 03:27:48 INFO - PROCESS | 9516 | Browser inner width/height: 1024/697 03:27:48 INFO - PROCESS | 9516 | __metrics 03:27:49 ERROR - PROCESS | 9516 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 03:27:50 INFO - TEST-INFO | 9516: exit 0 03:27:50 INFO - Browser initialized. 03:27:50 INFO - Running cycle 1/1 for kraken test... 03:27:50 INFO - TEST-INFO | started process 9645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9HFZ2s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:51 INFO - PROCESS | 9645 | 03:27:51 INFO - PROCESS | 9645 | (process:9713): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:28:01 INFO - PROCESS | 9645 | RSS: Main: 152236032 03:28:01 INFO - PROCESS | 9645 | 03:28:04 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46420/tests/kraken/driver.html?testName=audio-beat-detection) 03:28:05 INFO - PROCESS | 9645 | RSS: Main: 156999680 03:28:05 INFO - PROCESS | 9645 | 03:28:07 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46420/tests/kraken/driver.html?testName=audio-dft) 03:28:08 INFO - PROCESS | 9645 | RSS: Main: 156991488 03:28:08 INFO - PROCESS | 9645 | 03:28:11 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46420/tests/kraken/driver.html?testName=audio-fft) 03:28:11 INFO - PROCESS | 9645 | RSS: Main: 157192192 03:28:11 INFO - PROCESS | 9645 | 03:28:14 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46420/tests/kraken/driver.html?testName=audio-oscillator) 03:28:14 INFO - PROCESS | 9645 | RSS: Main: 157130752 03:28:14 INFO - PROCESS | 9645 | 03:28:16 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46420/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:28:17 INFO - PROCESS | 9645 | RSS: Main: 157085696 03:28:17 INFO - PROCESS | 9645 | 03:28:20 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46420/tests/kraken/driver.html?testName=imaging-darkroom) 03:28:21 INFO - PROCESS | 9645 | RSS: Main: 157093888 03:28:21 INFO - PROCESS | 9645 | 03:28:24 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46420/tests/kraken/driver.html?testName=imaging-desaturate) 03:28:24 INFO - PROCESS | 9645 | RSS: Main: 158273536 03:28:24 INFO - PROCESS | 9645 | 03:28:27 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46420/tests/kraken/driver.html?testName=json-parse-financial) 03:28:28 INFO - PROCESS | 9645 | RSS: Main: 157708288 03:28:28 INFO - PROCESS | 9645 | 03:28:29 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46420/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:28:30 INFO - PROCESS | 9645 | RSS: Main: 157089792 03:28:30 INFO - PROCESS | 9645 | 03:28:32 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:28:32 INFO - PROCESS | 9645 | RSS: Main: 157188096 03:28:32 INFO - PROCESS | 9645 | 03:28:34 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:28:35 INFO - PROCESS | 9645 | RSS: Main: 157609984 03:28:35 INFO - PROCESS | 9645 | 03:28:37 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:28:38 INFO - PROCESS | 9645 | RSS: Main: 158162944 03:28:38 INFO - PROCESS | 9645 | 03:28:41 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:28:41 INFO - PROCESS | 9645 | RSS: Main: 158400512 03:28:41 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46420/tests/kraken/driver.html?testName=ai-astar) 03:28:43 INFO - PROCESS | 9645 | RSS: Main: 159899648 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | __start_tp_report 03:28:43 INFO - PROCESS | 9645 | _x_x_mozilla_page_load 03:28:43 INFO - PROCESS | 9645 | _x_x_mozilla_page_load_details 03:28:43 INFO - PROCESS | 9645 | |i|pagename|runs| 03:28:43 INFO - PROCESS | 9645 | |0;ai-astar;108;111;103;109;111;112;100;110;109;109 03:28:43 INFO - PROCESS | 9645 | |1;audio-beat-detection;162;128;154;183;130;161;153;129;194;132 03:28:43 INFO - PROCESS | 9645 | |2;audio-dft;163;161;163;162;161;161;162;161;163;161 03:28:43 INFO - PROCESS | 9645 | |3;audio-fft;74;75;77;182;76;74;74;74;173;76 03:28:43 INFO - PROCESS | 9645 | |4;audio-oscillator;91;91;146;92;94;91;140;94;93;144 03:28:43 INFO - PROCESS | 9645 | |5;imaging-gaussian-blur;118;117;118;117;118;118;118;119;117;117 03:28:43 INFO - PROCESS | 9645 | |6;imaging-darkroom;146;146;146;147;150;146;146;147;146;147 03:28:43 INFO - PROCESS | 9645 | |7;imaging-desaturate;95;95;95;96;94;96;94;95;95;96 03:28:43 INFO - PROCESS | 9645 | |8;json-parse-financial;54;59;56;55;55;56;56;75;55;53 03:28:43 INFO - PROCESS | 9645 | |9;json-stringify-tinderbox;58;57;57;58;58;57;59;59;58;59 03:28:43 INFO - PROCESS | 9645 | |10;stanford-crypto-aes;75;84;76;75;73;74;75;74;75;76 03:28:43 INFO - PROCESS | 9645 | |11;stanford-crypto-ccm;122;122;115;117;114;120;114;121;128;130 03:28:43 INFO - PROCESS | 9645 | |12;stanford-crypto-pbkdf2;164;157;160;158;169;159;162;164;158;159 03:28:43 INFO - PROCESS | 9645 | |13;stanford-crypto-sha256-iterative;67;69;66;65;66;67;66;70;66;67 03:28:43 INFO - PROCESS | 9645 | __end_tp_report 03:28:43 INFO - PROCESS | 9645 | __start_cc_report 03:28:43 INFO - PROCESS | 9645 | _x_x_mozilla_cycle_collect,831 03:28:43 INFO - PROCESS | 9645 | __end_cc_report 03:28:43 INFO - PROCESS | 9645 | __startTimestamp1463480923882__endTimestamp 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | ------- Summary: start ------- 03:28:43 INFO - PROCESS | 9645 | Number of tests: 14 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.50 stddev:3.79 (3.5%) stddev-sans-first:4.02 03:28:43 INFO - PROCESS | 9645 | Values: 108.0 111.0 103.0 109.0 111.0 112.0 100.0 110.0 109.0 109.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:157.50 stddev:23.32 (14.8%) stddev-sans-first:24.49 03:28:43 INFO - PROCESS | 9645 | Values: 162.0 128.0 154.0 183.0 130.0 161.0 153.0 129.0 194.0 132.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 03:28:43 INFO - PROCESS | 9645 | Values: 163.0 161.0 163.0 162.0 161.0 161.0 162.0 161.0 163.0 161.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#3] audio-fft Cycles:10 Average:95.50 Median:74.50 stddev:43.28 (58.1%) stddev-sans-first:45.20 03:28:43 INFO - PROCESS | 9645 | Values: 74.0 75.0 77.0 182.0 76.0 74.0 74.0 74.0 173.0 76.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:91.50 stddev:24.73 (27.0%) stddev-sans-first:25.49 03:28:43 INFO - PROCESS | 9645 | Values: 91.0 91.0 146.0 92.0 94.0 91.0 140.0 94.0 93.0 144.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:28:43 INFO - PROCESS | 9645 | Values: 118.0 117.0 118.0 117.0 118.0 118.0 118.0 119.0 117.0 117.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:1.25 (0.9%) stddev-sans-first:1.30 03:28:43 INFO - PROCESS | 9645 | Values: 146.0 146.0 146.0 147.0 150.0 146.0 146.0 147.0 146.0 147.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 03:28:43 INFO - PROCESS | 9645 | Values: 95.0 95.0 95.0 96.0 94.0 96.0 94.0 95.0 95.0 96.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:56.00 stddev:6.38 (11.4%) stddev-sans-first:6.65 03:28:43 INFO - PROCESS | 9645 | Values: 54.0 59.0 56.0 55.0 55.0 56.0 56.0 75.0 55.0 53.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 03:28:43 INFO - PROCESS | 9645 | Values: 58.0 57.0 57.0 58.0 58.0 57.0 59.0 59.0 58.0 59.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.00 stddev:3.06 (4.1%) stddev-sans-first:3.23 03:28:43 INFO - PROCESS | 9645 | Values: 75.0 84.0 76.0 75.0 73.0 74.0 75.0 74.0 75.0 76.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:121.50 stddev:5.56 (4.6%) stddev-sans-first:5.86 03:28:43 INFO - PROCESS | 9645 | Values: 122.0 122.0 115.0 117.0 114.0 120.0 114.0 121.0 128.0 130.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.00 stddev:3.74 (2.3%) stddev-sans-first:3.81 03:28:43 INFO - PROCESS | 9645 | Values: 164.0 157.0 160.0 158.0 169.0 159.0 162.0 164.0 158.0 159.0 03:28:43 INFO - PROCESS | 9645 | 03:28:43 INFO - PROCESS | 9645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.52 (2.3%) stddev-sans-first:1.62 03:28:43 INFO - PROCESS | 9645 | Values: 67.0 69.0 66.0 65.0 66.0 67.0 66.0 70.0 66.0 67.0 03:28:43 INFO - PROCESS | 9645 | -------- Summary: end -------- 03:28:43 INFO - PROCESS | 9645 | 03:28:44 INFO - TEST-INFO | 9645: exit 0 03:28:44 INFO - TEST-OK | kraken | took 60404ms 03:28:44 INFO - SUITE-END | took 1169s 03:28:45 INFO - Completed test suite (00:19:29) 03:28:45 INFO - javascript benchmark 03:28:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3355.664433556644, 3418.2650730093033, 3434.6908778209954, 3443.982780086101, 3465.8960231193073, 5556.666600004002, 5627.380988091312, 5631.042722737135, 5642.097264437691, 5655.3779084300695, 5547.667139971594, 5596.664200147984, 5603.159526071081, 5638.492535671789, 5682.801101961432, 5103.591712662978, 5110.923336149961, 5125.231215317714, 5151.536361727443, 5190.506901844319, 5045.899082018357, 5210.2445145453885, 5229.60777941654, 5233.136532472137, 5273.815416460425, 5172.172452407615, 5182.119039763249, 5184.066867963765, 5194.0910340690225, 5244.501772331622, 5187.948120518803, 5188.8183913563225, 5198.9480105198845, 5204.323437953042, 5234.345706786652, 4952.059108769322, 5013.373328333958, 5105.744712764384, 5142.588592912558, 5193.636445448782, 5537.529310008654, 5571.944280557183, 5581.8604534886545, 5597.74810133545, 5649.152627105926, 6034.125051867454, 6067.120267561223, 6096.085587161917, 6097.17688112108, 6110.7861224856915, 5978.342382337939, 6096.451319381233, 6097.756089756404, 6115.788007244199, 6118.235220597426, 5632.2678051853, 5637.605367624227, 5643.407442218549, 5652.773889044433, 5698.2592263005545, 6122.0, 6126.632402055891, 6130.63216207029, 6145.723442445101, 6153.661548614779, 5896.911546326808, 5903.321118071477, 5904.4095590441475, 5971.671558064349, 6013.0, 6086.2087928569, 6087.817365479043, 6088.0, 6098.786542470993, 6106.542009349317, 6031.215941927521, 6054.697265136726, 6072.271327440735, 6082.969585152135, 6085.878282434326, 5975.611585247032, 6064.36324185963, 6137.355577664371, 6146.231721034871, 6154.292256390572, 4631.722096674211, 4636.35091087248, 4638.6752927294765, 4648.837290694877, 4657.86026419208, 4119.237940980928, 4170.457840480718, 4170.645495132887, 4172.666186705056, 4192.937105943413, 5674.801381951695, 5703.9429605704245, 5787.826365209051, 5820.621659592113, 5836.67898265591, 6120.722263144302, 6127.724252408652, 6152.107944348045, 6156.938430615636, 6175.073738939105, 5814.592978491465, 5875.794347197828, 5876.882462350729, 5886.411358864165, 5886.941130588725, 5188.688678679291, 5192.273081768555, 5204.869878252998, 5216.374035115735, 5242.7640756166065, 6334.398232167937, 6344.777932772331, 6356.396142366468, 6362.2683391409655, 6365.809025729235, 6041.697915104315, 6076.0, 6155.322914479493, 6158.538109641795, 6185.257769067741, 6192.411720886508, 6209.161763161916, 6212.192414986023, 6236.750529978932, 6242.438180563771, 5849.61977471463, 5872.349735470626, 5891.941080589139, 5897.469227769521, 5917.319508256433, 5916.0, 5974.9103763444455, 6011.308699499614, 6016.217891674054, 6024.819255422344, 6048.516118710405, 6089.421504957022, 6106.969465152823, 6109.313572000111, 6123.8162855114415, 6030.0, 6052.818415447544, 6060.424259695322, 6072.574919755575, 6080.3615620361, 5830.5627077968475, 5834.649921004753, 5931.406859314034, 5962.70186490665, 5972.163897054503, 5997.430244126801, 6057.333693293822, 6060.000099983629, 6067.362926892612, 6083.939160608515, 5836.270466191726, 5907.556933229939, 5910.970445147918, 5921.14143449206, 5922.111683247547], "value": 5612.90783422704, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.1332294818411, 657.7500549791079, 662.2185820731535, 668.2949488289854, 676.9559978601392, 37850.62149378505, 38179.0, 38637.80681096591, 38674.806625966834, 38846.41730374043, 45306.54693453065, 45972.310415343796, 46213.53786462134, 46217.0, 46413.30380044302, 8820.2502787263, 9061.637534498612, 9080.636774529012, 9099.727008189764, 9114.45313281202, 9052.41159324645, 9068.54657267134, 9090.181883630472, 9147.085291470867, 9177.174054335108, 9202.0, 9225.769355766093, 9230.630774769, 9233.95383023084, 9244.8613270801, 9066.410683305565, 9177.908220917805, 9216.124468175512, 9221.216196623294, 9250.814983700322, 9009.189172974464, 9082.636694532212, 9108.817823643556, 9141.131592498701, 9168.908310916871, 41699.7915010426, 41927.371089433684, 41999.58000420018, 42086.57913420888, 42114.0, 3930.390789427643, 3992.9800350998057, 4236.449261596003, 4308.655307575386, 4579.290210017452, 32029.398530073402, 32060.358792824012, 32252.516212256836, 32315.353692926008, 34188.0, 4616.884577885546, 4685.20351540239, 4726.574608285271, 4760.095581839474, 4849.248366503198, 338043.0, 338948.0, 338992.0, 340041.9999999975, 341483.0, 39238.60761392407, 39773.40339894904, 39960.60039399627, 59818.700906495185, 59985.10022349668, 37508.81245593809, 37516.81241593775, 37566.0, 37709.245815083545, 37944.620553794106, 15235.16206608625, 15300.770488442682, 15354.155521446204, 15441.845581544265, 15458.768118478232, 12821.935890320676, 12833.743325133632, 12870.356482175854, 12946.741065178643, 12949.805752913713, 9359.438433694, 9360.859587106199, 9395.718128456158, 9410.341276110606, 9494.145526902474, 3645.9453108203397, 3672.375696131664, 3723.1622884851236, 3755.5681096673684, 3784.2242340320167, 1090.8472813806075, 1125.4429057616533, 1196.5393323570313, 1200.4117982188839, 1216.0818581970732, 32464.0, 33041.0, 33173.336533269685, 33288.50067248993, 33953.15117122092, 1106.2706927883362, 1157.9421028948518, 1171.3030746705867, 1204.1390405859852, 1226.3868065967017, 17007.319707211573, 17147.0, 17355.392561260294, 17377.826221737872, 17544.649107017787, 459668.0, 550866.0, 562336.0, 563063.0, 829465.0, 61071.0, 61720.0, 62057.68971155115, 62477.687611561654, 62572.0, 1473.616859616486, 1480.3042569992087, 1497.9026363286353, 1498.2134379450877, 1502.068717395222, 32734.0, 33152.83423582867, 33465.83267083649, 33773.49339759856, 34169.0, 52831.20753188782, 53029.0, 53048.73475632597, 53552.73223633857, 53624.46375536195, 436101.0, 437907.0, 437986.0, 439674.0, 440082.0, 30448.543271850496, 30725.53911691371, 31004.0, 31251.68748312488, 31303.84348078245, 48538.75730621324, 49286.0, 49424.75287623539, 50003.499964999886, 50199.0, 41218.38172427356, 41256.174876501704, 41265.14306856139, 41277.38083928683, 42398.36402454027, 40945.59054409418, 40989.38515922323, 41582.58417415787, 41798.58201417947, 42075.57924420839, 41566.79216603898, 42113.57886421219, 43987.56012439835, 44962.77518612386, 45348.77325613351, 32710.34579308353, 33028.00915972525, 33257.00228993134, 33419.33161336711, 34052.48921266232, 28288.575671364535, 28492.43015139727, 28636.713632863404, 28730.712692872803, 29039.274018149714], "value": 19565.007474061276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.774339600012, 441.46803102261777, 443.52099732289133, 445.5255153261778, 455.0739245635131, 18449.0, 18564.907175464137, 19053.71419428708, 19888.90055549724, 19942.202311907506, 12230.266184028964, 12860.421281042352, 12910.741785164315, 12918.483260669585, 12975.221486710803, 5291.814786482483, 5440.945590544084, 5595.468430499096, 5841.7955371562, 5877.471027607515, 5774.2782152230975, 5797.5651826113, 5804.332501762288, 5817.0, 6327.968360158193, 6560.147180866505, 6610.537262391635, 6628.072069910192, 6628.867422651544, 6630.3701148391065, 5873.442023007808, 5879.32387775407, 6270.561060725729, 6576.243731970812, 6583.736650533973, 5817.941820581782, 5819.330776960662, 5822.505087067604, 5839.941600583982, 5853.443922827325, 14667.193304368255, 20215.0, 23202.76797232023, 23546.882265588734, 23940.204484663547, 2363.1138323128826, 2569.2806014315834, 2569.6145578163237, 2864.613277207592, 2949.3806300676883, 9880.456574888378, 10454.738631534197, 10609.628662996758, 11089.2237543372, 11235.887641123565, 2094.413564202026, 2103.5792841431776, 2106.7682554918947, 2133.0401319406174, 2144.5174835662006, 77047.0, 81745.59127204385, 82864.342713146, 85916.0, 89375.0, 11723.472443740053, 11737.471813768401, 11771.529138834521, 11856.70358241051, 12152.21010634306, 16607.50177494677, 16796.328146873988, 16868.831311686972, 16894.40869569559, 16993.83006169947, 8245.587720614065, 8575.185357391038, 8743.300535957109, 8988.146126118008, 9046.954765226132, 8146.389020823343, 8338.749837504885, 8342.541160236246, 8348.373871959628, 8493.405461617751, 5061.746912654353, 5104.259882317043, 5113.207452844815, 5244.056069907453, 5272.894542109137, 2079.6880467929627, 2132.797384248494, 2156.9352919412445, 2167.349795061475, 2197.2419515267206, 967.7241986033946, 1117.709395557161, 1164.6913567904512, 1164.8485696859354, 1205.7950148474604, 19552.706709399372, 19755.308564200182, 19896.801031989784, 19937.501562461053, 20446.07992640335, 1043.994780026095, 1047.6176195688672, 1064.8296272596347, 1077.6551503518956, 1079.5857426770956, 11234.15743819217, 11324.15068869838, 11356.716082097848, 11374.601888933848, 11377.146713996483, 468664.0, 468764.0, 473208.0, 478440.0, 479313.0, 88685.0, 89426.0, 92934.0, 92970.0, 93541.0, 1102.7573933734566, 1104.8066588347008, 1132.0660455124555, 1136.8010598145456, 1141.3380239461092, 17471.0, 17669.0, 17839.554011149827, 18058.81941180624, 18089.27642894322, 40519.0, 40834.0, 41158.588414115475, 41168.79415602903, 42256.0, 59561.7021914905, 59937.400625993185, 60028.69985650044, 60557.39442605517, 60824.69587652033, 9078.45529268246, 9266.305027122859, 9312.161905428273, 9347.719568412958, 9517.428954262767, 13397.665058373228, 13569.86430135686, 13625.454981800616, 13640.931795341357, 13754.862451375358, 6122.142899994094, 7538.0, 8843.204111629984, 11469.655910322703, 11723.35521546323, 11996.520139194334, 12100.697482563006, 12351.19717218378, 12421.503139874303, 12483.812742809047, 11843.763124737285, 11998.520059197534, 12535.24788512692, 12573.371331433209, 12887.613371598867, 8989.7752556184, 9197.86203206939, 9240.676576320066, 9342.392744471588, 9398.906010939803, 9507.714768556954, 12269.447874845475, 12298.385080746106, 12464.688382790502, 12654.683632909251], "value": 9510.090927811843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1588.2455833479098, 1592.2277695317769, 1819.672458957388, 1841.9079046047693, 1921.5100149461875, 7843.686252549891, 8494.787630309245, 8610.483370997737, 8837.513936733478, 8867.201951824343, 8629.093945135764, 8686.565671716404, 8737.956310218457, 8771.03518612952, 8771.736847894574, 2467.050185678513, 2491.9626205606933, 2494.2018554062706, 2499.962515556042, 2507.059852555292, 2436.987815060922, 2446.0460420436043, 2461.729209786931, 2463.2363967170236, 2470.8023358131304, 2475.4553998120386, 2483.1184929350093, 2519.6976362836394, 2536.2391282615235, 2540.212534114421, 2440.1093600835743, 2450.803935685141, 2451.36264571211, 2455.5088982203542, 2467.2351571012955, 2448.3511869354634, 2454.2514533067406, 2470.7529247075327, 2475.603903375469, 2494.675692160026, 8855.291576673852, 8934.955325223398, 8950.955245223797, 8952.507612081334, 8953.0, 5198.8440346789275, 5337.4662533746705, 5346.8395948121615, 5395.271638328814, 5400.810971615974, 3533.381658209829, 3558.6441355864467, 3629.94555081674, 3652.8356223969986, 3653.5615726113037, 1229.2931564350533, 1258.735665510244, 1293.4826069572152, 1303.9543615973491, 2233.9218127365625, 11656.184067115306, 11709.0, 11762.235454695418, 11764.058875290042, 11772.470238839272, 4472.44094488189, 4532.342810292489, 4573.314002899591, 4579.725216486955, 4618.468876079227, 9512.09635084666, 9512.95243523778, 9519.286053546011, 9542.61829526825, 9542.666006689733, 5136.383633963948, 5151.124308867426, 5184.714840683799, 5194.168932970782, 5206.088934436459, 4738.8341408050555, 4863.440704318978, 4888.120138375127, 4896.0, 4920.581750551171, 3878.6897048236638, 3953.150072734376, 4012.8394864205106, 4015.5181378234797, 4038.353863381845, 1165.1785491228663, 1168.1881092640704, 1168.4333098447246, 1182.810750279951, 1246.389269258075, 872.5768002518773, 1061.6178175856685, 1072.6192201768415, 1076.531708706715, 1096.9122470202365, 6219.0, 6236.282827474898, 6251.3123556408755, 6289.213848268966, 6438.227412710505, 497.3261231031972, 505.83054676683724, 506.3872714016082, 514.5934711577812, 514.9021685879671, 4036.8183431745642, 4064.918701625951, 4093.324601440729, 4097.651699605507, 4149.937750933738, 10608.522616482276, 10957.452127393599, 10982.231243813016, 11086.168537359568, 11132.777344453065, 10766.892331076746, 10908.181886358554, 10921.672349829518, 10989.395583242998, 10992.670219893416, 8072.8385432291025, 8144.063432705315, 8226.136255693065, 8242.17578242171, 8563.229309362063, 6152.292486364126, 6168.136460895568, 6200.3179650237535, 6245.812625621239, 6367.522435817425, 9499.762505937131, 9729.805403892024, 9738.561764720464, 9758.609655613696, 9784.315097943361, 9671.0, 9765.755856103655, 10011.54948027326, 10150.796984060426, 10197.13324367437, 6679.198496180489, 7508.136564295176, 7513.173550909286, 7726.575038372944, 7788.8831667526165, 8176.0, 8225.054118776417, 8243.958780206061, 8261.1325810789, 8269.875951860606, 7413.147488038944, 7418.221086786026, 7529.209433009455, 7543.1325397579985, 7749.8837517438415, 7362.374198193, 7420.109586849612, 7474.103107627119, 7557.584332861746, 7590.506617069873, 6994.055802466602, 7032.12098487689, 7051.612161330971, 7093.255208203064, 7096.467764917548, 4769.833055843029, 4989.9251511228085, 5007.649464537448, 5215.5827533797965, 5318.8936221276135, 5139.665921715076, 5334.813281535127, 5347.465253474621, 5364.731763411735, 5505.559555235652], "value": 4638.631923140489, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.3882984830257, 368.52092280035953, 373.3988278871019, 375.2607363493918, 379.1469194312796, 6556.836079098025, 6583.6708164591755, 6610.735570577177, 6621.006848972651, 6664.5001624878205, 6753.729850805962, 6765.695543700533, 6767.255601883801, 6792.796216113512, 6800.761973330935, 5140.228965655163, 5151.330327057477, 5154.69071855688, 5155.072087024334, 5165.664231824938, 5123.487651234884, 5155.20094385369, 5159.458256883029, 5161.27742116104, 5162.5028741665055, 5098.770555325019, 5107.361579802525, 5114.795408183668, 5115.488451154892, 5131.923021154686, 4799.592034677056, 4901.828436004758, 4905.583025442842, 5084.771185296652, 5110.616703747215, 4270.338097594847, 4274.636655884254, 4281.892952676177, 4284.550122237151, 4286.76422796746, 6393.7442502299855, 6447.355264473562, 6454.290028096905, 6465.094886715863, 6501.284858665543, 5713.114467257582, 5885.676287804169, 5899.823005309848, 5901.557383196277, 5928.911066334009, 7029.402500787439, 7125.39434148098, 7129.857402851966, 7132.5007249492555, 7136.144602403412, 4830.058138662962, 4833.32333473314, 4834.226523756182, 4858.489858564871, 4859.58693511052, 7383.889241661379, 7461.216572259943, 7475.962620186919, 7483.9251607483775, 7489.700411983514, 4694.1550520905885, 4865.659403841697, 4976.353074100416, 4983.227599722049, 4988.6009119270375, 4878.95121048792, 4890.877728056827, 4894.070126675921, 4905.141600219948, 4923.335349727741, 5767.971160144256, 5777.971110144506, 5780.479756821906, 5792.478676919098, 5810.82567522975, 7125.42996560274, 7162.104736907887, 7179.461540384492, 7190.101237345332, 7192.568445893263, 1747.3185457671518, 1775.2898840463658, 1777.9288828446718, 1778.6087060846594, 1782.7415024821328, 1072.6460268111505, 1120.6806060272784, 1122.2256642916361, 1152.2683096233952, 1175.7001964498997, 6844.28135045823, 6845.965770171118, 6866.313368663094, 6872.10662613857, 6882.8623427531165, 7326.450516211199, 7329.486935914541, 7334.66993985272, 7345.595992220372, 7353.117625884821, 6756.966215168893, 6788.864222715518, 6822.522423430312, 6845.726170953106, 6851.2806155353965, 3908.843646254175, 3921.490206273166, 3972.880813575597, 3988.6210809973004, 3995.320795464778, 7591.202923692933, 7701.961490192625, 7708.807279817937, 7728.0, 7735.110462296795, 7639.579823109782, 7673.11759147694, 7699.384049276045, 7719.266669666373, 7731.536107833548, 7809.0, 7809.219078092259, 7812.296893279632, 7812.687492500237, 7825.530468171928, 7270.127584689871, 7424.0, 7429.7399591014055, 7464.066991626047, 7472.8879066815125, 7340.559566426032, 7344.96327518359, 7355.411567074728, 7379.151397589346, 7390.113186417664, 7770.184130666199, 7801.453898227297, 7812.375009999073, 7856.214378562098, 7857.253560911704, 4951.331570237971, 4997.700137991586, 4999.600111968654, 5000.449950505369, 5004.3994720633755, 7290.088738907637, 7466.514676546007, 7470.103587569526, 7471.925280747123, 7486.663100160615, 7233.095863017123, 7259.854802904018, 7290.234525374972, 7290.270972902667, 7300.853982920418, 7228.421726261991, 7261.164966028974, 7315.63421828917, 7321.341079302888, 7324.816879578053, 7073.363397294268, 7127.429805615435, 7129.215786263403, 7130.5365151265005, 7142.857142857218, 7015.403690686348, 7327.926720732725, 7347.375473084848, 7357.668904899186, 7368.59472729005, 6931.965340173469, 7135.5361901476235, 7150.0, 7158.749443769443, 7165.964170179324], "value": 5363.201310612307, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.7399454158293, 904.4121321141257, 909.5361365703492, 921.1663444582655, 930.418488444722, 15466.304016319264, 15466.767998480032, 15542.999999999985, 15626.453074142408, 15637.0, 13907.165570065803, 13973.510927117528, 13979.79030314546, 14013.369398377072, 14023.579292621213, 747.8055705516578, 864.9740507784777, 882.0650110882453, 888.1118881118881, 890.5458216309664, 882.7042940614901, 882.8101958079012, 885.1944730295432, 885.9246964008034, 888.5779254853958, 945.7541039329755, 949.1742184299634, 949.586929685589, 953.3088510829627, 953.9952300238489, 941.764558860285, 941.929355298352, 945.5933948402185, 946.5598496699033, 949.5537097564134, 697.490831692862, 697.8639165362756, 699.646678427396, 700.1038670501766, 700.8142842146835, 15604.297806598617, 15609.921950390175, 15653.765193521993, 15663.843361566353, 15711.92144039284, 15051.616381462101, 15272.236388180658, 15352.923235383863, 15542.844571554253, 15806.288717007763, 11798.233114847508, 12071.155019148664, 12377.876221237762, 12421.93789031058, 12527.310997895112, 4026.697997650188, 4109.773962432065, 4135.152293779768, 4208.968802643341, 4209.34755112958, 58207.0, 58232.0, 58788.70605646987, 59083.0, 60013.09980350342, 10507.369557826554, 10732.946335268274, 10787.83818242727, 10837.566497340176, 11928.986036186847, 19808.306709265395, 19953.301634442723, 20029.298974536112, 20079.59840803205, 20198.899005504878, 8316.792080198044, 8411.158884111539, 8656.78358041054, 8707.085755995657, 8758.2993360531, 5163.586913046947, 5194.6104042196985, 5206.088934436459, 5288.0745869472685, 5368.221607866915, 3741.5136032315627, 3769.7361184716806, 3779.1874746928993, 3779.9433008504893, 3817.122061925717, 713.8607971445622, 714.3392362065069, 716.3338095571065, 716.4984510842431, 718.9137303523506, 735.7057177129191, 768.9849398793539, 777.2577188784697, 780.0288640642323, 787.7715462515806, 10130.594776209016, 10315.948420257851, 10332.690019299433, 10409.219308551888, 10637.574497020187, 738.4867517075688, 760.3157158557232, 821.6138414944967, 853.1724227499316, 853.4452605806151, 4646.279826626811, 4732.124556956974, 4733.692309999908, 4751.311059896296, 4798.736069516141, 68251.31748682549, 68306.0, 68576.31423685799, 68933.0, 68987.0, 60692.39307606956, 61760.0, 62154.37845621486, 62316.065259021154, 62917.056244156374, 53502.19746703802, 54308.18537721937, 54697.45302547003, 54897.176542351895, 55262.0, 9071.773205669648, 9081.137291957253, 9121.680741174026, 9124.224440922331, 9391.624335026523, 38578.15837275676, 38985.41521877231, 39108.80445597754, 39145.0, 39301.80349098236, 47098.52901471079, 48799.75600122118, 54008.459915400344, 54337.72831135977, 54409.18386224289, 11944.4637554498, 12127.939360303142, 12251.142420030512, 12294.0, 12297.56958506448, 12612.49550017989, 12662.683432914251, 12930.030247731645, 13021.934890325489, 13095.41070651804, 12349.814752778535, 12388.62834114978, 12646.936765316115, 13073.542426015043, 13317.866821331663, 12475.812862806884, 12915.870841291468, 13100.213987160801, 13312.933435332761, 13728.519501817389, 12442.253464792142, 12445.37773111359, 12511.499540018662, 12743.617691469271, 12748.872511274769, 10185.643502477378, 10314.638987635397, 10607.098396636373, 10793.946030269799, 10864.619738309122, 10517.894821051692, 10807.567697292021, 10999.890001100206, 11000.669979900616, 11025.283356581796], "value": 7241.0923867742185, "unit": "score"}], "name": "dromaeo_css", "value": 7569.799543886267, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 103.0, 109.0, 111.0, 112.0, 100.0, 110.0, 109.0, 109.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 128.0, 154.0, 183.0, 130.0, 161.0, 153.0, 129.0, 194.0, 132.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 162.0, 161.0, 161.0, 162.0, 161.0, 163.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 182.0, 76.0, 74.0, 74.0, 74.0, 173.0, 76.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 146.0, 92.0, 94.0, 91.0, 140.0, 94.0, 93.0, 144.0], "value": 107.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 150.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 94.0, 96.0, 94.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 56.0, 55.0, 55.0, 56.0, 56.0, 75.0, 55.0, 53.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 58.0, 58.0, 57.0, 59.0, 59.0, 58.0, 59.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 76.0, 75.0, 73.0, 74.0, 75.0, 74.0, 75.0, 76.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 115.0, 117.0, 114.0, 120.0, 114.0, 121.0, 128.0, 130.0], "value": 120.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 157.0, 160.0, 158.0, 169.0, 159.0, 162.0, 164.0, 158.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 66.0, 65.0, 66.0, 67.0, 66.0, 70.0, 66.0, 67.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1524.5000000000002, "alertThreshold": 2.0}]} 03:28:45 INFO - Return code: 0 03:28:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:28:45 ERROR - # TBPL SUCCESS # 03:28:45 INFO - Running post-action listener: _resource_record_post_action 03:28:45 INFO - Running post-run listener: _resource_record_post_run 03:28:46 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 266240; Write bytes: 500379648; Read time: 24; Write time: 368136 03:28:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 248467456; Read time: 0; Write time: 207972 03:28:46 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251912192; Read time: 24; Write time: 160164 03:28:46 INFO - Running post-run listener: _upload_blobber_files 03:28:46 INFO - Blob upload gear active. 03:28:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:28:46 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 03:28:46 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'] 03:28:46 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 03:28:46 INFO - (blobuploader) - INFO - Open directory for files ... 03:28:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:28:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:28:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:47 INFO - (blobuploader) - INFO - Done attempting. 03:28:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:28:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:28:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:48 INFO - (blobuploader) - INFO - Done attempting. 03:28:48 INFO - (blobuploader) - INFO - Iteration through files over. 03:28:48 INFO - Return code: 0 03:28:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:28:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:28:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93c89345960c5ef93fe1cdb7260bbaecd1163e0099017c21c3811f10447df97c4df2caf477f4d0e5815d35f8ba329395932896f6ef8763f43490f9d70fb87154", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77ba5e4b3639815745cc6e11312418e6e01ba3572ed32aae109533e726ef71057d2331d491e6b68b1c71da4563cbba7c9031fddefe97047fdbcc8038fbfcb425"} 03:28:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:28:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:28:48 INFO - Contents: 03:28:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93c89345960c5ef93fe1cdb7260bbaecd1163e0099017c21c3811f10447df97c4df2caf477f4d0e5815d35f8ba329395932896f6ef8763f43490f9d70fb87154", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77ba5e4b3639815745cc6e11312418e6e01ba3572ed32aae109533e726ef71057d2331d491e6b68b1c71da4563cbba7c9031fddefe97047fdbcc8038fbfcb425"} 03:28:48 INFO - Running post-run listener: copy_logs_to_upload_dir 03:28:48 INFO - Copying logs to upload dir... 03:28:48 INFO - mkdir: /builds/slave/test/build/upload/logs 03:28:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.770192 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-17 03:28:48.415320) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 03:28:48.419002) ========= 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=ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934 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/93c89345960c5ef93fe1cdb7260bbaecd1163e0099017c21c3811f10447df97c4df2caf477f4d0e5815d35f8ba329395932896f6ef8763f43490f9d70fb87154", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77ba5e4b3639815745cc6e11312418e6e01ba3572ed32aae109533e726ef71057d2331d491e6b68b1c71da4563cbba7c9031fddefe97047fdbcc8038fbfcb425"} 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.011380 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/93c89345960c5ef93fe1cdb7260bbaecd1163e0099017c21c3811f10447df97c4df2caf477f4d0e5815d35f8ba329395932896f6ef8763f43490f9d70fb87154", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77ba5e4b3639815745cc6e11312418e6e01ba3572ed32aae109533e726ef71057d2331d491e6b68b1c71da4563cbba7c9031fddefe97047fdbcc8038fbfcb425"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 03:28:48.446719) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 03:28:48.447437) ========= 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=ed14279e38b05397cf4aa391000001a4-1463478534.922778-2047237934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 03:28:48.532734) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 03:28:48.533074) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 03:28:48.533611) ========= ========= Total master_lag: 0.19 =========