builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1463507537.81 results: success (0) buildid: 20160517004009 builduid: ef91a013044b49f4abd91345e579e6b6 revision: 17724486e1591858eea09dc327475a25883854a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.805477) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.806014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.806300) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.823236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.823568) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 10:52:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.8M=0s 2016-05-17 10:52:18 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124202 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.961639) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:17.961949) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017977 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:18.011778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 10:52:18.012138) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 10:52:18,181 truncating revision to first 12 chars 2016-05-17 10:52:18,181 Setting DEBUG logging. 2016-05-17 10:52:18,181 attempt 1/10 2016-05-17 10:52:18,181 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/17724486e159?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 10:52:19,389 unpacking tar archive at: mozilla-aurora-17724486e159/testing/mozharness/ program finished with exit code 0 elapsedTime=1.473530 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 10:52:19.498992) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:19.499334) ========= script_repo_revision: 17724486e1591858eea09dc327475a25883854a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:19.499791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:19.500080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:52:19.510111) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-17 10:52:19.510608) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:52:19 INFO - MultiFileLogger online at 20160517 10:52:19 in /builds/slave/test 10:52:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:52:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:52:19 INFO - {'append_to_log': False, 10:52:19 INFO - 'base_work_dir': '/builds/slave/test', 10:52:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:52:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:52:19 INFO - 'branch': 'Mozilla-Aurora', 10:52:19 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:19 INFO - 'config_files': ('talos/linux_config.py',), 10:52:19 INFO - 'default_actions': ('clobber', 10:52:19 INFO - 'read-buildbot-config', 10:52:19 INFO - 'download-and-extract', 10:52:19 INFO - 'populate-webroot', 10:52:19 INFO - 'create-virtualenv', 10:52:19 INFO - 'install', 10:52:19 INFO - 'run-tests'), 10:52:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:19 INFO - 'download_minidump_stackwalk': True, 10:52:19 INFO - 'download_symbols': 'ondemand', 10:52:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:19 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:19 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:19 INFO - 'installer_path': 'installer.exe', 10:52:19 INFO - 'log_level': 'info', 10:52:19 INFO - 'log_name': 'talos', 10:52:19 INFO - 'log_to_console': True, 10:52:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:52:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:52:19 INFO - 'opt_config_files': (), 10:52:19 INFO - 'pip_index': False, 10:52:19 INFO - 'sps_profile': False, 10:52:19 INFO - 'sps_profile_interval': 0, 10:52:19 INFO - 'suite': 'dromaeojs-e10s', 10:52:19 INFO - 'system_bits': '32', 10:52:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:19 INFO - 'title': 'talos-linux64-ix-006', 10:52:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:19 INFO - 'use_talos_json': True, 10:52:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:52:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:19 INFO - 'work_dir': 'build'} 10:52:19 INFO - ##### 10:52:19 INFO - ##### Running clobber step. 10:52:19 INFO - ##### 10:52:19 INFO - Running pre-action listener: _resource_record_pre_action 10:52:19 INFO - Running main action method: clobber 10:52:19 INFO - rmtree: /builds/slave/test/build 10:52:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:20 INFO - Running post-action listener: _resource_record_post_action 10:52:20 INFO - ##### 10:52:20 INFO - ##### Running read-buildbot-config step. 10:52:20 INFO - ##### 10:52:20 INFO - Running pre-action listener: _resource_record_pre_action 10:52:20 INFO - Running main action method: read_buildbot_config 10:52:20 INFO - Using buildbot properties: 10:52:20 INFO - { 10:52:20 INFO - "project": "", 10:52:20 INFO - "product": "firefox", 10:52:20 INFO - "script_repo_revision": "production", 10:52:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:52:20 INFO - "repository": "", 10:52:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:52:20 INFO - "buildid": "20160517004009", 10:52:20 INFO - "stage_platform": "linux64-pgo", 10:52:20 INFO - "basedir": "/builds/slave/test", 10:52:20 INFO - "nightly_build": "True", 10:52:20 INFO - "buildnumber": 274, 10:52:20 INFO - "slavename": "talos-linux64-ix-006", 10:52:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:52:20 INFO - "platform": "ubuntu64_hw", 10:52:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:52:20 INFO - "branch": "mozilla-aurora", 10:52:20 INFO - "repo_path": "releases/mozilla-aurora", 10:52:20 INFO - "revision": "17724486e1591858eea09dc327475a25883854a4", 10:52:20 INFO - "pgo_build": "True", 10:52:20 INFO - "builduid": "ef91a013044b49f4abd91345e579e6b6", 10:52:20 INFO - "slavebuilddir": "test" 10:52:20 INFO - } 10:52:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 10:52:20 INFO - Running post-action listener: _resource_record_post_action 10:52:20 INFO - ##### 10:52:20 INFO - ##### Running download-and-extract step. 10:52:20 INFO - ##### 10:52:20 INFO - Running pre-action listener: _resource_record_pre_action 10:52:20 INFO - Running main action method: download_and_extract 10:52:20 INFO - mkdir: /builds/slave/test/build/tests 10:52: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')]} 10:52:20 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:52: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.test_packages.json 10:52: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.test_packages.json 10:52: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.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:52:20 INFO - Downloaded 1361 bytes. 10:52:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:52:20 INFO - Using the following test package requirements: 10:52:20 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:52:20 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:52:20 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:52:20 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:20 INFO - u'jsshell-linux-x86_64.zip'], 10:52:20 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:52:20 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:52:20 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:52:20 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:52:20 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:52:20 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:52:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:52:20 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:52: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')]} 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52:21 INFO - Downloaded 23813806 bytes. 10:52:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:52:23 INFO - Return code: 0 10:52:23 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:23 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:52:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:52:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:52:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:52:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:52:30 INFO - Downloaded 23813806 bytes. 10:52:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:52:32 INFO - Return code: 0 10:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:32 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:52:33 INFO - Downloaded 10840145 bytes. 10:52:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:52:33 INFO - Return code: 0 10:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:33 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:52:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:52:35 INFO - Downloaded 62686410 bytes. 10:52:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:35 INFO - mkdir: /builds/slave/test/properties 10:52:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:52:35 INFO - Writing to file /builds/slave/test/properties/build_url 10:52:35 INFO - Contents: 10:52:35 INFO - build_url:https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:36 INFO - Running post-action listener: _resource_record_post_action 10:52:36 INFO - Running post-action listener: set_extra_try_arguments 10:52:36 INFO - ##### 10:52:36 INFO - ##### Running populate-webroot step. 10:52:36 INFO - ##### 10:52:36 INFO - Running pre-action listener: _resource_record_pre_action 10:52:36 INFO - Running main action method: populate_webroot 10:52:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:52:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:52:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:52:36 INFO - '--tppagecycles', 10:52:36 INFO - '7'], 10:52:36 INFO - 'tests': ['tsvgm']}}, 10:52:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:52:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:52:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:52:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:52:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:52:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:52:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:36 INFO - 'talos_options': ['--disable-e10s'], 10:52:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:36 INFO - 'talos_options': ['--disable-e10s'], 10:52:36 INFO - 'tests': ['damp', 'tps']}, 10:52:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:36 INFO - 'tests': ['damp', 'tps']}, 10:52:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:52:36 INFO - 'tests': ['dromaeo_dom']}, 10:52:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:52:36 INFO - 'tests': ['a11yr', 10:52:36 INFO - 'ts_paint', 10:52:36 INFO - 'tpaint', 10:52:36 INFO - 'sessionrestore', 10:52:36 INFO - 'sessionrestore_no_auto_restore', 10:52:36 INFO - 'tabpaint']}, 10:52:36 INFO - 'other-e10s': {'tests': ['a11yr', 10:52:36 INFO - 'ts_paint', 10:52:36 INFO - 'tpaint', 10:52:36 INFO - 'sessionrestore', 10:52:36 INFO - 'sessionrestore_no_auto_restore', 10:52:36 INFO - 'tabpaint']}, 10:52:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:52:36 INFO - 'ts_paint', 10:52:36 INFO - 'tpaint', 10:52:36 INFO - 'sessionrestore', 10:52:36 INFO - 'sessionrestore_no_auto_restore', 10:52:36 INFO - 'tabpaint']}, 10:52:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:52:36 INFO - 'ts_paint', 10:52:36 INFO - 'tpaint', 10:52:36 INFO - 'sessionrestore', 10:52:36 INFO - 'sessionrestore_no_auto_restore', 10:52:36 INFO - 'tabpaint']}, 10:52:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:52:36 INFO - 'tests': ['a11yr', 10:52:36 INFO - 'ts_paint', 10:52:36 INFO - 'tpaint', 10:52:36 INFO - 'sessionrestore', 10:52:36 INFO - 'sessionrestore_no_auto_restore', 10:52:36 INFO - 'tabpaint']}, 10:52:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:52:36 INFO - 'tests': ['a11yr', 10:52:36 INFO - 'ts_paint', 10:52:36 INFO - 'tpaint', 10:52:36 INFO - 'sessionrestore', 10:52:36 INFO - 'sessionrestore_no_auto_restore', 10:52:36 INFO - 'tabpaint']}, 10:52:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:52:36 INFO - 'tests': ['tsvgx', 10:52:36 INFO - 'tsvgr_opacity', 10:52:36 INFO - 'tart', 10:52:36 INFO - 'tscrollx', 10:52:36 INFO - 'cart']}, 10:52:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:52:36 INFO - 'tsvgr_opacity', 10:52:36 INFO - 'tart', 10:52:36 INFO - 'tscrollx', 10:52:36 INFO - 'cart']}, 10:52:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:36 INFO - 'talos_options': ['--disable-e10s'], 10:52:36 INFO - 'tests': ['tp5o']}, 10:52:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:36 INFO - 'tests': ['tp5o']}, 10:52:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:36 INFO - 'talos_options': ['--disable-e10s', 10:52:36 INFO - '--xperf_path', 10:52:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:36 INFO - 'tests': ['tp5n']}, 10:52:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:36 INFO - 'talos_options': ['--xperf_path', 10:52:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:36 INFO - 'tests': ['tp5n']}}, 10:52:36 INFO - 'talos.zip': {'path': '', 10:52:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:52:36 INFO - Running post-action listener: _resource_record_post_action 10:52:36 INFO - ##### 10:52:36 INFO - ##### Running create-virtualenv step. 10:52:36 INFO - ##### 10:52:36 INFO - Running pre-action listener: _resource_record_pre_action 10:52:36 INFO - Running main action method: create_virtualenv 10:52:36 INFO - Creating virtualenv /builds/slave/test/build/venv 10:52:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:52:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:52:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:36 INFO - Using real prefix '/usr' 10:52:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:52:36 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:38 INFO - Installing pip.................done. 10:52:38 INFO - Return code: 0 10:52:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:38 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 0x7f7a4dcd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f410>, '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 0xe60310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe607a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:52:38 INFO - Using env: {'DISPLAY': ':0', 10:52:38 INFO - 'HOME': '/home/cltbld', 10:52:38 INFO - 'LANG': 'en_US.UTF-8', 10:52:38 INFO - 'LANGUAGE': 'en_US:en', 10:52:38 INFO - 'LOGNAME': 'cltbld', 10:52:38 INFO - 'MAIL': '/var/mail/cltbld', 10:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:38 INFO - 'MOZ_NO_REMOTE': '1', 10:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:38 INFO - 'NO_EM_RESTART': '1', 10:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:38 INFO - 'PWD': '/builds/slave/test', 10:52:38 INFO - 'SHELL': '/bin/bash', 10:52:38 INFO - 'SHLVL': '1', 10:52:38 INFO - 'TERM': 'linux', 10:52:38 INFO - 'TMOUT': '86400', 10:52:38 INFO - 'USER': 'cltbld', 10:52:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 10:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:38 INFO - '_': '/tools/buildbot/bin/python'} 10:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:52:39 INFO - Cleaning up... 10:52:39 INFO - Return code: 0 10:52:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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', '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 0x7f7a4dcd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f410>, '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 0xe60310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe607a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52: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', 'psutil>=0.7.1'] in /builds/slave/test/build 10:52: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 psutil>=0.7.1 10:52:39 INFO - Using env: {'DISPLAY': ':0', 10:52:39 INFO - 'HOME': '/home/cltbld', 10:52:39 INFO - 'LANG': 'en_US.UTF-8', 10:52:39 INFO - 'LANGUAGE': 'en_US:en', 10:52:39 INFO - 'LOGNAME': 'cltbld', 10:52:39 INFO - 'MAIL': '/var/mail/cltbld', 10:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:39 INFO - 'MOZ_NO_REMOTE': '1', 10:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:39 INFO - 'NO_EM_RESTART': '1', 10:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:39 INFO - 'PWD': '/builds/slave/test', 10:52:39 INFO - 'SHELL': '/bin/bash', 10:52:39 INFO - 'SHLVL': '1', 10:52:39 INFO - 'TERM': 'linux', 10:52:39 INFO - 'TMOUT': '86400', 10:52:39 INFO - 'USER': 'cltbld', 10:52:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 10:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:39 INFO - '_': '/tools/buildbot/bin/python'} 10:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:39 INFO - Downloading/unpacking psutil>=0.7.1 10:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:41 INFO - Installing collected packages: psutil 10:52:41 INFO - Running setup.py install for psutil 10:52:41 INFO - building 'psutil._psutil_linux' extension 10:52:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:52:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:52:41 INFO - building 'psutil._psutil_posix' extension 10:52:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:52:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:52:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:41 INFO - Successfully installed psutil 10:52:41 INFO - Cleaning up... 10:52:41 INFO - Return code: 0 10:52:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7a4dcd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f410>, '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 0xe60310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe607a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:52:41 INFO - Using env: {'DISPLAY': ':0', 10:52:41 INFO - 'HOME': '/home/cltbld', 10:52:41 INFO - 'LANG': 'en_US.UTF-8', 10:52:41 INFO - 'LANGUAGE': 'en_US:en', 10:52:41 INFO - 'LOGNAME': 'cltbld', 10:52:41 INFO - 'MAIL': '/var/mail/cltbld', 10:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:41 INFO - 'MOZ_NO_REMOTE': '1', 10:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:41 INFO - 'NO_EM_RESTART': '1', 10:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:41 INFO - 'PWD': '/builds/slave/test', 10:52:41 INFO - 'SHELL': '/bin/bash', 10:52:41 INFO - 'SHLVL': '1', 10:52:41 INFO - 'TERM': 'linux', 10:52:41 INFO - 'TMOUT': '86400', 10:52:41 INFO - 'USER': 'cltbld', 10:52:41 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 10:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:41 INFO - '_': '/tools/buildbot/bin/python'} 10:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:52:44 INFO - Installing collected packages: mozsystemmonitor 10:52:44 INFO - Running setup.py install for mozsystemmonitor 10:52:44 INFO - Successfully installed mozsystemmonitor 10:52:44 INFO - Cleaning up... 10:52:44 INFO - Return code: 0 10:52:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7a4dcd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f410>, '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 0xe60310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe607a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:52:44 INFO - Using env: {'DISPLAY': ':0', 10:52:44 INFO - 'HOME': '/home/cltbld', 10:52:44 INFO - 'LANG': 'en_US.UTF-8', 10:52:44 INFO - 'LANGUAGE': 'en_US:en', 10:52:44 INFO - 'LOGNAME': 'cltbld', 10:52:44 INFO - 'MAIL': '/var/mail/cltbld', 10:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:44 INFO - 'MOZ_NO_REMOTE': '1', 10:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:44 INFO - 'NO_EM_RESTART': '1', 10:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:44 INFO - 'PWD': '/builds/slave/test', 10:52:44 INFO - 'SHELL': '/bin/bash', 10:52:44 INFO - 'SHLVL': '1', 10:52:44 INFO - 'TERM': 'linux', 10:52:44 INFO - 'TMOUT': '86400', 10:52:44 INFO - 'USER': 'cltbld', 10:52:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 10:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:44 INFO - '_': '/tools/buildbot/bin/python'} 10:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:44 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:46 INFO - Downloading blobuploader-1.2.4.tar.gz 10:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:52:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:52:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:46 INFO - Downloading docopt-0.6.1.tar.gz 10:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:52:47 INFO - Installing collected packages: blobuploader, requests, docopt 10:52:47 INFO - Running setup.py install for blobuploader 10:52:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:52:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:52:47 INFO - Running setup.py install for requests 10:52:47 INFO - Running setup.py install for docopt 10:52:47 INFO - Successfully installed blobuploader requests docopt 10:52:47 INFO - Cleaning up... 10:52:47 INFO - Return code: 0 10:52:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:47 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 0x7f7a4dcd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f410>, '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 0xe60310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe607a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:47 INFO - Using env: {'DISPLAY': ':0', 10:52:47 INFO - 'HOME': '/home/cltbld', 10:52:47 INFO - 'LANG': 'en_US.UTF-8', 10:52:47 INFO - 'LANGUAGE': 'en_US:en', 10:52:47 INFO - 'LOGNAME': 'cltbld', 10:52:47 INFO - 'MAIL': '/var/mail/cltbld', 10:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:47 INFO - 'MOZ_NO_REMOTE': '1', 10:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:47 INFO - 'NO_EM_RESTART': '1', 10:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:47 INFO - 'PWD': '/builds/slave/test', 10:52:47 INFO - 'SHELL': '/bin/bash', 10:52:47 INFO - 'SHLVL': '1', 10:52:47 INFO - 'TERM': 'linux', 10:52:47 INFO - 'TMOUT': '86400', 10:52:47 INFO - 'USER': 'cltbld', 10:52:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 10:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:47 INFO - '_': '/tools/buildbot/bin/python'} 10:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:47 INFO - Running setup.py (path:/tmp/pip-HwRNWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:47 INFO - Running setup.py (path:/tmp/pip-edJVZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:47 INFO - Running setup.py (path:/tmp/pip-oKjcb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:48 INFO - Running setup.py (path:/tmp/pip-Wxcyb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:48 INFO - Running setup.py (path:/tmp/pip-L0XJwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:48 INFO - Running setup.py (path:/tmp/pip-l6bQhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:48 INFO - Running setup.py (path:/tmp/pip-Gep_mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:48 INFO - Running setup.py (path:/tmp/pip-yUrF_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:48 INFO - Running setup.py (path:/tmp/pip-7uGfZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:48 INFO - Running setup.py (path:/tmp/pip-ixR8nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:48 INFO - Running setup.py (path:/tmp/pip-1rR3IA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:48 INFO - Running setup.py (path:/tmp/pip-YrbRtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:48 INFO - Running setup.py (path:/tmp/pip-y8qn36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:48 INFO - Running setup.py (path:/tmp/pip-ZWcqHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:48 INFO - Running setup.py (path:/tmp/pip-WEqf16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:48 INFO - Running setup.py (path:/tmp/pip-gMOaGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:48 INFO - Running setup.py (path:/tmp/pip-LP8aD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:52:49 INFO - Running setup.py install for manifestparser 10:52:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Running setup.py install for mozcrash 10:52:49 INFO - Running setup.py install for mozdebug 10:52:49 INFO - Running setup.py install for mozdevice 10:52:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Running setup.py install for mozfile 10:52:49 INFO - Running setup.py install for mozhttpd 10:52:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Running setup.py install for mozinfo 10:52:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Running setup.py install for mozInstall 10:52:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:52:49 INFO - Running setup.py install for mozleak 10:52:49 INFO - Running setup.py install for mozlog 10:52:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:52:50 INFO - Running setup.py install for moznetwork 10:52:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:52:50 INFO - Running setup.py install for mozprocess 10:52:50 INFO - Running setup.py install for mozprofile 10:52:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:52:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:52:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:52:50 INFO - Running setup.py install for mozrunner 10:52:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:52:50 INFO - Running setup.py install for mozscreenshot 10:52:50 INFO - Running setup.py install for moztest 10:52:50 INFO - Running setup.py install for mozversion 10:52:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:52:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:52:50 INFO - Cleaning up... 10:52:50 INFO - Return code: 0 10:52:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:50 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 0x7f7a4dcd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f410>, '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 0xe60310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe607a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:50 INFO - Using env: {'DISPLAY': ':0', 10:52:50 INFO - 'HOME': '/home/cltbld', 10:52:50 INFO - 'LANG': 'en_US.UTF-8', 10:52:50 INFO - 'LANGUAGE': 'en_US:en', 10:52:50 INFO - 'LOGNAME': 'cltbld', 10:52:50 INFO - 'MAIL': '/var/mail/cltbld', 10:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:50 INFO - 'MOZ_NO_REMOTE': '1', 10:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:50 INFO - 'NO_EM_RESTART': '1', 10:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:50 INFO - 'PWD': '/builds/slave/test', 10:52:50 INFO - 'SHELL': '/bin/bash', 10:52:50 INFO - 'SHLVL': '1', 10:52:50 INFO - 'TERM': 'linux', 10:52:50 INFO - 'TMOUT': '86400', 10:52:50 INFO - 'USER': 'cltbld', 10:52:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 10:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:50 INFO - '_': '/tools/buildbot/bin/python'} 10:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:51 INFO - Running setup.py (path:/tmp/pip-LGpPoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:51 INFO - Running setup.py (path:/tmp/pip-fpo4rY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:51 INFO - Running setup.py (path:/tmp/pip-qP0z9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:51 INFO - Running setup.py (path:/tmp/pip-ZSk3DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:51 INFO - Running setup.py (path:/tmp/pip-wXL6yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:51 INFO - Running setup.py (path:/tmp/pip-wD1dZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:51 INFO - Running setup.py (path:/tmp/pip-1Qqm2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:51 INFO - Running setup.py (path:/tmp/pip-a3lb98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:51 INFO - Running setup.py (path:/tmp/pip-mUZy_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:51 INFO - Running setup.py (path:/tmp/pip-9k6C6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:51 INFO - Running setup.py (path:/tmp/pip-S_t1JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:51 INFO - Running setup.py (path:/tmp/pip-5rPVb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:51 INFO - Running setup.py (path:/tmp/pip-bnuNr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:52 INFO - Running setup.py (path:/tmp/pip-Ig8vDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:52 INFO - Running setup.py (path:/tmp/pip-VyuG1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:52 INFO - Running setup.py (path:/tmp/pip-En2THF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:52 INFO - Running setup.py (path:/tmp/pip-ekijfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:52:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:54 INFO - Downloading blessings-1.6.tar.gz 10:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:54 INFO - Installing collected packages: blessings 10:52:54 INFO - Running setup.py install for blessings 10:52:54 INFO - Successfully installed blessings 10:52:54 INFO - Cleaning up... 10:52:54 INFO - Return code: 0 10:52:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:54 INFO - Reading from file tmpfile_stdout 10:52:54 INFO - Current package versions: 10:52:54 INFO - argparse == 1.2.1 10:52:54 INFO - blessings == 1.6 10:52:54 INFO - blobuploader == 1.2.4 10:52:54 INFO - docopt == 0.6.1 10:52:54 INFO - manifestparser == 1.1 10:52:54 INFO - mozInstall == 1.12 10:52:54 INFO - mozcrash == 0.17 10:52:54 INFO - mozdebug == 0.1 10:52:54 INFO - mozdevice == 0.48 10:52:54 INFO - mozfile == 1.2 10:52:54 INFO - mozhttpd == 0.7 10:52:54 INFO - mozinfo == 0.9 10:52:54 INFO - mozleak == 0.1 10:52:54 INFO - mozlog == 3.1 10:52:54 INFO - moznetwork == 0.27 10:52:54 INFO - mozprocess == 0.22 10:52:54 INFO - mozprofile == 0.28 10:52:54 INFO - mozrunner == 6.11 10:52:54 INFO - mozscreenshot == 0.1 10:52:54 INFO - mozsystemmonitor == 0.0 10:52:54 INFO - moztest == 0.7 10:52:54 INFO - mozversion == 1.4 10:52:54 INFO - psutil == 3.1.1 10:52:54 INFO - requests == 1.2.3 10:52:54 INFO - wsgiref == 0.1.2 10:52:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:54 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 0x7f7a4dcd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f410>, '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 0xe60310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe607a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:54 INFO - Using env: {'DISPLAY': ':0', 10:52:54 INFO - 'HOME': '/home/cltbld', 10:52:54 INFO - 'LANG': 'en_US.UTF-8', 10:52:54 INFO - 'LANGUAGE': 'en_US:en', 10:52:54 INFO - 'LOGNAME': 'cltbld', 10:52:54 INFO - 'MAIL': '/var/mail/cltbld', 10:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:54 INFO - 'MOZ_NO_REMOTE': '1', 10:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:54 INFO - 'NO_EM_RESTART': '1', 10:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:54 INFO - 'PWD': '/builds/slave/test', 10:52:54 INFO - 'SHELL': '/bin/bash', 10:52:54 INFO - 'SHLVL': '1', 10:52:54 INFO - 'TERM': 'linux', 10:52:54 INFO - 'TMOUT': '86400', 10:52:54 INFO - 'USER': 'cltbld', 10:52:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 10:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:54 INFO - '_': '/tools/buildbot/bin/python'} 10:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:52:54 INFO - Cleaning up... 10:52:54 INFO - Return code: 0 10:52:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:54 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 0x7f7a4dcd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f410>, '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 0xe60310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe607a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:52:54 INFO - Using env: {'DISPLAY': ':0', 10:52:54 INFO - 'HOME': '/home/cltbld', 10:52:54 INFO - 'LANG': 'en_US.UTF-8', 10:52:54 INFO - 'LANGUAGE': 'en_US:en', 10:52:54 INFO - 'LOGNAME': 'cltbld', 10:52:54 INFO - 'MAIL': '/var/mail/cltbld', 10:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:54 INFO - 'MOZ_NO_REMOTE': '1', 10:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:54 INFO - 'NO_EM_RESTART': '1', 10:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:54 INFO - 'PWD': '/builds/slave/test', 10:52:54 INFO - 'SHELL': '/bin/bash', 10:52:54 INFO - 'SHLVL': '1', 10:52:54 INFO - 'TERM': 'linux', 10:52:54 INFO - 'TMOUT': '86400', 10:52:54 INFO - 'USER': 'cltbld', 10:52:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 10:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:54 INFO - '_': '/tools/buildbot/bin/python'} 10:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:55 INFO - Downloading/unpacking jsonschema 10:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:52:56 INFO - Downloading/unpacking functools32 (from jsonschema) 10:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:57 INFO - Downloading functools32-3.2.3-2.tar.gz 10:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:52:57 INFO - warning: no files found matching '*.txt' 10:52:57 INFO - no previously-included directories found matching 'build' 10:52:57 INFO - no previously-included directories found matching 'dist' 10:52:57 INFO - no previously-included directories found matching '.git*' 10:52:57 INFO - Installing collected packages: jsonschema, functools32 10:52:57 INFO - Running setup.py install for functools32 10:52:57 INFO - warning: no files found matching '*.txt' 10:52:57 INFO - no previously-included directories found matching 'build' 10:52:57 INFO - no previously-included directories found matching 'dist' 10:52:57 INFO - no previously-included directories found matching '.git*' 10:52:57 INFO - Successfully installed jsonschema functools32 10:52:57 INFO - Cleaning up... 10:52:57 INFO - Return code: 0 10:52:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:57 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 0x7f7a4dcd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f410>, '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 0xe60310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe607a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:52:57 INFO - Using env: {'DISPLAY': ':0', 10:52:57 INFO - 'HOME': '/home/cltbld', 10:52:57 INFO - 'LANG': 'en_US.UTF-8', 10:52:57 INFO - 'LANGUAGE': 'en_US:en', 10:52:57 INFO - 'LOGNAME': 'cltbld', 10:52:57 INFO - 'MAIL': '/var/mail/cltbld', 10:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:57 INFO - 'MOZ_NO_REMOTE': '1', 10:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:57 INFO - 'NO_EM_RESTART': '1', 10:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:57 INFO - 'PWD': '/builds/slave/test', 10:52:57 INFO - 'SHELL': '/bin/bash', 10:52:57 INFO - 'SHLVL': '1', 10:52:57 INFO - 'TERM': 'linux', 10:52:57 INFO - 'TMOUT': '86400', 10:52:57 INFO - 'USER': 'cltbld', 10:52:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 10:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:57 INFO - '_': '/tools/buildbot/bin/python'} 10:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:57 INFO - Downloading/unpacking flake8 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:52:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:52:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:53:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:00 INFO - no previously-included directories found matching 'docs/_build' 10:53:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:53:00 INFO - Running setup.py install for pep8 10:53:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:00 INFO - no previously-included directories found matching 'docs/_build' 10:53:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:53:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:53:00 INFO - Cleaning up... 10:53:00 INFO - Return code: 0 10:53:00 INFO - Running post-action listener: _resource_record_post_action 10:53:00 INFO - Running post-action listener: _start_resource_monitoring 10:53:00 INFO - Starting resource monitoring. 10:53:00 INFO - ##### 10:53:00 INFO - ##### Running install step. 10:53:00 INFO - ##### 10:53:00 INFO - Running pre-action listener: _resource_record_pre_action 10:53:00 INFO - Running main action method: install 10:53:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:00 INFO - Reading from file tmpfile_stdout 10:53:00 INFO - Detecting whether we're running mozinstall >=1.0... 10:53:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:53:00 INFO - Reading from file tmpfile_stdout 10:53:00 INFO - Output received: 10:53:00 INFO - Usage: mozinstall [options] installer 10:53:00 INFO - Options: 10:53:00 INFO - -h, --help show this help message and exit 10:53:00 INFO - -d DEST, --destination=DEST 10:53:00 INFO - Directory to install application into. [default: 10:53:00 INFO - "/builds/slave/test"] 10:53:00 INFO - --app=APP Application being installed. [default: firefox] 10:53:00 INFO - mkdir: /builds/slave/test/build/application 10:53:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:53:16 INFO - Reading from file tmpfile_stdout 10:53:16 INFO - Output received: 10:53:16 INFO - /builds/slave/test/build/application/firefox/firefox 10:53:16 INFO - Running post-action listener: _resource_record_post_action 10:53:16 INFO - ##### 10:53:16 INFO - ##### Running run-tests step. 10:53:16 INFO - ##### 10:53:16 INFO - Running pre-action listener: _resource_record_pre_action 10:53:16 INFO - Running main action method: run_tests 10:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:53:16 INFO - Python 2.7.3 10:53:16 INFO - Return code: 0 10:53:16 INFO - grabbing minidump binary from tooltool 10:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:16 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 0xe5f410>, '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 0xe60310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe607a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:53:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:53:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:53:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:16 INFO - Return code: 0 10:53:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:53:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:53:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:53:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:53:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:53:17 INFO - Return code: 0 10:53:17 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-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:53:17 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-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:53:17 INFO - Using env: {'DISPLAY': ':0', 10:53:17 INFO - 'HOME': '/home/cltbld', 10:53:17 INFO - 'LANG': 'en_US.UTF-8', 10:53:17 INFO - 'LANGUAGE': 'en_US:en', 10:53:17 INFO - 'LOGNAME': 'cltbld', 10:53:17 INFO - 'MAIL': '/var/mail/cltbld', 10:53:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:53:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:17 INFO - 'MOZ_NO_REMOTE': '1', 10:53:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:17 INFO - 'NO_EM_RESTART': '1', 10:53:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:17 INFO - 'PWD': '/builds/slave/test', 10:53:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:53:17 INFO - 'SHELL': '/bin/bash', 10:53:17 INFO - 'SHLVL': '1', 10:53:17 INFO - 'TERM': 'linux', 10:53:17 INFO - 'TMOUT': '86400', 10:53:17 INFO - 'USER': 'cltbld', 10:53:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477', 10:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:17 INFO - '_': '/tools/buildbot/bin/python'} 10:53:17 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-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:53:17 INFO - mozversion application_buildid: 20160517004009 10:53:17 INFO - mozversion application_changeset: 17724486e1591858eea09dc327475a25883854a4 10:53:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:53:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:17 INFO - mozversion application_name: Firefox 10:53:17 INFO - mozversion application_remotingname: firefox-dev 10:53:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:53:17 INFO - mozversion application_vendor: Mozilla 10:53:17 INFO - mozversion application_version: 48.0a2 10:53:17 INFO - mozversion platform_buildid: 20160517004009 10:53:17 INFO - mozversion platform_changeset: 17724486e1591858eea09dc327475a25883854a4 10:53:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:53:17 INFO - mozversion platform_version: 48.0a2 10:53:17 INFO - using testdate: 1463507597 10:53:17 INFO - actual date: 1463507597 10:53:17 INFO - starting webserver on 'localhost:45778' 10:53:17 INFO - SUITE-START | Running 2 tests 10:53:17 INFO - TEST-START | dromaeo_css 10:53:17 INFO - operating with platform_type : linux_ 10:53:17 INFO - Initialising browser for dromaeo_css test... 10:53:17 INFO - TEST-INFO | started process 17192 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP9cfRj/profile http://localhost:45778/getInfo.html) 10:53:21 INFO - PROCESS | 17192 | 10:53:21 INFO - PROCESS | 17192 | (process:17275): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:53:22 INFO - PROCESS | 17192 | __metrics Screen width/height:1600/1200 10:53:22 INFO - PROCESS | 17192 | colorDepth:24 10:53:22 INFO - PROCESS | 17192 | Browser inner width/height: 1024/697 10:53:22 INFO - PROCESS | 17192 | __metrics 10:53:22 ERROR - PROCESS | 17192 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 10:53:23 INFO - TEST-INFO | 17192: exit 0 10:53:23 INFO - Browser initialized. 10:53:23 INFO - Running cycle 1/1 for dromaeo_css test... 10:53:23 INFO - TEST-INFO | started process 17326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP9cfRj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:25 INFO - PROCESS | 17326 | 10:53:25 INFO - PROCESS | 17326 | (process:17399): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:53:35 INFO - PROCESS | 17326 | RSS: Main: 151871488 10:53:35 INFO - PROCESS | 17326 | 10:54:24 INFO - PROCESS | 17326 | 1463507664968 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:56:32 INFO - PROCESS | 17326 | Cycle 1(1): loaded http://localhost:45778/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45778/tests/dromaeo/cssquery-ext.html) 10:56:33 INFO - PROCESS | 17326 | RSS: Main: 156151808 10:56:33 INFO - PROCESS | 17326 | 10:59:35 INFO - PROCESS | 17326 | Cycle 1(1): loaded http://localhost:45778/tests/dromaeo/cssquery-ext.html (next: http://localhost:45778/tests/dromaeo/cssquery-jquery.html) 10:59:35 INFO - PROCESS | 17326 | RSS: Main: 153268224 10:59:35 INFO - PROCESS | 17326 | 11:02:37 INFO - PROCESS | 17326 | Cycle 1(1): loaded http://localhost:45778/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45778/tests/dromaeo/cssquery-mootools.html) 11:02:38 INFO - PROCESS | 17326 | RSS: Main: 153202688 11:02:38 INFO - PROCESS | 17326 | 11:05:39 INFO - PROCESS | 17326 | Cycle 1(1): loaded http://localhost:45778/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45778/tests/dromaeo/cssquery-prototype.html) 11:05:40 INFO - PROCESS | 17326 | RSS: Main: 153231360 11:05:40 INFO - PROCESS | 17326 | 11:08:42 INFO - PROCESS | 17326 | Cycle 1(1): loaded http://localhost:45778/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45778/tests/dromaeo/cssquery-yui.html) 11:08:43 INFO - PROCESS | 17326 | RSS: Main: 154439680 11:08:43 INFO - PROCESS | 17326 | 11:11:45 INFO - PROCESS | 17326 | Cycle 1(1): loaded http://localhost:45778/tests/dromaeo/cssquery-yui.html (next: http://localhost:45778/tests/dromaeo/cssquery-dojo.html) 11:11:45 INFO - PROCESS | 17326 | RSS: Main: 156172288 11:11:45 INFO - PROCESS | 17326 | 11:11:45 INFO - PROCESS | 17326 | __start_tp_report 11:11:45 INFO - PROCESS | 17326 | _x_x_mozilla_page_load 11:11:45 INFO - PROCESS | 17326 | _x_x_mozilla_page_load_details 11:11:45 INFO - PROCESS | 17326 | |i|pagename|runs| 11:11:45 INFO - PROCESS | 17326 | |0;dojo.html;3366.2425954160312;3429.777064490808;3439.7936123832555;3482.895513134605;3496.318217947501;5512.779488820453;5536.861578460535;5550.833474995747;5567.33192016958;5586.832395028146;5595.21666966625;5602.691851948141;5607.663540187581;5609.719514024293;5614.550835933126;5054.898902021957;5086.008228395464;5089.592832573385;5106.183010718286;5107.69353838769;5161.354830646169;5210;5216.556592689607;5224.059669259532;5256.027634887558;5190.169572868342;5206.609504287175;5232.947670523303;5312.92030619541;5336.519713225809;5163.948360516384;5164.122099243138;5166.61250406221;5181.35233095863;5191.299174611417;5003.974980125076;5073.315102461194;5140.33175687162;5146.253793200002;5191.402988656278;5546.611737178399;5577.247071645357;5615.719214039282;5632.9436705632825;5681.119426488901;6045.365236650133;6055.27336719592;6081.270247570275;6085.208922840046;6090.817275481742;6047.365026672224;6140.6929653517145;6141.846453838645;6150.569460137792;6150.66171360575;5622.887542249173;5714.857128571777;5751.1373294006235;5758.93459709955;5769.451902069339;6216.409441103178;6227.657478838707;6253.187085678833;6288.842778930563;6298.622082675054;5925.881482370329;6021.036634138517;6035.547333949971;6037.516998640098;6057.151998720183;5953.970230148908;5964.075568286922;5976.252968378953;5977.103434484775;6014.1580178775;5921.526277897758;5972.940270597239;5980.312264089598;5989.9101513477335;6002.819915402545;5825.359210486843;5908.291005079418;5949.25634295713;5975.223220981245;6001.789937352259;4611.976940115278;4617.376654151713;4637.281221410687;4641.164590373765;4667.929981050287;4175.979120104441;4177.728447650954;4196.664266858644;4200.642945349679;4223.72545784523;5871.32479764824;5904.822855314347;5930.970345148246;5942.049272116441;5965.940340596539;6045.274567051982;6155.938440615626;6192.566520343533;6196.349383314777;6207.844803879849;5752.597318187771;5864.091065884794;5898.233229680114;5900.498457631149;5925.703714814328;5219.947800522022;5255.421903590602;5258.947410525922;5287.127623942083;5291.576673866081;6078.6048906820915;6108.602940808833;6178.814635560941;6186.19579454668;6188.566800324024;5994.790182343597;6002.7298771554515;6011.759529618854;6097.481714054177;6120.265568131853;6353.142325786144;6359;6388.776392826228;6405.135306733531;6419.101325814297;5986.01230796931;5990.610610310316;5998.4601385875485;6004.219451471456;6050.818475445568;5988.700564971647;6012.518998480024;6065.60573562717;6159.84600384994;6170.197874276315;6006.519478441802;6034.39656034393;6057.18228039209;6068.939310607014;6082.330943596289;5931.970340148272;5997.430244126801;6010.819675409744;6012.188354572077;6013.5189184865985;5776.653400795965;5852.209951656472;5884.146798714248;5911.349751527415;5941.37615550361;5918.201042859331;5947.434993675594;5956.5532585055425;5974.731137098928;5993.101034844808;5793.188953546591;5795.072788353843;5800.187973683604;5801.8549536261935;5815.82552523425 11:11:45 INFO - PROCESS | 17326 | |1;ext.html;664.5348256220643;677.6374639567832;677.7627830259408;720.4452571519927;738.9963050184747;39158.804205978966;39958.60041399585;40035.399469007985;40122.39816402752;40126.7993660032;42530;43254.56745432545;43293;43400.78299608498;43541.34687979675;8816.074312197206;9043.683471078513;9046.638134474613;9047.547622618875;9077.591508382106;8891.199792018717;9014.819703605925;9043.773905652379;9054.592543335533;9073.319501037415;9051.637934482613;9089.727308180765;9100.044495327995;9122.680706175284;9156.45061296321;8963.686270980517;9040.728778136667;9046.502442365667;9065.22945549629;9068.319876009326;8946.463212207289;9072.591733372014;9095.49974751395;9099.590518426687;9115.134062264075;43175.35236971448;43342.56657433417;43806;43883.561164388266;43967;3748.8687895923513;3942.7437216581116;4197.622214000724;4212.326027835532;4514.9774251128865;32861;33158.502622460685;33757.15607109817;33938.151546211295;33990;4560.77196140195;4636.35912944328;4665.603423708989;4671.416072990876;4722.811087556528;323851;324726;325526.9999999976;326043;326173;39838.20323593512;62068.37931620716;62870.68564657239;62893.37106628875;63020;37929.431058534145;38237.42643860344;38267.23465530729;38367.808160959576;38380.23239535194;15369.308381122653;15478.148701821508;15533.145676987875;15550.76673849893;15579.298931548108;14006.789898151535;14085.43658253679;14092.436302547989;14101.153930764187;14177.22025288619;9407.247420206368;9450.763730906783;9467.431954082776;9489.430634161834;9580.56887440067;3504.299140171976;3613.33153366628;3623.7282203834816;3661.4324779659196;3664.633536646314;1036.1348274191134;1109.9667009989714;1168.462507246676;1234.3457967277177;1237.6101528018646;32926.506102408486;33433;33542.49686254708;33785.662143378744;34053.31893362119;1080.8162612355918;1199.142613031669;1210.7639010393066;1239.1326071749631;1289.149161553389;17136.22886970089;17318.220680069426;17545.385911493035;17597.7360339595;17768.62807803007;474977;535299;544294;880013;889643;62658.373416266164;62833;63609;63621.363786361544;63677;1544.3050627217797;1551.1468692219235;1551.6353656890622;1564.1553561076892;1615.5153453963765;32971;33537.832310839265;33557;33749.325013500085;34200.65799341975;54301;54375;54851;54901.45098548963;55144.44855551393;441972;447146;447222;449093;450153;31082.53376199404;31453.213669658442;31679.36641267208;31820.68179318177;32128;49908.26597907588;50396.748016259684;50934.49065509297;51245.48754512407;51607;41795.37306940459;42209.15581688411;42727;42901.57098429101;44844.55155448534;40738.79630601828;41353.1729365405;41507.58492415158;42450.938726532084;42632;42032.78983605062;42539.787301064534;42772.572274276856;43020.35469468023;43409.78295108631;35417;36381.63618363783;36513.63486365102;36697;36960.63039369572;27809.304767380978;29008.564871526523;29121.271968200963;29164.416711665224;29386.412271754874 11:11:45 INFO - PROCESS | 17326 | |2;jquery.html;426.5457287988292;429.5983255655964;439.1446140058254;441.9955800441996;444.2137416772311;19125.521861953457;19550.90224548877;19676.11457484413;20792.792072079275;21278.57442851142;18429;18917.621647567074;19468.51328716783;19519.316823911166;19637.11632976516;5369.919451208245;5500.367457742371;5538.0585300498815;5546.91679624806;5548.55611551077;5458.344998600173;5461.808836690717;5504.862378440531;5942.524598032169;6221.4400703936635;6139.38606139387;6165.136880836686;6173.41352571505;6212.565120441571;6214.533909956749;6091.847703807396;6128.172696685957;6508.28408875021;6555.967220163869;6714.362135597111;5939.732712027969;5984.222051133324;5985.670788106652;6025.78909738157;6037.72830222641;15214.619634509116;16115.516534503984;23772;23805.642915356282;23818.047278108854;2359.421941624296;2493.3268017635137;2524.6086856537268;2580.238829545289;2946.410717856416;10502.369857808479;10860.782784344348;11094.057005154571;11120.55517779288;11288.830667539993;2079.2306846466904;2107.9367618971455;2176.3688530326185;2263.807576356012;2379.809615230795;78185;83923.5803820977;85052.14947850566;85603.57198214032;88262.5586872068;11361.488733007034;11837.171398002229;11849.289042657296;11969.940150299368;12084.637460876187;16625.83374166267;16712.74930876038;16859.24133413999;16875.831241687672;16889.071101089314;7809.68761249555;8865.157810008168;8872.8669069964;8919.152680495343;8951.462912225157;8622.137786221454;8658.95670521656;8666.306695464475;8704.695335663222;8732.607032683545;4961.603071754251;5107.668001579886;5116.667416617908;5134.5635620972635;5153.123968925292;2062.896855157236;2085.301424022939;2116.682497625338;2119.5760847830497;2136.626090434199;1018.3737001744022;1019.3374306700556;1091.9727006824894;1121.5177473686392;1127.4250132432355;19098.71351929722;19111;19370.80629193718;19599.510012249524;19960.3013894513;1038.055369613648;1040.885502594714;1060.4273692206277;1096.9122470202524;1123.6741345009855;10728.249022568345;11082.61210857616;11125.777484450266;11143.72140696489;11164.776704465865;465972;466057;473250.1687457772;489554;491614;55277.44722552723;56312.43687563154;86581;91459.54270228607;92475.5376223128;1078.5308390849848;1097.7530055737395;1105.7567335186245;1114.0975809594254;1118.3960661243;17111.13324039016;17288.827111728722;17490.82509174892;17645.647087058445;17676.91161544184;31339.843300783352;38713.4192987111;39808.80095599504;40121.39817902676;40348.79825600853;49597;49781.253281201534;49918.500814991385;49922.500774991786;50240.497595025045;8394.790130246549;8451.746447606582;8572.271356934481;8767.517786521803;8949.32880033987;9563.139317461462;12812.871871281168;13287.069905106937;13294.734105318033;13625.591232263048;11104.333739975627;11308.151888608552;11886.702832428913;11963.521459141537;12054;11593.24643898144;11607.89724976126;11718.824217636571;11979.580714674945;12004.639860804189;11610.129240306842;11908.464119114487;12042.879571204527;12093.57672481459;12291.262524248574;8812.603432845666;8829.823403532022;9039.45763254207;9066;9074.047225041275;9406.623735050522;11610.6516804496;11794.410279486163;11814.527418903148;12209.511619535118 11:11:45 INFO - PROCESS | 17326 | |3;mootools.html;1563.2027665890396;1573.276292905264;1792.1397729090036;1907.341967021378;1918.1560113550029;7852.332551733095;8549.358798090137;8562.571871406435;8712.60793264303;8715.564221788916;8635.611397487113;8679.522626255553;8752.8687069694;8761.342899282563;8779.03430622631;2429.6962879640046;2443.5601591713485;2447.2658202539255;2459.6187590923437;2463.273334366357;2411.047636183715;2447.620618804079;2459.311392810016;2477.3682710908693;2482.726900041003;2464.950700985979;2473.307473907309;2506.4611108611643;2530.5698031334623;2531.1141100614823;2467.2968204061935;2480.491499242651;2512.510060538196;2513.673222481075;2513.8114641401876;2438.573249681299;2465.704115506133;2476.6656501372263;2483.242611003643;2490.6264060390904;8909.73270801877;9005.234555062827;9015.639374425014;9018.503982280972;9023.278137748965;5225.581953443753;5325.360956685223;5346.492083252085;5360.544353729938;5374.7850085996515;3535.3459609972238;3562.3943929532043;3588.1209103769484;3602;3615.3130905128205;1232.6610182199968;1255.7802384582662;1264.1909178126007;1280.1103233252893;1305.8041293805911;12490.75018499625;12565.56020539286;12579.119461637689;12611.495540178383;12631.115821892472;4844.612431005511;4851.054044461296;4854;4892;4941.752912354368;10585.100266477435;10604.416757078434;10609.575616975235;10639.574417023387;10654.893451065545;5373.435789242151;5379.865503362369;5382.811601593926;5384.19237114436;5398.757055932492;4340.60934515895;4810.6151507879285;4887.047025829929;4914.140025495524;4926.866820631275;4125.608067233608;4158.230727315396;4184.707070505096;4233.809478573472;4236.555161707976;1356.7829147336379;1393.2197969137314;1400.7058517711191;1403.3825116948715;1406.662401023747;989.7575094101991;1057.5241141486363;1061.395004847245;1068.2468859454066;1072.8068947589352;6076.848078798065;6162.106494558354;6221.09794079865;6223.253209614784;6247.110351033342;493.01643221772076;494.6018455143644;497.98008079676407;1115.5705053554277;1130.4065365683082;4237.258479766028;4275.935860962088;4285.250081235771;4298.20483210607;4315.28797748368;10882.673519794418;11175.72060698489;11294.096472282197;11318.207725459304;11323.603673871376;11039.116870650329;11046.834297485544;11097.72255693598;11146.944265278622;11175.21773475849;8033.19668033192;8347.749567512985;8362.916370836214;8388.790280243044;8478.915210847812;6138.07928810682;6222.906656400067;6233.376662333731;6350.1109844622715;6392.840178995562;9452.810943781224;9471.621135154517;9489.66786162481;9574.569144388659;9697.369670971364;9389.43663380172;9813.803723925625;10035.046670566284;10039.34744241622;10065.295429319878;6821.1814582250445;7577.0907491101425;7618.733344333144;7700.3454706350585;7721.729739459092;8272.33821294283;8294.751157465285;8351.290140337896;8363.540005299767;8398;7458.5151965122095;7648.541087534766;7651.081870175614;7674.040744906887;7692.076950765944;7485.7754267372065;7542.358899493385;7569.47013709035;7591.734289299848;7644.503107298008;7251.56490610565;7264.12830460327;7282.344588987016;7309.488335816442;7325.4872158948365;5197.870053248699;5248.396434410091;5290.523852853262;5330.120530112488;5429.782808687608;5331.067063263991;5365.356157261153;5443.292371991616;5559.054960656617;5565 11:11:45 INFO - PROCESS | 17326 | |4;prototype.html;361.5209846952788;367.5203858964052;368.787946930515;373.9719521035923;375.0548617483942;6454.515911306659;6599.142111525501;6615.206175258975;6732.6297053661965;6758;6673.799786006415;6677.33226677332;6683.832904177398;6697.8995315070315;6698.6985585648645;5052.343195384595;5073.112205364065;5077.314562534066;5078.4413714491375;5079.6190285728535;5082.771275292602;5085.186370180753;5085.898282034357;5091.0581542414775;5106.923396149061;5043.36957880265;5043.470435604264;5047.924281135786;5053.722045287508;5053.84838454847;4765.118453086156;4875.756212189376;5035.395752509686;5044.949550504503;5051.520105589963;4227.471566054243;4228.703990720651;4235.618794308496;4238.173556156551;4241.321388577843;6306.085617585471;6339.746410143589;6351.110844481776;6360.71376788041;6361.80914572559;5730.19777231188;5761.164631128505;5765.077587585966;5768.509676677488;5781.161731548902;6975.755848545327;6997.580145191305;6999.965000175018;7009.088818453569;7013.964930175367;4660.184467718136;4754.286856971482;4787.952120478785;4794.113089078532;4794.712317260975;7320.0483937088375;7370.410367170613;7409;7417.258274172594;7422.294881986203;4860.73265970368;4897.240927656219;4903.141950158708;4908.214685650279;4928.28539861718;4974.228994505857;4974.825881094144;4975.228839529878;4976.328195693607;4977.452480227172;5771.422857714279;5783.681897495594;5784.4504772046585;5785.768569257182;5795.768169273266;6815.727370905208;7064.540804847668;7072.398846098036;7130.144382674009;7137.321954414322;1701.676681430549;1708.863290936722;1710.7006273902018;1713.5202143399868;1719.1404297851075;1135.1769966774023;1137.4881303413497;1145.833854091152;1151.694800877768;1195.384377045822;6653.068570400148;6692.59844409337;6702.698378572878;6709.993500974892;6806.6256355900905;7177.354038136593;7217.097862767154;7252.709891604382;7252.927470725331;7270.127584689871;6739.157605299338;6757.155355580552;6763.086983257295;6775.762848300385;6781.11845460087;3890.7471014383973;3921.176552923861;3945.782981936021;3951.4467974483596;3957.584453632385;7452.105747310357;7705.614719264015;7725.381969442544;7726.497777644548;7745.728899488491;7534.962325188339;7543;7570;7598.620068996528;7607.35337496319;7625.580593067434;7673.923260767432;7682.001339825899;7687.923120768833;7714.997050383414;7235.2764723529335;7387.704491820482;7388.556686598821;7393.371563417169;7420.777376678492;7223.638818059181;7256.854862902818;7280.271972802678;7293.197748247795;7300.196978332273;7612.467127301035;7627.961860190663;7651.426143039405;7654.808629784077;7655.961720191363;4882.170031094652;4921.26181072842;4929.679570827885;4930.964497455575;4936.58039066669;7159.105111861018;7332.9266707332245;7359.043324367798;7367.4106071515225;7379.631018449163;7195.208527062124;7199.388052015637;7205.567665940061;7284.271572842674;7302.2697730226555;7111.502194846518;7135.429165666838;7138.428925686037;7142.607156606437;7160.856782864418;7006.054182685476;7021.754238601625;7022.33287837675;7028.964855175692;7029.683664235224;7031.507794454544;7212.927870721225;7215.2063273038875;7224.241454647186;7259.564426134449;6890.44876409876;7016.193137789015;7061.576305421691;7065.82335441618;7066.046083778624 11:11:45 INFO - PROCESS | 17326 | |5;yui.html;835.1773503099449;838.3125836813813;856.503228127686;860.126971124309;863.3222920007795;14744.852551474482;14969.10185388876;15217.239138043109;15244.923775381136;15279;14690.559283221493;14805.3337599808;14849.628759281024;14949.701005979874;14959.999999999973;870.4124715816814;891.8260939116875;895.4403497813867;899.177252813678;902.0122965352928;897.9595918183664;903.4624398482893;903.7469508537587;906.1663269791808;909.1999040844081;936.7330310861406;939.0843927171022;943.0710749911332;946.2666433514013;947.8436058050413;938.8357037518475;941.1341565759484;941.3410612571228;946.2146418472652;948.4072454715803;686.8454597715524;692.7506097804786;695.5478938689841;696.8466937273791;698.5948150072996;15291.694166116728;15369.615759606098;15381.846181538152;15385.153816540085;15589.922050389789;14913.254337283093;14942;15008.099514029193;15036.774448383283;15116.773248401283;12043.458044387937;12278.324692141929;12324.383780810924;12337.074719396081;12378.81431778524;4014.859479918218;4057.1682805025193;4096.8566100186645;4100.7334523256195;4158.209940111369;60866;60953.695231524005;62146.37853621451;62547.6872615634;62786;11445.942770286096;11581.247218930743;11704.473298701409;11809.40952952349;12063.095267854771;21192.78807211939;21225.78774212269;21326.04032818527;21396.572068558853;21485;7782.883256751154;7840.803979900548;7860.606969651494;8405.537695426689;8716.12838716136;5007.048660754445;5037.748112594429;5060.873478163076;5103.209002604603;5192.065428222956;3798.6961043116485;3842.9423558646645;3845.2309538092495;3853.6917046636204;3861.6331448512346;632.7310892870512;653.2226650286144;656.143732429175;668.9464842812563;675.537256978971;670.6747227594612;759.3317880265441;799.160881074869;799.2167675677869;802.5826570183472;9087.273018158532;9263.212626926786;9495.857562136573;9949.751256218653;10094.343867648578;770.6300975531664;775.0892701076212;783.565121357652;805.4482679364654;812.0580127052708;4472.686911916199;4476.440444944382;4590.380298659705;4637.976810115928;4642.698224615389;67840;67861.32138678648;67880.32119678838;67884.32115678879;68512.31487685059;59059.40940590625;61107.38892611017;61286;61499.38500615026;61864.38135618586;53079.203811942854;53466.46533534615;53970.19044714254;54204.18693719598;54643;8866.335024873031;9090.181883630505;9165.770855728393;9222.677206298016;9225.400348977295;40348.79825600853;40606.187876242904;40642.59357406388;41548;41967.58032419759;49959.25061124013;51946.220806687175;52033.47966520438;52193;52307;11488.138389620979;11805.940970295094;11828.290302581872;11892.702682432662;11900.188117727828;13103.934480327538;13148.342582870628;13159.934200328937;13270.800937985745;13490.932545337211;12307.26156430617;12334.259944403364;12377.257364558156;12381.690457738629;12390.442430090849;11881.524739010343;12212.633620991384;12405.75188496207;12444.937775311066;12542.749145017231;11854.288742675468;12072.879271207175;12144.635660930186;12150.453229604866;12170.14808963364;10447.582096716047;10491;10533.525991330256;10561.683149505527;10703.518341674799;10099.646512372032;10682.521986869813;10802.243842930919;10910.563577457131;10928.836067458835 11:11:45 INFO - PROCESS | 17326 | __end_tp_report 11:11:45 INFO - PROCESS | 17326 | __start_cc_report 11:11:45 INFO - PROCESS | 17326 | _x_x_mozilla_cycle_collect,321 11:11:45 INFO - PROCESS | 17326 | __end_cc_report 11:11:45 INFO - PROCESS | 17326 | __startTimestamp1463508705554__endTimestamp 11:11:45 INFO - PROCESS | 17326 | 11:11:45 INFO - PROCESS | 17326 | ------- Summary: start ------- 11:11:45 INFO - PROCESS | 17326 | Number of tests: 6 11:11:45 INFO - PROCESS | 17326 | 11:11:45 INFO - PROCESS | 17326 | [#0] dojo.html Cycles:165 Average:5651.90 Median:5918.20 stddev:622.23 (10.5%) stddev-sans-first:597.75 11:11:45 INFO - PROCESS | 17326 | Values: 3366.2 3429.8 3439.8 3482.9 3496.3 5512.8 5536.9 5550.8 5567.3 5586.8 5595.2 5602.7 5607.7 5609.7 5614.6 5054.9 5086.0 5089.6 5106.2 5107.7 5161.4 5210.0 5216.6 5224.1 5256.0 5190.2 5206.6 5232.9 5312.9 5336.5 5163.9 5164.1 5166.6 5181.4 5191.3 5004.0 5073.3 5140.3 5146.3 5191.4 5546.6 5577.2 5615.7 5632.9 5681.1 6045.4 6055.3 6081.3 6085.2 6090.8 6047.4 6140.7 6141.8 6150.6 6150.7 5622.9 5714.9 5751.1 5758.9 5769.5 6216.4 6227.7 6253.2 6288.8 6298.6 5925.9 6021.0 6035.5 6037.5 6057.2 5954.0 5964.1 5976.3 5977.1 6014.2 5921.5 5972.9 5980.3 5989.9 6002.8 5825.4 5908.3 5949.3 5975.2 6001.8 4612.0 4617.4 4637.3 4641.2 4667.9 4176.0 4177.7 4196.7 4200.6 4223.7 5871.3 5904.8 5931.0 5942.0 5965.9 6045.3 6155.9 6192.6 6196.3 6207.8 5752.6 5864.1 5898.2 5900.5 5925.7 5219.9 5255.4 5258.9 5287.1 5291.6 6078.6 6108.6 6178.8 6186.2 6188.6 5994.8 6002.7 6011.8 6097.5 6120.3 6353.1 6359.0 6388.8 6405.1 6419.1 5986.0 5990.6 5998.5 6004.2 6050.8 5988.7 6012.5 6065.6 6159.8 6170.2 6006.5 6034.4 6057.2 6068.9 6082.3 5932.0 5997.4 6010.8 6012.2 6013.5 5776.7 5852.2 5884.1 5911.3 5941.4 5918.2 5947.4 5956.6 5974.7 5993.1 5793.2 5795.1 5800.2 5801.9 5815.8 11:11:45 INFO - PROCESS | 17326 | 11:11:45 INFO - PROCESS | 17326 | [#1] ext.html Cycles:180 Average:63136.76 Median:42330.05 stddev:136822.95 (323.2%) stddev-sans-first:137126.38 11:11:45 INFO - PROCESS | 17326 | Values: 664.5 677.6 677.8 720.4 739.0 39158.8 39958.6 40035.4 40122.4 40126.8 42530.0 43254.6 43293.0 43400.8 43541.3 8816.1 9043.7 9046.6 9047.5 9077.6 8891.2 9014.8 9043.8 9054.6 9073.3 9051.6 9089.7 9100.0 9122.7 9156.5 8963.7 9040.7 9046.5 9065.2 9068.3 8946.5 9072.6 9095.5 9099.6 9115.1 43175.4 43342.6 43806.0 43883.6 43967.0 3748.9 3942.7 4197.6 4212.3 4515.0 32861.0 33158.5 33757.2 33938.2 33990.0 4560.8 4636.4 4665.6 4671.4 4722.8 323851.0 324726.0 325527.0 326043.0 326173.0 39838.2 62068.4 62870.7 62893.4 63020.0 37929.4 38237.4 38267.2 38367.8 38380.2 15369.3 15478.1 15533.1 15550.8 15579.3 14006.8 14085.4 14092.4 14101.2 14177.2 9407.2 9450.8 9467.4 9489.4 9580.6 3504.3 3613.3 3623.7 3661.4 3664.6 1036.1 1110.0 1168.5 1234.3 1237.6 32926.5 33433.0 33542.5 33785.7 34053.3 1080.8 1199.1 1210.8 1239.1 1289.1 17136.2 17318.2 17545.4 17597.7 17768.6 474977.0 535299.0 544294.0 880013.0 889643.0 62658.4 62833.0 63609.0 63621.4 63677.0 1544.3 1551.1 1551.6 1564.2 1615.5 32971.0 33537.8 33557.0 33749.3 34200.7 54301.0 54375.0 54851.0 54901.5 55144.4 441972.0 447146.0 447222.0 449093.0 450153.0 31082.5 31453.2 31679.4 31820.7 32128.0 49908.3 50396.7 50934.5 51245.5 51607.0 41795.4 42209.2 42727.0 42901.6 44844.6 40738.8 41353.2 41507.6 42450.9 42632.0 42032.8 42539.8 42772.6 43020.4 43409.8 35417.0 36381.6 36513.6 36697.0 36960.6 27809.3 29008.6 29121.3 29164.4 29386.4 11:11:45 INFO - PROCESS | 17326 | 11:11:45 INFO - PROCESS | 17326 | [#2] jquery.html Cycles:180 Average:28137.12 Median:13075.90 stddev:78463.48 (600.1%) stddev-sans-first:78656.00 11:11:45 INFO - PROCESS | 17326 | Values: 426.5 429.6 439.1 442.0 444.2 19125.5 19550.9 19676.1 20792.8 21278.6 18429.0 18917.6 19468.5 19519.3 19637.1 5369.9 5500.4 5538.1 5546.9 5548.6 5458.3 5461.8 5504.9 5942.5 6221.4 6139.4 6165.1 6173.4 6212.6 6214.5 6091.8 6128.2 6508.3 6556.0 6714.4 5939.7 5984.2 5985.7 6025.8 6037.7 15214.6 16115.5 23772.0 23805.6 23818.0 2359.4 2493.3 2524.6 2580.2 2946.4 10502.4 10860.8 11094.1 11120.6 11288.8 2079.2 2107.9 2176.4 2263.8 2379.8 78185.0 83923.6 85052.1 85603.6 88262.6 11361.5 11837.2 11849.3 11969.9 12084.6 16625.8 16712.7 16859.2 16875.8 16889.1 7809.7 8865.2 8872.9 8919.2 8951.5 8622.1 8659.0 8666.3 8704.7 8732.6 4961.6 5107.7 5116.7 5134.6 5153.1 2062.9 2085.3 2116.7 2119.6 2136.6 1018.4 1019.3 1092.0 1121.5 1127.4 19098.7 19111.0 19370.8 19599.5 19960.3 1038.1 1040.9 1060.4 1096.9 1123.7 10728.2 11082.6 11125.8 11143.7 11164.8 465972.0 466057.0 473250.2 489554.0 491614.0 55277.4 56312.4 86581.0 91459.5 92475.5 1078.5 1097.8 1105.8 1114.1 1118.4 17111.1 17288.8 17490.8 17645.6 17676.9 31339.8 38713.4 39808.8 40121.4 40348.8 49597.0 49781.3 49918.5 49922.5 50240.5 8394.8 8451.7 8572.3 8767.5 8949.3 9563.1 12812.9 13287.1 13294.7 13625.6 11104.3 11308.2 11886.7 11963.5 12054.0 11593.2 11607.9 11718.8 11979.6 12004.6 11610.1 11908.5 12042.9 12093.6 12291.3 8812.6 8829.8 9039.5 9066.0 9074.0 9406.6 11610.7 11794.4 11814.5 12209.5 11:11:45 INFO - PROCESS | 17326 | 11:11:45 INFO - PROCESS | 17326 | [#3] mootools.html Cycles:180 Average:5886.65 Median:4903.07 stddev:3258.17 (66.5%) stddev-sans-first:3251.11 11:11:45 INFO - PROCESS | 17326 | Values: 1563.2 1573.3 1792.1 1907.3 1918.2 7852.3 8549.4 8562.6 8712.6 8715.6 8635.6 8679.5 8752.9 8761.3 8779.0 2429.7 2443.6 2447.3 2459.6 2463.3 2411.0 2447.6 2459.3 2477.4 2482.7 2465.0 2473.3 2506.5 2530.6 2531.1 2467.3 2480.5 2512.5 2513.7 2513.8 2438.6 2465.7 2476.7 2483.2 2490.6 8909.7 9005.2 9015.6 9018.5 9023.3 5225.6 5325.4 5346.5 5360.5 5374.8 3535.3 3562.4 3588.1 3602.0 3615.3 1232.7 1255.8 1264.2 1280.1 1305.8 12490.8 12565.6 12579.1 12611.5 12631.1 4844.6 4851.1 4854.0 4892.0 4941.8 10585.1 10604.4 10609.6 10639.6 10654.9 5373.4 5379.9 5382.8 5384.2 5398.8 4340.6 4810.6 4887.0 4914.1 4926.9 4125.6 4158.2 4184.7 4233.8 4236.6 1356.8 1393.2 1400.7 1403.4 1406.7 989.8 1057.5 1061.4 1068.2 1072.8 6076.8 6162.1 6221.1 6223.3 6247.1 493.0 494.6 498.0 1115.6 1130.4 4237.3 4275.9 4285.3 4298.2 4315.3 10882.7 11175.7 11294.1 11318.2 11323.6 11039.1 11046.8 11097.7 11146.9 11175.2 8033.2 8347.7 8362.9 8388.8 8478.9 6138.1 6222.9 6233.4 6350.1 6392.8 9452.8 9471.6 9489.7 9574.6 9697.4 9389.4 9813.8 10035.0 10039.3 10065.3 6821.2 7577.1 7618.7 7700.3 7721.7 8272.3 8294.8 8351.3 8363.5 8398.0 7458.5 7648.5 7651.1 7674.0 7692.1 7485.8 7542.4 7569.5 7591.7 7644.5 7251.6 7264.1 7282.3 7309.5 7325.5 5197.9 5248.4 5290.5 5330.1 5429.8 5331.1 5365.4 5443.3 5559.1 5565.0 11:11:45 INFO - PROCESS | 17326 | 11:11:45 INFO - PROCESS | 17326 | [#4] prototype.html Cycles:180 Average:5905.26 Median:6706.35 stddev:1826.49 (27.2%) stddev-sans-first:1783.58 11:11:45 INFO - PROCESS | 17326 | Values: 361.5 367.5 368.8 374.0 375.1 6454.5 6599.1 6615.2 6732.6 6758.0 6673.8 6677.3 6683.8 6697.9 6698.7 5052.3 5073.1 5077.3 5078.4 5079.6 5082.8 5085.2 5085.9 5091.1 5106.9 5043.4 5043.5 5047.9 5053.7 5053.8 4765.1 4875.8 5035.4 5044.9 5051.5 4227.5 4228.7 4235.6 4238.2 4241.3 6306.1 6339.7 6351.1 6360.7 6361.8 5730.2 5761.2 5765.1 5768.5 5781.2 6975.8 6997.6 7000.0 7009.1 7014.0 4660.2 4754.3 4788.0 4794.1 4794.7 7320.0 7370.4 7409.0 7417.3 7422.3 4860.7 4897.2 4903.1 4908.2 4928.3 4974.2 4974.8 4975.2 4976.3 4977.5 5771.4 5783.7 5784.5 5785.8 5795.8 6815.7 7064.5 7072.4 7130.1 7137.3 1701.7 1708.9 1710.7 1713.5 1719.1 1135.2 1137.5 1145.8 1151.7 1195.4 6653.1 6692.6 6702.7 6710.0 6806.6 7177.4 7217.1 7252.7 7252.9 7270.1 6739.2 6757.2 6763.1 6775.8 6781.1 3890.7 3921.2 3945.8 3951.4 3957.6 7452.1 7705.6 7725.4 7726.5 7745.7 7535.0 7543.0 7570.0 7598.6 7607.4 7625.6 7673.9 7682.0 7687.9 7715.0 7235.3 7387.7 7388.6 7393.4 7420.8 7223.6 7256.9 7280.3 7293.2 7300.2 7612.5 7628.0 7651.4 7654.8 7656.0 4882.2 4921.3 4929.7 4931.0 4936.6 7159.1 7332.9 7359.0 7367.4 7379.6 7195.2 7199.4 7205.6 7284.3 7302.3 7111.5 7135.4 7138.4 7142.6 7160.9 7006.1 7021.8 7022.3 7029.0 7029.7 7031.5 7212.9 7215.2 7224.2 7259.6 6890.4 7016.2 7061.6 7065.8 7066.0 11:11:45 INFO - PROCESS | 17326 | 11:11:45 INFO - PROCESS | 17326 | [#5] yui.html Cycles:180 Average:16052.13 Median:27300.97 stddev:19142.76 (70.1%) stddev-sans-first:19162.35 11:11:45 INFO - PROCESS | 17326 | Values: 835.2 838.3 856.5 860.1 863.3 14744.9 14969.1 15217.2 15244.9 15279.0 14690.6 14805.3 14849.6 14949.7 14960.0 870.4 891.8 895.4 899.2 902.0 898.0 903.5 903.7 906.2 909.2 936.7 939.1 943.1 946.3 947.8 938.8 941.1 941.3 946.2 948.4 686.8 692.8 695.5 696.8 698.6 15291.7 15369.6 15381.8 15385.2 15589.9 14913.3 14942.0 15008.1 15036.8 15116.8 12043.5 12278.3 12324.4 12337.1 12378.8 4014.9 4057.2 4096.9 4100.7 4158.2 60866.0 60953.7 62146.4 62547.7 62786.0 11445.9 11581.2 11704.5 11809.4 12063.1 21192.8 21225.8 21326.0 21396.6 21485.0 7782.9 7840.8 7860.6 8405.5 8716.1 5007.0 5037.7 5060.9 5103.2 5192.1 3798.7 3842.9 3845.2 3853.7 3861.6 632.7 653.2 656.1 668.9 675.5 670.7 759.3 799.2 799.2 802.6 9087.3 9263.2 9495.9 9949.8 10094.3 770.6 775.1 783.6 805.4 812.1 4472.7 4476.4 4590.4 4638.0 4642.7 67840.0 67861.3 67880.3 67884.3 68512.3 59059.4 61107.4 61286.0 61499.4 61864.4 53079.2 53466.5 53970.2 54204.2 54643.0 8866.3 9090.2 9165.8 9222.7 9225.4 40348.8 40606.2 40642.6 41548.0 41967.6 49959.3 51946.2 52033.5 52193.0 52307.0 11488.1 11805.9 11828.3 11892.7 11900.2 13103.9 13148.3 13159.9 13270.8 13490.9 12307.3 12334.3 12377.3 12381.7 12390.4 11881.5 12212.6 12405.8 12444.9 12542.7 11854.3 12072.9 12144.6 12150.5 12170.1 10447.6 10491.0 10533.5 10561.7 10703.5 10099.6 10682.5 10802.2 10910.6 10928.8 11:11:45 INFO - PROCESS | 17326 | -------- Summary: end -------- 11:11:45 INFO - PROCESS | 17326 | 11:11:46 INFO - TEST-INFO | 17326: exit 0 11:11:46 INFO - TEST-OK | dromaeo_css | took 1108548ms 11:11:46 INFO - TEST-START | kraken 11:11:46 INFO - operating with platform_type : linux_ 11:11:46 INFO - Initialising browser for kraken test... 11:11:46 INFO - TEST-INFO | started process 17572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE4hdww/profile http://localhost:45778/getInfo.html) 11:11:49 INFO - PROCESS | 17572 | 11:11:49 INFO - PROCESS | 17572 | (process:17649): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:11:50 INFO - PROCESS | 17572 | __metrics Screen width/height:1600/1200 11:11:50 INFO - PROCESS | 17572 | colorDepth:24 11:11:50 INFO - PROCESS | 17572 | Browser inner width/height: 1024/697 11:11:50 INFO - PROCESS | 17572 | __metrics 11:11:51 ERROR - PROCESS | 17572 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:11:51 INFO - TEST-INFO | 17572: exit 0 11:11:51 INFO - Browser initialized. 11:11:51 INFO - Running cycle 1/1 for kraken test... 11:11:51 INFO - TEST-INFO | started process 17700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE4hdww/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:53 INFO - PROCESS | 17700 | 11:11:53 INFO - PROCESS | 17700 | (process:17771): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:12:03 INFO - PROCESS | 17700 | RSS: Main: 152047616 11:12:03 INFO - PROCESS | 17700 | 11:12:06 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45778/tests/kraken/driver.html?testName=audio-beat-detection) 11:12:07 INFO - PROCESS | 17700 | RSS: Main: 157085696 11:12:07 INFO - PROCESS | 17700 | 11:12:09 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45778/tests/kraken/driver.html?testName=audio-dft) 11:12:10 INFO - PROCESS | 17700 | RSS: Main: 156844032 11:12:10 INFO - PROCESS | 17700 | 11:12:13 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45778/tests/kraken/driver.html?testName=audio-fft) 11:12:13 INFO - PROCESS | 17700 | RSS: Main: 157044736 11:12:13 INFO - PROCESS | 17700 | 11:12:15 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45778/tests/kraken/driver.html?testName=audio-oscillator) 11:12:16 INFO - PROCESS | 17700 | RSS: Main: 157659136 11:12:16 INFO - PROCESS | 17700 | 11:12:18 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45778/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:12:19 INFO - PROCESS | 17700 | RSS: Main: 157392896 11:12:19 INFO - PROCESS | 17700 | 11:12:22 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45778/tests/kraken/driver.html?testName=imaging-darkroom) 11:12:22 INFO - PROCESS | 17700 | RSS: Main: 157528064 11:12:22 INFO - PROCESS | 17700 | 11:12:26 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45778/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:26 INFO - PROCESS | 17700 | RSS: Main: 157761536 11:12:26 INFO - PROCESS | 17700 | 11:12:29 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45778/tests/kraken/driver.html?testName=json-parse-financial) 11:12:30 INFO - PROCESS | 17700 | RSS: Main: 157245440 11:12:30 INFO - PROCESS | 17700 | 11:12:31 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45778/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:32 INFO - PROCESS | 17700 | RSS: Main: 157413376 11:12:32 INFO - PROCESS | 17700 | 11:12:34 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45778/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:34 INFO - PROCESS | 17700 | RSS: Main: 157224960 11:12:34 INFO - PROCESS | 17700 | 11:12:36 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45778/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:37 INFO - PROCESS | 17700 | RSS: Main: 157573120 11:12:37 INFO - PROCESS | 17700 | 11:12:39 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45778/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:40 INFO - PROCESS | 17700 | RSS: Main: 158081024 11:12:40 INFO - PROCESS | 17700 | 11:12:43 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45778/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:43 INFO - PROCESS | 17700 | RSS: Main: 158023680 11:12:43 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | Cycle 1(1): loaded http://localhost:45778/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45778/tests/kraken/driver.html?testName=ai-astar) 11:12:45 INFO - PROCESS | 17700 | RSS: Main: 159604736 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | __start_tp_report 11:12:45 INFO - PROCESS | 17700 | _x_x_mozilla_page_load 11:12:45 INFO - PROCESS | 17700 | _x_x_mozilla_page_load_details 11:12:45 INFO - PROCESS | 17700 | |i|pagename|runs| 11:12:45 INFO - PROCESS | 17700 | |0;ai-astar;108;112;102;110;110;110;100;110;111;112 11:12:45 INFO - PROCESS | 17700 | |1;audio-beat-detection;163;127;155;170;130;156;156;131;184;129 11:12:45 INFO - PROCESS | 17700 | |2;audio-dft;163;160;163;165;162;161;161;164;162;160 11:12:45 INFO - PROCESS | 17700 | |3;audio-fft;87;76;73;172;77;75;79;76;164;76 11:12:45 INFO - PROCESS | 17700 | |4;audio-oscillator;93;92;149;94;93;92;142;92;92;152 11:12:45 INFO - PROCESS | 17700 | |5;imaging-gaussian-blur;118;118;118;118;116;117;118;117;118;117 11:12:45 INFO - PROCESS | 17700 | |6;imaging-darkroom;147;147;146;146;146;147;148;146;146;147 11:12:45 INFO - PROCESS | 17700 | |7;imaging-desaturate;96;95;95;95;95;96;95;95;95;95 11:12:45 INFO - PROCESS | 17700 | |8;json-parse-financial;55;56;55;56;60;59;56;78;58;58 11:12:45 INFO - PROCESS | 17700 | |9;json-stringify-tinderbox;60;58;58;58;58;58;58;59;59;59 11:12:45 INFO - PROCESS | 17700 | |10;stanford-crypto-aes;81;73;72;74;75;74;80;74;77;74 11:12:45 INFO - PROCESS | 17700 | |11;stanford-crypto-ccm;115;114;117;116;115;114;114;121;130;129 11:12:45 INFO - PROCESS | 17700 | |12;stanford-crypto-pbkdf2;173;166;170;162;162;159;159;163;168;159 11:12:45 INFO - PROCESS | 17700 | |13;stanford-crypto-sha256-iterative;69;69;70;66;72;66;65;66;66;67 11:12:45 INFO - PROCESS | 17700 | __end_tp_report 11:12:45 INFO - PROCESS | 17700 | __start_cc_report 11:12:45 INFO - PROCESS | 17700 | _x_x_mozilla_cycle_collect,864 11:12:45 INFO - PROCESS | 17700 | __end_cc_report 11:12:45 INFO - PROCESS | 17700 | __startTimestamp1463508765871__endTimestamp 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | ------- Summary: start ------- 11:12:45 INFO - PROCESS | 17700 | Number of tests: 14 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:4.14 (3.8%) stddev-sans-first:4.39 11:12:45 INFO - PROCESS | 17700 | Values: 108.0 112.0 102.0 110.0 110.0 110.0 100.0 110.0 111.0 112.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:156.00 stddev:19.87 (12.7%) stddev-sans-first:20.52 11:12:45 INFO - PROCESS | 17700 | Values: 163.0 127.0 155.0 170.0 130.0 156.0 156.0 131.0 184.0 129.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.66 (1.0%) stddev-sans-first:1.73 11:12:45 INFO - PROCESS | 17700 | Values: 163.0 160.0 163.0 165.0 162.0 161.0 161.0 164.0 162.0 160.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:38.44 (50.6%) stddev-sans-first:40.65 11:12:45 INFO - PROCESS | 17700 | Values: 87.0 76.0 73.0 172.0 77.0 75.0 79.0 76.0 164.0 76.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:92.00 stddev:26.73 (29.1%) stddev-sans-first:27.71 11:12:45 INFO - PROCESS | 17700 | Values: 93.0 92.0 149.0 94.0 93.0 92.0 142.0 92.0 92.0 152.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.71 (0.6%) stddev-sans-first:0.73 11:12:45 INFO - PROCESS | 17700 | Values: 118.0 118.0 118.0 118.0 116.0 117.0 118.0 117.0 118.0 117.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 11:12:45 INFO - PROCESS | 17700 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 148.0 146.0 146.0 147.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 11:12:45 INFO - PROCESS | 17700 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:58.00 stddev:6.85 (11.8%) stddev-sans-first:7.11 11:12:45 INFO - PROCESS | 17700 | Values: 55.0 56.0 55.0 56.0 60.0 59.0 56.0 78.0 58.0 58.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.50 stddev:0.71 (1.2%) stddev-sans-first:0.50 11:12:45 INFO - PROCESS | 17700 | Values: 60.0 58.0 58.0 58.0 58.0 58.0 58.0 59.0 59.0 59.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:74.50 stddev:2.99 (4.0%) stddev-sans-first:2.39 11:12:45 INFO - PROCESS | 17700 | Values: 81.0 73.0 72.0 74.0 75.0 74.0 80.0 74.0 77.0 74.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:116.50 stddev:6.17 (5.3%) stddev-sans-first:6.41 11:12:45 INFO - PROCESS | 17700 | Values: 115.0 114.0 117.0 116.0 115.0 114.0 114.0 121.0 130.0 129.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.50 stddev:4.95 (3.0%) stddev-sans-first:4.08 11:12:45 INFO - PROCESS | 17700 | Values: 173.0 166.0 170.0 162.0 162.0 159.0 159.0 163.0 168.0 159.0 11:12:45 INFO - PROCESS | 17700 | 11:12:45 INFO - PROCESS | 17700 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:2.27 (3.3%) stddev-sans-first:2.35 11:12:45 INFO - PROCESS | 17700 | Values: 69.0 69.0 70.0 66.0 72.0 66.0 65.0 66.0 66.0 67.0 11:12:45 INFO - PROCESS | 17700 | -------- Summary: end -------- 11:12:45 INFO - PROCESS | 17700 | 11:12:46 INFO - TEST-INFO | 17700: exit 0 11:12:46 INFO - TEST-OK | kraken | took 60560ms 11:12:46 INFO - SUITE-END | took 1169s 11:12:47 INFO - Completed test suite (00:19:29) 11:12:47 INFO - javascript benchmark 11:12:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3366.2425954160312, 3429.777064490808, 3439.7936123832555, 3482.895513134605, 3496.318217947501, 5512.779488820453, 5536.861578460535, 5550.833474995747, 5567.33192016958, 5586.832395028146, 5595.21666966625, 5602.691851948141, 5607.663540187581, 5609.719514024293, 5614.550835933126, 5054.898902021957, 5086.008228395464, 5089.592832573385, 5106.183010718286, 5107.69353838769, 5161.354830646169, 5210.0, 5216.556592689607, 5224.059669259532, 5256.027634887558, 5190.169572868342, 5206.609504287175, 5232.947670523303, 5312.92030619541, 5336.519713225809, 5163.948360516384, 5164.122099243138, 5166.61250406221, 5181.35233095863, 5191.299174611417, 5003.974980125076, 5073.315102461194, 5140.33175687162, 5146.253793200002, 5191.402988656278, 5546.611737178399, 5577.247071645357, 5615.719214039282, 5632.9436705632825, 5681.119426488901, 6045.365236650133, 6055.27336719592, 6081.270247570275, 6085.208922840046, 6090.817275481742, 6047.365026672224, 6140.6929653517145, 6141.846453838645, 6150.569460137792, 6150.66171360575, 5622.887542249173, 5714.857128571777, 5751.1373294006235, 5758.93459709955, 5769.451902069339, 6216.409441103178, 6227.657478838707, 6253.187085678833, 6288.842778930563, 6298.622082675054, 5925.881482370329, 6021.036634138517, 6035.547333949971, 6037.516998640098, 6057.151998720183, 5953.970230148908, 5964.075568286922, 5976.252968378953, 5977.103434484775, 6014.1580178775, 5921.526277897758, 5972.940270597239, 5980.312264089598, 5989.9101513477335, 6002.819915402545, 5825.359210486843, 5908.291005079418, 5949.25634295713, 5975.223220981245, 6001.789937352259, 4611.976940115278, 4617.376654151713, 4637.281221410687, 4641.164590373765, 4667.929981050287, 4175.979120104441, 4177.728447650954, 4196.664266858644, 4200.642945349679, 4223.72545784523, 5871.32479764824, 5904.822855314347, 5930.970345148246, 5942.049272116441, 5965.940340596539, 6045.274567051982, 6155.938440615626, 6192.566520343533, 6196.349383314777, 6207.844803879849, 5752.597318187771, 5864.091065884794, 5898.233229680114, 5900.498457631149, 5925.703714814328, 5219.947800522022, 5255.421903590602, 5258.947410525922, 5287.127623942083, 5291.576673866081, 6078.6048906820915, 6108.602940808833, 6178.814635560941, 6186.19579454668, 6188.566800324024, 5994.790182343597, 6002.7298771554515, 6011.759529618854, 6097.481714054177, 6120.265568131853, 6353.142325786144, 6359.0, 6388.776392826228, 6405.135306733531, 6419.101325814297, 5986.01230796931, 5990.610610310316, 5998.4601385875485, 6004.219451471456, 6050.818475445568, 5988.700564971647, 6012.518998480024, 6065.60573562717, 6159.84600384994, 6170.197874276315, 6006.519478441802, 6034.39656034393, 6057.18228039209, 6068.939310607014, 6082.330943596289, 5931.970340148272, 5997.430244126801, 6010.819675409744, 6012.188354572077, 6013.5189184865985, 5776.653400795965, 5852.209951656472, 5884.146798714248, 5911.349751527415, 5941.37615550361, 5918.201042859331, 5947.434993675594, 5956.5532585055425, 5974.731137098928, 5993.101034844808, 5793.188953546591, 5795.072788353843, 5800.187973683604, 5801.8549536261935, 5815.82552523425], "value": 5611.912233187608, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.5348256220643, 677.6374639567832, 677.7627830259408, 720.4452571519927, 738.9963050184747, 39158.804205978966, 39958.60041399585, 40035.399469007985, 40122.39816402752, 40126.7993660032, 42530.0, 43254.56745432545, 43293.0, 43400.78299608498, 43541.34687979675, 8816.074312197206, 9043.683471078513, 9046.638134474613, 9047.547622618875, 9077.591508382106, 8891.199792018717, 9014.819703605925, 9043.773905652379, 9054.592543335533, 9073.319501037415, 9051.637934482613, 9089.727308180765, 9100.044495327995, 9122.680706175284, 9156.45061296321, 8963.686270980517, 9040.728778136667, 9046.502442365667, 9065.22945549629, 9068.319876009326, 8946.463212207289, 9072.591733372014, 9095.49974751395, 9099.590518426687, 9115.134062264075, 43175.35236971448, 43342.56657433417, 43806.0, 43883.561164388266, 43967.0, 3748.8687895923513, 3942.7437216581116, 4197.622214000724, 4212.326027835532, 4514.9774251128865, 32861.0, 33158.502622460685, 33757.15607109817, 33938.151546211295, 33990.0, 4560.77196140195, 4636.35912944328, 4665.603423708989, 4671.416072990876, 4722.811087556528, 323851.0, 324726.0, 325526.9999999976, 326043.0, 326173.0, 39838.20323593512, 62068.37931620716, 62870.68564657239, 62893.37106628875, 63020.0, 37929.431058534145, 38237.42643860344, 38267.23465530729, 38367.808160959576, 38380.23239535194, 15369.308381122653, 15478.148701821508, 15533.145676987875, 15550.76673849893, 15579.298931548108, 14006.789898151535, 14085.43658253679, 14092.436302547989, 14101.153930764187, 14177.22025288619, 9407.247420206368, 9450.763730906783, 9467.431954082776, 9489.430634161834, 9580.56887440067, 3504.299140171976, 3613.33153366628, 3623.7282203834816, 3661.4324779659196, 3664.633536646314, 1036.1348274191134, 1109.9667009989714, 1168.462507246676, 1234.3457967277177, 1237.6101528018646, 32926.506102408486, 33433.0, 33542.49686254708, 33785.662143378744, 34053.31893362119, 1080.8162612355918, 1199.142613031669, 1210.7639010393066, 1239.1326071749631, 1289.149161553389, 17136.22886970089, 17318.220680069426, 17545.385911493035, 17597.7360339595, 17768.62807803007, 474977.0, 535299.0, 544294.0, 880013.0, 889643.0, 62658.373416266164, 62833.0, 63609.0, 63621.363786361544, 63677.0, 1544.3050627217797, 1551.1468692219235, 1551.6353656890622, 1564.1553561076892, 1615.5153453963765, 32971.0, 33537.832310839265, 33557.0, 33749.325013500085, 34200.65799341975, 54301.0, 54375.0, 54851.0, 54901.45098548963, 55144.44855551393, 441972.0, 447146.0, 447222.0, 449093.0, 450153.0, 31082.53376199404, 31453.213669658442, 31679.36641267208, 31820.68179318177, 32128.0, 49908.26597907588, 50396.748016259684, 50934.49065509297, 51245.48754512407, 51607.0, 41795.37306940459, 42209.15581688411, 42727.0, 42901.57098429101, 44844.55155448534, 40738.79630601828, 41353.1729365405, 41507.58492415158, 42450.938726532084, 42632.0, 42032.78983605062, 42539.787301064534, 42772.572274276856, 43020.35469468023, 43409.78295108631, 35417.0, 36381.63618363783, 36513.63486365102, 36697.0, 36960.63039369572, 27809.304767380978, 29008.564871526523, 29121.271968200963, 29164.416711665224, 29386.412271754874], "value": 19954.85866724362, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.5457287988292, 429.5983255655964, 439.1446140058254, 441.9955800441996, 444.2137416772311, 19125.521861953457, 19550.90224548877, 19676.11457484413, 20792.792072079275, 21278.57442851142, 18429.0, 18917.621647567074, 19468.51328716783, 19519.316823911166, 19637.11632976516, 5369.919451208245, 5500.367457742371, 5538.0585300498815, 5546.91679624806, 5548.55611551077, 5458.344998600173, 5461.808836690717, 5504.862378440531, 5942.524598032169, 6221.4400703936635, 6139.38606139387, 6165.136880836686, 6173.41352571505, 6212.565120441571, 6214.533909956749, 6091.847703807396, 6128.172696685957, 6508.28408875021, 6555.967220163869, 6714.362135597111, 5939.732712027969, 5984.222051133324, 5985.670788106652, 6025.78909738157, 6037.72830222641, 15214.619634509116, 16115.516534503984, 23772.0, 23805.642915356282, 23818.047278108854, 2359.421941624296, 2493.3268017635137, 2524.6086856537268, 2580.238829545289, 2946.410717856416, 10502.369857808479, 10860.782784344348, 11094.057005154571, 11120.55517779288, 11288.830667539993, 2079.2306846466904, 2107.9367618971455, 2176.3688530326185, 2263.807576356012, 2379.809615230795, 78185.0, 83923.5803820977, 85052.14947850566, 85603.57198214032, 88262.5586872068, 11361.488733007034, 11837.171398002229, 11849.289042657296, 11969.940150299368, 12084.637460876187, 16625.83374166267, 16712.74930876038, 16859.24133413999, 16875.831241687672, 16889.071101089314, 7809.68761249555, 8865.157810008168, 8872.8669069964, 8919.152680495343, 8951.462912225157, 8622.137786221454, 8658.95670521656, 8666.306695464475, 8704.695335663222, 8732.607032683545, 4961.603071754251, 5107.668001579886, 5116.667416617908, 5134.5635620972635, 5153.123968925292, 2062.896855157236, 2085.301424022939, 2116.682497625338, 2119.5760847830497, 2136.626090434199, 1018.3737001744022, 1019.3374306700556, 1091.9727006824894, 1121.5177473686392, 1127.4250132432355, 19098.71351929722, 19111.0, 19370.80629193718, 19599.510012249524, 19960.3013894513, 1038.055369613648, 1040.885502594714, 1060.4273692206277, 1096.9122470202524, 1123.6741345009855, 10728.249022568345, 11082.61210857616, 11125.777484450266, 11143.72140696489, 11164.776704465865, 465972.0, 466057.0, 473250.1687457772, 489554.0, 491614.0, 55277.44722552723, 56312.43687563154, 86581.0, 91459.54270228607, 92475.5376223128, 1078.5308390849848, 1097.7530055737395, 1105.7567335186245, 1114.0975809594254, 1118.3960661243, 17111.13324039016, 17288.827111728722, 17490.82509174892, 17645.647087058445, 17676.91161544184, 31339.843300783352, 38713.4192987111, 39808.80095599504, 40121.39817902676, 40348.79825600853, 49597.0, 49781.253281201534, 49918.500814991385, 49922.500774991786, 50240.497595025045, 8394.790130246549, 8451.746447606582, 8572.271356934481, 8767.517786521803, 8949.32880033987, 9563.139317461462, 12812.871871281168, 13287.069905106937, 13294.734105318033, 13625.591232263048, 11104.333739975627, 11308.151888608552, 11886.702832428913, 11963.521459141537, 12054.0, 11593.24643898144, 11607.89724976126, 11718.824217636571, 11979.580714674945, 12004.639860804189, 11610.129240306842, 11908.464119114487, 12042.879571204527, 12093.57672481459, 12291.262524248574, 8812.603432845666, 8829.823403532022, 9039.45763254207, 9066.0, 9074.047225041275, 9406.623735050522, 11610.6516804496, 11794.410279486163, 11814.527418903148, 12209.511619535118], "value": 9449.826312303781, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1563.2027665890396, 1573.276292905264, 1792.1397729090036, 1907.341967021378, 1918.1560113550029, 7852.332551733095, 8549.358798090137, 8562.571871406435, 8712.60793264303, 8715.564221788916, 8635.611397487113, 8679.522626255553, 8752.8687069694, 8761.342899282563, 8779.03430622631, 2429.6962879640046, 2443.5601591713485, 2447.2658202539255, 2459.6187590923437, 2463.273334366357, 2411.047636183715, 2447.620618804079, 2459.311392810016, 2477.3682710908693, 2482.726900041003, 2464.950700985979, 2473.307473907309, 2506.4611108611643, 2530.5698031334623, 2531.1141100614823, 2467.2968204061935, 2480.491499242651, 2512.510060538196, 2513.673222481075, 2513.8114641401876, 2438.573249681299, 2465.704115506133, 2476.6656501372263, 2483.242611003643, 2490.6264060390904, 8909.73270801877, 9005.234555062827, 9015.639374425014, 9018.503982280972, 9023.278137748965, 5225.581953443753, 5325.360956685223, 5346.492083252085, 5360.544353729938, 5374.7850085996515, 3535.3459609972238, 3562.3943929532043, 3588.1209103769484, 3602.0, 3615.3130905128205, 1232.6610182199968, 1255.7802384582662, 1264.1909178126007, 1280.1103233252893, 1305.8041293805911, 12490.75018499625, 12565.56020539286, 12579.119461637689, 12611.495540178383, 12631.115821892472, 4844.612431005511, 4851.054044461296, 4854.0, 4892.0, 4941.752912354368, 10585.100266477435, 10604.416757078434, 10609.575616975235, 10639.574417023387, 10654.893451065545, 5373.435789242151, 5379.865503362369, 5382.811601593926, 5384.19237114436, 5398.757055932492, 4340.60934515895, 4810.6151507879285, 4887.047025829929, 4914.140025495524, 4926.866820631275, 4125.608067233608, 4158.230727315396, 4184.707070505096, 4233.809478573472, 4236.555161707976, 1356.7829147336379, 1393.2197969137314, 1400.7058517711191, 1403.3825116948715, 1406.662401023747, 989.7575094101991, 1057.5241141486363, 1061.395004847245, 1068.2468859454066, 1072.8068947589352, 6076.848078798065, 6162.106494558354, 6221.09794079865, 6223.253209614784, 6247.110351033342, 493.01643221772076, 494.6018455143644, 497.98008079676407, 1115.5705053554277, 1130.4065365683082, 4237.258479766028, 4275.935860962088, 4285.250081235771, 4298.20483210607, 4315.28797748368, 10882.673519794418, 11175.72060698489, 11294.096472282197, 11318.207725459304, 11323.603673871376, 11039.116870650329, 11046.834297485544, 11097.72255693598, 11146.944265278622, 11175.21773475849, 8033.19668033192, 8347.749567512985, 8362.916370836214, 8388.790280243044, 8478.915210847812, 6138.07928810682, 6222.906656400067, 6233.376662333731, 6350.1109844622715, 6392.840178995562, 9452.810943781224, 9471.621135154517, 9489.66786162481, 9574.569144388659, 9697.369670971364, 9389.43663380172, 9813.803723925625, 10035.046670566284, 10039.34744241622, 10065.295429319878, 6821.1814582250445, 7577.0907491101425, 7618.733344333144, 7700.3454706350585, 7721.729739459092, 8272.33821294283, 8294.751157465285, 8351.290140337896, 8363.540005299767, 8398.0, 7458.5151965122095, 7648.541087534766, 7651.081870175614, 7674.040744906887, 7692.076950765944, 7485.7754267372065, 7542.358899493385, 7569.47013709035, 7591.734289299848, 7644.503107298008, 7251.56490610565, 7264.12830460327, 7282.344588987016, 7309.488335816442, 7325.4872158948365, 5197.870053248699, 5248.396434410091, 5290.523852853262, 5330.120530112488, 5429.782808687608, 5331.067063263991, 5365.356157261153, 5443.292371991616, 5559.054960656617, 5565.0], "value": 4758.975750674519, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.5209846952788, 367.5203858964052, 368.787946930515, 373.9719521035923, 375.0548617483942, 6454.515911306659, 6599.142111525501, 6615.206175258975, 6732.6297053661965, 6758.0, 6673.799786006415, 6677.33226677332, 6683.832904177398, 6697.8995315070315, 6698.6985585648645, 5052.343195384595, 5073.112205364065, 5077.314562534066, 5078.4413714491375, 5079.6190285728535, 5082.771275292602, 5085.186370180753, 5085.898282034357, 5091.0581542414775, 5106.923396149061, 5043.36957880265, 5043.470435604264, 5047.924281135786, 5053.722045287508, 5053.84838454847, 4765.118453086156, 4875.756212189376, 5035.395752509686, 5044.949550504503, 5051.520105589963, 4227.471566054243, 4228.703990720651, 4235.618794308496, 4238.173556156551, 4241.321388577843, 6306.085617585471, 6339.746410143589, 6351.110844481776, 6360.71376788041, 6361.80914572559, 5730.19777231188, 5761.164631128505, 5765.077587585966, 5768.509676677488, 5781.161731548902, 6975.755848545327, 6997.580145191305, 6999.965000175018, 7009.088818453569, 7013.964930175367, 4660.184467718136, 4754.286856971482, 4787.952120478785, 4794.113089078532, 4794.712317260975, 7320.0483937088375, 7370.410367170613, 7409.0, 7417.258274172594, 7422.294881986203, 4860.73265970368, 4897.240927656219, 4903.141950158708, 4908.214685650279, 4928.28539861718, 4974.228994505857, 4974.825881094144, 4975.228839529878, 4976.328195693607, 4977.452480227172, 5771.422857714279, 5783.681897495594, 5784.4504772046585, 5785.768569257182, 5795.768169273266, 6815.727370905208, 7064.540804847668, 7072.398846098036, 7130.144382674009, 7137.321954414322, 1701.676681430549, 1708.863290936722, 1710.7006273902018, 1713.5202143399868, 1719.1404297851075, 1135.1769966774023, 1137.4881303413497, 1145.833854091152, 1151.694800877768, 1195.384377045822, 6653.068570400148, 6692.59844409337, 6702.698378572878, 6709.993500974892, 6806.6256355900905, 7177.354038136593, 7217.097862767154, 7252.709891604382, 7252.927470725331, 7270.127584689871, 6739.157605299338, 6757.155355580552, 6763.086983257295, 6775.762848300385, 6781.11845460087, 3890.7471014383973, 3921.176552923861, 3945.782981936021, 3951.4467974483596, 3957.584453632385, 7452.105747310357, 7705.614719264015, 7725.381969442544, 7726.497777644548, 7745.728899488491, 7534.962325188339, 7543.0, 7570.0, 7598.620068996528, 7607.35337496319, 7625.580593067434, 7673.923260767432, 7682.001339825899, 7687.923120768833, 7714.997050383414, 7235.2764723529335, 7387.704491820482, 7388.556686598821, 7393.371563417169, 7420.777376678492, 7223.638818059181, 7256.854862902818, 7280.271972802678, 7293.197748247795, 7300.196978332273, 7612.467127301035, 7627.961860190663, 7651.426143039405, 7654.808629784077, 7655.961720191363, 4882.170031094652, 4921.26181072842, 4929.679570827885, 4930.964497455575, 4936.58039066669, 7159.105111861018, 7332.9266707332245, 7359.043324367798, 7367.4106071515225, 7379.631018449163, 7195.208527062124, 7199.388052015637, 7205.567665940061, 7284.271572842674, 7302.2697730226555, 7111.502194846518, 7135.429165666838, 7138.428925686037, 7142.607156606437, 7160.856782864418, 7006.054182685476, 7021.754238601625, 7022.33287837675, 7028.964855175692, 7029.683664235224, 7031.507794454544, 7212.927870721225, 7215.2063273038875, 7224.241454647186, 7259.564426134449, 6890.44876409876, 7016.193137789015, 7061.576305421691, 7065.82335441618, 7066.046083778624], "value": 5305.354270684968, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.1773503099449, 838.3125836813813, 856.503228127686, 860.126971124309, 863.3222920007795, 14744.852551474482, 14969.10185388876, 15217.239138043109, 15244.923775381136, 15279.0, 14690.559283221493, 14805.3337599808, 14849.628759281024, 14949.701005979874, 14959.999999999973, 870.4124715816814, 891.8260939116875, 895.4403497813867, 899.177252813678, 902.0122965352928, 897.9595918183664, 903.4624398482893, 903.7469508537587, 906.1663269791808, 909.1999040844081, 936.7330310861406, 939.0843927171022, 943.0710749911332, 946.2666433514013, 947.8436058050413, 938.8357037518475, 941.1341565759484, 941.3410612571228, 946.2146418472652, 948.4072454715803, 686.8454597715524, 692.7506097804786, 695.5478938689841, 696.8466937273791, 698.5948150072996, 15291.694166116728, 15369.615759606098, 15381.846181538152, 15385.153816540085, 15589.922050389789, 14913.254337283093, 14942.0, 15008.099514029193, 15036.774448383283, 15116.773248401283, 12043.458044387937, 12278.324692141929, 12324.383780810924, 12337.074719396081, 12378.81431778524, 4014.859479918218, 4057.1682805025193, 4096.8566100186645, 4100.7334523256195, 4158.209940111369, 60866.0, 60953.695231524005, 62146.37853621451, 62547.6872615634, 62786.0, 11445.942770286096, 11581.247218930743, 11704.473298701409, 11809.40952952349, 12063.095267854771, 21192.78807211939, 21225.78774212269, 21326.04032818527, 21396.572068558853, 21485.0, 7782.883256751154, 7840.803979900548, 7860.606969651494, 8405.537695426689, 8716.12838716136, 5007.048660754445, 5037.748112594429, 5060.873478163076, 5103.209002604603, 5192.065428222956, 3798.6961043116485, 3842.9423558646645, 3845.2309538092495, 3853.6917046636204, 3861.6331448512346, 632.7310892870512, 653.2226650286144, 656.143732429175, 668.9464842812563, 675.537256978971, 670.6747227594612, 759.3317880265441, 799.160881074869, 799.2167675677869, 802.5826570183472, 9087.273018158532, 9263.212626926786, 9495.857562136573, 9949.751256218653, 10094.343867648578, 770.6300975531664, 775.0892701076212, 783.565121357652, 805.4482679364654, 812.0580127052708, 4472.686911916199, 4476.440444944382, 4590.380298659705, 4637.976810115928, 4642.698224615389, 67840.0, 67861.32138678648, 67880.32119678838, 67884.32115678879, 68512.31487685059, 59059.40940590625, 61107.38892611017, 61286.0, 61499.38500615026, 61864.38135618586, 53079.203811942854, 53466.46533534615, 53970.19044714254, 54204.18693719598, 54643.0, 8866.335024873031, 9090.181883630505, 9165.770855728393, 9222.677206298016, 9225.400348977295, 40348.79825600853, 40606.187876242904, 40642.59357406388, 41548.0, 41967.58032419759, 49959.25061124013, 51946.220806687175, 52033.47966520438, 52193.0, 52307.0, 11488.138389620979, 11805.940970295094, 11828.290302581872, 11892.702682432662, 11900.188117727828, 13103.934480327538, 13148.342582870628, 13159.934200328937, 13270.800937985745, 13490.932545337211, 12307.26156430617, 12334.259944403364, 12377.257364558156, 12381.690457738629, 12390.442430090849, 11881.524739010343, 12212.633620991384, 12405.75188496207, 12444.937775311066, 12542.749145017231, 11854.288742675468, 12072.879271207175, 12144.635660930186, 12150.453229604866, 12170.14808963364, 10447.582096716047, 10491.0, 10533.525991330256, 10561.683149505527, 10703.518341674799, 10099.646512372032, 10682.521986869813, 10802.243842930919, 10910.563577457131, 10928.836067458835], "value": 7178.689367355415, "unit": "score"}], "name": "dromaeo_css", "value": 7594.199425651053, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 102.0, 110.0, 110.0, 110.0, 100.0, 110.0, 111.0, 112.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 127.0, 155.0, 170.0, 130.0, 156.0, 156.0, 131.0, 184.0, 129.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 163.0, 165.0, 162.0, 161.0, 161.0, 164.0, 162.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 76.0, 73.0, 172.0, 77.0, 75.0, 79.0, 76.0, 164.0, 76.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 149.0, 94.0, 93.0, 92.0, 142.0, 92.0, 92.0, 152.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 116.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 60.0, 59.0, 56.0, 78.0, 58.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0, 59.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 73.0, 72.0, 74.0, 75.0, 74.0, 80.0, 74.0, 77.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 117.0, 116.0, 115.0, 114.0, 114.0, 121.0, 130.0, 129.0], "value": 118.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 166.0, 170.0, 162.0, 162.0, 159.0, 159.0, 163.0, 168.0, 159.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 66.0, 72.0, 66.0, 65.0, 66.0, 66.0, 67.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1527.8, "alertThreshold": 2.0}]} 11:12:47 INFO - Return code: 0 11:12:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:12:47 ERROR - # TBPL SUCCESS # 11:12:47 INFO - Running post-action listener: _resource_record_post_action 11:12:47 INFO - Running post-run listener: _resource_record_post_run 11:12:48 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 266240; Write bytes: 500502528; Read time: 20; Write time: 387540 11:12:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248721408; Read time: 0; Write time: 251552 11:12:48 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251781120; Read time: 20; Write time: 135988 11:12:48 INFO - Running post-run listener: _upload_blobber_files 11:12:48 INFO - Blob upload gear active. 11:12:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:12:48 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:12:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:12:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:49 INFO - (blobuploader) - INFO - Done attempting. 11:12:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:12:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:12:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:50 INFO - (blobuploader) - INFO - Done attempting. 11:12:50 INFO - (blobuploader) - INFO - Iteration through files over. 11:12:50 INFO - Return code: 0 11:12:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:12:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:12:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4580777d1a6ee40dba28f17b84fb9b138d5c61fd3a41afb0b9e03ef77c2fa27ebfae8523276e00475b5a161c1778740d2ce022f801cd68389db31a98a151d196", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44533e9a3e8edf1db1a9af4b590e46520adf2bf2f7fbf3047650609e3318d4bb77e69cc321d9da4070ea92785ab892640e68ac212977d529471070fc57306d54"} 11:12:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:12:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:12:50 INFO - Contents: 11:12:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4580777d1a6ee40dba28f17b84fb9b138d5c61fd3a41afb0b9e03ef77c2fa27ebfae8523276e00475b5a161c1778740d2ce022f801cd68389db31a98a151d196", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44533e9a3e8edf1db1a9af4b590e46520adf2bf2f7fbf3047650609e3318d4bb77e69cc321d9da4070ea92785ab892640e68ac212977d529471070fc57306d54"} 11:12:50 INFO - Running post-run listener: copy_logs_to_upload_dir 11:12:50 INFO - Copying logs to upload dir... 11:12:50 INFO - mkdir: /builds/slave/test/build/upload/logs 11:12:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.059469 ========= master_lag: 0.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-17 11:12:51.032108) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:51.036894) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477 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/4580777d1a6ee40dba28f17b84fb9b138d5c61fd3a41afb0b9e03ef77c2fa27ebfae8523276e00475b5a161c1778740d2ce022f801cd68389db31a98a151d196", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44533e9a3e8edf1db1a9af4b590e46520adf2bf2f7fbf3047650609e3318d4bb77e69cc321d9da4070ea92785ab892640e68ac212977d529471070fc57306d54"} 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.011237 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/4580777d1a6ee40dba28f17b84fb9b138d5c61fd3a41afb0b9e03ef77c2fa27ebfae8523276e00475b5a161c1778740d2ce022f801cd68389db31a98a151d196", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44533e9a3e8edf1db1a9af4b590e46520adf2bf2f7fbf3047650609e3318d4bb77e69cc321d9da4070ea92785ab892640e68ac212977d529471070fc57306d54"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:51.061864) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:51.062232) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1463506136.916698-1750683477 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:51.354756) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:12:51.355240) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:12:51.355758) ========= ========= Total master_lag: 0.82 =========