builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1463308278.21 results: success (0) buildid: 20160515004019 builduid: 642a012a63264eaa81a12f0a5a7a60eb revision: f00f9e754ce71fc5efa3e4334afea5cf6ad6c215 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.210403) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.210879) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.211213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.237099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.237419) ========= 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=0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-15 03:31:19-- 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.4M=0s 2016-05-15 03:31:19 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136394 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.390861) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.391188) ========= 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=0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018735 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.449281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:18.452796) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f00f9e754ce71fc5efa3e4334afea5cf6ad6c215 --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 f00f9e754ce71fc5efa3e4334afea5cf6ad6c215 --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=0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-15 03:31:19,450 truncating revision to first 12 chars 2016-05-15 03:31:19,450 Setting DEBUG logging. 2016-05-15 03:31:19,450 attempt 1/10 2016-05-15 03:31:19,450 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f00f9e754ce7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-15 03:31:19,700 unpacking tar archive at: mozilla-aurora-f00f9e754ce7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.511141 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:19.004193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:19.004521) ========= script_repo_revision: f00f9e754ce71fc5efa3e4334afea5cf6ad6c215 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:19.004916) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:19.005186) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-15 03:31:19.053644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-15 03:31:19.053944) ========= /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=0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:20 INFO - MultiFileLogger online at 20160515 03:31:20 in /builds/slave/test 03:31:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:31:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:20 INFO - {'append_to_log': False, 03:31:20 INFO - 'base_work_dir': '/builds/slave/test', 03:31:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:31:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:20 INFO - 'branch': 'Mozilla-Aurora', 03:31:20 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:20 INFO - 'config_files': ('talos/linux_config.py',), 03:31:20 INFO - 'default_actions': ('clobber', 03:31:20 INFO - 'read-buildbot-config', 03:31:20 INFO - 'download-and-extract', 03:31:20 INFO - 'populate-webroot', 03:31:20 INFO - 'create-virtualenv', 03:31:20 INFO - 'install', 03:31:20 INFO - 'run-tests'), 03:31:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:20 INFO - 'download_minidump_stackwalk': True, 03:31:20 INFO - 'download_symbols': 'ondemand', 03:31:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:20 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:20 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:20 INFO - 'installer_path': 'installer.exe', 03:31:20 INFO - 'log_level': 'info', 03:31:20 INFO - 'log_name': 'talos', 03:31:20 INFO - 'log_to_console': True, 03:31:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:20 INFO - 'opt_config_files': (), 03:31:20 INFO - 'pip_index': False, 03:31:20 INFO - 'sps_profile': False, 03:31:20 INFO - 'sps_profile_interval': 0, 03:31:20 INFO - 'suite': 'dromaeojs-e10s', 03:31:20 INFO - 'system_bits': '32', 03:31:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:20 INFO - 'title': 'talos-linux64-ix-017', 03:31:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:20 INFO - 'use_talos_json': True, 03:31:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:20 INFO - 'work_dir': 'build'} 03:31:20 INFO - ##### 03:31:20 INFO - ##### Running clobber step. 03:31:20 INFO - ##### 03:31:20 INFO - Running pre-action listener: _resource_record_pre_action 03:31:20 INFO - Running main action method: clobber 03:31:20 INFO - rmtree: /builds/slave/test/build 03:31:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:21 INFO - Running post-action listener: _resource_record_post_action 03:31:21 INFO - ##### 03:31:21 INFO - ##### Running read-buildbot-config step. 03:31:21 INFO - ##### 03:31:21 INFO - Running pre-action listener: _resource_record_pre_action 03:31:21 INFO - Running main action method: read_buildbot_config 03:31:21 INFO - Using buildbot properties: 03:31:21 INFO - { 03:31:21 INFO - "project": "", 03:31:21 INFO - "product": "firefox", 03:31:21 INFO - "script_repo_revision": "production", 03:31:21 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:31:21 INFO - "repository": "", 03:31:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:31:21 INFO - "buildid": "20160515004019", 03:31:21 INFO - "stage_platform": "linux64-pgo", 03:31:21 INFO - "basedir": "/builds/slave/test", 03:31:21 INFO - "nightly_build": "True", 03:31:21 INFO - "buildnumber": 270, 03:31:21 INFO - "slavename": "talos-linux64-ix-017", 03:31:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:31:21 INFO - "platform": "ubuntu64_hw", 03:31:21 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:31:21 INFO - "branch": "mozilla-aurora", 03:31:21 INFO - "repo_path": "releases/mozilla-aurora", 03:31:21 INFO - "revision": "f00f9e754ce71fc5efa3e4334afea5cf6ad6c215", 03:31:21 INFO - "pgo_build": "True", 03:31:21 INFO - "builduid": "642a012a63264eaa81a12f0a5a7a60eb", 03:31:21 INFO - "slavebuilddir": "test" 03:31:21 INFO - } 03:31:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:31:21 INFO - Running post-action listener: _resource_record_post_action 03:31:21 INFO - ##### 03:31:21 INFO - ##### Running download-and-extract step. 03:31:21 INFO - ##### 03:31:21 INFO - Running pre-action listener: _resource_record_pre_action 03:31:21 INFO - Running main action method: download_and_extract 03:31:21 INFO - mkdir: /builds/slave/test/build/tests 03:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:21 INFO - https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:31:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:31:27 INFO - Downloaded 1361 bytes. 03:31:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:27 INFO - Using the following test package requirements: 03:31:27 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:27 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:27 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:31:27 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:27 INFO - u'jsshell-linux-x86_64.zip'], 03:31:27 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:27 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:27 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:31:27 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:31:27 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:27 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:27 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:27 INFO - https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:36 INFO - Downloaded 23813292 bytes. 03:31:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:31:37 INFO - Return code: 0 03:31:37 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:37 INFO - https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:39 INFO - Downloaded 23813292 bytes. 03:31:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:31:40 INFO - Return code: 0 03:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:40 INFO - https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:31:42 INFO - Downloaded 10840145 bytes. 03:31:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:31:42 INFO - Return code: 0 03:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:42 INFO - https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:31:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:31:43 INFO - Downloaded 62706158 bytes. 03:31:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:43 INFO - mkdir: /builds/slave/test/properties 03:31:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:43 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:43 INFO - Contents: 03:31:43 INFO - build_url:https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:31:44 INFO - Running post-action listener: _resource_record_post_action 03:31:44 INFO - Running post-action listener: set_extra_try_arguments 03:31:44 INFO - ##### 03:31:44 INFO - ##### Running populate-webroot step. 03:31:44 INFO - ##### 03:31:44 INFO - Running pre-action listener: _resource_record_pre_action 03:31:44 INFO - Running main action method: populate_webroot 03:31:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:44 INFO - '--tppagecycles', 03:31:44 INFO - '7'], 03:31:44 INFO - 'tests': ['tsvgm']}}, 03:31:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:44 INFO - 'talos_options': ['--disable-e10s'], 03:31:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:44 INFO - 'talos_options': ['--disable-e10s'], 03:31:44 INFO - 'tests': ['damp', 'tps']}, 03:31:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:44 INFO - 'tests': ['damp', 'tps']}, 03:31:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:44 INFO - 'tests': ['dromaeo_dom']}, 03:31:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:44 INFO - 'tests': ['a11yr', 03:31:44 INFO - 'ts_paint', 03:31:44 INFO - 'tpaint', 03:31:44 INFO - 'sessionrestore', 03:31:44 INFO - 'sessionrestore_no_auto_restore', 03:31:44 INFO - 'tabpaint']}, 03:31:44 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:44 INFO - 'ts_paint', 03:31:44 INFO - 'tpaint', 03:31:44 INFO - 'sessionrestore', 03:31:44 INFO - 'sessionrestore_no_auto_restore', 03:31:44 INFO - 'tabpaint']}, 03:31:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:44 INFO - 'ts_paint', 03:31:44 INFO - 'tpaint', 03:31:44 INFO - 'sessionrestore', 03:31:44 INFO - 'sessionrestore_no_auto_restore', 03:31:44 INFO - 'tabpaint']}, 03:31:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:44 INFO - 'ts_paint', 03:31:44 INFO - 'tpaint', 03:31:44 INFO - 'sessionrestore', 03:31:44 INFO - 'sessionrestore_no_auto_restore', 03:31:44 INFO - 'tabpaint']}, 03:31:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:44 INFO - 'tests': ['a11yr', 03:31:44 INFO - 'ts_paint', 03:31:44 INFO - 'tpaint', 03:31:44 INFO - 'sessionrestore', 03:31:44 INFO - 'sessionrestore_no_auto_restore', 03:31:44 INFO - 'tabpaint']}, 03:31:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:44 INFO - 'tests': ['a11yr', 03:31:44 INFO - 'ts_paint', 03:31:44 INFO - 'tpaint', 03:31:44 INFO - 'sessionrestore', 03:31:44 INFO - 'sessionrestore_no_auto_restore', 03:31:44 INFO - 'tabpaint']}, 03:31:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:44 INFO - 'tests': ['tsvgx', 03:31:44 INFO - 'tsvgr_opacity', 03:31:44 INFO - 'tart', 03:31:44 INFO - 'tscrollx', 03:31:44 INFO - 'cart']}, 03:31:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:44 INFO - 'tsvgr_opacity', 03:31:44 INFO - 'tart', 03:31:44 INFO - 'tscrollx', 03:31:44 INFO - 'cart']}, 03:31:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:44 INFO - 'talos_options': ['--disable-e10s'], 03:31:44 INFO - 'tests': ['tp5o']}, 03:31:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:44 INFO - 'tests': ['tp5o']}, 03:31:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:44 INFO - 'talos_options': ['--disable-e10s', 03:31:44 INFO - '--xperf_path', 03:31:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:44 INFO - 'tests': ['tp5n']}, 03:31:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:44 INFO - 'talos_options': ['--xperf_path', 03:31:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:44 INFO - 'tests': ['tp5n']}}, 03:31:44 INFO - 'talos.zip': {'path': '', 03:31:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:44 INFO - Running post-action listener: _resource_record_post_action 03:31:44 INFO - ##### 03:31:44 INFO - ##### Running create-virtualenv step. 03:31:44 INFO - ##### 03:31:44 INFO - Running pre-action listener: _resource_record_pre_action 03:31:44 INFO - Running main action method: create_virtualenv 03:31:44 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:31:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:44 INFO - Using real prefix '/usr' 03:31:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:45 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:46 INFO - Installing pip.................done. 03:31:47 INFO - Return code: 0 03:31:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8f72d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531410>, '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 0x2532310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25327a0>, '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': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:31:47 INFO - Using env: {'DISPLAY': ':0', 03:31:47 INFO - 'HOME': '/home/cltbld', 03:31:47 INFO - 'LANG': 'en_US.UTF-8', 03:31:47 INFO - 'LANGUAGE': 'en_US:en', 03:31:47 INFO - 'LOGNAME': 'cltbld', 03:31:47 INFO - 'MAIL': '/var/mail/cltbld', 03:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:47 INFO - 'MOZ_NO_REMOTE': '1', 03:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:47 INFO - 'NO_EM_RESTART': '1', 03:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:47 INFO - 'PWD': '/builds/slave/test', 03:31:47 INFO - 'SHELL': '/bin/bash', 03:31:47 INFO - 'SHLVL': '1', 03:31:47 INFO - 'TERM': 'linux', 03:31:47 INFO - 'TMOUT': '86400', 03:31:47 INFO - 'USER': 'cltbld', 03:31:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 03:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:47 INFO - '_': '/tools/buildbot/bin/python'} 03:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:31:47 INFO - Cleaning up... 03:31:47 INFO - Return code: 0 03:31:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc8f72d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531410>, '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 0x2532310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25327a0>, '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': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:31:47 INFO - Using env: {'DISPLAY': ':0', 03:31:47 INFO - 'HOME': '/home/cltbld', 03:31:47 INFO - 'LANG': 'en_US.UTF-8', 03:31:47 INFO - 'LANGUAGE': 'en_US:en', 03:31:47 INFO - 'LOGNAME': 'cltbld', 03:31:47 INFO - 'MAIL': '/var/mail/cltbld', 03:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:47 INFO - 'MOZ_NO_REMOTE': '1', 03:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:47 INFO - 'NO_EM_RESTART': '1', 03:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:47 INFO - 'PWD': '/builds/slave/test', 03:31:47 INFO - 'SHELL': '/bin/bash', 03:31:47 INFO - 'SHLVL': '1', 03:31:47 INFO - 'TERM': 'linux', 03:31:47 INFO - 'TMOUT': '86400', 03:31:47 INFO - 'USER': 'cltbld', 03:31:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 03:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:47 INFO - '_': '/tools/buildbot/bin/python'} 03:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:47 INFO - Downloading/unpacking psutil>=0.7.1 03:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:49 INFO - Installing collected packages: psutil 03:31:49 INFO - Running setup.py install for psutil 03:31:49 INFO - building 'psutil._psutil_linux' extension 03:31:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:31:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:31:49 INFO - building 'psutil._psutil_posix' extension 03:31:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:31:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:31:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:49 INFO - Successfully installed psutil 03:31:49 INFO - Cleaning up... 03:31:49 INFO - Return code: 0 03:31:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:49 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 0x7fc8f72d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531410>, '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 0x2532310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25327a0>, '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': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:31:49 INFO - Using env: {'DISPLAY': ':0', 03:31:49 INFO - 'HOME': '/home/cltbld', 03:31:49 INFO - 'LANG': 'en_US.UTF-8', 03:31:49 INFO - 'LANGUAGE': 'en_US:en', 03:31:49 INFO - 'LOGNAME': 'cltbld', 03:31:49 INFO - 'MAIL': '/var/mail/cltbld', 03:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:49 INFO - 'MOZ_NO_REMOTE': '1', 03:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:49 INFO - 'NO_EM_RESTART': '1', 03:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:49 INFO - 'PWD': '/builds/slave/test', 03:31:49 INFO - 'SHELL': '/bin/bash', 03:31:49 INFO - 'SHLVL': '1', 03:31:49 INFO - 'TERM': 'linux', 03:31:49 INFO - 'TMOUT': '86400', 03:31:49 INFO - 'USER': 'cltbld', 03:31:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 03:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:49 INFO - '_': '/tools/buildbot/bin/python'} 03:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:31:52 INFO - Installing collected packages: mozsystemmonitor 03:31:52 INFO - Running setup.py install for mozsystemmonitor 03:31:52 INFO - Successfully installed mozsystemmonitor 03:31:52 INFO - Cleaning up... 03:31:52 INFO - Return code: 0 03:31:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc8f72d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531410>, '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 0x2532310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25327a0>, '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': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:31:52 INFO - Using env: {'DISPLAY': ':0', 03:31:52 INFO - 'HOME': '/home/cltbld', 03:31:52 INFO - 'LANG': 'en_US.UTF-8', 03:31:52 INFO - 'LANGUAGE': 'en_US:en', 03:31:52 INFO - 'LOGNAME': 'cltbld', 03:31:52 INFO - 'MAIL': '/var/mail/cltbld', 03:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:52 INFO - 'MOZ_NO_REMOTE': '1', 03:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:52 INFO - 'NO_EM_RESTART': '1', 03:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:52 INFO - 'PWD': '/builds/slave/test', 03:31:52 INFO - 'SHELL': '/bin/bash', 03:31:52 INFO - 'SHLVL': '1', 03:31:52 INFO - 'TERM': 'linux', 03:31:52 INFO - 'TMOUT': '86400', 03:31:52 INFO - 'USER': 'cltbld', 03:31:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 03:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:52 INFO - '_': '/tools/buildbot/bin/python'} 03:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:52 INFO - Downloading/unpacking blobuploader==1.2.4 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:54 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:55 INFO - Downloading docopt-0.6.1.tar.gz 03:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:55 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:55 INFO - Running setup.py install for blobuploader 03:31:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:55 INFO - Running setup.py install for requests 03:31:55 INFO - Running setup.py install for docopt 03:31:55 INFO - Successfully installed blobuploader requests docopt 03:31:55 INFO - Cleaning up... 03:31:55 INFO - Return code: 0 03:31:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 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 0x7fc8f72d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531410>, '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 0x2532310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25327a0>, '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': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:31:55 INFO - Using env: {'DISPLAY': ':0', 03:31:55 INFO - 'HOME': '/home/cltbld', 03:31:55 INFO - 'LANG': 'en_US.UTF-8', 03:31:55 INFO - 'LANGUAGE': 'en_US:en', 03:31:55 INFO - 'LOGNAME': 'cltbld', 03:31:55 INFO - 'MAIL': '/var/mail/cltbld', 03:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:55 INFO - 'MOZ_NO_REMOTE': '1', 03:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:55 INFO - 'NO_EM_RESTART': '1', 03:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:55 INFO - 'PWD': '/builds/slave/test', 03:31:55 INFO - 'SHELL': '/bin/bash', 03:31:55 INFO - 'SHLVL': '1', 03:31:55 INFO - 'TERM': 'linux', 03:31:55 INFO - 'TMOUT': '86400', 03:31:55 INFO - 'USER': 'cltbld', 03:31:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 03:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:55 INFO - '_': '/tools/buildbot/bin/python'} 03:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:56 INFO - Running setup.py (path:/tmp/pip-j1tEYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:56 INFO - Running setup.py (path:/tmp/pip-EmiLjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:56 INFO - Running setup.py (path:/tmp/pip-bj4Z3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:56 INFO - Running setup.py (path:/tmp/pip-508mg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:56 INFO - Running setup.py (path:/tmp/pip-RKZdR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:56 INFO - Running setup.py (path:/tmp/pip-QeUmvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:56 INFO - Running setup.py (path:/tmp/pip-GW1qAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:56 INFO - Running setup.py (path:/tmp/pip-JiLqJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:56 INFO - Running setup.py (path:/tmp/pip-ImRlhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:56 INFO - Running setup.py (path:/tmp/pip-bjWRps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:56 INFO - Running setup.py (path:/tmp/pip-p9kDVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:56 INFO - Running setup.py (path:/tmp/pip-5mpT2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:56 INFO - Running setup.py (path:/tmp/pip-EYrOSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:56 INFO - Running setup.py (path:/tmp/pip-fUqPCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:57 INFO - Running setup.py (path:/tmp/pip-5kqMZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:57 INFO - Running setup.py (path:/tmp/pip-nKvVc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:57 INFO - Running setup.py (path:/tmp/pip-wfQnKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:57 INFO - Running setup.py install for manifestparser 03:31:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:57 INFO - Running setup.py install for mozcrash 03:31:57 INFO - Running setup.py install for mozdebug 03:31:57 INFO - Running setup.py install for mozdevice 03:31:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:57 INFO - Running setup.py install for mozfile 03:31:57 INFO - Running setup.py install for mozhttpd 03:31:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:57 INFO - Running setup.py install for mozinfo 03:31:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:57 INFO - Running setup.py install for mozInstall 03:31:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:58 INFO - Running setup.py install for mozleak 03:31:58 INFO - Running setup.py install for mozlog 03:31:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:58 INFO - Running setup.py install for moznetwork 03:31:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:58 INFO - Running setup.py install for mozprocess 03:31:58 INFO - Running setup.py install for mozprofile 03:31:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:58 INFO - Running setup.py install for mozrunner 03:31:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:58 INFO - Running setup.py install for mozscreenshot 03:31:58 INFO - Running setup.py install for moztest 03:31:58 INFO - Running setup.py install for mozversion 03:31:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:59 INFO - Cleaning up... 03:31:59 INFO - Return code: 0 03:31:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:59 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 0x7fc8f72d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531410>, '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 0x2532310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25327a0>, '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': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:31:59 INFO - Using env: {'DISPLAY': ':0', 03:31:59 INFO - 'HOME': '/home/cltbld', 03:31:59 INFO - 'LANG': 'en_US.UTF-8', 03:31:59 INFO - 'LANGUAGE': 'en_US:en', 03:31:59 INFO - 'LOGNAME': 'cltbld', 03:31:59 INFO - 'MAIL': '/var/mail/cltbld', 03:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:59 INFO - 'MOZ_NO_REMOTE': '1', 03:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:59 INFO - 'NO_EM_RESTART': '1', 03:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:59 INFO - 'PWD': '/builds/slave/test', 03:31:59 INFO - 'SHELL': '/bin/bash', 03:31:59 INFO - 'SHLVL': '1', 03:31:59 INFO - 'TERM': 'linux', 03:31:59 INFO - 'TMOUT': '86400', 03:31:59 INFO - 'USER': 'cltbld', 03:31:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 03:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:59 INFO - '_': '/tools/buildbot/bin/python'} 03:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:59 INFO - Running setup.py (path:/tmp/pip-rzL9Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:59 INFO - Running setup.py (path:/tmp/pip-k5enEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:59 INFO - Running setup.py (path:/tmp/pip-Qtspf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:59 INFO - Running setup.py (path:/tmp/pip-fTqftp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:59 INFO - Running setup.py (path:/tmp/pip-GYSD9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:59 INFO - Running setup.py (path:/tmp/pip-7bc1N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:59 INFO - Running setup.py (path:/tmp/pip-eDl2aU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:59 INFO - Running setup.py (path:/tmp/pip-dPwc5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:59 INFO - Running setup.py (path:/tmp/pip-CIsb6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:59 INFO - Running setup.py (path:/tmp/pip-btaSea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:59 INFO - Running setup.py (path:/tmp/pip-cvu47m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:00 INFO - Running setup.py (path:/tmp/pip-S5Z06H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:00 INFO - Running setup.py (path:/tmp/pip-uXFMcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:00 INFO - Running setup.py (path:/tmp/pip-jQwykL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:00 INFO - Running setup.py (path:/tmp/pip-cr1SKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:00 INFO - Running setup.py (path:/tmp/pip-bR4quj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:00 INFO - Running setup.py (path:/tmp/pip-kl4PCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32: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 03:32: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 03:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32: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 03:32: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 03:32: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 03:32:02 INFO - Downloading blessings-1.6.tar.gz 03:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:02 INFO - Installing collected packages: blessings 03:32:02 INFO - Running setup.py install for blessings 03:32:02 INFO - Successfully installed blessings 03:32:02 INFO - Cleaning up... 03:32:02 INFO - Return code: 0 03:32:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:02 INFO - Reading from file tmpfile_stdout 03:32:02 INFO - Current package versions: 03:32:02 INFO - argparse == 1.2.1 03:32:02 INFO - blessings == 1.6 03:32:02 INFO - blobuploader == 1.2.4 03:32:02 INFO - docopt == 0.6.1 03:32:02 INFO - manifestparser == 1.1 03:32:02 INFO - mozInstall == 1.12 03:32:02 INFO - mozcrash == 0.17 03:32:02 INFO - mozdebug == 0.1 03:32:02 INFO - mozdevice == 0.48 03:32:02 INFO - mozfile == 1.2 03:32:02 INFO - mozhttpd == 0.7 03:32:02 INFO - mozinfo == 0.9 03:32:02 INFO - mozleak == 0.1 03:32:02 INFO - mozlog == 3.1 03:32:02 INFO - moznetwork == 0.27 03:32:02 INFO - mozprocess == 0.22 03:32:02 INFO - mozprofile == 0.28 03:32:02 INFO - mozrunner == 6.11 03:32:02 INFO - mozscreenshot == 0.1 03:32:02 INFO - mozsystemmonitor == 0.0 03:32:02 INFO - moztest == 0.7 03:32:02 INFO - mozversion == 1.4 03:32:02 INFO - psutil == 3.1.1 03:32:02 INFO - requests == 1.2.3 03:32:02 INFO - wsgiref == 0.1.2 03:32:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:02 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 0x7fc8f72d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531410>, '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 0x2532310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25327a0>, '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': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:32:02 INFO - Using env: {'DISPLAY': ':0', 03:32:02 INFO - 'HOME': '/home/cltbld', 03:32:02 INFO - 'LANG': 'en_US.UTF-8', 03:32:02 INFO - 'LANGUAGE': 'en_US:en', 03:32:02 INFO - 'LOGNAME': 'cltbld', 03:32:02 INFO - 'MAIL': '/var/mail/cltbld', 03:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:02 INFO - 'MOZ_NO_REMOTE': '1', 03:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:02 INFO - 'NO_EM_RESTART': '1', 03:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:02 INFO - 'PWD': '/builds/slave/test', 03:32:02 INFO - 'SHELL': '/bin/bash', 03:32:02 INFO - 'SHLVL': '1', 03:32:02 INFO - 'TERM': 'linux', 03:32:02 INFO - 'TMOUT': '86400', 03:32:02 INFO - 'USER': 'cltbld', 03:32:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 03:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:02 INFO - '_': '/tools/buildbot/bin/python'} 03:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:32:03 INFO - Cleaning up... 03:32:03 INFO - Return code: 0 03:32:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8f72d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531410>, '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 0x2532310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25327a0>, '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': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:32:03 INFO - Using env: {'DISPLAY': ':0', 03:32:03 INFO - 'HOME': '/home/cltbld', 03:32:03 INFO - 'LANG': 'en_US.UTF-8', 03:32:03 INFO - 'LANGUAGE': 'en_US:en', 03:32:03 INFO - 'LOGNAME': 'cltbld', 03:32:03 INFO - 'MAIL': '/var/mail/cltbld', 03:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:03 INFO - 'MOZ_NO_REMOTE': '1', 03:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:03 INFO - 'NO_EM_RESTART': '1', 03:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:03 INFO - 'PWD': '/builds/slave/test', 03:32:03 INFO - 'SHELL': '/bin/bash', 03:32:03 INFO - 'SHLVL': '1', 03:32:03 INFO - 'TERM': 'linux', 03:32:03 INFO - 'TMOUT': '86400', 03:32:03 INFO - 'USER': 'cltbld', 03:32:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 03:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:03 INFO - '_': '/tools/buildbot/bin/python'} 03:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:03 INFO - Downloading/unpacking jsonschema 03:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:32:05 INFO - Downloading/unpacking functools32 (from jsonschema) 03:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:05 INFO - Downloading functools32-3.2.3-2.tar.gz 03:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:32:05 INFO - warning: no files found matching '*.txt' 03:32:05 INFO - no previously-included directories found matching 'build' 03:32:05 INFO - no previously-included directories found matching 'dist' 03:32:05 INFO - no previously-included directories found matching '.git*' 03:32:05 INFO - Installing collected packages: jsonschema, functools32 03:32:05 INFO - Running setup.py install for functools32 03:32:05 INFO - warning: no files found matching '*.txt' 03:32:05 INFO - no previously-included directories found matching 'build' 03:32:05 INFO - no previously-included directories found matching 'dist' 03:32:05 INFO - no previously-included directories found matching '.git*' 03:32:05 INFO - Successfully installed jsonschema functools32 03:32:05 INFO - Cleaning up... 03:32:05 INFO - Return code: 0 03:32:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:05 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 0x7fc8f72d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531410>, '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 0x2532310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25327a0>, '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': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:32:05 INFO - Using env: {'DISPLAY': ':0', 03:32:05 INFO - 'HOME': '/home/cltbld', 03:32:05 INFO - 'LANG': 'en_US.UTF-8', 03:32:05 INFO - 'LANGUAGE': 'en_US:en', 03:32:05 INFO - 'LOGNAME': 'cltbld', 03:32:05 INFO - 'MAIL': '/var/mail/cltbld', 03:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:05 INFO - 'MOZ_NO_REMOTE': '1', 03:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:05 INFO - 'NO_EM_RESTART': '1', 03:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:05 INFO - 'PWD': '/builds/slave/test', 03:32:05 INFO - 'SHELL': '/bin/bash', 03:32:05 INFO - 'SHLVL': '1', 03:32:05 INFO - 'TERM': 'linux', 03:32:05 INFO - 'TMOUT': '86400', 03:32:05 INFO - 'USER': 'cltbld', 03:32:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 03:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:05 INFO - '_': '/tools/buildbot/bin/python'} 03:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:05 INFO - Downloading/unpacking flake8 03:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:32:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:32:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:32:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:08 INFO - no previously-included directories found matching 'docs/_build' 03:32:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:32:08 INFO - Running setup.py install for pep8 03:32:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:08 INFO - no previously-included directories found matching 'docs/_build' 03:32:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:32:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:32:08 INFO - Cleaning up... 03:32:08 INFO - Return code: 0 03:32:08 INFO - Running post-action listener: _resource_record_post_action 03:32:08 INFO - Running post-action listener: _start_resource_monitoring 03:32:08 INFO - Starting resource monitoring. 03:32:08 INFO - ##### 03:32:08 INFO - ##### Running install step. 03:32:08 INFO - ##### 03:32:08 INFO - Running pre-action listener: _resource_record_pre_action 03:32:08 INFO - Running main action method: install 03:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:08 INFO - Reading from file tmpfile_stdout 03:32:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:08 INFO - Reading from file tmpfile_stdout 03:32:08 INFO - Output received: 03:32:08 INFO - Usage: mozinstall [options] installer 03:32:08 INFO - Options: 03:32:08 INFO - -h, --help show this help message and exit 03:32:08 INFO - -d DEST, --destination=DEST 03:32:08 INFO - Directory to install application into. [default: 03:32:08 INFO - "/builds/slave/test"] 03:32:08 INFO - --app=APP Application being installed. [default: firefox] 03:32:08 INFO - mkdir: /builds/slave/test/build/application 03:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:32:24 INFO - Reading from file tmpfile_stdout 03:32:24 INFO - Output received: 03:32:24 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:24 INFO - Running post-action listener: _resource_record_post_action 03:32:24 INFO - ##### 03:32:24 INFO - ##### Running run-tests step. 03:32:24 INFO - ##### 03:32:24 INFO - Running pre-action listener: _resource_record_pre_action 03:32:24 INFO - Running main action method: run_tests 03:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:24 INFO - Python 2.7.3 03:32:24 INFO - Return code: 0 03:32:24 INFO - grabbing minidump binary from tooltool 03:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:24 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 0x2531410>, '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 0x2532310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25327a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:32:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:32:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:24 INFO - Return code: 0 03:32:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:32:25 INFO - Return code: 0 03:32:25 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/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:32:25 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/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:32:25 INFO - Using env: {'DISPLAY': ':0', 03:32:25 INFO - 'HOME': '/home/cltbld', 03:32:25 INFO - 'LANG': 'en_US.UTF-8', 03:32:25 INFO - 'LANGUAGE': 'en_US:en', 03:32:25 INFO - 'LOGNAME': 'cltbld', 03:32:25 INFO - 'MAIL': '/var/mail/cltbld', 03:32:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:25 INFO - 'MOZ_NO_REMOTE': '1', 03:32:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:25 INFO - 'NO_EM_RESTART': '1', 03:32:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:25 INFO - 'PWD': '/builds/slave/test', 03:32:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:25 INFO - 'SHELL': '/bin/bash', 03:32:25 INFO - 'SHLVL': '1', 03:32:25 INFO - 'TERM': 'linux', 03:32:25 INFO - 'TMOUT': '86400', 03:32:25 INFO - 'USER': 'cltbld', 03:32:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721', 03:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:25 INFO - '_': '/tools/buildbot/bin/python'} 03:32:25 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/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:32:25 INFO - mozversion application_buildid: 20160515004019 03:32:25 INFO - mozversion application_changeset: f00f9e754ce71fc5efa3e4334afea5cf6ad6c215 03:32:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:32:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:25 INFO - mozversion application_name: Firefox 03:32:25 INFO - mozversion application_remotingname: firefox-dev 03:32:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:25 INFO - mozversion application_vendor: Mozilla 03:32:25 INFO - mozversion application_version: 48.0a2 03:32:25 INFO - mozversion platform_buildid: 20160515004019 03:32:25 INFO - mozversion platform_changeset: f00f9e754ce71fc5efa3e4334afea5cf6ad6c215 03:32:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:25 INFO - mozversion platform_version: 48.0a2 03:32:25 INFO - using testdate: 1463308345 03:32:25 INFO - actual date: 1463308345 03:32:25 INFO - starting webserver on 'localhost:51440' 03:32:25 INFO - SUITE-START | Running 2 tests 03:32:25 INFO - TEST-START | dromaeo_css 03:32:25 INFO - operating with platform_type : linux_ 03:32:25 INFO - Initialising browser for dromaeo_css test... 03:32:25 INFO - TEST-INFO | started process 21123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZips4r/profile http://localhost:51440/getInfo.html) 03:32:29 INFO - PROCESS | 21123 | 03:32:29 INFO - PROCESS | 21123 | (process:21200): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:32:29 INFO - PROCESS | 21123 | __metrics Screen width/height:1600/1200 03:32:29 INFO - PROCESS | 21123 | colorDepth:24 03:32:29 INFO - PROCESS | 21123 | Browser inner width/height: 1024/697 03:32:29 INFO - PROCESS | 21123 | __metrics 03:32:30 ERROR - PROCESS | 21123 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 03:32:31 INFO - TEST-INFO | 21123: exit 0 03:32:31 INFO - Browser initialized. 03:32:31 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:31 INFO - TEST-INFO | started process 21251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZips4r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:33 INFO - PROCESS | 21251 | 03:32:33 INFO - PROCESS | 21251 | (process:21319): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:32:43 INFO - PROCESS | 21251 | RSS: Main: 151986176 03:32:43 INFO - PROCESS | 21251 | 03:33:32 INFO - PROCESS | 21251 | 1463308412821 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:35:40 INFO - PROCESS | 21251 | Cycle 1(1): loaded http://localhost:51440/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51440/tests/dromaeo/cssquery-ext.html) 03:35:41 INFO - PROCESS | 21251 | RSS: Main: 155828224 03:35:41 INFO - PROCESS | 21251 | 03:38:43 INFO - PROCESS | 21251 | Cycle 1(1): loaded http://localhost:51440/tests/dromaeo/cssquery-ext.html (next: http://localhost:51440/tests/dromaeo/cssquery-jquery.html) 03:38:43 INFO - PROCESS | 21251 | RSS: Main: 153513984 03:38:43 INFO - PROCESS | 21251 | 03:41:45 INFO - PROCESS | 21251 | Cycle 1(1): loaded http://localhost:51440/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51440/tests/dromaeo/cssquery-mootools.html) 03:41:46 INFO - PROCESS | 21251 | RSS: Main: 153346048 03:41:46 INFO - PROCESS | 21251 | 03:44:47 INFO - PROCESS | 21251 | Cycle 1(1): loaded http://localhost:51440/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51440/tests/dromaeo/cssquery-prototype.html) 03:44:48 INFO - PROCESS | 21251 | RSS: Main: 153403392 03:44:48 INFO - PROCESS | 21251 | 03:47:50 INFO - PROCESS | 21251 | Cycle 1(1): loaded http://localhost:51440/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51440/tests/dromaeo/cssquery-yui.html) 03:47:51 INFO - PROCESS | 21251 | RSS: Main: 154468352 03:47:51 INFO - PROCESS | 21251 | 03:50:53 INFO - PROCESS | 21251 | Cycle 1(1): loaded http://localhost:51440/tests/dromaeo/cssquery-yui.html (next: http://localhost:51440/tests/dromaeo/cssquery-dojo.html) 03:50:53 INFO - PROCESS | 21251 | RSS: Main: 156356608 03:50:53 INFO - PROCESS | 21251 | 03:50:53 INFO - PROCESS | 21251 | __start_tp_report 03:50:53 INFO - PROCESS | 21251 | _x_x_mozilla_page_load 03:50:53 INFO - PROCESS | 21251 | _x_x_mozilla_page_load_details 03:50:53 INFO - PROCESS | 21251 | |i|pagename|runs| 03:50:53 INFO - PROCESS | 21251 | |0;dojo.html;3336.9666303336967;3427.6229614742374;3462.532558104658;3494.7903125812454;3495.440729483283;5537.446255374461;5577.609567330289;5616.971915140419;5623.578231632629;5648.152777083439;5602.971985140069;5645.435456454353;5657.830265092054;5666.433356664332;5669.121286200645;5114.156164232906;5163.044836705203;5171.922421163686;5185.066687996159;5211.4267430582795;5128.794848206067;5254.395744489375;5294;5300.469953004707;5324.387695415019;5163.302954101205;5235.581153507729;5265.9473405266035;5312.096943519611;5320.893582128355;5268.31511903452;5278.762455689503;5306.257124002643;5313.362396512443;5313.707746073965;5150.381954165487;5181.326427564431;5255.290535777659;5264.631475796696;5290.0477913975465;5384.892302153935;5506.80726174586;5564.10974244119;5590.524805391547;5594.524465420444;5981.431763982415;5996.760129594811;6024;6025.096235564656;6044.063170208625;6027.9095813562835;6069.817905462844;6141.232345956755;6153.169322141498;6171.907421388682;5615.410381909923;5646.322441307069;5662.37713851476;5663.2637757091725;5735.082386818089;6209.9068513972325;6234.781782637586;6234.781782637586;6235.625862448268;6240.812775616739;5983.19226904371;5983.401659834069;5984.760609575568;6034.939650603438;6096.756129754849;6097.756089756449;6108.205933228741;6120.387961203844;6121.387861213932;6126.509879209652;6075.605085669417;6102.542309326818;6111.083337499411;6111.388861113942;6126.479249263863;5902.173695682608;5952.166696662384;5994.520438364921;6008.038713805858;6008.429199226067;4596.218642830727;4603.562661547147;4604.447466303998;4611.631069514431;4628;4127.690423218271;4134.462519872397;4136.234796562585;4144.834206631701;4184.895377615523;5876.676782776988;5916.526677865761;5950.791722289786;5978.103284507359;5998.910016349758;5916.1421593868645;5969.731362088716;5995.160677505153;6008.158857759917;6085.330613632497;5753.395893431213;5903.114532820111;5918.8816223675285;5923.526117910556;5928.762849485972;5036.169032109734;5099.796008159632;5107.821226257063;5116.641835071509;5141.126008578551;6239.157713708682;6283.654399008007;6290.811275661737;6313.526485513605;6334.556581039283;6067.969660151671;6112.877742445037;6130.9883869161085;6132.049532322586;6143.662098584621;6281.497480201664;6407.551471396958;6412.519061070345;6414.326495717883;6417.2299324081405;6014.308354539284;6031.306399763907;6049.667268300285;6066.090086487062;6066.393360663898;6009.969950150221;6069.787557435468;6107.572469927062;6121.051237058263;6147.170132032118;5932.0508718604815;5932.377100404396;5939.792107276225;5941.851453713692;5962.165296858357;5863.970680146572;5912.438318359749;5914.704264786657;5914.822555323347;5926.614770039933;5737.168110624019;5801.245838041028;5900.70496475166;5950.583459157818;5983.700814959322;5978.222831031938;6009.639421634716;6049.727762250621;6055.1522786809;6056.333803281724;5897.528197744256;5899;5901.675407852609;5901.940980590139;5908.3205431375945 03:50:53 INFO - PROCESS | 21251 | |1;ext.html;659.811953593226;678.1421501800227;682.3483573187606;705.731821907675;739.0281779460008;39259.99999999996;39578.40632390513;39664;39894.20211595766;39929.40105898414;43379;43721.562784372145;44031;44069.33895991563;44162.55837441624;8829.514376709294;8920.553972301392;9004.279657627407;9007.504587247699;9009.189172974431;8759.51822649754;8858.202761751441;8882.600282987249;8910.50992195429;8919.197272245498;9152;9163.725088247364;9185.265178785714;9239.168474837263;9243.6302547898;9108.499032553207;9108.954455227715;9157.86263206049;9169.449833009974;9171.266298696088;8924.643014279422;9154.084591540859;9195.448273103568;9230.169284764337;9238.86141707875;43958;44092.3386149208;44220.778896105636;44303.113937721384;44404.333934991;4006.939895901564;4040.9595904040875;4058.9797051014557;4162.146759914211;4699.295105734133;33190.668093319;33840.153996150046;34172.14569635754;34508.82745586281;34550.654493455;4532.909341813178;4562.543745625444;4656.999442275542;4696.605423802617;4740.2889566564945;321008;323905;325262;325286;326695;39152.41271380932;60117.09824352638;60185.39814601885;60238.39761602328;60369.698151508965;36927.0768230791;37254.25491490155;37268.813655931546;37276.44085338722;37301.44047839285;15547.067175969478;15936.601584960237;15998.9200053999;16215.189240537926;16250.918745406198;14454.638634034023;14525.346359413852;14533.636659083397;14548;14575.781363279559;9223.354365194373;9268.351215414856;9392.95303523478;9428.481433521085;9498.382605130644;3613.602503724588;3693.8337774800198;3740.495033170542;3750.5686846012513;3787.3750831112557;1133.4446121400454;1187.3291590251654;1212.630147804928;1227.858796238426;1228.5331574001823;32030.679693203238;32216.516752248735;32595;32671.836640816644;33433.83283083569;1190.190670344157;1225.7671042502075;1265.6835791052238;1309.240640428549;1349.595121463557;17022;17126.743098853527;17140.742888856676;17200.39798607068;17209.483715488554;236736;534923;585340;893805;909628;60375.39624603785;61088.694556526934;61274.387256126865;61359.38640613626;61459.692701537104;1529.8852586056091;1531.9693606128037;1567.4827306988666;1568.6941046495824;1657.9585510362097;33232.66767332392;33414.832925836185;33764.493532597524;34187.829060854536;34253.65746342505;53482.860685572145;53621.19568206558;53928.19107713309;53963.730181348845;54158;333978;334735;335166;336434;337405;29850.701492984794;48854;49219.50780492293;49528;49717.50282497273;46451.76774116108;47368.763156183995;47392.28911566261;47502.52497474981;47552.762236188595;39528.40707389449;40605.796971014955;40658.79670601628;41358;41546;38637;39223.41164882586;39466;39611.00972475711;39773.204535909696;42405;42637.786811065744;43111.784441077594;48592.5140748588;48758;40132;42367.788161059;43222;45159.774201128785;45485.317720233565;34642.30715385628;35106;35140.29719405649;35387;35447.87282844935 03:50:53 INFO - PROCESS | 21251 | |2;jquery.html;430.95690430956887;434.0905802344089;435.7799311347771;442.32766195383016;446.2235709864834;18434.078296085194;18796.248150073996;19182;19344.226230950764;19344.322948696798;18689.34587289445;19176;19448;19969.20123195074;20000.49998750032;5263.236830659552;5447.1829225616275;5457;5474.91787623186;5496.148097044965;5380.192971054354;5450.809221677242;5456.972715136419;5668.971655141719;5932.495737862287;5862.06207006879;5865.32548756892;5866.823995280149;5877.500412464946;5918.763249470016;5680.375158732536;5759.798407055754;5783.739731712062;5802.767889284423;5849.444302791228;5602.1036634138745;5625.774969001235;5665.348484924204;5670.744816483227;5671.8582035449035;13413.993950453754;13992.720145597032;13996.72006559863;14027.929860350734;14038.298085095807;2327.837051406402;2418.3470462975074;2430.538197742423;2457.778799907999;2508.6613307203475;10488.528016239212;10712.517936692868;11133.610323638633;13597.184168949894;14854.405823767036;2020.1212472574477;2037.215671966289;2055.876647401146;2076.563921576471;2132.8507004509693;79739.6013019937;80880.19119808785;81880.18119818845;82462;83277.58361208216;12060.939695301468;12518.873301402917;12562.87437125617;12681.048921330937;12760.93619531915;16653.66692666164;16764.664706705797;16831.495055148363;16877.66244675124;16898.74651880223;8526.616302266413;8798;9011.188992990663;9195.95402022999;9202.35583509148;9111.908880911238;9113.316501262432;9116.544172791333;9128.726138215865;9132.863007054899;5000.149974504343;5005.823631446608;5053.216751403538;5070.062038522885;5160.122779127557;2062.4431403520966;2077.9376618701463;2097.3078883968255;2113.3026101386813;2170.544185721016;965.932384733076;1077.978440431187;1107.6400169944638;1122.893325134111;1207.7101495640984;17643;18831.529211769815;19569.510762231057;19879;20228.19087236494;1094.5457635081511;1121.52895783771;1193.373478923572;1201.1591885679884;1210.9273443593236;11066.612668556561;11293.54825806975;11320;11327.376994265394;11332.6033588824;533989;542941;550233;558847;559979;87844;88474.11525884659;91284.54357728301;98401;100762;1137.5961533655434;1151.6487471321327;1192.6064398748392;1194.2476239968764;1202.7113492761848;17042.233099510304;17097.401590944257;17279.827201728323;17361.47915562535;17399.13004349752;31259.84370078135;34415.48376774401;36859;38116.42825357677;38419.231615368095;44404.99461443363;55170.17244741412;56859;57037.42962570321;58035.419645803;8892.955535222283;8938.374313798231;8993.190612844875;9226.861597075915;9471.431714097176;12747.235165890077;13052.086353955512;13595.660108497366;13651.590452286448;13786.724265514433;11408.372539510407;11550.88449115498;11583.305001699924;11633.53465861356;11932.642020739391;11631.243969141979;12020.699482513008;12104.394780261127;12202.938985305016;12486.500539978299;11943.522259109539;12374.62876113718;12452.750944980868;12595.74808503843;12737.745245095231;9012.86480702803;9203.76990575241;9305.627258647479;9319.58061887203;9380.343375963617;9644.517774111408;12509.74980500403;12602.49590016389;12663.93668031654;12713.11008229415 03:50:53 INFO - PROCESS | 21251 | |3;mootools.html;1583.5328578069468;1593.7928069350987;1763.8853474524155;1881.7647794025747;1892.687706528422;7593.924060759391;8346.874796878037;8388.412811103226;8599.828003439936;8619.612117454722;8487.618057187427;8492.872606910885;8500.61747221375;8510.106438823927;8581.656733730642;2404.495056038234;2428.8299819012677;2436.7806897379232;2443.2914454808083;2450.6814114165136;2423.612222044473;2455.312512496504;2488.35302821266;2491.1530079772874;2491.177911289279;2449.4121410861444;2450.963235551468;2472.987635061822;2477.909719723316;2480.4914992426598;2397.964030539552;2413.7827595516314;2420.068273714615;2434.513097380522;2448.400141965221;2456.2876765737915;2472.6909136357954;2482.404222986488;2487.4030232744194;2488.950220995588;8706.56467176645;8757.956210218908;8770.649174033031;8780.560971951378;8822.86765698515;5360.571154307685;5478.726063696799;5506.366767821712;5506.972465137648;5520.91718624221;3578.8031658258788;3624.2207925295925;3672.5225720656413;3788.337041017811;3813.7521061131215;1195.7488927325185;1224.3021477757682;1227.1532642476752;1240.7456471423336;1261.2936755416904;12289.815652765215;12298.446569904376;12324.568640097554;12353.073519486075;12356.567520136841;4789.6349540381525;4797.6639542358325;4859.392575928009;4966.627502937222;4977.427595826526;10383;10404.843927341097;10470.738231544272;10484;10493.422861742525;5445.673259604358;5460.972695136578;5476.288082549323;5488.094464413327;5494.066008778517;4267.445232119867;4833.589144922721;4928.704277743347;4937.432195297587;4942.481039490874;4102.283195976408;4115.8971025724595;4204.62158405745;4204.831806727758;4227.936580951288;1349.1365526063328;1353.1339942436848;1361.9046666733432;1381.281733498575;1384.566973182751;1007.4559737741538;1121.4841173060483;1128.0468004536153;1130.8869113088626;1136.4885801389407;6265.279492858289;6317.6209427434505;6409.327020662857;6417.229932408048;6473.805785826433;470.6352576753044;472.2750577862964;486.63502373220086;495.64313694140884;496.9850904472872;4375.27807911691;4409.184300904343;4416.094700586372;4421.712588681726;4514.88712782183;10454.163666906628;10771.946140269249;10791.6222932197;10815.621453249256;10820.945895270474;10010.699679009496;10328.431936243429;10368.481575921174;10604.681859544226;10661.200409969284;8014.238647328494;8091.595420228965;8115.634796434175;8130.59347032646;8159.347252219808;6027.21646185993;6114.847128821815;6260.74957001733;6272.4982001440685;6296.929521981366;9606.903930960601;9626.32615716893;9711.125998660154;9741.659041933499;9785.461799601091;9279.67521136757;9430.10414010668;9476.620935162791;9481.573329200064;9694.75763105928;6918.723251070102;7381.261873812576;7650.8087297818;7656.540607563564;7844.294013538809;8327.458715183493;8327.54198519063;8333.83332333362;8335.458195217292;8379.58102094905;7405.703771849066;7524.172341042371;7528.284812942762;7652.273034061755;7705.383569314554;7397.667104980396;7463.477556570988;7516.135644400964;7526.285002924714;7536.057992750906;6844.589324640538;6910.378065973885;6954.547954382949;6961.547499412522;6975.720971161097;5295.523402893758;5325.440828713085;5436.021516127135;5454.263674404064;5478.671279723229;4921.532454416824;5280.6303558750515;5317.707526086102;5345;5383.730813459233 03:50:53 INFO - PROCESS | 21251 | |4;prototype.html;346.5200697034607;347.3123216032256;347.98086105264207;348.1262032298929;349.24214454633443;6704.966475167624;6734;6819.454443644515;6835.487338449611;6847.623380714059;6656.467482601381;6686.130802995616;6692.498062645297;6725.730970761164;6747;4843;4934.777934992934;5041.294218809369;5049.823256186034;5063.6202284828605;5036.320096786923;5038.2190760432195;5108.948910510903;5109.156989096795;5109.4379618241965;4991.226359914219;5010.048090862724;5067.898642027158;5068.493150684939;5082.4155222149375;5068.265101560271;5083.7712302946275;5098.745062746848;5098.847034588968;5105.923411148836;4439.356293337448;4441.600255976978;4445.466544014706;4457.509673935897;4462.062966776981;6280.654563998978;6428.871422571569;6454.225492940877;6496.415322620986;6520.673966301666;5835.35811060783;5858.945389829829;5868.178455016301;5871.3541510433815;5876.794312199096;7120.679569419389;7164.641767911584;7183.640817959081;7186.568805871612;7191.316824901626;4792.281157826319;4798;4799.2321228603605;4799.3041009053495;4801.087793319293;7193.928060719326;7386.113666360017;7452.292032256927;7468;7471.178170401252;4908.460069392364;4915.361003069578;4925.458199598042;4933.210686290176;4935.235038569028;4954.5540901319055;4966.627502937295;4988.6757360771435;4992.126377883856;4994.425641051253;5822.621529600562;5829.329627092939;5834.708264586754;5848.824535263949;5857.677827719516;7139.785806425815;7141.750038748619;7158.856822863513;7160.9641951790945;7161.9973203751515;1717.1414292853574;1724.8792584518962;1749;1749.8425141737305;1753.552844024791;1095.2661716649864;1097.286763603664;1099.0603034405628;1109.839073334362;1116.4864162485185;6892.620905850126;6978.441724662015;6986;6997.895031574531;6999.440044796404;7248.347648711641;7381.557106573623;7390.630468476555;7403.148637906602;7404.851902961911;6983.755568555076;6988.126484189476;7030.859382812315;7032.12098487689;7032.578045317297;3992.6007399259843;4000.3399439092223;4021.2158629067053;4034.0519977805193;4048.8785336439955;7728.111267204344;7747.496412733154;7752.844943101107;7755.7673269802;7765.72819951299;7360.66876990526;7555.584442855586;7561.357284630758;7573.318401343906;7586.165521792598;7671.501352412075;7757.573333466714;7766.339861111869;7818.726344577913;7836.843263134705;7443.739469118555;7445.4043676506835;7486.588237646982;7501.962490187514;7510.849783004419;7275.490715649854;7305.780826575211;7325.230850760593;7333.816654583678;7379.9262007381385;7632.236776322324;7763.650635721293;7802.570858602831;7803.297703206738;7809.726659566888;4946.233333833262;4962.478939711278;4990.076835785391;4996.850094497171;4999.175136102503;7356.448266379936;7393.963030184815;7424.888626670496;7456.51532650376;7481.476296659182;7185.317394847481;7220.927790722026;7245.963770181115;7246.7101315946775;7253.1296244451005;7016.859662806817;7194.064771579661;7202.567845929261;7226.241244669444;7232.855342893007;7057.435405167472;7065.364117229474;7068.399186069241;7079.752208672672;7094.184168820651;7227.096612923385;7260.854782904206;7271.745488907863;7279.944408060695;7294.96352518234;6877.65611719422;7036.050133231948;7049.894251586128;7070.469714771516;7070.823229419306 03:50:53 INFO - PROCESS | 21251 | |5;yui.html;869.3393021303807;876.5880036382898;941.4445477168472;942.3497786527296;946.3564775952352;15207;15241.390344386211;15375.384984600616;15406.69186616267;15431.305591248392;13974.790378144337;14038.508652197175;14050.367733451994;14052.156870587773;14053.71892562148;765.0933643632286;883.1301168349171;906.0395980260928;919.8114386550741;921.424109931293;910.3945875992457;910.5811326789685;913.0914739833875;914.8307563100815;919.4023884475112;961.9278554108434;964.8408012677935;969.3602222533129;970.873786407766;971.961121555137;953.6662168241129;957.4781743949565;958.089814676057;962.8170647576937;965.5896244096266;712.7291629180878;713.6574444266781;713.7894321175214;714.8212946763309;715.8353578676881;14811.407543698348;14813.407463701438;14851.405943762236;14854.925725371411;14888.181150036744;15462.458813941457;15524.922375388163;15562;15635.765463518057;15694.843051569453;12286.385680716017;12298.877011229863;12349;12384;12402.13185077045;4061.8829821798945;4091.2226676931587;4118.238125946709;4122.855700050513;4129.215449064668;56374.15438768422;56720.14919776165;57296.427035729525;58098.12852807211;59319.703401482715;11649.941750291195;11756.05951523876;11761.117916156152;11792.587259445878;12297.754044919231;21969.121235150735;21991.120355185612;22024.11903523873;22038.88980555087;22045.448863778212;8752.396548969464;8893.110688931185;8914.331425143011;8959.955200223958;8985.371024028254;5026.1204289249235;5132.717700526507;5169.922451163236;5178.456262092502;5195.558377537876;3765.604611515806;3835.137094153849;3844.8077596120083;3849.942250866239;3862.9227415451533;699.576756062585;709.6309918842173;709.8473828126978;717.2863001313726;717.5622870049266;798.7164556582329;807.8182408957938;810.9513429194267;820.6061090676509;851.4423052900361;9547.331686781998;9635.951820240994;10264.794704106025;10302.845457318146;10443.634472793416;796.5579103597559;801.4790386248985;806.1736719862071;813.2436833744674;815.4006804998321;4620.907581848344;4696.953030469652;4697.600703940135;4722.527747225318;4748.810047598126;62045;64184;64717.35282647207;65592;65604.67197663982;55442.16836747452;55711.442885571436;55928;56956.14565781516;59797.40202598005;49105.75447122742;49853;50046.499535004914;50074.499255007715;50250.497495025316;9183.403078799856;9285.885693716797;9290.442573445345;9297.395669281475;9350;38885.22229555449;39498.2100357997;39717.60282397255;39812.2037559253;40487.595124048385;47821;50221.49778502168;50892;51301.48698513117;51695.483045169065;12022.218555794196;12153.513859445524;12205.755884882075;12331.506739730668;12409.379531023593;12731.299778512272;12756;12812.231266124063;12836.679083022998;13166.605001849959;11699.824502632297;11929.28424294545;11943.820842687193;11952.34262115592;11956.58151964677;11749.236299640495;12177.269363838199;12222.572209972608;12241.326727029742;12273.263604183778;11704.648860534198;11711.765764684487;11872.525098995944;11905.40472976365;11923.105767067678;10244;10315.226358023328;10327.225458090523;10378.117859981987;10467.790644187226;10252.692419227435;10606.257561970588;10660.360378377321;10723.89276107229;10728.141748659933 03:50:53 INFO - PROCESS | 21251 | __end_tp_report 03:50:53 INFO - PROCESS | 21251 | __start_cc_report 03:50:53 INFO - PROCESS | 21251 | _x_x_mozilla_cycle_collect,343 03:50:53 INFO - PROCESS | 21251 | __end_cc_report 03:50:53 INFO - PROCESS | 21251 | __startTimestamp1463309453494__endTimestamp 03:50:53 INFO - PROCESS | 21251 | 03:50:53 INFO - PROCESS | 21251 | ------- Summary: start ------- 03:50:53 INFO - PROCESS | 21251 | Number of tests: 6 03:50:53 INFO - PROCESS | 21251 | 03:50:53 INFO - PROCESS | 21251 | [#0] dojo.html Cycles:165 Average:5664.66 Median:5916.53 stddev:628.84 (10.6%) stddev-sans-first:603.68 03:50:53 INFO - PROCESS | 21251 | Values: 3337.0 3427.6 3462.5 3494.8 3495.4 5537.4 5577.6 5617.0 5623.6 5648.2 5603.0 5645.4 5657.8 5666.4 5669.1 5114.2 5163.0 5171.9 5185.1 5211.4 5128.8 5254.4 5294.0 5300.5 5324.4 5163.3 5235.6 5265.9 5312.1 5320.9 5268.3 5278.8 5306.3 5313.4 5313.7 5150.4 5181.3 5255.3 5264.6 5290.0 5384.9 5506.8 5564.1 5590.5 5594.5 5981.4 5996.8 6024.0 6025.1 6044.1 6027.9 6069.8 6141.2 6153.2 6171.9 5615.4 5646.3 5662.4 5663.3 5735.1 6209.9 6234.8 6234.8 6235.6 6240.8 5983.2 5983.4 5984.8 6034.9 6096.8 6097.8 6108.2 6120.4 6121.4 6126.5 6075.6 6102.5 6111.1 6111.4 6126.5 5902.2 5952.2 5994.5 6008.0 6008.4 4596.2 4603.6 4604.4 4611.6 4628.0 4127.7 4134.5 4136.2 4144.8 4184.9 5876.7 5916.5 5950.8 5978.1 5998.9 5916.1 5969.7 5995.2 6008.2 6085.3 5753.4 5903.1 5918.9 5923.5 5928.8 5036.2 5099.8 5107.8 5116.6 5141.1 6239.2 6283.7 6290.8 6313.5 6334.6 6068.0 6112.9 6131.0 6132.0 6143.7 6281.5 6407.6 6412.5 6414.3 6417.2 6014.3 6031.3 6049.7 6066.1 6066.4 6010.0 6069.8 6107.6 6121.1 6147.2 5932.1 5932.4 5939.8 5941.9 5962.2 5864.0 5912.4 5914.7 5914.8 5926.6 5737.2 5801.2 5900.7 5950.6 5983.7 5978.2 6009.6 6049.7 6055.2 6056.3 5897.5 5899.0 5901.7 5901.9 5908.3 03:50:53 INFO - PROCESS | 21251 | 03:50:53 INFO - PROCESS | 21251 | [#1] ext.html Cycles:180 Average:59562.87 Median:41452.00 stddev:127987.65 (308.8%) stddev-sans-first:128270.28 03:50:53 INFO - PROCESS | 21251 | Values: 659.8 678.1 682.3 705.7 739.0 39260.0 39578.4 39664.0 39894.2 39929.4 43379.0 43721.6 44031.0 44069.3 44162.6 8829.5 8920.6 9004.3 9007.5 9009.2 8759.5 8858.2 8882.6 8910.5 8919.2 9152.0 9163.7 9185.3 9239.2 9243.6 9108.5 9109.0 9157.9 9169.4 9171.3 8924.6 9154.1 9195.4 9230.2 9238.9 43958.0 44092.3 44220.8 44303.1 44404.3 4006.9 4041.0 4059.0 4162.1 4699.3 33190.7 33840.2 34172.1 34508.8 34550.7 4532.9 4562.5 4657.0 4696.6 4740.3 321008.0 323905.0 325262.0 325286.0 326695.0 39152.4 60117.1 60185.4 60238.4 60369.7 36927.1 37254.3 37268.8 37276.4 37301.4 15547.1 15936.6 15998.9 16215.2 16250.9 14454.6 14525.3 14533.6 14548.0 14575.8 9223.4 9268.4 9393.0 9428.5 9498.4 3613.6 3693.8 3740.5 3750.6 3787.4 1133.4 1187.3 1212.6 1227.9 1228.5 32030.7 32216.5 32595.0 32671.8 33433.8 1190.2 1225.8 1265.7 1309.2 1349.6 17022.0 17126.7 17140.7 17200.4 17209.5 236736.0 534923.0 585340.0 893805.0 909628.0 60375.4 61088.7 61274.4 61359.4 61459.7 1529.9 1532.0 1567.5 1568.7 1658.0 33232.7 33414.8 33764.5 34187.8 34253.7 53482.9 53621.2 53928.2 53963.7 54158.0 333978.0 334735.0 335166.0 336434.0 337405.0 29850.7 48854.0 49219.5 49528.0 49717.5 46451.8 47368.8 47392.3 47502.5 47552.8 39528.4 40605.8 40658.8 41358.0 41546.0 38637.0 39223.4 39466.0 39611.0 39773.2 42405.0 42637.8 43111.8 48592.5 48758.0 40132.0 42367.8 43222.0 45159.8 45485.3 34642.3 35106.0 35140.3 35387.0 35447.9 03:50:53 INFO - PROCESS | 21251 | 03:50:53 INFO - PROCESS | 21251 | [#2] jquery.html Cycles:180 Average:30491.00 Median:2105.31 stddev:90240.98 (4286.4%) stddev-sans-first:90465.90 03:50:53 INFO - PROCESS | 21251 | Values: 431.0 434.1 435.8 442.3 446.2 18434.1 18796.2 19182.0 19344.2 19344.3 18689.3 19176.0 19448.0 19969.2 20000.5 5263.2 5447.2 5457.0 5474.9 5496.1 5380.2 5450.8 5457.0 5669.0 5932.5 5862.1 5865.3 5866.8 5877.5 5918.8 5680.4 5759.8 5783.7 5802.8 5849.4 5602.1 5625.8 5665.3 5670.7 5671.9 13414.0 13992.7 13996.7 14027.9 14038.3 2327.8 2418.3 2430.5 2457.8 2508.7 10488.5 10712.5 11133.6 13597.2 14854.4 2020.1 2037.2 2055.9 2076.6 2132.9 79739.6 80880.2 81880.2 82462.0 83277.6 12060.9 12518.9 12562.9 12681.0 12760.9 16653.7 16764.7 16831.5 16877.7 16898.7 8526.6 8798.0 9011.2 9196.0 9202.4 9111.9 9113.3 9116.5 9128.7 9132.9 5000.1 5005.8 5053.2 5070.1 5160.1 2062.4 2077.9 2097.3 2113.3 2170.5 965.9 1078.0 1107.6 1122.9 1207.7 17643.0 18831.5 19569.5 19879.0 20228.2 1094.5 1121.5 1193.4 1201.2 1210.9 11066.6 11293.5 11320.0 11327.4 11332.6 533989.0 542941.0 550233.0 558847.0 559979.0 87844.0 88474.1 91284.5 98401.0 100762.0 1137.6 1151.6 1192.6 1194.2 1202.7 17042.2 17097.4 17279.8 17361.5 17399.1 31259.8 34415.5 36859.0 38116.4 38419.2 44405.0 55170.2 56859.0 57037.4 58035.4 8893.0 8938.4 8993.2 9226.9 9471.4 12747.2 13052.1 13595.7 13651.6 13786.7 11408.4 11550.9 11583.3 11633.5 11932.6 11631.2 12020.7 12104.4 12202.9 12486.5 11943.5 12374.6 12452.8 12595.7 12737.7 9012.9 9203.8 9305.6 9319.6 9380.3 9644.5 12509.7 12602.5 12663.9 12713.1 03:50:53 INFO - PROCESS | 21251 | 03:50:53 INFO - PROCESS | 21251 | [#3] mootools.html Cycles:180 Average:5802.46 Median:4939.96 stddev:3164.03 (64.0%) stddev-sans-first:3157.02 03:50:53 INFO - PROCESS | 21251 | Values: 1583.5 1593.8 1763.9 1881.8 1892.7 7593.9 8346.9 8388.4 8599.8 8619.6 8487.6 8492.9 8500.6 8510.1 8581.7 2404.5 2428.8 2436.8 2443.3 2450.7 2423.6 2455.3 2488.4 2491.2 2491.2 2449.4 2451.0 2473.0 2477.9 2480.5 2398.0 2413.8 2420.1 2434.5 2448.4 2456.3 2472.7 2482.4 2487.4 2489.0 8706.6 8758.0 8770.6 8780.6 8822.9 5360.6 5478.7 5506.4 5507.0 5520.9 3578.8 3624.2 3672.5 3788.3 3813.8 1195.7 1224.3 1227.2 1240.7 1261.3 12289.8 12298.4 12324.6 12353.1 12356.6 4789.6 4797.7 4859.4 4966.6 4977.4 10383.0 10404.8 10470.7 10484.0 10493.4 5445.7 5461.0 5476.3 5488.1 5494.1 4267.4 4833.6 4928.7 4937.4 4942.5 4102.3 4115.9 4204.6 4204.8 4227.9 1349.1 1353.1 1361.9 1381.3 1384.6 1007.5 1121.5 1128.0 1130.9 1136.5 6265.3 6317.6 6409.3 6417.2 6473.8 470.6 472.3 486.6 495.6 497.0 4375.3 4409.2 4416.1 4421.7 4514.9 10454.2 10771.9 10791.6 10815.6 10820.9 10010.7 10328.4 10368.5 10604.7 10661.2 8014.2 8091.6 8115.6 8130.6 8159.3 6027.2 6114.8 6260.7 6272.5 6296.9 9606.9 9626.3 9711.1 9741.7 9785.5 9279.7 9430.1 9476.6 9481.6 9694.8 6918.7 7381.3 7650.8 7656.5 7844.3 8327.5 8327.5 8333.8 8335.5 8379.6 7405.7 7524.2 7528.3 7652.3 7705.4 7397.7 7463.5 7516.1 7526.3 7536.1 6844.6 6910.4 6954.5 6961.5 6975.7 5295.5 5325.4 5436.0 5454.3 5478.7 4921.5 5280.6 5317.7 5345.0 5383.7 03:50:53 INFO - PROCESS | 21251 | 03:50:53 INFO - PROCESS | 21251 | [#4] prototype.html Cycles:180 Average:5973.17 Median:6885.14 stddev:1852.57 (26.9%) stddev-sans-first:1808.99 03:50:53 INFO - PROCESS | 21251 | Values: 346.5 347.3 348.0 348.1 349.2 6705.0 6734.0 6819.5 6835.5 6847.6 6656.5 6686.1 6692.5 6725.7 6747.0 4843.0 4934.8 5041.3 5049.8 5063.6 5036.3 5038.2 5108.9 5109.2 5109.4 4991.2 5010.0 5067.9 5068.5 5082.4 5068.3 5083.8 5098.7 5098.8 5105.9 4439.4 4441.6 4445.5 4457.5 4462.1 6280.7 6428.9 6454.2 6496.4 6520.7 5835.4 5858.9 5868.2 5871.4 5876.8 7120.7 7164.6 7183.6 7186.6 7191.3 4792.3 4798.0 4799.2 4799.3 4801.1 7193.9 7386.1 7452.3 7468.0 7471.2 4908.5 4915.4 4925.5 4933.2 4935.2 4954.6 4966.6 4988.7 4992.1 4994.4 5822.6 5829.3 5834.7 5848.8 5857.7 7139.8 7141.8 7158.9 7161.0 7162.0 1717.1 1724.9 1749.0 1749.8 1753.6 1095.3 1097.3 1099.1 1109.8 1116.5 6892.6 6978.4 6986.0 6997.9 6999.4 7248.3 7381.6 7390.6 7403.1 7404.9 6983.8 6988.1 7030.9 7032.1 7032.6 3992.6 4000.3 4021.2 4034.1 4048.9 7728.1 7747.5 7752.8 7755.8 7765.7 7360.7 7555.6 7561.4 7573.3 7586.2 7671.5 7757.6 7766.3 7818.7 7836.8 7443.7 7445.4 7486.6 7502.0 7510.8 7275.5 7305.8 7325.2 7333.8 7379.9 7632.2 7763.7 7802.6 7803.3 7809.7 4946.2 4962.5 4990.1 4996.9 4999.2 7356.4 7394.0 7424.9 7456.5 7481.5 7185.3 7220.9 7246.0 7246.7 7253.1 7016.9 7194.1 7202.6 7226.2 7232.9 7057.4 7065.4 7068.4 7079.8 7094.2 7227.1 7260.9 7271.7 7279.9 7295.0 6877.7 7036.1 7049.9 7070.5 7070.8 03:50:53 INFO - PROCESS | 21251 | 03:50:53 INFO - PROCESS | 21251 | [#5] yui.html Cycles:180 Average:15562.33 Median:4710.06 stddev:17972.70 (381.6%) stddev-sans-first:17989.25 03:50:53 INFO - PROCESS | 21251 | Values: 869.3 876.6 941.4 942.3 946.4 15207.0 15241.4 15375.4 15406.7 15431.3 13974.8 14038.5 14050.4 14052.2 14053.7 765.1 883.1 906.0 919.8 921.4 910.4 910.6 913.1 914.8 919.4 961.9 964.8 969.4 970.9 972.0 953.7 957.5 958.1 962.8 965.6 712.7 713.7 713.8 714.8 715.8 14811.4 14813.4 14851.4 14854.9 14888.2 15462.5 15524.9 15562.0 15635.8 15694.8 12286.4 12298.9 12349.0 12384.0 12402.1 4061.9 4091.2 4118.2 4122.9 4129.2 56374.2 56720.1 57296.4 58098.1 59319.7 11649.9 11756.1 11761.1 11792.6 12297.8 21969.1 21991.1 22024.1 22038.9 22045.4 8752.4 8893.1 8914.3 8960.0 8985.4 5026.1 5132.7 5169.9 5178.5 5195.6 3765.6 3835.1 3844.8 3849.9 3862.9 699.6 709.6 709.8 717.3 717.6 798.7 807.8 811.0 820.6 851.4 9547.3 9636.0 10264.8 10302.8 10443.6 796.6 801.5 806.2 813.2 815.4 4620.9 4697.0 4697.6 4722.5 4748.8 62045.0 64184.0 64717.4 65592.0 65604.7 55442.2 55711.4 55928.0 56956.1 59797.4 49105.8 49853.0 50046.5 50074.5 50250.5 9183.4 9285.9 9290.4 9297.4 9350.0 38885.2 39498.2 39717.6 39812.2 40487.6 47821.0 50221.5 50892.0 51301.5 51695.5 12022.2 12153.5 12205.8 12331.5 12409.4 12731.3 12756.0 12812.2 12836.7 13166.6 11699.8 11929.3 11943.8 11952.3 11956.6 11749.2 12177.3 12222.6 12241.3 12273.3 11704.6 11711.8 11872.5 11905.4 11923.1 10244.0 10315.2 10327.2 10378.1 10467.8 10252.7 10606.3 10660.4 10723.9 10728.1 03:50:53 INFO - PROCESS | 21251 | -------- Summary: end -------- 03:50:53 INFO - PROCESS | 21251 | 03:50:54 INFO - TEST-INFO | 21251: exit 0 03:50:54 INFO - TEST-OK | dromaeo_css | took 1108396ms 03:50:54 INFO - TEST-START | kraken 03:50:54 INFO - operating with platform_type : linux_ 03:50:54 INFO - Initialising browser for kraken test... 03:50:54 INFO - TEST-INFO | started process 21499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnJZppZ/profile http://localhost:51440/getInfo.html) 03:50:57 INFO - PROCESS | 21499 | 03:50:57 INFO - PROCESS | 21499 | (process:21577): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:50:58 INFO - PROCESS | 21499 | __metrics Screen width/height:1600/1200 03:50:58 INFO - PROCESS | 21499 | colorDepth:24 03:50:58 INFO - PROCESS | 21499 | Browser inner width/height: 1024/697 03:50:58 INFO - PROCESS | 21499 | __metrics 03:50:58 ERROR - PROCESS | 21499 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 03:50:59 INFO - TEST-INFO | 21499: exit 0 03:50:59 INFO - Browser initialized. 03:50:59 INFO - Running cycle 1/1 for kraken test... 03:50:59 INFO - TEST-INFO | started process 21628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnJZppZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:01 INFO - PROCESS | 21628 | 03:51:01 INFO - PROCESS | 21628 | (process:21702): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:51:11 INFO - PROCESS | 21628 | RSS: Main: 152227840 03:51:11 INFO - PROCESS | 21628 | 03:51:13 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51440/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:14 INFO - PROCESS | 21628 | RSS: Main: 156917760 03:51:14 INFO - PROCESS | 21628 | 03:51:17 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51440/tests/kraken/driver.html?testName=audio-dft) 03:51:18 INFO - PROCESS | 21628 | RSS: Main: 156798976 03:51:18 INFO - PROCESS | 21628 | 03:51:20 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51440/tests/kraken/driver.html?testName=audio-fft) 03:51:21 INFO - PROCESS | 21628 | RSS: Main: 157036544 03:51:21 INFO - PROCESS | 21628 | 03:51:23 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51440/tests/kraken/driver.html?testName=audio-oscillator) 03:51:24 INFO - PROCESS | 21628 | RSS: Main: 157257728 03:51:24 INFO - PROCESS | 21628 | 03:51:26 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51440/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:27 INFO - PROCESS | 21628 | RSS: Main: 157151232 03:51:27 INFO - PROCESS | 21628 | 03:51:30 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51440/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:30 INFO - PROCESS | 21628 | RSS: Main: 157433856 03:51:30 INFO - PROCESS | 21628 | 03:51:34 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51440/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:34 INFO - PROCESS | 21628 | RSS: Main: 157474816 03:51:34 INFO - PROCESS | 21628 | 03:51:37 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51440/tests/kraken/driver.html?testName=json-parse-financial) 03:51:38 INFO - PROCESS | 21628 | RSS: Main: 157593600 03:51:38 INFO - PROCESS | 21628 | 03:51:39 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51440/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:40 INFO - PROCESS | 21628 | RSS: Main: 157319168 03:51:40 INFO - PROCESS | 21628 | 03:51:41 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51440/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:42 INFO - PROCESS | 21628 | RSS: Main: 157499392 03:51:42 INFO - PROCESS | 21628 | 03:51:44 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51440/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:45 INFO - PROCESS | 21628 | RSS: Main: 157732864 03:51:45 INFO - PROCESS | 21628 | 03:51:47 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:48 INFO - PROCESS | 21628 | RSS: Main: 158236672 03:51:48 INFO - PROCESS | 21628 | 03:51:51 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:51 INFO - PROCESS | 21628 | RSS: Main: 158130176 03:51:51 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | Cycle 1(1): loaded http://localhost:51440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51440/tests/kraken/driver.html?testName=ai-astar) 03:51:53 INFO - PROCESS | 21628 | RSS: Main: 159510528 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | __start_tp_report 03:51:53 INFO - PROCESS | 21628 | _x_x_mozilla_page_load 03:51:53 INFO - PROCESS | 21628 | _x_x_mozilla_page_load_details 03:51:53 INFO - PROCESS | 21628 | |i|pagename|runs| 03:51:53 INFO - PROCESS | 21628 | |0;ai-astar;108;111;102;110;110;112;101;111;111;111 03:51:53 INFO - PROCESS | 21628 | |1;audio-beat-detection;155;129;156;175;134;161;160;127;183;134 03:51:53 INFO - PROCESS | 21628 | |2;audio-dft;163;162;162;162;163;162;163;163;161;163 03:51:53 INFO - PROCESS | 21628 | |3;audio-fft;76;76;76;172;76;75;74;84;172;74 03:51:53 INFO - PROCESS | 21628 | |4;audio-oscillator;98;92;149;93;94;94;149;92;93;156 03:51:53 INFO - PROCESS | 21628 | |5;imaging-gaussian-blur;118;117;118;117;117;117;117;117;117;117 03:51:53 INFO - PROCESS | 21628 | |6;imaging-darkroom;146;147;146;145;146;146;147;148;147;147 03:51:53 INFO - PROCESS | 21628 | |7;imaging-desaturate;95;95;95;95;96;96;95;94;95;99 03:51:53 INFO - PROCESS | 21628 | |8;json-parse-financial;55;58;58;55;56;55;56;80;58;55 03:51:53 INFO - PROCESS | 21628 | |9;json-stringify-tinderbox;58;58;58;58;57;59;58;58;57;58 03:51:53 INFO - PROCESS | 21628 | |10;stanford-crypto-aes;81;82;73;72;73;77;76;74;74;75 03:51:53 INFO - PROCESS | 21628 | |11;stanford-crypto-ccm;117;114;120;120;121;125;124;116;138;143 03:51:53 INFO - PROCESS | 21628 | |12;stanford-crypto-pbkdf2;163;159;166;161;163;162;161;169;160;160 03:51:53 INFO - PROCESS | 21628 | |13;stanford-crypto-sha256-iterative;66;67;67;68;67;74;66;70;68;66 03:51:53 INFO - PROCESS | 21628 | __end_tp_report 03:51:53 INFO - PROCESS | 21628 | __start_cc_report 03:51:53 INFO - PROCESS | 21628 | _x_x_mozilla_cycle_collect,864 03:51:53 INFO - PROCESS | 21628 | __end_cc_report 03:51:53 INFO - PROCESS | 21628 | __startTimestamp1463309513686__endTimestamp 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | ------- Summary: start ------- 03:51:53 INFO - PROCESS | 21628 | Number of tests: 14 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#0] ai-astar Cycles:10 Average:108.70 Median:111.00 stddev:3.95 (3.6%) stddev-sans-first:4.18 03:51:53 INFO - PROCESS | 21628 | Values: 108.0 111.0 102.0 110.0 110.0 112.0 101.0 111.0 111.0 111.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:158.00 stddev:19.60 (12.4%) stddev-sans-first:20.75 03:51:53 INFO - PROCESS | 21628 | Values: 155.0 129.0 156.0 175.0 134.0 161.0 160.0 127.0 183.0 134.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 03:51:53 INFO - PROCESS | 21628 | Values: 163.0 162.0 162.0 162.0 163.0 162.0 163.0 163.0 161.0 163.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:40.42 (53.2%) stddev-sans-first:42.25 03:51:53 INFO - PROCESS | 21628 | Values: 76.0 76.0 76.0 172.0 76.0 75.0 74.0 84.0 172.0 74.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:93.00 stddev:27.95 (30.1%) stddev-sans-first:29.25 03:51:53 INFO - PROCESS | 21628 | Values: 98.0 92.0 149.0 93.0 94.0 94.0 149.0 92.0 93.0 156.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:51:53 INFO - PROCESS | 21628 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 03:51:53 INFO - PROCESS | 21628 | Values: 146.0 147.0 146.0 145.0 146.0 146.0 147.0 148.0 147.0 147.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 03:51:53 INFO - PROCESS | 21628 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 94.0 95.0 99.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.00 stddev:7.63 (13.4%) stddev-sans-first:7.98 03:51:53 INFO - PROCESS | 21628 | Values: 55.0 58.0 58.0 55.0 56.0 55.0 56.0 80.0 58.0 55.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 03:51:53 INFO - PROCESS | 21628 | Values: 58.0 58.0 58.0 58.0 57.0 59.0 58.0 58.0 57.0 58.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.50 stddev:3.40 (4.5%) stddev-sans-first:3.02 03:51:53 INFO - PROCESS | 21628 | Values: 81.0 82.0 73.0 72.0 73.0 77.0 76.0 74.0 74.0 75.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:122.50 stddev:9.50 (7.8%) stddev-sans-first:9.75 03:51:53 INFO - PROCESS | 21628 | Values: 117.0 114.0 120.0 120.0 121.0 125.0 124.0 116.0 138.0 143.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:162.50 stddev:3.06 (1.9%) stddev-sans-first:3.24 03:51:53 INFO - PROCESS | 21628 | Values: 163.0 159.0 166.0 161.0 163.0 162.0 161.0 169.0 160.0 160.0 03:51:53 INFO - PROCESS | 21628 | 03:51:53 INFO - PROCESS | 21628 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:2.47 (3.7%) stddev-sans-first:2.52 03:51:53 INFO - PROCESS | 21628 | Values: 66.0 67.0 67.0 68.0 67.0 74.0 66.0 70.0 68.0 66.0 03:51:53 INFO - PROCESS | 21628 | -------- Summary: end -------- 03:51:53 INFO - PROCESS | 21628 | 03:51:54 INFO - TEST-INFO | 21628: exit 0 03:51:54 INFO - TEST-OK | kraken | took 60405ms 03:51:54 INFO - SUITE-END | took 1168s 03:51:54 INFO - Completed test suite (00:19:29) 03:51:54 INFO - javascript benchmark 03:51:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3336.9666303336967, 3427.6229614742374, 3462.532558104658, 3494.7903125812454, 3495.440729483283, 5537.446255374461, 5577.609567330289, 5616.971915140419, 5623.578231632629, 5648.152777083439, 5602.971985140069, 5645.435456454353, 5657.830265092054, 5666.433356664332, 5669.121286200645, 5114.156164232906, 5163.044836705203, 5171.922421163686, 5185.066687996159, 5211.4267430582795, 5128.794848206067, 5254.395744489375, 5294.0, 5300.469953004707, 5324.387695415019, 5163.302954101205, 5235.581153507729, 5265.9473405266035, 5312.096943519611, 5320.893582128355, 5268.31511903452, 5278.762455689503, 5306.257124002643, 5313.362396512443, 5313.707746073965, 5150.381954165487, 5181.326427564431, 5255.290535777659, 5264.631475796696, 5290.0477913975465, 5384.892302153935, 5506.80726174586, 5564.10974244119, 5590.524805391547, 5594.524465420444, 5981.431763982415, 5996.760129594811, 6024.0, 6025.096235564656, 6044.063170208625, 6027.9095813562835, 6069.817905462844, 6141.232345956755, 6153.169322141498, 6171.907421388682, 5615.410381909923, 5646.322441307069, 5662.37713851476, 5663.2637757091725, 5735.082386818089, 6209.9068513972325, 6234.781782637586, 6234.781782637586, 6235.625862448268, 6240.812775616739, 5983.19226904371, 5983.401659834069, 5984.760609575568, 6034.939650603438, 6096.756129754849, 6097.756089756449, 6108.205933228741, 6120.387961203844, 6121.387861213932, 6126.509879209652, 6075.605085669417, 6102.542309326818, 6111.083337499411, 6111.388861113942, 6126.479249263863, 5902.173695682608, 5952.166696662384, 5994.520438364921, 6008.038713805858, 6008.429199226067, 4596.218642830727, 4603.562661547147, 4604.447466303998, 4611.631069514431, 4628.0, 4127.690423218271, 4134.462519872397, 4136.234796562585, 4144.834206631701, 4184.895377615523, 5876.676782776988, 5916.526677865761, 5950.791722289786, 5978.103284507359, 5998.910016349758, 5916.1421593868645, 5969.731362088716, 5995.160677505153, 6008.158857759917, 6085.330613632497, 5753.395893431213, 5903.114532820111, 5918.8816223675285, 5923.526117910556, 5928.762849485972, 5036.169032109734, 5099.796008159632, 5107.821226257063, 5116.641835071509, 5141.126008578551, 6239.157713708682, 6283.654399008007, 6290.811275661737, 6313.526485513605, 6334.556581039283, 6067.969660151671, 6112.877742445037, 6130.9883869161085, 6132.049532322586, 6143.662098584621, 6281.497480201664, 6407.551471396958, 6412.519061070345, 6414.326495717883, 6417.2299324081405, 6014.308354539284, 6031.306399763907, 6049.667268300285, 6066.090086487062, 6066.393360663898, 6009.969950150221, 6069.787557435468, 6107.572469927062, 6121.051237058263, 6147.170132032118, 5932.0508718604815, 5932.377100404396, 5939.792107276225, 5941.851453713692, 5962.165296858357, 5863.970680146572, 5912.438318359749, 5914.704264786657, 5914.822555323347, 5926.614770039933, 5737.168110624019, 5801.245838041028, 5900.70496475166, 5950.583459157818, 5983.700814959322, 5978.222831031938, 6009.639421634716, 6049.727762250621, 6055.1522786809, 6056.333803281724, 5897.528197744256, 5899.0, 5901.675407852609, 5901.940980590139, 5908.3205431375945], "value": 5623.807876154811, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.811953593226, 678.1421501800227, 682.3483573187606, 705.731821907675, 739.0281779460008, 39259.99999999996, 39578.40632390513, 39664.0, 39894.20211595766, 39929.40105898414, 43379.0, 43721.562784372145, 44031.0, 44069.33895991563, 44162.55837441624, 8829.514376709294, 8920.553972301392, 9004.279657627407, 9007.504587247699, 9009.189172974431, 8759.51822649754, 8858.202761751441, 8882.600282987249, 8910.50992195429, 8919.197272245498, 9152.0, 9163.725088247364, 9185.265178785714, 9239.168474837263, 9243.6302547898, 9108.499032553207, 9108.954455227715, 9157.86263206049, 9169.449833009974, 9171.266298696088, 8924.643014279422, 9154.084591540859, 9195.448273103568, 9230.169284764337, 9238.86141707875, 43958.0, 44092.3386149208, 44220.778896105636, 44303.113937721384, 44404.333934991, 4006.939895901564, 4040.9595904040875, 4058.9797051014557, 4162.146759914211, 4699.295105734133, 33190.668093319, 33840.153996150046, 34172.14569635754, 34508.82745586281, 34550.654493455, 4532.909341813178, 4562.543745625444, 4656.999442275542, 4696.605423802617, 4740.2889566564945, 321008.0, 323905.0, 325262.0, 325286.0, 326695.0, 39152.41271380932, 60117.09824352638, 60185.39814601885, 60238.39761602328, 60369.698151508965, 36927.0768230791, 37254.25491490155, 37268.813655931546, 37276.44085338722, 37301.44047839285, 15547.067175969478, 15936.601584960237, 15998.9200053999, 16215.189240537926, 16250.918745406198, 14454.638634034023, 14525.346359413852, 14533.636659083397, 14548.0, 14575.781363279559, 9223.354365194373, 9268.351215414856, 9392.95303523478, 9428.481433521085, 9498.382605130644, 3613.602503724588, 3693.8337774800198, 3740.495033170542, 3750.5686846012513, 3787.3750831112557, 1133.4446121400454, 1187.3291590251654, 1212.630147804928, 1227.858796238426, 1228.5331574001823, 32030.679693203238, 32216.516752248735, 32595.0, 32671.836640816644, 33433.83283083569, 1190.190670344157, 1225.7671042502075, 1265.6835791052238, 1309.240640428549, 1349.595121463557, 17022.0, 17126.743098853527, 17140.742888856676, 17200.39798607068, 17209.483715488554, 236736.0, 534923.0, 585340.0, 893805.0, 909628.0, 60375.39624603785, 61088.694556526934, 61274.387256126865, 61359.38640613626, 61459.692701537104, 1529.8852586056091, 1531.9693606128037, 1567.4827306988666, 1568.6941046495824, 1657.9585510362097, 33232.66767332392, 33414.832925836185, 33764.493532597524, 34187.829060854536, 34253.65746342505, 53482.860685572145, 53621.19568206558, 53928.19107713309, 53963.730181348845, 54158.0, 333978.0, 334735.0, 335166.0, 336434.0, 337405.0, 29850.701492984794, 48854.0, 49219.50780492293, 49528.0, 49717.50282497273, 46451.76774116108, 47368.763156183995, 47392.28911566261, 47502.52497474981, 47552.762236188595, 39528.40707389449, 40605.796971014955, 40658.79670601628, 41358.0, 41546.0, 38637.0, 39223.41164882586, 39466.0, 39611.00972475711, 39773.204535909696, 42405.0, 42637.786811065744, 43111.784441077594, 48592.5140748588, 48758.0, 40132.0, 42367.788161059, 43222.0, 45159.774201128785, 45485.317720233565, 34642.30715385628, 35106.0, 35140.29719405649, 35387.0, 35447.87282844935], "value": 20136.0241109812, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.95690430956887, 434.0905802344089, 435.7799311347771, 442.32766195383016, 446.2235709864834, 18434.078296085194, 18796.248150073996, 19182.0, 19344.226230950764, 19344.322948696798, 18689.34587289445, 19176.0, 19448.0, 19969.20123195074, 20000.49998750032, 5263.236830659552, 5447.1829225616275, 5457.0, 5474.91787623186, 5496.148097044965, 5380.192971054354, 5450.809221677242, 5456.972715136419, 5668.971655141719, 5932.495737862287, 5862.06207006879, 5865.32548756892, 5866.823995280149, 5877.500412464946, 5918.763249470016, 5680.375158732536, 5759.798407055754, 5783.739731712062, 5802.767889284423, 5849.444302791228, 5602.1036634138745, 5625.774969001235, 5665.348484924204, 5670.744816483227, 5671.8582035449035, 13413.993950453754, 13992.720145597032, 13996.72006559863, 14027.929860350734, 14038.298085095807, 2327.837051406402, 2418.3470462975074, 2430.538197742423, 2457.778799907999, 2508.6613307203475, 10488.528016239212, 10712.517936692868, 11133.610323638633, 13597.184168949894, 14854.405823767036, 2020.1212472574477, 2037.215671966289, 2055.876647401146, 2076.563921576471, 2132.8507004509693, 79739.6013019937, 80880.19119808785, 81880.18119818845, 82462.0, 83277.58361208216, 12060.939695301468, 12518.873301402917, 12562.87437125617, 12681.048921330937, 12760.93619531915, 16653.66692666164, 16764.664706705797, 16831.495055148363, 16877.66244675124, 16898.74651880223, 8526.616302266413, 8798.0, 9011.188992990663, 9195.95402022999, 9202.35583509148, 9111.908880911238, 9113.316501262432, 9116.544172791333, 9128.726138215865, 9132.863007054899, 5000.149974504343, 5005.823631446608, 5053.216751403538, 5070.062038522885, 5160.122779127557, 2062.4431403520966, 2077.9376618701463, 2097.3078883968255, 2113.3026101386813, 2170.544185721016, 965.932384733076, 1077.978440431187, 1107.6400169944638, 1122.893325134111, 1207.7101495640984, 17643.0, 18831.529211769815, 19569.510762231057, 19879.0, 20228.19087236494, 1094.5457635081511, 1121.52895783771, 1193.373478923572, 1201.1591885679884, 1210.9273443593236, 11066.612668556561, 11293.54825806975, 11320.0, 11327.376994265394, 11332.6033588824, 533989.0, 542941.0, 550233.0, 558847.0, 559979.0, 87844.0, 88474.11525884659, 91284.54357728301, 98401.0, 100762.0, 1137.5961533655434, 1151.6487471321327, 1192.6064398748392, 1194.2476239968764, 1202.7113492761848, 17042.233099510304, 17097.401590944257, 17279.827201728323, 17361.47915562535, 17399.13004349752, 31259.84370078135, 34415.48376774401, 36859.0, 38116.42825357677, 38419.231615368095, 44404.99461443363, 55170.17244741412, 56859.0, 57037.42962570321, 58035.419645803, 8892.955535222283, 8938.374313798231, 8993.190612844875, 9226.861597075915, 9471.431714097176, 12747.235165890077, 13052.086353955512, 13595.660108497366, 13651.590452286448, 13786.724265514433, 11408.372539510407, 11550.88449115498, 11583.305001699924, 11633.53465861356, 11932.642020739391, 11631.243969141979, 12020.699482513008, 12104.394780261127, 12202.938985305016, 12486.500539978299, 11943.522259109539, 12374.62876113718, 12452.750944980868, 12595.74808503843, 12737.745245095231, 9012.86480702803, 9203.76990575241, 9305.627258647479, 9319.58061887203, 9380.343375963617, 9644.517774111408, 12509.74980500403, 12602.49590016389, 12663.93668031654, 12713.11008229415], "value": 9499.69835824149, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1583.5328578069468, 1593.7928069350987, 1763.8853474524155, 1881.7647794025747, 1892.687706528422, 7593.924060759391, 8346.874796878037, 8388.412811103226, 8599.828003439936, 8619.612117454722, 8487.618057187427, 8492.872606910885, 8500.61747221375, 8510.106438823927, 8581.656733730642, 2404.495056038234, 2428.8299819012677, 2436.7806897379232, 2443.2914454808083, 2450.6814114165136, 2423.612222044473, 2455.312512496504, 2488.35302821266, 2491.1530079772874, 2491.177911289279, 2449.4121410861444, 2450.963235551468, 2472.987635061822, 2477.909719723316, 2480.4914992426598, 2397.964030539552, 2413.7827595516314, 2420.068273714615, 2434.513097380522, 2448.400141965221, 2456.2876765737915, 2472.6909136357954, 2482.404222986488, 2487.4030232744194, 2488.950220995588, 8706.56467176645, 8757.956210218908, 8770.649174033031, 8780.560971951378, 8822.86765698515, 5360.571154307685, 5478.726063696799, 5506.366767821712, 5506.972465137648, 5520.91718624221, 3578.8031658258788, 3624.2207925295925, 3672.5225720656413, 3788.337041017811, 3813.7521061131215, 1195.7488927325185, 1224.3021477757682, 1227.1532642476752, 1240.7456471423336, 1261.2936755416904, 12289.815652765215, 12298.446569904376, 12324.568640097554, 12353.073519486075, 12356.567520136841, 4789.6349540381525, 4797.6639542358325, 4859.392575928009, 4966.627502937222, 4977.427595826526, 10383.0, 10404.843927341097, 10470.738231544272, 10484.0, 10493.422861742525, 5445.673259604358, 5460.972695136578, 5476.288082549323, 5488.094464413327, 5494.066008778517, 4267.445232119867, 4833.589144922721, 4928.704277743347, 4937.432195297587, 4942.481039490874, 4102.283195976408, 4115.8971025724595, 4204.62158405745, 4204.831806727758, 4227.936580951288, 1349.1365526063328, 1353.1339942436848, 1361.9046666733432, 1381.281733498575, 1384.566973182751, 1007.4559737741538, 1121.4841173060483, 1128.0468004536153, 1130.8869113088626, 1136.4885801389407, 6265.279492858289, 6317.6209427434505, 6409.327020662857, 6417.229932408048, 6473.805785826433, 470.6352576753044, 472.2750577862964, 486.63502373220086, 495.64313694140884, 496.9850904472872, 4375.27807911691, 4409.184300904343, 4416.094700586372, 4421.712588681726, 4514.88712782183, 10454.163666906628, 10771.946140269249, 10791.6222932197, 10815.621453249256, 10820.945895270474, 10010.699679009496, 10328.431936243429, 10368.481575921174, 10604.681859544226, 10661.200409969284, 8014.238647328494, 8091.595420228965, 8115.634796434175, 8130.59347032646, 8159.347252219808, 6027.21646185993, 6114.847128821815, 6260.74957001733, 6272.4982001440685, 6296.929521981366, 9606.903930960601, 9626.32615716893, 9711.125998660154, 9741.659041933499, 9785.461799601091, 9279.67521136757, 9430.10414010668, 9476.620935162791, 9481.573329200064, 9694.75763105928, 6918.723251070102, 7381.261873812576, 7650.8087297818, 7656.540607563564, 7844.294013538809, 8327.458715183493, 8327.54198519063, 8333.83332333362, 8335.458195217292, 8379.58102094905, 7405.703771849066, 7524.172341042371, 7528.284812942762, 7652.273034061755, 7705.383569314554, 7397.667104980396, 7463.477556570988, 7516.135644400964, 7526.285002924714, 7536.057992750906, 6844.589324640538, 6910.378065973885, 6954.547954382949, 6961.547499412522, 6975.720971161097, 5295.523402893758, 5325.440828713085, 5436.021516127135, 5454.263674404064, 5478.671279723229, 4921.532454416824, 5280.6303558750515, 5317.707526086102, 5345.0, 5383.730813459233], "value": 4666.665211228049, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.5200697034607, 347.3123216032256, 347.98086105264207, 348.1262032298929, 349.24214454633443, 6704.966475167624, 6734.0, 6819.454443644515, 6835.487338449611, 6847.623380714059, 6656.467482601381, 6686.130802995616, 6692.498062645297, 6725.730970761164, 6747.0, 4843.0, 4934.777934992934, 5041.294218809369, 5049.823256186034, 5063.6202284828605, 5036.320096786923, 5038.2190760432195, 5108.948910510903, 5109.156989096795, 5109.4379618241965, 4991.226359914219, 5010.048090862724, 5067.898642027158, 5068.493150684939, 5082.4155222149375, 5068.265101560271, 5083.7712302946275, 5098.745062746848, 5098.847034588968, 5105.923411148836, 4439.356293337448, 4441.600255976978, 4445.466544014706, 4457.509673935897, 4462.062966776981, 6280.654563998978, 6428.871422571569, 6454.225492940877, 6496.415322620986, 6520.673966301666, 5835.35811060783, 5858.945389829829, 5868.178455016301, 5871.3541510433815, 5876.794312199096, 7120.679569419389, 7164.641767911584, 7183.640817959081, 7186.568805871612, 7191.316824901626, 4792.281157826319, 4798.0, 4799.2321228603605, 4799.3041009053495, 4801.087793319293, 7193.928060719326, 7386.113666360017, 7452.292032256927, 7468.0, 7471.178170401252, 4908.460069392364, 4915.361003069578, 4925.458199598042, 4933.210686290176, 4935.235038569028, 4954.5540901319055, 4966.627502937295, 4988.6757360771435, 4992.126377883856, 4994.425641051253, 5822.621529600562, 5829.329627092939, 5834.708264586754, 5848.824535263949, 5857.677827719516, 7139.785806425815, 7141.750038748619, 7158.856822863513, 7160.9641951790945, 7161.9973203751515, 1717.1414292853574, 1724.8792584518962, 1749.0, 1749.8425141737305, 1753.552844024791, 1095.2661716649864, 1097.286763603664, 1099.0603034405628, 1109.839073334362, 1116.4864162485185, 6892.620905850126, 6978.441724662015, 6986.0, 6997.895031574531, 6999.440044796404, 7248.347648711641, 7381.557106573623, 7390.630468476555, 7403.148637906602, 7404.851902961911, 6983.755568555076, 6988.126484189476, 7030.859382812315, 7032.12098487689, 7032.578045317297, 3992.6007399259843, 4000.3399439092223, 4021.2158629067053, 4034.0519977805193, 4048.8785336439955, 7728.111267204344, 7747.496412733154, 7752.844943101107, 7755.7673269802, 7765.72819951299, 7360.66876990526, 7555.584442855586, 7561.357284630758, 7573.318401343906, 7586.165521792598, 7671.501352412075, 7757.573333466714, 7766.339861111869, 7818.726344577913, 7836.843263134705, 7443.739469118555, 7445.4043676506835, 7486.588237646982, 7501.962490187514, 7510.849783004419, 7275.490715649854, 7305.780826575211, 7325.230850760593, 7333.816654583678, 7379.9262007381385, 7632.236776322324, 7763.650635721293, 7802.570858602831, 7803.297703206738, 7809.726659566888, 4946.233333833262, 4962.478939711278, 4990.076835785391, 4996.850094497171, 4999.175136102503, 7356.448266379936, 7393.963030184815, 7424.888626670496, 7456.51532650376, 7481.476296659182, 7185.317394847481, 7220.927790722026, 7245.963770181115, 7246.7101315946775, 7253.1296244451005, 7016.859662806817, 7194.064771579661, 7202.567845929261, 7226.241244669444, 7232.855342893007, 7057.435405167472, 7065.364117229474, 7068.399186069241, 7079.752208672672, 7094.184168820651, 7227.096612923385, 7260.854782904206, 7271.745488907863, 7279.944408060695, 7294.96352518234, 6877.65611719422, 7036.050133231948, 7049.894251586128, 7070.469714771516, 7070.823229419306], "value": 5350.801773115178, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.3393021303807, 876.5880036382898, 941.4445477168472, 942.3497786527296, 946.3564775952352, 15207.0, 15241.390344386211, 15375.384984600616, 15406.69186616267, 15431.305591248392, 13974.790378144337, 14038.508652197175, 14050.367733451994, 14052.156870587773, 14053.71892562148, 765.0933643632286, 883.1301168349171, 906.0395980260928, 919.8114386550741, 921.424109931293, 910.3945875992457, 910.5811326789685, 913.0914739833875, 914.8307563100815, 919.4023884475112, 961.9278554108434, 964.8408012677935, 969.3602222533129, 970.873786407766, 971.961121555137, 953.6662168241129, 957.4781743949565, 958.089814676057, 962.8170647576937, 965.5896244096266, 712.7291629180878, 713.6574444266781, 713.7894321175214, 714.8212946763309, 715.8353578676881, 14811.407543698348, 14813.407463701438, 14851.405943762236, 14854.925725371411, 14888.181150036744, 15462.458813941457, 15524.922375388163, 15562.0, 15635.765463518057, 15694.843051569453, 12286.385680716017, 12298.877011229863, 12349.0, 12384.0, 12402.13185077045, 4061.8829821798945, 4091.2226676931587, 4118.238125946709, 4122.855700050513, 4129.215449064668, 56374.15438768422, 56720.14919776165, 57296.427035729525, 58098.12852807211, 59319.703401482715, 11649.941750291195, 11756.05951523876, 11761.117916156152, 11792.587259445878, 12297.754044919231, 21969.121235150735, 21991.120355185612, 22024.11903523873, 22038.88980555087, 22045.448863778212, 8752.396548969464, 8893.110688931185, 8914.331425143011, 8959.955200223958, 8985.371024028254, 5026.1204289249235, 5132.717700526507, 5169.922451163236, 5178.456262092502, 5195.558377537876, 3765.604611515806, 3835.137094153849, 3844.8077596120083, 3849.942250866239, 3862.9227415451533, 699.576756062585, 709.6309918842173, 709.8473828126978, 717.2863001313726, 717.5622870049266, 798.7164556582329, 807.8182408957938, 810.9513429194267, 820.6061090676509, 851.4423052900361, 9547.331686781998, 9635.951820240994, 10264.794704106025, 10302.845457318146, 10443.634472793416, 796.5579103597559, 801.4790386248985, 806.1736719862071, 813.2436833744674, 815.4006804998321, 4620.907581848344, 4696.953030469652, 4697.600703940135, 4722.527747225318, 4748.810047598126, 62045.0, 64184.0, 64717.35282647207, 65592.0, 65604.67197663982, 55442.16836747452, 55711.442885571436, 55928.0, 56956.14565781516, 59797.40202598005, 49105.75447122742, 49853.0, 50046.499535004914, 50074.499255007715, 50250.497495025316, 9183.403078799856, 9285.885693716797, 9290.442573445345, 9297.395669281475, 9350.0, 38885.22229555449, 39498.2100357997, 39717.60282397255, 39812.2037559253, 40487.595124048385, 47821.0, 50221.49778502168, 50892.0, 51301.48698513117, 51695.483045169065, 12022.218555794196, 12153.513859445524, 12205.755884882075, 12331.506739730668, 12409.379531023593, 12731.299778512272, 12756.0, 12812.231266124063, 12836.679083022998, 13166.605001849959, 11699.824502632297, 11929.28424294545, 11943.820842687193, 11952.34262115592, 11956.58151964677, 11749.236299640495, 12177.269363838199, 12222.572209972608, 12241.326727029742, 12273.263604183778, 11704.648860534198, 11711.765764684487, 11872.525098995944, 11905.40472976365, 11923.105767067678, 10244.0, 10315.226358023328, 10327.225458090523, 10378.117859981987, 10467.790644187226, 10252.692419227435, 10606.257561970588, 10660.360378377321, 10723.89276107229, 10728.141748659933], "value": 7196.3506308873075, "unit": "score"}], "name": "dromaeo_css", "value": 7604.103844357621, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 102.0, 110.0, 110.0, 112.0, 101.0, 111.0, 111.0, 111.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 156.0, 175.0, 134.0, 161.0, 160.0, 127.0, 183.0, 134.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 163.0, 162.0, 163.0, 163.0, 161.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 172.0, 76.0, 75.0, 74.0, 84.0, 172.0, 74.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 92.0, 149.0, 93.0, 94.0, 94.0, 149.0, 92.0, 93.0, 156.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 147.0, 148.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 94.0, 95.0, 99.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 58.0, 55.0, 56.0, 55.0, 56.0, 80.0, 58.0, 55.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 57.0, 59.0, 58.0, 58.0, 57.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 73.0, 72.0, 73.0, 77.0, 76.0, 74.0, 74.0, 75.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 120.0, 120.0, 121.0, 125.0, 124.0, 116.0, 138.0, 143.0], "value": 123.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 166.0, 161.0, 163.0, 162.0, 161.0, 169.0, 160.0, 160.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 68.0, 67.0, 74.0, 66.0, 70.0, 68.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1534.5000000000002, "alertThreshold": 2.0}]} 03:51:54 INFO - Return code: 0 03:51:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:51:55 ERROR - # TBPL SUCCESS # 03:51:55 INFO - Running post-action listener: _resource_record_post_action 03:51:55 INFO - Running post-run listener: _resource_record_post_run 03:51:56 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 501870592; Read time: 16; Write time: 388096 03:51:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248446976; Read time: 0; Write time: 240488 03:51:56 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 253255680; Read time: 16; Write time: 147584 03:51:56 INFO - Running post-run listener: _upload_blobber_files 03:51:56 INFO - Blob upload gear active. 03:51:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:51:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:51:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:51:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:51:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:51:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:57 INFO - (blobuploader) - INFO - Done attempting. 03:51:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:51:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:51:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:58 INFO - (blobuploader) - INFO - Done attempting. 03:51:58 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:58 INFO - Return code: 0 03:51:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ede53079e38304199cd3d21cc7f70dc2510190479a90fd487c8ed946e30c5bc9d4476e950340482678b4c889d481bf6626d6c1c34a8828c187f261092dc371c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/568872d631e51d635bf1c20cac856e48dd6dea0e9896f4e99bda95b46874db8e4297ddedc6ced0fae04a4b34be9b6526bbfa6bbe2e52c7b19aad1cf1ad7996d9"} 03:51:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:58 INFO - Contents: 03:51:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ede53079e38304199cd3d21cc7f70dc2510190479a90fd487c8ed946e30c5bc9d4476e950340482678b4c889d481bf6626d6c1c34a8828c187f261092dc371c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/568872d631e51d635bf1c20cac856e48dd6dea0e9896f4e99bda95b46874db8e4297ddedc6ced0fae04a4b34be9b6526bbfa6bbe2e52c7b19aad1cf1ad7996d9"} 03:51:58 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:58 INFO - Copying logs to upload dir... 03:51:58 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.118486 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-15 03:51:57.208406) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-15 03:51:57.219161) ========= 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=0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721 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/ede53079e38304199cd3d21cc7f70dc2510190479a90fd487c8ed946e30c5bc9d4476e950340482678b4c889d481bf6626d6c1c34a8828c187f261092dc371c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/568872d631e51d635bf1c20cac856e48dd6dea0e9896f4e99bda95b46874db8e4297ddedc6ced0fae04a4b34be9b6526bbfa6bbe2e52c7b19aad1cf1ad7996d9"} build_url:https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/EdfSS2SvR8StqRJX9ViN3A/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/ede53079e38304199cd3d21cc7f70dc2510190479a90fd487c8ed946e30c5bc9d4476e950340482678b4c889d481bf6626d6c1c34a8828c187f261092dc371c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/568872d631e51d635bf1c20cac856e48dd6dea0e9896f4e99bda95b46874db8e4297ddedc6ced0fae04a4b34be9b6526bbfa6bbe2e52c7b19aad1cf1ad7996d9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-15 03:51:57.250008) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:51:57.250399) ========= 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=0333a256a5e4f052382dd180000001b1-1463289700.17637-1010474721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 03:51:57.333749) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-15 03:51:57.334401) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-15 03:51:57.335048) ========= ========= Total master_lag: 0.23 =========