builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1467873306.22 results: success (0) buildid: 20160706204229 builduid: 8d63b2827b9f4cf9b8f9f0da9fefc1a1 revision: e4b27dae353c933a01584dfeff27d547ef60f04e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.217335) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.217704) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.217988) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.244475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.244766) ========= 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=0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 23:35:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-07-06 23:35:06 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080252 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.371689) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.372008) ========= 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=0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019113 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.427933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.428331) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e4b27dae353c933a01584dfeff27d547ef60f04e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e4b27dae353c933a01584dfeff27d547ef60f04e --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=0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 23:35:06,647 truncating revision to first 12 chars 2016-07-06 23:35:06,647 Setting DEBUG logging. 2016-07-06 23:35:06,647 attempt 1/10 2016-07-06 23:35:06,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e4b27dae353c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 23:35:06,956 unpacking tar archive at: mozilla-beta-e4b27dae353c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607323 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:07.071673) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:07.071938) ========= script_repo_revision: e4b27dae353c933a01584dfeff27d547ef60f04e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:07.072308) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:07.072572) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:07.085795) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-06 23:35:07.086106) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:35:07 INFO - MultiFileLogger online at 20160706 23:35:07 in /builds/slave/test 23:35:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:35:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:35:07 INFO - {'append_to_log': False, 23:35:07 INFO - 'base_work_dir': '/builds/slave/test', 23:35:07 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:35:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:35:07 INFO - 'branch': 'Mozilla-Beta', 23:35:07 INFO - 'buildbot_json_path': 'buildprops.json', 23:35:07 INFO - 'config_files': ('talos/linux_config.py',), 23:35:07 INFO - 'default_actions': ('clobber', 23:35:07 INFO - 'read-buildbot-config', 23:35:07 INFO - 'download-and-extract', 23:35:07 INFO - 'populate-webroot', 23:35:07 INFO - 'create-virtualenv', 23:35:07 INFO - 'install', 23:35:07 INFO - 'run-tests'), 23:35:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:35:07 INFO - 'download_minidump_stackwalk': True, 23:35:07 INFO - 'download_symbols': 'ondemand', 23:35:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:35:07 INFO - 'tooltool.py': '/tools/tooltool.py', 23:35:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:35:07 INFO - '/tools/misc-python/virtualenv.py')}, 23:35:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:35:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:35:07 INFO - 'installer_path': 'installer.exe', 23:35:07 INFO - 'log_level': 'info', 23:35:07 INFO - 'log_name': 'talos', 23:35:07 INFO - 'log_to_console': True, 23:35:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:35:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:35:07 INFO - 'opt_config_files': (), 23:35:07 INFO - 'pip_index': False, 23:35:07 INFO - 'sps_profile': False, 23:35:07 INFO - 'sps_profile_interval': 0, 23:35:07 INFO - 'suite': 'dromaeojs-e10s', 23:35:07 INFO - 'system_bits': '32', 23:35:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:35:07 INFO - 'title': 'talos-linux64-ix-058', 23:35:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:35:07 INFO - 'use_talos_json': True, 23:35:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:35:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:35:07 INFO - 'work_dir': 'build'} 23:35:07 INFO - ##### 23:35:07 INFO - ##### Running clobber step. 23:35:07 INFO - ##### 23:35:07 INFO - Running pre-action listener: _resource_record_pre_action 23:35:07 INFO - Running main action method: clobber 23:35:07 INFO - rmtree: /builds/slave/test/build 23:35:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:35:08 INFO - Running post-action listener: _resource_record_post_action 23:35:08 INFO - ##### 23:35:08 INFO - ##### Running read-buildbot-config step. 23:35:08 INFO - ##### 23:35:08 INFO - Running pre-action listener: _resource_record_pre_action 23:35:08 INFO - Running main action method: read_buildbot_config 23:35:08 INFO - Using buildbot properties: 23:35:08 INFO - { 23:35:08 INFO - "project": "", 23:35:08 INFO - "product": "firefox", 23:35:08 INFO - "script_repo_revision": "production", 23:35:08 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 23:35:08 INFO - "repository": "", 23:35:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 23:35:08 INFO - "buildid": "20160706204229", 23:35:08 INFO - "pgo_build": "True", 23:35:08 INFO - "basedir": "/builds/slave/test", 23:35:08 INFO - "buildnumber": 171, 23:35:08 INFO - "slavename": "talos-linux64-ix-058", 23:35:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:35:08 INFO - "platform": "ubuntu64_hw", 23:35:08 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:35:08 INFO - "branch": "mozilla-beta", 23:35:08 INFO - "repo_path": "releases/mozilla-beta", 23:35:08 INFO - "revision": "e4b27dae353c933a01584dfeff27d547ef60f04e", 23:35:08 INFO - "stage_platform": "linux64-pgo", 23:35:08 INFO - "builduid": "8d63b2827b9f4cf9b8f9f0da9fefc1a1", 23:35:08 INFO - "slavebuilddir": "test" 23:35:08 INFO - } 23:35:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 23:35:08 INFO - Running post-action listener: _resource_record_post_action 23:35:08 INFO - ##### 23:35:08 INFO - ##### Running download-and-extract step. 23:35:08 INFO - ##### 23:35:08 INFO - Running pre-action listener: _resource_record_pre_action 23:35:08 INFO - Running main action method: download_and_extract 23:35:08 INFO - mkdir: /builds/slave/test/build/tests 23:35:08 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')]} 23:35:08 INFO - https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:35:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:35:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:35:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:35:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:35:12 INFO - Downloaded 1327 bytes. 23:35:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:35:12 INFO - Using the following test package requirements: 23:35:12 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:35:12 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:12 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:35:12 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:12 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 23:35:12 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:12 INFO - u'jsshell-linux-x86_64.zip'], 23:35:12 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:12 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:35:12 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:35:12 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:12 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 23:35:12 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:12 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 23:35:12 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:12 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:35:12 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:12 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:35:12 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:35:12 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')]} 23:35:12 INFO - https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:35:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:35:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:35:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:35:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:35:16 INFO - Downloaded 24237506 bytes. 23:35:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:35:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:35:17 INFO - Return code: 0 23:35:17 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:35:17 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')]} 23:35:17 INFO - https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:35:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:35:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:35:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:35:31 INFO - Downloaded 24237506 bytes. 23:35:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:35:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:35:32 INFO - Return code: 0 23:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:32 INFO - https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:35:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:35:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:35:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:35:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:35:34 INFO - Downloaded 10840145 bytes. 23:35:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:35:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:35:34 INFO - Return code: 0 23:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:34 INFO - https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:35:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:35:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:35:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:35:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:35:35 INFO - Downloaded 56026598 bytes. 23:35:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:35:35 INFO - mkdir: /builds/slave/test/properties 23:35:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:35:35 INFO - Writing to file /builds/slave/test/properties/build_url 23:35:35 INFO - Contents: 23:35:35 INFO - build_url:https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:35:36 INFO - Running post-action listener: _resource_record_post_action 23:35:36 INFO - Running post-action listener: set_extra_try_arguments 23:35:36 INFO - ##### 23:35:36 INFO - ##### Running populate-webroot step. 23:35:36 INFO - ##### 23:35:36 INFO - Running pre-action listener: _resource_record_pre_action 23:35:36 INFO - Running main action method: populate_webroot 23:35:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:35:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:35:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:35:36 INFO - '--tppagecycles', 23:35:36 INFO - '7'], 23:35:36 INFO - 'tests': ['tsvgm']}}, 23:35:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:35:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:35:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:35:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:35:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:35:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:35:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:36 INFO - 'talos_options': ['--disable-e10s'], 23:35:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:35:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:35:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:36 INFO - 'talos_options': ['--disable-e10s'], 23:35:36 INFO - 'tests': ['damp', 'tps']}, 23:35:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:36 INFO - 'tests': ['damp', 'tps']}, 23:35:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:35:36 INFO - 'tests': ['dromaeo_dom']}, 23:35:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:35:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:35:36 INFO - 'tests': ['a11yr', 23:35:36 INFO - 'ts_paint', 23:35:36 INFO - 'tpaint', 23:35:36 INFO - 'sessionrestore', 23:35:36 INFO - 'sessionrestore_no_auto_restore', 23:35:36 INFO - 'tabpaint']}, 23:35:36 INFO - 'other-e10s': {'tests': ['a11yr', 23:35:36 INFO - 'ts_paint', 23:35:36 INFO - 'tpaint', 23:35:36 INFO - 'sessionrestore', 23:35:36 INFO - 'sessionrestore_no_auto_restore', 23:35:36 INFO - 'tabpaint']}, 23:35:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:35:36 INFO - 'ts_paint', 23:35:36 INFO - 'tpaint', 23:35:36 INFO - 'sessionrestore', 23:35:36 INFO - 'sessionrestore_no_auto_restore', 23:35:36 INFO - 'tabpaint']}, 23:35:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:35:36 INFO - 'ts_paint', 23:35:36 INFO - 'tpaint', 23:35:36 INFO - 'sessionrestore', 23:35:36 INFO - 'sessionrestore_no_auto_restore', 23:35:36 INFO - 'tabpaint']}, 23:35:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:35:36 INFO - 'tests': ['a11yr', 23:35:36 INFO - 'ts_paint', 23:35:36 INFO - 'tpaint', 23:35:36 INFO - 'sessionrestore', 23:35:36 INFO - 'sessionrestore_no_auto_restore', 23:35:36 INFO - 'tabpaint']}, 23:35:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:35:36 INFO - 'tests': ['a11yr', 23:35:36 INFO - 'ts_paint', 23:35:36 INFO - 'tpaint', 23:35:36 INFO - 'sessionrestore', 23:35:36 INFO - 'sessionrestore_no_auto_restore', 23:35:36 INFO - 'tabpaint']}, 23:35:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:35:36 INFO - 'tests': ['tsvgx', 23:35:36 INFO - 'tsvgr_opacity', 23:35:36 INFO - 'tart', 23:35:36 INFO - 'tscrollx', 23:35:36 INFO - 'cart']}, 23:35:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:35:36 INFO - 'tsvgr_opacity', 23:35:36 INFO - 'tart', 23:35:36 INFO - 'tscrollx', 23:35:36 INFO - 'cart']}, 23:35:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:36 INFO - 'talos_options': ['--disable-e10s'], 23:35:36 INFO - 'tests': ['tp5o']}, 23:35:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:36 INFO - 'tests': ['tp5o']}, 23:35:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:36 INFO - 'talos_options': ['--disable-e10s', 23:35:36 INFO - '--xperf_path', 23:35:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:35:36 INFO - 'tests': ['tp5n']}, 23:35:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:36 INFO - 'talos_options': ['--xperf_path', 23:35:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:35:36 INFO - 'tests': ['tp5n']}}, 23:35:36 INFO - 'talos.zip': {'path': '', 23:35:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:35:36 INFO - Running post-action listener: _resource_record_post_action 23:35:36 INFO - ##### 23:35:36 INFO - ##### Running create-virtualenv step. 23:35:36 INFO - ##### 23:35:36 INFO - Running pre-action listener: _resource_record_pre_action 23:35:36 INFO - Running main action method: create_virtualenv 23:35:36 INFO - Creating virtualenv /builds/slave/test/build/venv 23:35:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:35:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:35:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:35:36 INFO - Using real prefix '/usr' 23:35:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:35:37 INFO - Installing distribute.............................................................................................................................................................................................done. 23:35:39 INFO - Installing pip.................done. 23:35:39 INFO - Return code: 0 23:35:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f542275ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb410>, '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 0x1ecc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', '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 23:35:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:35:39 INFO - Using env: {'DISPLAY': ':0', 23:35:39 INFO - 'HOME': '/home/cltbld', 23:35:39 INFO - 'LANG': 'en_US.UTF-8', 23:35:39 INFO - 'LANGUAGE': 'en_US:en', 23:35:39 INFO - 'LOGNAME': 'cltbld', 23:35:39 INFO - 'MAIL': '/var/mail/cltbld', 23:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:39 INFO - 'MOZ_NO_REMOTE': '1', 23:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:39 INFO - 'NO_EM_RESTART': '1', 23:35:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:39 INFO - 'PWD': '/builds/slave/test', 23:35:39 INFO - 'SHELL': '/bin/bash', 23:35:39 INFO - 'SHLVL': '1', 23:35:39 INFO - 'TERM': 'linux', 23:35:39 INFO - 'TMOUT': '86400', 23:35:39 INFO - 'USER': 'cltbld', 23:35:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', 23:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:39 INFO - '_': '/tools/buildbot/bin/python'} 23:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:35:39 INFO - Cleaning up... 23:35:39 INFO - Return code: 0 23:35:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f542275ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb410>, '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 0x1ecc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', '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 23:35:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:35:39 INFO - Using env: {'DISPLAY': ':0', 23:35:39 INFO - 'HOME': '/home/cltbld', 23:35:39 INFO - 'LANG': 'en_US.UTF-8', 23:35:39 INFO - 'LANGUAGE': 'en_US:en', 23:35:39 INFO - 'LOGNAME': 'cltbld', 23:35:39 INFO - 'MAIL': '/var/mail/cltbld', 23:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:39 INFO - 'MOZ_NO_REMOTE': '1', 23:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:39 INFO - 'NO_EM_RESTART': '1', 23:35:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:39 INFO - 'PWD': '/builds/slave/test', 23:35:39 INFO - 'SHELL': '/bin/bash', 23:35:39 INFO - 'SHLVL': '1', 23:35:39 INFO - 'TERM': 'linux', 23:35:39 INFO - 'TMOUT': '86400', 23:35:39 INFO - 'USER': 'cltbld', 23:35:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', 23:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:39 INFO - '_': '/tools/buildbot/bin/python'} 23:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:39 INFO - Downloading/unpacking psutil>=0.7.1 23:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:35:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:35:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:35:41 INFO - Installing collected packages: psutil 23:35:41 INFO - Running setup.py install for psutil 23:35:41 INFO - building 'psutil._psutil_linux' extension 23:35:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:35:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:35:41 INFO - building 'psutil._psutil_posix' extension 23:35:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:35:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:35:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:35:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:35:41 INFO - Successfully installed psutil 23:35:41 INFO - Cleaning up... 23:35:42 INFO - Return code: 0 23:35:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:35: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')]} 23:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35: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')]} 23:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f542275ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb410>, '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 0x1ecc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', '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 23:35:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:35:42 INFO - Using env: {'DISPLAY': ':0', 23:35:42 INFO - 'HOME': '/home/cltbld', 23:35:42 INFO - 'LANG': 'en_US.UTF-8', 23:35:42 INFO - 'LANGUAGE': 'en_US:en', 23:35:42 INFO - 'LOGNAME': 'cltbld', 23:35:42 INFO - 'MAIL': '/var/mail/cltbld', 23:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:42 INFO - 'MOZ_NO_REMOTE': '1', 23:35:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:42 INFO - 'NO_EM_RESTART': '1', 23:35:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:42 INFO - 'PWD': '/builds/slave/test', 23:35:42 INFO - 'SHELL': '/bin/bash', 23:35:42 INFO - 'SHLVL': '1', 23:35:42 INFO - 'TERM': 'linux', 23:35:42 INFO - 'TMOUT': '86400', 23:35:42 INFO - 'USER': 'cltbld', 23:35:42 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', 23:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:42 INFO - '_': '/tools/buildbot/bin/python'} 23:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:35:44 INFO - Installing collected packages: mozsystemmonitor 23:35:44 INFO - Running setup.py install for mozsystemmonitor 23:35:44 INFO - Successfully installed mozsystemmonitor 23:35:44 INFO - Cleaning up... 23:35:44 INFO - Return code: 0 23:35:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f542275ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb410>, '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 0x1ecc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', '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 23:35:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:35:44 INFO - Using env: {'DISPLAY': ':0', 23:35:44 INFO - 'HOME': '/home/cltbld', 23:35:44 INFO - 'LANG': 'en_US.UTF-8', 23:35:44 INFO - 'LANGUAGE': 'en_US:en', 23:35:44 INFO - 'LOGNAME': 'cltbld', 23:35:44 INFO - 'MAIL': '/var/mail/cltbld', 23:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:44 INFO - 'MOZ_NO_REMOTE': '1', 23:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:44 INFO - 'NO_EM_RESTART': '1', 23:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:44 INFO - 'PWD': '/builds/slave/test', 23:35:44 INFO - 'SHELL': '/bin/bash', 23:35:44 INFO - 'SHLVL': '1', 23:35:44 INFO - 'TERM': 'linux', 23:35:44 INFO - 'TMOUT': '86400', 23:35:44 INFO - 'USER': 'cltbld', 23:35:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', 23:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:44 INFO - '_': '/tools/buildbot/bin/python'} 23:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:44 INFO - Downloading/unpacking blobuploader==1.2.4 23:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:46 INFO - Downloading blobuploader-1.2.4.tar.gz 23:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:35:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:35:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:47 INFO - Downloading docopt-0.6.1.tar.gz 23:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:35:47 INFO - Installing collected packages: blobuploader, requests, docopt 23:35:47 INFO - Running setup.py install for blobuploader 23:35:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:35:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:35:47 INFO - Running setup.py install for requests 23:35:47 INFO - Running setup.py install for docopt 23:35:47 INFO - Successfully installed blobuploader requests docopt 23:35:47 INFO - Cleaning up... 23:35:47 INFO - Return code: 0 23:35:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:35: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')]} 23:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35: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')]} 23:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f542275ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb410>, '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 0x1ecc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', '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 23:35:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:35:47 INFO - Using env: {'DISPLAY': ':0', 23:35:47 INFO - 'HOME': '/home/cltbld', 23:35:47 INFO - 'LANG': 'en_US.UTF-8', 23:35:47 INFO - 'LANGUAGE': 'en_US:en', 23:35:47 INFO - 'LOGNAME': 'cltbld', 23:35:47 INFO - 'MAIL': '/var/mail/cltbld', 23:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:47 INFO - 'MOZ_NO_REMOTE': '1', 23:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:47 INFO - 'NO_EM_RESTART': '1', 23:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:47 INFO - 'PWD': '/builds/slave/test', 23:35:47 INFO - 'SHELL': '/bin/bash', 23:35:47 INFO - 'SHLVL': '1', 23:35:47 INFO - 'TERM': 'linux', 23:35:47 INFO - 'TMOUT': '86400', 23:35:47 INFO - 'USER': 'cltbld', 23:35:47 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', 23:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:47 INFO - '_': '/tools/buildbot/bin/python'} 23:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:35:48 INFO - Running setup.py (path:/tmp/pip-jwr2ZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:35:48 INFO - Running setup.py (path:/tmp/pip-eGPZul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:35:48 INFO - Running setup.py (path:/tmp/pip-Rf2rbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:35:48 INFO - Running setup.py (path:/tmp/pip-J3NrU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:35:48 INFO - Running setup.py (path:/tmp/pip-mvJAKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:35:48 INFO - Running setup.py (path:/tmp/pip-s1CMQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:35:48 INFO - Running setup.py (path:/tmp/pip-eLBaQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:35:48 INFO - Running setup.py (path:/tmp/pip-BYiEvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:35:48 INFO - Running setup.py (path:/tmp/pip-aDIgZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:35:48 INFO - Running setup.py (path:/tmp/pip-kAWvBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:35:48 INFO - Running setup.py (path:/tmp/pip-aBxGnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:35:48 INFO - Running setup.py (path:/tmp/pip-XIDewW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:35:48 INFO - Running setup.py (path:/tmp/pip-mQLhO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:35:48 INFO - Running setup.py (path:/tmp/pip-nMi1Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:35:49 INFO - Running setup.py (path:/tmp/pip-iVBAh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:35:49 INFO - Running setup.py (path:/tmp/pip-rpljB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:35:49 INFO - Running setup.py (path:/tmp/pip-58Ba82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:35:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:35:49 INFO - Running setup.py install for manifestparser 23:35:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:35:49 INFO - Running setup.py install for mozcrash 23:35:49 INFO - Running setup.py install for mozdebug 23:35:49 INFO - Running setup.py install for mozdevice 23:35:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:35:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:35:49 INFO - Running setup.py install for mozfile 23:35:49 INFO - Running setup.py install for mozhttpd 23:35:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:35:49 INFO - Running setup.py install for mozinfo 23:35:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:35:49 INFO - Running setup.py install for mozInstall 23:35:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:35:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:35:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:35:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:35:50 INFO - Running setup.py install for mozleak 23:35:50 INFO - Running setup.py install for mozlog 23:35:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:35:50 INFO - Running setup.py install for moznetwork 23:35:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:35:50 INFO - Running setup.py install for mozprocess 23:35:50 INFO - Running setup.py install for mozprofile 23:35:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:35:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:35:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:35:50 INFO - Running setup.py install for mozrunner 23:35:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:35:50 INFO - Running setup.py install for mozscreenshot 23:35:50 INFO - Running setup.py install for moztest 23:35:50 INFO - Running setup.py install for mozversion 23:35:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:35:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:35:51 INFO - Cleaning up... 23:35:51 INFO - Return code: 0 23:35:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:35:51 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')]} 23:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:51 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')]} 23:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:51 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 0x7f542275ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb410>, '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 0x1ecc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', '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 23:35:51 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 23:35:51 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 23:35:51 INFO - Using env: {'DISPLAY': ':0', 23:35:51 INFO - 'HOME': '/home/cltbld', 23:35:51 INFO - 'LANG': 'en_US.UTF-8', 23:35:51 INFO - 'LANGUAGE': 'en_US:en', 23:35:51 INFO - 'LOGNAME': 'cltbld', 23:35:51 INFO - 'MAIL': '/var/mail/cltbld', 23:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:51 INFO - 'MOZ_NO_REMOTE': '1', 23:35:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:51 INFO - 'NO_EM_RESTART': '1', 23:35:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:51 INFO - 'PWD': '/builds/slave/test', 23:35:51 INFO - 'SHELL': '/bin/bash', 23:35:51 INFO - 'SHLVL': '1', 23:35:51 INFO - 'TERM': 'linux', 23:35:51 INFO - 'TMOUT': '86400', 23:35:51 INFO - 'USER': 'cltbld', 23:35:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', 23:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:51 INFO - '_': '/tools/buildbot/bin/python'} 23:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:35:51 INFO - Running setup.py (path:/tmp/pip-JY3sAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:35:51 INFO - Running setup.py (path:/tmp/pip-DQt8BL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:35:51 INFO - Running setup.py (path:/tmp/pip-S_J4DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:35:51 INFO - Running setup.py (path:/tmp/pip-2oiK59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:35:51 INFO - Running setup.py (path:/tmp/pip-ihYRIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:35:51 INFO - Running setup.py (path:/tmp/pip-8Xr9XD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:35:51 INFO - Running setup.py (path:/tmp/pip-0YKND4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:35:51 INFO - Running setup.py (path:/tmp/pip-T72pUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:35:51 INFO - Running setup.py (path:/tmp/pip-oVNAFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:35:51 INFO - Running setup.py (path:/tmp/pip-rRNiCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:35:52 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)) 23:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:35:52 INFO - Running setup.py (path:/tmp/pip-RVSrCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:35:52 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)) 23:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:35:52 INFO - Running setup.py (path:/tmp/pip-KkVUQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:35:52 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)) 23:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:35:52 INFO - Running setup.py (path:/tmp/pip-tmGZQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:35:52 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)) 23:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:35:52 INFO - Running setup.py (path:/tmp/pip-WlNLQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:35:52 INFO - Running setup.py (path:/tmp/pip-cNyJns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:35:52 INFO - Running setup.py (path:/tmp/pip-KdZFJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:35:52 INFO - Running setup.py (path:/tmp/pip-l3Folk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:35:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:35: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 23:35: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 23:35: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 23:35: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 23:35: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 23:35: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 23:35:54 INFO - Downloading blessings-1.6.tar.gz 23:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:35:54 INFO - Installing collected packages: blessings 23:35:54 INFO - Running setup.py install for blessings 23:35:54 INFO - Successfully installed blessings 23:35:54 INFO - Cleaning up... 23:35:54 INFO - Return code: 0 23:35:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:35:54 INFO - Reading from file tmpfile_stdout 23:35:54 INFO - Current package versions: 23:35:54 INFO - argparse == 1.2.1 23:35:54 INFO - blessings == 1.6 23:35:54 INFO - blobuploader == 1.2.4 23:35:54 INFO - docopt == 0.6.1 23:35:54 INFO - manifestparser == 1.1 23:35:54 INFO - mozInstall == 1.12 23:35:54 INFO - mozcrash == 0.17 23:35:54 INFO - mozdebug == 0.1 23:35:54 INFO - mozdevice == 0.48 23:35:54 INFO - mozfile == 1.2 23:35:54 INFO - mozhttpd == 0.7 23:35:54 INFO - mozinfo == 0.9 23:35:54 INFO - mozleak == 0.1 23:35:54 INFO - mozlog == 3.1 23:35:54 INFO - moznetwork == 0.27 23:35:54 INFO - mozprocess == 0.22 23:35:54 INFO - mozprofile == 0.28 23:35:54 INFO - mozrunner == 6.11 23:35:54 INFO - mozscreenshot == 0.1 23:35:54 INFO - mozsystemmonitor == 0.0 23:35:54 INFO - moztest == 0.7 23:35:54 INFO - mozversion == 1.4 23:35:54 INFO - psutil == 3.1.1 23:35:54 INFO - requests == 1.2.3 23:35:54 INFO - wsgiref == 0.1.2 23:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f542275ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb410>, '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 0x1ecc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', '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 23:35:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:35:54 INFO - Using env: {'DISPLAY': ':0', 23:35:54 INFO - 'HOME': '/home/cltbld', 23:35:54 INFO - 'LANG': 'en_US.UTF-8', 23:35:54 INFO - 'LANGUAGE': 'en_US:en', 23:35:54 INFO - 'LOGNAME': 'cltbld', 23:35:54 INFO - 'MAIL': '/var/mail/cltbld', 23:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:54 INFO - 'MOZ_NO_REMOTE': '1', 23:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:54 INFO - 'NO_EM_RESTART': '1', 23:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:54 INFO - 'PWD': '/builds/slave/test', 23:35:54 INFO - 'SHELL': '/bin/bash', 23:35:54 INFO - 'SHLVL': '1', 23:35:54 INFO - 'TERM': 'linux', 23:35:54 INFO - 'TMOUT': '86400', 23:35:54 INFO - 'USER': 'cltbld', 23:35:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', 23:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:54 INFO - '_': '/tools/buildbot/bin/python'} 23:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:55 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)) 23:35:55 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)) 23:35:55 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)) 23:35:55 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)) 23:35:55 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)) 23:35:55 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)) 23:35:55 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)) 23:35:55 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)) 23:35:55 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)) 23:35:55 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)) 23:35:55 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)) 23:35:55 INFO - Cleaning up... 23:35:55 INFO - Return code: 0 23:35:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:35: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')]} 23:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35: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')]} 23:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f542275ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb410>, '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 0x1ecc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', '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 23:35:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:35:55 INFO - Using env: {'DISPLAY': ':0', 23:35:55 INFO - 'HOME': '/home/cltbld', 23:35:55 INFO - 'LANG': 'en_US.UTF-8', 23:35:55 INFO - 'LANGUAGE': 'en_US:en', 23:35:55 INFO - 'LOGNAME': 'cltbld', 23:35:55 INFO - 'MAIL': '/var/mail/cltbld', 23:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:55 INFO - 'MOZ_NO_REMOTE': '1', 23:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:55 INFO - 'NO_EM_RESTART': '1', 23:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:55 INFO - 'PWD': '/builds/slave/test', 23:35:55 INFO - 'SHELL': '/bin/bash', 23:35:55 INFO - 'SHLVL': '1', 23:35:55 INFO - 'TERM': 'linux', 23:35:55 INFO - 'TMOUT': '86400', 23:35:55 INFO - 'USER': 'cltbld', 23:35:55 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', 23:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:55 INFO - '_': '/tools/buildbot/bin/python'} 23:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:55 INFO - Downloading/unpacking jsonschema 23:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:35:57 INFO - Downloading/unpacking functools32 (from jsonschema) 23:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:57 INFO - Downloading functools32-3.2.3-2.tar.gz 23:35:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:35:57 INFO - warning: no files found matching '*.txt' 23:35:57 INFO - no previously-included directories found matching 'build' 23:35:57 INFO - no previously-included directories found matching 'dist' 23:35:57 INFO - no previously-included directories found matching '.git*' 23:35:57 INFO - Installing collected packages: jsonschema, functools32 23:35:57 INFO - Running setup.py install for functools32 23:35:57 INFO - warning: no files found matching '*.txt' 23:35:57 INFO - no previously-included directories found matching 'build' 23:35:57 INFO - no previously-included directories found matching 'dist' 23:35:57 INFO - no previously-included directories found matching '.git*' 23:35:57 INFO - Successfully installed jsonschema functools32 23:35:57 INFO - Cleaning up... 23:35:57 INFO - Return code: 0 23:35:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f542275ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb410>, '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 0x1ecc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', '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 23:35:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:35:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:35:57 INFO - Using env: {'DISPLAY': ':0', 23:35:57 INFO - 'HOME': '/home/cltbld', 23:35:57 INFO - 'LANG': 'en_US.UTF-8', 23:35:57 INFO - 'LANGUAGE': 'en_US:en', 23:35:57 INFO - 'LOGNAME': 'cltbld', 23:35:57 INFO - 'MAIL': '/var/mail/cltbld', 23:35:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:57 INFO - 'MOZ_NO_REMOTE': '1', 23:35:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:57 INFO - 'NO_EM_RESTART': '1', 23:35:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:57 INFO - 'PWD': '/builds/slave/test', 23:35:57 INFO - 'SHELL': '/bin/bash', 23:35:57 INFO - 'SHLVL': '1', 23:35:57 INFO - 'TERM': 'linux', 23:35:57 INFO - 'TMOUT': '86400', 23:35:57 INFO - 'USER': 'cltbld', 23:35:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', 23:35:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:57 INFO - '_': '/tools/buildbot/bin/python'} 23:35:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:57 INFO - Downloading/unpacking flake8 23:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:35:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:36:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:36: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 23:36: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 23:36: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 23:36: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 23:36: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 23:36: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 23:36:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:36: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 23:36: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 23:36: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 23:36: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 23:36: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 23:36: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 23:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:36:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:36:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:36:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:36:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:36:00 INFO - no previously-included directories found matching 'docs/_build' 23:36:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:36:00 INFO - Running setup.py install for pep8 23:36:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:36:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:36:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:36:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:36:00 INFO - no previously-included directories found matching 'docs/_build' 23:36:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:36:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:36:00 INFO - Cleaning up... 23:36:00 INFO - Return code: 0 23:36:00 INFO - Running post-action listener: _resource_record_post_action 23:36:00 INFO - Running post-action listener: _start_resource_monitoring 23:36:00 INFO - Starting resource monitoring. 23:36:00 INFO - ##### 23:36:00 INFO - ##### Running install step. 23:36:00 INFO - ##### 23:36:00 INFO - Running pre-action listener: _resource_record_pre_action 23:36:00 INFO - Running main action method: install 23:36:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:36:01 INFO - Reading from file tmpfile_stdout 23:36:01 INFO - Detecting whether we're running mozinstall >=1.0... 23:36:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:36:01 INFO - Reading from file tmpfile_stdout 23:36:01 INFO - Output received: 23:36:01 INFO - Usage: mozinstall [options] installer 23:36:01 INFO - Options: 23:36:01 INFO - -h, --help show this help message and exit 23:36:01 INFO - -d DEST, --destination=DEST 23:36:01 INFO - Directory to install application into. [default: 23:36:01 INFO - "/builds/slave/test"] 23:36:01 INFO - --app=APP Application being installed. [default: firefox] 23:36:01 INFO - mkdir: /builds/slave/test/build/application 23:36:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:36:14 INFO - Reading from file tmpfile_stdout 23:36:14 INFO - Output received: 23:36:14 INFO - /builds/slave/test/build/application/firefox/firefox 23:36:14 INFO - Running post-action listener: _resource_record_post_action 23:36:14 INFO - ##### 23:36:14 INFO - ##### Running run-tests step. 23:36:14 INFO - ##### 23:36:14 INFO - Running pre-action listener: _resource_record_pre_action 23:36:14 INFO - Running main action method: run_tests 23:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:36:14 INFO - Python 2.7.3 23:36:14 INFO - Return code: 0 23:36:14 INFO - grabbing minidump binary from tooltool 23:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb410>, '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 0x1ecc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:36:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:36:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:36:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:36:14 INFO - Return code: 0 23:36:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:36:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:36:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:36:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:36:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:36:15 INFO - Return code: 0 23:36:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 23:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 23:36:15 INFO - Using env: {'DISPLAY': ':0', 23:36:15 INFO - 'HOME': '/home/cltbld', 23:36:15 INFO - 'LANG': 'en_US.UTF-8', 23:36:15 INFO - 'LANGUAGE': 'en_US:en', 23:36:15 INFO - 'LOGNAME': 'cltbld', 23:36:15 INFO - 'MAIL': '/var/mail/cltbld', 23:36:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:36:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:15 INFO - 'MOZ_NO_REMOTE': '1', 23:36:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:15 INFO - 'NO_EM_RESTART': '1', 23:36:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:15 INFO - 'PWD': '/builds/slave/test', 23:36:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:36:15 INFO - 'SHELL': '/bin/bash', 23:36:15 INFO - 'SHLVL': '1', 23:36:15 INFO - 'TERM': 'linux', 23:36:15 INFO - 'TMOUT': '86400', 23:36:15 INFO - 'USER': 'cltbld', 23:36:15 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310', 23:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:15 INFO - '_': '/tools/buildbot/bin/python'} 23:36:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 23:36:15 INFO - mozversion application_buildid: 20160706204229 23:36:15 INFO - mozversion application_changeset: e4b27dae353c933a01584dfeff27d547ef60f04e 23:36:15 INFO - mozversion application_display_name: Firefox 23:36:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:36:15 INFO - mozversion application_name: Firefox 23:36:15 INFO - mozversion application_remotingname: firefox 23:36:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:36:15 INFO - mozversion application_vendor: Mozilla 23:36:15 INFO - mozversion application_version: 48.0 23:36:15 INFO - mozversion platform_buildid: 20160706204229 23:36:15 INFO - mozversion platform_changeset: e4b27dae353c933a01584dfeff27d547ef60f04e 23:36:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:36:15 INFO - mozversion platform_version: 48.0 23:36:15 INFO - using testdate: 1467873375 23:36:15 INFO - actual date: 1467873375 23:36:15 INFO - starting webserver on 'localhost:58454' 23:36:15 INFO - SUITE-START | Running 2 tests 23:36:15 INFO - TEST-START | dromaeo_css 23:36:15 INFO - operating with platform_type : linux_ 23:36:15 INFO - Initialising browser for dromaeo_css test... 23:36:15 INFO - TEST-INFO | started process 22879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWzc5Gj/profile http://localhost:58454/getInfo.html) 23:36:19 INFO - PROCESS | 22879 | 23:36:19 INFO - PROCESS | 22879 | (process:22960): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:36:19 INFO - PROCESS | 22879 | __metrics Screen width/height:1600/1200 23:36:19 INFO - PROCESS | 22879 | colorDepth:24 23:36:19 INFO - PROCESS | 22879 | Browser inner width/height: 1024/697 23:36:19 INFO - PROCESS | 22879 | __metrics 23:36:20 ERROR - PROCESS | 22879 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:36:21 INFO - TEST-INFO | 22879: exit 0 23:36:21 INFO - Browser initialized. 23:36:21 INFO - Running cycle 1/1 for dromaeo_css test... 23:36:21 INFO - TEST-INFO | started process 23010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWzc5Gj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:36:23 INFO - PROCESS | 23010 | 23:36:23 INFO - PROCESS | 23010 | (process:23078): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:36:33 INFO - PROCESS | 23010 | RSS: Main: 151052288 23:36:33 INFO - PROCESS | 23010 | 23:37:22 INFO - PROCESS | 23010 | 1467873442709 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] 23:39:30 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:58454/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58454/tests/dromaeo/cssquery-ext.html) 23:39:31 INFO - PROCESS | 23010 | RSS: Main: 154669056 23:39:31 INFO - PROCESS | 23010 | 23:42:32 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:58454/tests/dromaeo/cssquery-ext.html (next: http://localhost:58454/tests/dromaeo/cssquery-jquery.html) 23:42:33 INFO - PROCESS | 23010 | RSS: Main: 152653824 23:42:33 INFO - PROCESS | 23010 | 23:45:35 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:58454/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58454/tests/dromaeo/cssquery-mootools.html) 23:45:35 INFO - PROCESS | 23010 | RSS: Main: 152461312 23:45:35 INFO - PROCESS | 23010 | 23:48:37 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:58454/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58454/tests/dromaeo/cssquery-prototype.html) 23:48:38 INFO - PROCESS | 23010 | RSS: Main: 153649152 23:48:38 INFO - PROCESS | 23010 | 23:51:40 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:58454/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58454/tests/dromaeo/cssquery-yui.html) 23:51:41 INFO - PROCESS | 23010 | RSS: Main: 152403968 23:51:41 INFO - PROCESS | 23010 | 23:54:43 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:58454/tests/dromaeo/cssquery-yui.html (next: http://localhost:58454/tests/dromaeo/cssquery-dojo.html) 23:54:43 INFO - PROCESS | 23010 | RSS: Main: 156049408 23:54:43 INFO - PROCESS | 23010 | 23:54:43 INFO - PROCESS | 23010 | __start_tp_report 23:54:43 INFO - PROCESS | 23010 | _x_x_mozilla_page_load 23:54:43 INFO - PROCESS | 23010 | _x_x_mozilla_page_load_details 23:54:43 INFO - PROCESS | 23010 | |i|pagename|runs| 23:54:43 INFO - PROCESS | 23010 | |0;dojo.html;3327.7005069543734;3329.7502687298456;3372.140104273413;3398.9150271243216;3418.0258626291497;5537.750801213945;5552.056150454422;5561.944380556193;5576.693281869496;5630.296212973379;5562.054450743373;5585.218069470267;5586.636868603538;5590.02174619441;5598.384177740445;5006.880596717249;5067.34124563808;5067.366579177603;5084.847454576368;5098.923516147261;5049.520295571915;5089.109405853979;5135.9743201283945;5190.7664155112925;5209.21861720743;4994.77523511441;5005.324281222043;5012.498750124976;5198.324217851674;5232.267482552426;5026.748662566875;5032.949670503303;5094.6688465249645;5096.643234973553;5104.923426148611;5007.048660754482;5019.0965626187635;5029.119904016782;5048.419431765321;5078.542931136216;5577.247071645316;5592.5805564582815;5597.468240517144;5602.4957753802355;5609.411011843738;6096.939030609681;6102.72537735803;6107.083937409424;6111.724972376253;6113.877722445571;6030.185924900126;6069.544784141163;6093.11649810775;6145.279321789906;6162.938370616282;5650.434956504317;5655.1517272409055;5657.377688454267;5657.66054036755;5658.462446067617;6110.663913484712;6166.013437849922;6168.074788781629;6184.6598437086395;6197.597156184834;5953.732082056318;6012.939870601238;6013.909791353133;6025.246844144482;6054.757809687651;5999.550033747487;6069.575129740876;6071.119687645355;6074.605150665281;6077.270727512727;5918.8816223675285;5996.400359963969;6043.7280322385595;6046.818595442144;6047.8488037798525;6084.817455476343;6100.938990610037;6105.8473538161015;6127.816165515042;6133.44798968095;4685.648576356719;4701.48283688794;4704.905901882012;4710.788014539354;4734.19518681825;4131.772752498581;4150.813213405404;4162.375643653476;4197.160567886435;4208.284591619432;5790.71046447676;5790.826275211751;5817.331006934172;5846.239988801429;5896.911546326808;6062.484688801413;6096.481799047131;6096.481799047131;6109.572329936951;6152.661603611755;5571.470710282517;5706.543476521952;5739.827805165852;5774.422557744276;5840.795572155039;5156.690598564098;5211.895762084737;5232.790688372423;5255.185446255837;5307.416184219733;6225.62646241227;6269.592476489013;6273.592216505913;6299.433051025429;6309.747610095545;6008;6069.939300607114;6117.510599152057;6136;6139.140520327247;6118.284172697687;6251.71867265965;6265.530085243534;6270.996640537492;6275.435210831047;5949.405059494016;5976.940230597638;5988.257339163023;6002.519798416203;6039.365866583946;5986.161937328865;6100.664463454553;6120.08198770188;6134.14122022926;6141.877162456815;5914.349421563538;5944.910826337522;5946.048632218824;5956.612820166675;5964.194833697396;5881.470667639933;5935.317438494629;5938.940610594012;5952.196453478725;5962;5744.454276843693;5791.652500849962;5853.531717462508;5874.765009399576;5908.793192238251;5975.43233392827;5994.940050599438;5997.490213331916;6015.037593984942;6024.759009639565;5814.273215848019;5830.4461076197695;5871.500922421642;5884.35272120075;5885.205497257986 23:54:43 INFO - PROCESS | 23010 | |1;ext.html;666.257123307512;679.9354061364169;684.7055766020611;732.6739600877612;743.4535616322004;38836.223275534474;39402.211955760904;39793.20413591734;39900.600993990054;39989.80005099978;43278.13443731132;43570.346444803276;43825.12349753003;43858;43880.12239755203;8782.648694052246;8956.19394254517;8958.776030599221;8979.281657467387;8984.730458086235;8673.566321683922;8767.605457754384;8783.033866274705;9030.909690903105;9033.728988130366;8995.550222488882;9005.189532942033;9107.225885799682;9113.40762850416;9129.132732390446;8925.285977121815;8957.641694332218;8990.775230619221;9001.18989290967;9012.684556040507;8853.513056781874;8917.777055573597;8924.955375223148;8929.866052009225;8937.910620893774;44517.332240016425;44534;44760.77619611881;44768.55231447709;45016.3247551287;3818.1600047989677;3841.0589405595806;3851.5763266040713;3878.2437424702193;3965.4646622705854;33532;33695.83152084248;33974.83012584946;34351.828240858886;34395.484067739;4602.738085137187;4641.791119399635;4689.155951928651;4706.458757242926;4757.405324334458;322884;323524;324522;325987;326386.3680681605;62772;63871.36128638654;63927.360726392144;63930;63940;70222.2977770226;72206;72283.63858180675;72288;72432.63783681048;19390;19475.610487790163;19612.90193549023;19617.411477655693;19640;15023.624409389635;15168;15176.165310908005;15184.620384490476;15189.544313670607;20323.288684895957;20380.18479260813;20559.588808224053;20579.176832926816;21389.572208555743;7595.848083038309;7616.885746713804;7669.233076692286;7828.960855195802;7904.604769761489;1105.3920343811033;1122.119136477861;1143.1997601678693;1181.2381014245764;1273.4587800184884;33945.49081763776;34095.31809363799;34169.487457688156;34188.14529636729;34526.65473345234;1193.3854065156452;1198.3888217009387;1201.0691713921606;1223.7858374784378;1300.8373953255843;17510.91244543769;17562.560935976704;17738.822611773718;17905;17921.641567168583;517662;520785;520881;521284;528576;55741.1638825418;56575.43424565784;56838.43161568414;57168.142477862864;57199.42800571941;1521.8478152184914;1545;1547.1336051811022;1559.345075068474;1565.9921700391653;32262.516062259554;33491.66508334885;33673.15817104494;34178.31643367169;34399.656003439646;55060.72469637626;55376.72311638416;55936;56066.15900761574;56160.157597636884;459662;460251;461953;461962;469072;31385;31482.52776208313;31919.68080319167;32165.678343216267;32200.355992879544;51350.48649513457;51507;52269.215961759845;52566;52654.210186847995;42453.787731061144;42686.359704603834;43300.78349608232;43818.56181438145;44129.55870441254;43028;43293;43546.56453435425;44178.116437671706;44284;43899.56100438955;44349.55650443454;44738.55261447344;44981.55018449904;45123.548764511936;36683.44974825433;37603;38015.80992095022;38124.61875381211;38503;29519;29536.852315738284;29792.255193620334;30361.24096897595;30553.847230763702 23:54:43 INFO - PROCESS | 23010 | |2;jquery.html;431;432.96969212155165;435.23540045586725;436.8427366148187;447.0700942040558;18639.347622833204;18822.435326940198;19415;21157.259495917646;21379.25172618959;19379.4186174415;20089.196432142697;20097;20329.593408131866;20352.491187720316;5757.856053598673;5812.418758124186;5923.851903702399;5953.719950210704;5989.85025374367;5840.328362238333;5901.085331773561;5903.380145084769;5904.084866845646;5908.4091590841;5692.37383887772;5866.120081987693;5873.207117039187;5880.26496687914;5917.733701983399;5863.179154918314;5871.29544454666;5874.9118763218585;5899.174115623795;5911.733971971229;5277.920831187535;5298.178782288752;5331.973340133313;5333.839984800462;5338.652987555796;23612.64581031286;23798.405039873967;24247.878760606083;24372;24559.754402455925;2443.6090225564003;2470.765277298654;2513.1455305196137;2760.254731222579;2984.7761417893744;14896.62758431037;14970.47603333889;15180.165090919994;15270.923645381701;15375.271927160875;1992.9601407971904;2003.8998050097582;2024.2510271199603;2092.476880779805;2129.58473097746;57796.13305800416;70581.64709176472;72577.6371118141;79101.60449197717;80460.59769701172;10569.418681972566;10859.619913302997;10901.201301785117;11125.944370278097;11130.61042863512;15231.314590843216;15321.463748768963;15364.154971476675;15378.538643840702;15394.23028848553;9006.414583052212;9212.447253164832;9289.489078100769;9319.487428191378;9323.25413966881;9177.128172823572;9187.862182067274;9211.447313161232;9335.626574936927;9354.345195836226;6909.239983601799;6947;6984.615846128511;6991.545549539263;7084.964575177091;2012.175008246612;2025.696145578175;2045.4784030072533;2049.508118051687;2069.544700165961;1031.6234574380296;1131.9377434241196;1172.2556176827775;1202.927824330543;1245.9003279737599;19741.605167896563;19800.207991680458;20172.19311227564;20296;20356.79643203549;1136.2273653915252;1152.7694461107812;1161.355447726503;1196.9281843089443;1213.2841623442034;11607.013403860597;11620.76758464826;11667.35829529367;11725.589604363977;11831.645050648322;502974;515845;520981;521634;549680;51152.74423627932;57938;80087.19912800915;80124.19875801283;90320.54839725891;1138.5673444091192;1161.0479406886272;1163.2380790582183;1163.4648061891626;1187.780260651782;16769.66460670804;17456.825431746027;18077.548061298574;18432.907835460737;18623.90688046551;32244.516332254567;34629.48055779115;37103;38988;39939.80030099831;50834.23748643847;50928.490715092375;51245;52458.73770631122;52648.73675631597;8695.913040869764;8971.955140224258;9056.830109461636;9177.403468774508;9185.035571264922;12289.324087175291;12996.285204313854;13235.338233088114;13384.464621415424;13400.262985535888;11229.38238396896;11695.649130526097;11848.881511184778;12157.392130393622;12205.633830985085;11809.409529523662;11865.169438139248;12066.276023438622;12103.878961210627;12263.877361226274;12050.51797928073;12109.455074521844;12216.450259738156;12341.321227332583;12749.93625031869;8941;8960.462372257685;9059.22996545301;9063.365564410427;9110.271178305853;9233.399829011361;12377.814332785196;12505.062120340828;12528.686782830502;12699.492020319083 23:54:43 INFO - PROCESS | 23010 | |3;mootools.html;1514.3866733972739;1569.0272031340567;1755.473357992602;1881.680114380555;1888.9716654250196;7564.54612723237;8315.501069935808;8404.243618074372;8528.658853645855;8588.141185881408;8215.71245006425;8322.625481853316;8388.203120703538;8592.570371481432;8615.483071015728;2389.5220955808823;2396.2332053742807;2402.903883844644;2408.1691816323428;2423.612222044473;2457.1154384421593;2488.6267059940974;2518.7481251874756;2520.6723125993594;2523.205190365038;2437.695288088989;2440.719317278509;2444.9388765280924;2462.6182941644074;2469.5678256305073;2414.130912871365;2416.8429052111555;2419.927402177929;2423.2487928742057;2445;2438.67077944477;2439.475512764764;2446.425090103824;2451.7793398594035;2461.089396923132;8580.227779499875;8610.827783444358;8614.138586141398;8615.224629783286;8617.09520500351;5328;5420.07858664028;5466.945330546723;5480.835574932758;5508.614396992212;3620.8913732588067;3675.099600597844;3743.1765011697385;3792.6586607205486;3840.1743625120453;1215.7750816098962;1229.3238718704677;1242.142921384242;1293.3597869054784;2248.9437764055865;12054.397280136045;12212.511499540096;12216.26702397859;12217.816732749016;12218.083643726755;4716.764161791897;4722.693024953367;4757.048590281957;4772.284157376422;4820.807167713322;10394.740131496621;10402.947985260025;10411.687649370531;10421.53103110362;10450.216233782498;5378.327709036371;5414.458554144633;5416.241726158341;5421.105517589633;5454.972725136428;4746.572808447257;4867.610591152699;4922.138625740481;4928.926066109011;4968.279599458058;3879.6508314251287;3894.182221733411;3980.2636512245326;4000.8599699010397;4013.478247827822;1194.3371428857067;1218.6959952850543;1228.1893949992962;1229.237872519044;1237.3852122979597;876.5660997806127;1023.672424824064;1036.7459972306833;1079.1690398393193;1084.073117484555;5752.913706294409;5833.649981001154;5894.145348924382;5904.350521442638;6019.638821670714;979.7648564344506;997.5211898288862;1038.3510306058713;1048.3750187209794;1069.6951368859839;3924.980375098163;4005.379166229239;4047.0894048838777;4047.514298284225;4062.431259623655;10481.109105725945;10771.730706732395;10814.134869210444;10832.620858269922;10844.837327440095;10641.521131548943;10667.786644267071;10670.413127278074;10671.039606435457;10686.412247326316;8008.679652813822;8198.754037378889;8342.207490288412;8347.791305217419;8352.874706879402;5735.627184233012;5751.504608801658;5864.706764661835;5959.910601340896;5981.983062879408;9394.154526092685;9532.95233523828;9605;9812.754681133028;9816.607335706492;9581.808363832824;9729.318947673595;9736.805263894825;9800.901990979999;9840.901590984286;6530.869382612226;6967.233604303624;7096.680649370894;7353.522021068614;7460.738874139379;8019.799505012421;8073.636686349011;8102.0277566692375;8110;8122.7157049502985;7052.047973523714;7249.673764680497;7314.780556583311;7318.377937875341;7335.669894854637;7148.213696493485;7219.747308844166;7317.5609463432365;7339.926600733925;7456.701731930879;6867.587944723333;6879.346462086094;6949.652517374212;6962.860742785218;6964.825879353057;4851.708897466164;4920.778564964657;4923.359963204761;4934.7285899275885;4938.925916111333;5002.924956125588;5005.774740136775;5040.143175660073;5101.418560246336;5138.12651849179 23:54:43 INFO - PROCESS | 23010 | |4;prototype.html;350.4795378862389;351.4254194392168;360.63575788453653;361.77931461808294;362.50699049292973;6427.7750278740195;6435.549511534195;6655.467562594993;6657.600543967365;6672.466202703784;6457.2896981332015;6477.740890364392;6520;6526.934730652692;6530.673466326676;4705.341252224691;4812.759362031902;4909.042736666361;4913.877153071184;4925.310456536088;4801.8079276828885;4811.879703007417;4816.518348165173;4819.590334821544;4841.080194763002;4784.306275590037;4805.135075686375;4816.807327706888;4817.181079216542;4821.228603423453;4807.062622788558;4815.66290359675;4816.44610869751;4819.939613285072;4831.685940413862;4199.727017743837;4200.327947528412;4203.138356636882;4203.243416185085;4210.157968406331;6254.8123556293385;6258.843528911768;6266.467350275232;6267.247930248353;6282.434580887742;5513.972430137824;5638.210650508932;5690.516306113986;5732.283464566929;5742.2247996520355;6786.626735529544;6802.387785099315;6820.249772525019;6833.863322733568;6834.316568343175;4741.075490279397;4750.928736068961;4751.073540659573;4752.5485078917445;4759.762011899391;7129.322714342129;7132.6077065761365;7188.388986936169;7196.388306993859;7210.170830354524;4840.540148685869;4873.561379475864;4874.951250487521;4875.463698993108;4881.780319885614;4740.739259340769;4883.096627123993;4922.1140194765285;4926.433460152057;4926.5073492650445;5653.180288858092;5683.715814209273;5690.800821971211;5696.287964004499;5701.4013528579735;6847.828804279933;6872.175338959357;6873.48448866337;6877.4841886858685;6891.138607674041;1692.8561072308992;1737.1574786228668;1737.1922056243654;1739.399907032072;1744.6946784312695;1109.1625822503959;1136.9545218191179;1144.6451600004025;1146.4210573660248;1161.4599211366756;6635.86728265432;6642.535022548375;6647.069410282565;6656.101426307483;6658.600483970978;7053.57678539279;7060.505764596532;7069.469789765685;7071.186813516511;7076.4692648051605;6558.737650494022;6642.6014439133805;6643.900341494881;6709.597424154566;6751.797446076625;3820.3505404081375;3842.481265029185;3847.2690188864585;3850.172212974224;3861.343571592836;7329.486935914435;7336.339729424378;7347.118345798432;7351.669174887143;7353.669084891193;7220.891686624705;7271.127464704269;7287.161976372679;7292.416606671453;7301.926980730231;7107.324804143598;7266.491345605757;7313.780586582411;7330.120385553661;7334.339909408179;7115.679794409368;7134.60759658203;7136.357727804522;7140.285971402818;7147.035150254649;7034.437245020284;7038.2609825969585;7050.048243487064;7068.469864760266;7081.398081163159;7322.670479828314;7328.926710732824;7331.74338898136;7347.8530429392185;7361.595112268877;4690.249560070372;4822.662413631152;4846.442659094108;4864.343313652612;4873.95126048735;7057.082579264663;7089.680964356513;7090.042844215965;7096.787096387116;7104.751333703295;6813.7955861324235;6823.38589526945;6839.555428897106;6854.897176542256;6864.553804002724;6816.931830681629;6827.863442731018;6831.760888368884;6832.350926661959;6840.110785597841;6561.934380656132;6710.563813352116;6730.360615741497;6738.528303018742;6748.527603067738;6873.20958089806;6899.586024838526;6906.929425938987;6906.93093069083;6923.307669233238;6724.495662825406;6727.428168605723;6736.831579210363;6738.157730283715;6742.325767423218 23:54:43 INFO - PROCESS | 23010 | |5;yui.html;911.3893691226878;932.2728271947883;932.3194068330118;935.9298052646051;942.4627962061619;14871.628209294773;15048.623784405381;15166.62083447913;15784.289706963185;16288.511344659679;15856.28646710898;16006.19969001551;16061.116638584874;16093.517194484155;16127.274272657729;789.3606178995033;848.4569875279826;879.2877769007092;888.5868071346822;896.090468174803;889.6975028490313;897.6409436225497;898.2230370729304;905.3571963905634;906.9863952040691;938.8357037518441;954.0888451528773;963.5134257200104;963.6482683820425;964.3827950111934;941.4774799986005;943.2029934705198;943.580106852451;943.8253923024263;946.9621215151386;696.3489137656308;698.5145323999823;700.3066963705894;701.3022043067181;701.6807352654581;15665.06009639414;15718.921405393014;15765.132917689523;15788.526344209693;15810.604734881605;13664.863351366459;13791.931040344834;13972.93013534936;14090.154590724487;14318;11565;11674.883251167465;11704.414779261004;11708.882911170864;12009.939950300193;4004.9599504004877;4030.7984600770137;4093.406456063854;4129.669626429878;4131.690123240769;56957.430425695624;57061.14408283921;57290.71354643242;57297.42702572962;57352.852942941325;10874.075703565128;10885.83671244932;11121.777564448666;11343.716407089889;11479.770404591862;20211.191552338038;20287.492812679506;20303.796962030487;20352.592948140955;20362;8352.8329433411;8366.414350995494;8468.40721149526;8496.617652205665;8771.079036701181;5039.44566097729;5131.461196574306;5173.939342434792;5174.586033117342;5175.404828444702;3646.08847788053;3655.2689462107683;3685.8341374638208;3692.5753538343433;3697.5193224880595;672.3343889549409;675.9695813688396;684.387473211473;685.2838783471284;689.1007235557545;690.433844247712;731.8426538294292;819.868820988639;824.1675907333516;839.5760141128691;9098.272138228926;9787.314887957775;9915;9965.20278377728;10031.899681003242;809.0736107157272;809.4900212865974;814.385139219897;817.207308910356;827.6482494939627;4383.430154079949;4390.868273951786;4529.116822219636;4533.863984080483;4680.81276748933;59461.40538594559;62012;62039.06941395882;62067.689661551405;62251.377486225465;57579.136312955336;57922.84154316974;58876;59091.40908590859;59390;51510.48489515057;51536;52436.951260974565;52520.47479525156;52735.73632131892;8662.740117796477;8677.739667809976;8926.196642301964;8954.462732236087;9245.306602004743;38088.61911380962;38486.615133849424;39051.609483904795;39362.40956385714;40251.39622905717;44367;45386;47569.28646070381;48518.272225915935;50012.74993625009;10201.591936322464;10971.286866353661;11183.440827958731;11365.147613928822;13809.309534523032;13766.31168441594;13962.930185349009;14009.719805603627;14091.859081409055;15049.398024078915;12629.557965471164;13217.273049981959;13285.07004509675;13465.528706495226;13556.186628802303;12518.374081295717;13033.283169425773;13063;14336.068155569854;14488.927555362156;12294;13019.47922083144;13178.868211317764;13870.722585548434;14302.141871487744;10761.623343182951;10807.945960270463;10881.836772448578;11235.943820280847;11263.09895208365;10851.945740271249;11179.66461006171;11363.54545818158;11481.483333249857;11539.249948753304 23:54:43 INFO - PROCESS | 23010 | __end_tp_report 23:54:43 INFO - PROCESS | 23010 | __start_cc_report 23:54:43 INFO - PROCESS | 23010 | _x_x_mozilla_cycle_collect,319 23:54:43 INFO - PROCESS | 23010 | __end_cc_report 23:54:43 INFO - PROCESS | 23010 | __startTimestamp1467874483575__endTimestamp 23:54:43 INFO - PROCESS | 23010 | 23:54:43 INFO - PROCESS | 23010 | ------- Summary: start ------- 23:54:43 INFO - PROCESS | 23010 | Number of tests: 6 23:54:43 INFO - PROCESS | 23010 | 23:54:43 INFO - PROCESS | 23010 | [#0] dojo.html Cycles:165 Average:5629.48 Median:5884.35 stddev:637.34 (10.8%) stddev-sans-first:613.18 23:54:43 INFO - PROCESS | 23010 | Values: 3327.7 3329.8 3372.1 3398.9 3418.0 5537.8 5552.1 5561.9 5576.7 5630.3 5562.1 5585.2 5586.6 5590.0 5598.4 5006.9 5067.3 5067.4 5084.8 5098.9 5049.5 5089.1 5136.0 5190.8 5209.2 4994.8 5005.3 5012.5 5198.3 5232.3 5026.7 5032.9 5094.7 5096.6 5104.9 5007.0 5019.1 5029.1 5048.4 5078.5 5577.2 5592.6 5597.5 5602.5 5609.4 6096.9 6102.7 6107.1 6111.7 6113.9 6030.2 6069.5 6093.1 6145.3 6162.9 5650.4 5655.2 5657.4 5657.7 5658.5 6110.7 6166.0 6168.1 6184.7 6197.6 5953.7 6012.9 6013.9 6025.2 6054.8 5999.6 6069.6 6071.1 6074.6 6077.3 5918.9 5996.4 6043.7 6046.8 6047.8 6084.8 6100.9 6105.8 6127.8 6133.4 4685.6 4701.5 4704.9 4710.8 4734.2 4131.8 4150.8 4162.4 4197.2 4208.3 5790.7 5790.8 5817.3 5846.2 5896.9 6062.5 6096.5 6096.5 6109.6 6152.7 5571.5 5706.5 5739.8 5774.4 5840.8 5156.7 5211.9 5232.8 5255.2 5307.4 6225.6 6269.6 6273.6 6299.4 6309.7 6008.0 6069.9 6117.5 6136.0 6139.1 6118.3 6251.7 6265.5 6271.0 6275.4 5949.4 5976.9 5988.3 6002.5 6039.4 5986.2 6100.7 6120.1 6134.1 6141.9 5914.3 5944.9 5946.0 5956.6 5964.2 5881.5 5935.3 5938.9 5952.2 5962.0 5744.5 5791.7 5853.5 5874.8 5908.8 5975.4 5994.9 5997.5 6015.0 6024.8 5814.3 5830.4 5871.5 5884.4 5885.2 23:54:43 INFO - PROCESS | 23010 | 23:54:43 INFO - PROCESS | 23010 | [#1] ext.html Cycles:180 Average:61354.78 Median:43869.06 stddev:117511.18 (267.9%) stddev-sans-first:117752.49 23:54:43 INFO - PROCESS | 23010 | Values: 666.3 679.9 684.7 732.7 743.5 38836.2 39402.2 39793.2 39900.6 39989.8 43278.1 43570.3 43825.1 43858.0 43880.1 8782.6 8956.2 8958.8 8979.3 8984.7 8673.6 8767.6 8783.0 9030.9 9033.7 8995.6 9005.2 9107.2 9113.4 9129.1 8925.3 8957.6 8990.8 9001.2 9012.7 8853.5 8917.8 8925.0 8929.9 8937.9 44517.3 44534.0 44760.8 44768.6 45016.3 3818.2 3841.1 3851.6 3878.2 3965.5 33532.0 33695.8 33974.8 34351.8 34395.5 4602.7 4641.8 4689.2 4706.5 4757.4 322884.0 323524.0 324522.0 325987.0 326386.4 62772.0 63871.4 63927.4 63930.0 63940.0 70222.3 72206.0 72283.6 72288.0 72432.6 19390.0 19475.6 19612.9 19617.4 19640.0 15023.6 15168.0 15176.2 15184.6 15189.5 20323.3 20380.2 20559.6 20579.2 21389.6 7595.8 7616.9 7669.2 7829.0 7904.6 1105.4 1122.1 1143.2 1181.2 1273.5 33945.5 34095.3 34169.5 34188.1 34526.7 1193.4 1198.4 1201.1 1223.8 1300.8 17510.9 17562.6 17738.8 17905.0 17921.6 517662.0 520785.0 520881.0 521284.0 528576.0 55741.2 56575.4 56838.4 57168.1 57199.4 1521.8 1545.0 1547.1 1559.3 1566.0 32262.5 33491.7 33673.2 34178.3 34399.7 55060.7 55376.7 55936.0 56066.2 56160.2 459662.0 460251.0 461953.0 461962.0 469072.0 31385.0 31482.5 31919.7 32165.7 32200.4 51350.5 51507.0 52269.2 52566.0 52654.2 42453.8 42686.4 43300.8 43818.6 44129.6 43028.0 43293.0 43546.6 44178.1 44284.0 43899.6 44349.6 44738.6 44981.6 45123.5 36683.4 37603.0 38015.8 38124.6 38503.0 29519.0 29536.9 29792.3 30361.2 30553.8 23:54:43 INFO - PROCESS | 23010 | 23:54:43 INFO - PROCESS | 23010 | [#2] jquery.html Cycles:180 Average:29266.57 Median:24023.14 stddev:85372.21 (355.4%) stddev-sans-first:85584.24 23:54:43 INFO - PROCESS | 23010 | Values: 431.0 433.0 435.2 436.8 447.1 18639.3 18822.4 19415.0 21157.3 21379.3 19379.4 20089.2 20097.0 20329.6 20352.5 5757.9 5812.4 5923.9 5953.7 5989.9 5840.3 5901.1 5903.4 5904.1 5908.4 5692.4 5866.1 5873.2 5880.3 5917.7 5863.2 5871.3 5874.9 5899.2 5911.7 5277.9 5298.2 5332.0 5333.8 5338.7 23612.6 23798.4 24247.9 24372.0 24559.8 2443.6 2470.8 2513.1 2760.3 2984.8 14896.6 14970.5 15180.2 15270.9 15375.3 1993.0 2003.9 2024.3 2092.5 2129.6 57796.1 70581.6 72577.6 79101.6 80460.6 10569.4 10859.6 10901.2 11125.9 11130.6 15231.3 15321.5 15364.2 15378.5 15394.2 9006.4 9212.4 9289.5 9319.5 9323.3 9177.1 9187.9 9211.4 9335.6 9354.3 6909.2 6947.0 6984.6 6991.5 7085.0 2012.2 2025.7 2045.5 2049.5 2069.5 1031.6 1131.9 1172.3 1202.9 1245.9 19741.6 19800.2 20172.2 20296.0 20356.8 1136.2 1152.8 1161.4 1196.9 1213.3 11607.0 11620.8 11667.4 11725.6 11831.6 502974.0 515845.0 520981.0 521634.0 549680.0 51152.7 57938.0 80087.2 80124.2 90320.5 1138.6 1161.0 1163.2 1163.5 1187.8 16769.7 17456.8 18077.5 18432.9 18623.9 32244.5 34629.5 37103.0 38988.0 39939.8 50834.2 50928.5 51245.0 52458.7 52648.7 8695.9 8972.0 9056.8 9177.4 9185.0 12289.3 12996.3 13235.3 13384.5 13400.3 11229.4 11695.6 11848.9 12157.4 12205.6 11809.4 11865.2 12066.3 12103.9 12263.9 12050.5 12109.5 12216.5 12341.3 12749.9 8941.0 8960.5 9059.2 9063.4 9110.3 9233.4 12377.8 12505.1 12528.7 12699.5 23:54:43 INFO - PROCESS | 23010 | 23:54:43 INFO - PROCESS | 23010 | [#3] mootools.html Cycles:180 Average:5727.16 Median:4921.46 stddev:3140.67 (63.8%) stddev-sans-first:3133.52 23:54:43 INFO - PROCESS | 23010 | Values: 1514.4 1569.0 1755.5 1881.7 1889.0 7564.5 8315.5 8404.2 8528.7 8588.1 8215.7 8322.6 8388.2 8592.6 8615.5 2389.5 2396.2 2402.9 2408.2 2423.6 2457.1 2488.6 2518.7 2520.7 2523.2 2437.7 2440.7 2444.9 2462.6 2469.6 2414.1 2416.8 2419.9 2423.2 2445.0 2438.7 2439.5 2446.4 2451.8 2461.1 8580.2 8610.8 8614.1 8615.2 8617.1 5328.0 5420.1 5466.9 5480.8 5508.6 3620.9 3675.1 3743.2 3792.7 3840.2 1215.8 1229.3 1242.1 1293.4 2248.9 12054.4 12212.5 12216.3 12217.8 12218.1 4716.8 4722.7 4757.0 4772.3 4820.8 10394.7 10402.9 10411.7 10421.5 10450.2 5378.3 5414.5 5416.2 5421.1 5455.0 4746.6 4867.6 4922.1 4928.9 4968.3 3879.7 3894.2 3980.3 4000.9 4013.5 1194.3 1218.7 1228.2 1229.2 1237.4 876.6 1023.7 1036.7 1079.2 1084.1 5752.9 5833.6 5894.1 5904.4 6019.6 979.8 997.5 1038.4 1048.4 1069.7 3925.0 4005.4 4047.1 4047.5 4062.4 10481.1 10771.7 10814.1 10832.6 10844.8 10641.5 10667.8 10670.4 10671.0 10686.4 8008.7 8198.8 8342.2 8347.8 8352.9 5735.6 5751.5 5864.7 5959.9 5982.0 9394.2 9533.0 9605.0 9812.8 9816.6 9581.8 9729.3 9736.8 9800.9 9840.9 6530.9 6967.2 7096.7 7353.5 7460.7 8019.8 8073.6 8102.0 8110.0 8122.7 7052.0 7249.7 7314.8 7318.4 7335.7 7148.2 7219.7 7317.6 7339.9 7456.7 6867.6 6879.3 6949.7 6962.9 6964.8 4851.7 4920.8 4923.4 4934.7 4938.9 5002.9 5005.8 5040.1 5101.4 5138.1 23:54:43 INFO - PROCESS | 23010 | 23:54:43 INFO - PROCESS | 23010 | [#4] prototype.html Cycles:180 Average:5731.17 Median:6642.57 stddev:1747.65 (26.3%) stddev-sans-first:1705.25 23:54:43 INFO - PROCESS | 23010 | Values: 350.5 351.4 360.6 361.8 362.5 6427.8 6435.5 6655.5 6657.6 6672.5 6457.3 6477.7 6520.0 6526.9 6530.7 4705.3 4812.8 4909.0 4913.9 4925.3 4801.8 4811.9 4816.5 4819.6 4841.1 4784.3 4805.1 4816.8 4817.2 4821.2 4807.1 4815.7 4816.4 4819.9 4831.7 4199.7 4200.3 4203.1 4203.2 4210.2 6254.8 6258.8 6266.5 6267.2 6282.4 5514.0 5638.2 5690.5 5732.3 5742.2 6786.6 6802.4 6820.2 6833.9 6834.3 4741.1 4750.9 4751.1 4752.5 4759.8 7129.3 7132.6 7188.4 7196.4 7210.2 4840.5 4873.6 4875.0 4875.5 4881.8 4740.7 4883.1 4922.1 4926.4 4926.5 5653.2 5683.7 5690.8 5696.3 5701.4 6847.8 6872.2 6873.5 6877.5 6891.1 1692.9 1737.2 1737.2 1739.4 1744.7 1109.2 1137.0 1144.6 1146.4 1161.5 6635.9 6642.5 6647.1 6656.1 6658.6 7053.6 7060.5 7069.5 7071.2 7076.5 6558.7 6642.6 6643.9 6709.6 6751.8 3820.4 3842.5 3847.3 3850.2 3861.3 7329.5 7336.3 7347.1 7351.7 7353.7 7220.9 7271.1 7287.2 7292.4 7301.9 7107.3 7266.5 7313.8 7330.1 7334.3 7115.7 7134.6 7136.4 7140.3 7147.0 7034.4 7038.3 7050.0 7068.5 7081.4 7322.7 7328.9 7331.7 7347.9 7361.6 4690.2 4822.7 4846.4 4864.3 4874.0 7057.1 7089.7 7090.0 7096.8 7104.8 6813.8 6823.4 6839.6 6854.9 6864.6 6816.9 6827.9 6831.8 6832.4 6840.1 6561.9 6710.6 6730.4 6738.5 6748.5 6873.2 6899.6 6906.9 6906.9 6923.3 6724.5 6727.4 6736.8 6738.2 6742.3 23:54:43 INFO - PROCESS | 23010 | 23:54:43 INFO - PROCESS | 23010 | [#5] yui.html Cycles:180 Average:15560.23 Median:24959.93 stddev:17776.78 (71.2%) stddev-sans-first:17792.61 23:54:43 INFO - PROCESS | 23010 | Values: 911.4 932.3 932.3 935.9 942.5 14871.6 15048.6 15166.6 15784.3 16288.5 15856.3 16006.2 16061.1 16093.5 16127.3 789.4 848.5 879.3 888.6 896.1 889.7 897.6 898.2 905.4 907.0 938.8 954.1 963.5 963.6 964.4 941.5 943.2 943.6 943.8 947.0 696.3 698.5 700.3 701.3 701.7 15665.1 15718.9 15765.1 15788.5 15810.6 13664.9 13791.9 13972.9 14090.2 14318.0 11565.0 11674.9 11704.4 11708.9 12009.9 4005.0 4030.8 4093.4 4129.7 4131.7 56957.4 57061.1 57290.7 57297.4 57352.9 10874.1 10885.8 11121.8 11343.7 11479.8 20211.2 20287.5 20303.8 20352.6 20362.0 8352.8 8366.4 8468.4 8496.6 8771.1 5039.4 5131.5 5173.9 5174.6 5175.4 3646.1 3655.3 3685.8 3692.6 3697.5 672.3 676.0 684.4 685.3 689.1 690.4 731.8 819.9 824.2 839.6 9098.3 9787.3 9915.0 9965.2 10031.9 809.1 809.5 814.4 817.2 827.6 4383.4 4390.9 4529.1 4533.9 4680.8 59461.4 62012.0 62039.1 62067.7 62251.4 57579.1 57922.8 58876.0 59091.4 59390.0 51510.5 51536.0 52437.0 52520.5 52735.7 8662.7 8677.7 8926.2 8954.5 9245.3 38088.6 38486.6 39051.6 39362.4 40251.4 44367.0 45386.0 47569.3 48518.3 50012.7 10201.6 10971.3 11183.4 11365.1 13809.3 13766.3 13962.9 14009.7 14091.9 15049.4 12629.6 13217.3 13285.1 13465.5 13556.2 12518.4 13033.3 13063.0 14336.1 14488.9 12294.0 13019.5 13178.9 13870.7 14302.1 10761.6 10807.9 10881.8 11235.9 11263.1 10851.9 11179.7 11363.5 11481.5 11539.2 23:54:43 INFO - PROCESS | 23010 | -------- Summary: end -------- 23:54:43 INFO - PROCESS | 23010 | 23:54:44 INFO - TEST-INFO | 23010: exit 0 23:54:44 INFO - TEST-OK | dromaeo_css | took 1108731ms 23:54:44 INFO - TEST-START | kraken 23:54:44 INFO - operating with platform_type : linux_ 23:54:44 INFO - Initialising browser for kraken test... 23:54:44 INFO - TEST-INFO | started process 23250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppmb74E/profile http://localhost:58454/getInfo.html) 23:54:47 INFO - PROCESS | 23250 | 23:54:47 INFO - PROCESS | 23250 | (process:23330): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:54:48 INFO - PROCESS | 23250 | __metrics Screen width/height:1600/1200 23:54:48 INFO - PROCESS | 23250 | colorDepth:24 23:54:48 INFO - PROCESS | 23250 | Browser inner width/height: 1024/697 23:54:48 INFO - PROCESS | 23250 | __metrics 23:54:49 ERROR - PROCESS | 23250 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:54:49 INFO - TEST-INFO | 23250: exit 0 23:54:49 INFO - Browser initialized. 23:54:49 INFO - Running cycle 1/1 for kraken test... 23:54:49 INFO - TEST-INFO | started process 23380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppmb74E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:54:51 INFO - PROCESS | 23380 | 23:54:51 INFO - PROCESS | 23380 | (process:23447): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:55:01 INFO - PROCESS | 23380 | RSS: Main: 150953984 23:55:01 INFO - PROCESS | 23380 | 23:55:04 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58454/tests/kraken/driver.html?testName=audio-beat-detection) 23:55:04 INFO - PROCESS | 23380 | RSS: Main: 156528640 23:55:04 INFO - PROCESS | 23380 | 23:55:07 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58454/tests/kraken/driver.html?testName=audio-dft) 23:55:08 INFO - PROCESS | 23380 | RSS: Main: 156336128 23:55:08 INFO - PROCESS | 23380 | 23:55:11 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58454/tests/kraken/driver.html?testName=audio-fft) 23:55:11 INFO - PROCESS | 23380 | RSS: Main: 156266496 23:55:11 INFO - PROCESS | 23380 | 23:55:13 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58454/tests/kraken/driver.html?testName=audio-oscillator) 23:55:14 INFO - PROCESS | 23380 | RSS: Main: 156565504 23:55:14 INFO - PROCESS | 23380 | 23:55:16 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58454/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:55:17 INFO - PROCESS | 23380 | RSS: Main: 156012544 23:55:17 INFO - PROCESS | 23380 | 23:55:20 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58454/tests/kraken/driver.html?testName=imaging-darkroom) 23:55:20 INFO - PROCESS | 23380 | RSS: Main: 156913664 23:55:20 INFO - PROCESS | 23380 | 23:55:24 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58454/tests/kraken/driver.html?testName=imaging-desaturate) 23:55:24 INFO - PROCESS | 23380 | RSS: Main: 156614656 23:55:24 INFO - PROCESS | 23380 | 23:55:27 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58454/tests/kraken/driver.html?testName=json-parse-financial) 23:55:28 INFO - PROCESS | 23380 | RSS: Main: 156585984 23:55:28 INFO - PROCESS | 23380 | 23:55:29 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58454/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:55:30 INFO - PROCESS | 23380 | RSS: Main: 156356608 23:55:30 INFO - PROCESS | 23380 | 23:55:32 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58454/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:55:32 INFO - PROCESS | 23380 | RSS: Main: 156418048 23:55:32 INFO - PROCESS | 23380 | 23:55:34 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58454/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:55:35 INFO - PROCESS | 23380 | RSS: Main: 156430336 23:55:35 INFO - PROCESS | 23380 | 23:55:37 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:55:38 INFO - PROCESS | 23380 | RSS: Main: 156753920 23:55:38 INFO - PROCESS | 23380 | 23:55:41 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:55:41 INFO - PROCESS | 23380 | RSS: Main: 157077504 23:55:41 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | Cycle 1(1): loaded http://localhost:58454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58454/tests/kraken/driver.html?testName=ai-astar) 23:55:43 INFO - PROCESS | 23380 | RSS: Main: 158613504 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | __start_tp_report 23:55:43 INFO - PROCESS | 23380 | _x_x_mozilla_page_load 23:55:43 INFO - PROCESS | 23380 | _x_x_mozilla_page_load_details 23:55:43 INFO - PROCESS | 23380 | |i|pagename|runs| 23:55:43 INFO - PROCESS | 23380 | |0;ai-astar;108;110;105;111;114;112;102;111;112;114 23:55:43 INFO - PROCESS | 23380 | |1;audio-beat-detection;153;127;156;175;136;167;153;136;192;127 23:55:43 INFO - PROCESS | 23380 | |2;audio-dft;164;163;164;162;162;161;162;164;162;163 23:55:43 INFO - PROCESS | 23380 | |3;audio-fft;76;77;75;179;77;74;76;78;169;76 23:55:43 INFO - PROCESS | 23380 | |4;audio-oscillator;92;92;160;94;92;93;151;93;92;141 23:55:43 INFO - PROCESS | 23380 | |5;imaging-gaussian-blur;118;117;117;120;117;117;117;117;117;118 23:55:43 INFO - PROCESS | 23380 | |6;imaging-darkroom;149;152;148;146;147;147;147;146;147;146 23:55:43 INFO - PROCESS | 23380 | |7;imaging-desaturate;95;95;96;95;96;95;95;95;95;95 23:55:43 INFO - PROCESS | 23380 | |8;json-parse-financial;53;56;53;56;54;56;56;75;57;53 23:55:43 INFO - PROCESS | 23380 | |9;json-stringify-tinderbox;59;59;59;58;59;58;59;59;59;58 23:55:43 INFO - PROCESS | 23380 | |10;stanford-crypto-aes;71;73;73;74;74;74;77;74;74;73 23:55:43 INFO - PROCESS | 23380 | |11;stanford-crypto-ccm;116;118;115;113;126;122;113;120;129;130 23:55:43 INFO - PROCESS | 23380 | |12;stanford-crypto-pbkdf2;161;162;162;158;161;158;160;156;156;157 23:55:43 INFO - PROCESS | 23380 | |13;stanford-crypto-sha256-iterative;69;72;70;70;68;71;68;70;70;68 23:55:43 INFO - PROCESS | 23380 | __end_tp_report 23:55:43 INFO - PROCESS | 23380 | __start_cc_report 23:55:43 INFO - PROCESS | 23380 | _x_x_mozilla_cycle_collect,857 23:55:43 INFO - PROCESS | 23380 | __end_cc_report 23:55:43 INFO - PROCESS | 23380 | __startTimestamp1467874543581__endTimestamp 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | ------- Summary: start ------- 23:55:43 INFO - PROCESS | 23380 | Number of tests: 14 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.87 (3.5%) stddev-sans-first:4.04 23:55:43 INFO - PROCESS | 23380 | Values: 108.0 110.0 105.0 111.0 114.0 112.0 102.0 111.0 112.0 114.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:154.50 stddev:21.43 (13.9%) stddev-sans-first:22.73 23:55:43 INFO - PROCESS | 23380 | Values: 153.0 127.0 156.0 175.0 136.0 167.0 153.0 136.0 192.0 127.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.01 23:55:43 INFO - PROCESS | 23380 | Values: 164.0 163.0 164.0 162.0 162.0 161.0 162.0 164.0 162.0 163.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:41.35 (54.4%) stddev-sans-first:43.24 23:55:43 INFO - PROCESS | 23380 | Values: 76.0 77.0 75.0 179.0 77.0 74.0 76.0 78.0 169.0 76.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.00 stddev:28.43 (30.9%) stddev-sans-first:29.39 23:55:43 INFO - PROCESS | 23380 | Values: 92.0 92.0 160.0 94.0 92.0 93.0 151.0 93.0 92.0 141.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 23:55:43 INFO - PROCESS | 23380 | Values: 118.0 117.0 117.0 120.0 117.0 117.0 117.0 117.0 117.0 118.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:1.84 (1.3%) stddev-sans-first:1.87 23:55:43 INFO - PROCESS | 23380 | Values: 149.0 152.0 148.0 146.0 147.0 147.0 147.0 146.0 147.0 146.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:55:43 INFO - PROCESS | 23380 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.00 stddev:6.54 (11.7%) stddev-sans-first:6.78 23:55:43 INFO - PROCESS | 23380 | Values: 53.0 56.0 53.0 56.0 54.0 56.0 56.0 75.0 57.0 53.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 23:55:43 INFO - PROCESS | 23380 | Values: 59.0 59.0 59.0 58.0 59.0 58.0 59.0 59.0 59.0 58.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:74.00 stddev:1.49 (2.0%) stddev-sans-first:1.22 23:55:43 INFO - PROCESS | 23380 | Values: 71.0 73.0 73.0 74.0 74.0 74.0 77.0 74.0 74.0 73.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:121.00 stddev:6.36 (5.3%) stddev-sans-first:6.56 23:55:43 INFO - PROCESS | 23380 | Values: 116.0 118.0 115.0 113.0 126.0 122.0 113.0 120.0 129.0 130.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:160.50 stddev:2.38 (1.5%) stddev-sans-first:2.42 23:55:43 INFO - PROCESS | 23380 | Values: 161.0 162.0 162.0 158.0 161.0 158.0 160.0 156.0 156.0 157.0 23:55:43 INFO - PROCESS | 23380 | 23:55:43 INFO - PROCESS | 23380 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.35 (1.9%) stddev-sans-first:1.41 23:55:43 INFO - PROCESS | 23380 | Values: 69.0 72.0 70.0 70.0 68.0 71.0 68.0 70.0 70.0 68.0 23:55:43 INFO - PROCESS | 23380 | -------- Summary: end -------- 23:55:43 INFO - PROCESS | 23380 | 23:55:44 INFO - TEST-INFO | 23380: exit 0 23:55:44 INFO - TEST-OK | kraken | took 60227ms 23:55:44 INFO - SUITE-END | took 1168s 23:55:44 INFO - Completed test suite (00:19:29) 23:55:44 INFO - javascript benchmark 23:55:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.7005069543734, 3329.7502687298456, 3372.140104273413, 3398.9150271243216, 3418.0258626291497, 5537.750801213945, 5552.056150454422, 5561.944380556193, 5576.693281869496, 5630.296212973379, 5562.054450743373, 5585.218069470267, 5586.636868603538, 5590.02174619441, 5598.384177740445, 5006.880596717249, 5067.34124563808, 5067.366579177603, 5084.847454576368, 5098.923516147261, 5049.520295571915, 5089.109405853979, 5135.9743201283945, 5190.7664155112925, 5209.21861720743, 4994.77523511441, 5005.324281222043, 5012.498750124976, 5198.324217851674, 5232.267482552426, 5026.748662566875, 5032.949670503303, 5094.6688465249645, 5096.643234973553, 5104.923426148611, 5007.048660754482, 5019.0965626187635, 5029.119904016782, 5048.419431765321, 5078.542931136216, 5577.247071645316, 5592.5805564582815, 5597.468240517144, 5602.4957753802355, 5609.411011843738, 6096.939030609681, 6102.72537735803, 6107.083937409424, 6111.724972376253, 6113.877722445571, 6030.185924900126, 6069.544784141163, 6093.11649810775, 6145.279321789906, 6162.938370616282, 5650.434956504317, 5655.1517272409055, 5657.377688454267, 5657.66054036755, 5658.462446067617, 6110.663913484712, 6166.013437849922, 6168.074788781629, 6184.6598437086395, 6197.597156184834, 5953.732082056318, 6012.939870601238, 6013.909791353133, 6025.246844144482, 6054.757809687651, 5999.550033747487, 6069.575129740876, 6071.119687645355, 6074.605150665281, 6077.270727512727, 5918.8816223675285, 5996.400359963969, 6043.7280322385595, 6046.818595442144, 6047.8488037798525, 6084.817455476343, 6100.938990610037, 6105.8473538161015, 6127.816165515042, 6133.44798968095, 4685.648576356719, 4701.48283688794, 4704.905901882012, 4710.788014539354, 4734.19518681825, 4131.772752498581, 4150.813213405404, 4162.375643653476, 4197.160567886435, 4208.284591619432, 5790.71046447676, 5790.826275211751, 5817.331006934172, 5846.239988801429, 5896.911546326808, 6062.484688801413, 6096.481799047131, 6096.481799047131, 6109.572329936951, 6152.661603611755, 5571.470710282517, 5706.543476521952, 5739.827805165852, 5774.422557744276, 5840.795572155039, 5156.690598564098, 5211.895762084737, 5232.790688372423, 5255.185446255837, 5307.416184219733, 6225.62646241227, 6269.592476489013, 6273.592216505913, 6299.433051025429, 6309.747610095545, 6008.0, 6069.939300607114, 6117.510599152057, 6136.0, 6139.140520327247, 6118.284172697687, 6251.71867265965, 6265.530085243534, 6270.996640537492, 6275.435210831047, 5949.405059494016, 5976.940230597638, 5988.257339163023, 6002.519798416203, 6039.365866583946, 5986.161937328865, 6100.664463454553, 6120.08198770188, 6134.14122022926, 6141.877162456815, 5914.349421563538, 5944.910826337522, 5946.048632218824, 5956.612820166675, 5964.194833697396, 5881.470667639933, 5935.317438494629, 5938.940610594012, 5952.196453478725, 5962.0, 5744.454276843693, 5791.652500849962, 5853.531717462508, 5874.765009399576, 5908.793192238251, 5975.43233392827, 5994.940050599438, 5997.490213331916, 6015.037593984942, 6024.759009639565, 5814.273215848019, 5830.4461076197695, 5871.500922421642, 5884.35272120075, 5885.205497257986], "value": 5587.2816185155125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.257123307512, 679.9354061364169, 684.7055766020611, 732.6739600877612, 743.4535616322004, 38836.223275534474, 39402.211955760904, 39793.20413591734, 39900.600993990054, 39989.80005099978, 43278.13443731132, 43570.346444803276, 43825.12349753003, 43858.0, 43880.12239755203, 8782.648694052246, 8956.19394254517, 8958.776030599221, 8979.281657467387, 8984.730458086235, 8673.566321683922, 8767.605457754384, 8783.033866274705, 9030.909690903105, 9033.728988130366, 8995.550222488882, 9005.189532942033, 9107.225885799682, 9113.40762850416, 9129.132732390446, 8925.285977121815, 8957.641694332218, 8990.775230619221, 9001.18989290967, 9012.684556040507, 8853.513056781874, 8917.777055573597, 8924.955375223148, 8929.866052009225, 8937.910620893774, 44517.332240016425, 44534.0, 44760.77619611881, 44768.55231447709, 45016.3247551287, 3818.1600047989677, 3841.0589405595806, 3851.5763266040713, 3878.2437424702193, 3965.4646622705854, 33532.0, 33695.83152084248, 33974.83012584946, 34351.828240858886, 34395.484067739, 4602.738085137187, 4641.791119399635, 4689.155951928651, 4706.458757242926, 4757.405324334458, 322884.0, 323524.0, 324522.0, 325987.0, 326386.3680681605, 62772.0, 63871.36128638654, 63927.360726392144, 63930.0, 63940.0, 70222.2977770226, 72206.0, 72283.63858180675, 72288.0, 72432.63783681048, 19390.0, 19475.610487790163, 19612.90193549023, 19617.411477655693, 19640.0, 15023.624409389635, 15168.0, 15176.165310908005, 15184.620384490476, 15189.544313670607, 20323.288684895957, 20380.18479260813, 20559.588808224053, 20579.176832926816, 21389.572208555743, 7595.848083038309, 7616.885746713804, 7669.233076692286, 7828.960855195802, 7904.604769761489, 1105.3920343811033, 1122.119136477861, 1143.1997601678693, 1181.2381014245764, 1273.4587800184884, 33945.49081763776, 34095.31809363799, 34169.487457688156, 34188.14529636729, 34526.65473345234, 1193.3854065156452, 1198.3888217009387, 1201.0691713921606, 1223.7858374784378, 1300.8373953255843, 17510.91244543769, 17562.560935976704, 17738.822611773718, 17905.0, 17921.641567168583, 517662.0, 520785.0, 520881.0, 521284.0, 528576.0, 55741.1638825418, 56575.43424565784, 56838.43161568414, 57168.142477862864, 57199.42800571941, 1521.8478152184914, 1545.0, 1547.1336051811022, 1559.345075068474, 1565.9921700391653, 32262.516062259554, 33491.66508334885, 33673.15817104494, 34178.31643367169, 34399.656003439646, 55060.72469637626, 55376.72311638416, 55936.0, 56066.15900761574, 56160.157597636884, 459662.0, 460251.0, 461953.0, 461962.0, 469072.0, 31385.0, 31482.52776208313, 31919.68080319167, 32165.678343216267, 32200.355992879544, 51350.48649513457, 51507.0, 52269.215961759845, 52566.0, 52654.210186847995, 42453.787731061144, 42686.359704603834, 43300.78349608232, 43818.56181438145, 44129.55870441254, 43028.0, 43293.0, 43546.56453435425, 44178.116437671706, 44284.0, 43899.56100438955, 44349.55650443454, 44738.55261447344, 44981.55018449904, 45123.548764511936, 36683.44974825433, 37603.0, 38015.80992095022, 38124.61875381211, 38503.0, 29519.0, 29536.852315738284, 29792.255193620334, 30361.24096897595, 30553.847230763702], "value": 21358.609298218405, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.0, 432.96969212155165, 435.23540045586725, 436.8427366148187, 447.0700942040558, 18639.347622833204, 18822.435326940198, 19415.0, 21157.259495917646, 21379.25172618959, 19379.4186174415, 20089.196432142697, 20097.0, 20329.593408131866, 20352.491187720316, 5757.856053598673, 5812.418758124186, 5923.851903702399, 5953.719950210704, 5989.85025374367, 5840.328362238333, 5901.085331773561, 5903.380145084769, 5904.084866845646, 5908.4091590841, 5692.37383887772, 5866.120081987693, 5873.207117039187, 5880.26496687914, 5917.733701983399, 5863.179154918314, 5871.29544454666, 5874.9118763218585, 5899.174115623795, 5911.733971971229, 5277.920831187535, 5298.178782288752, 5331.973340133313, 5333.839984800462, 5338.652987555796, 23612.64581031286, 23798.405039873967, 24247.878760606083, 24372.0, 24559.754402455925, 2443.6090225564003, 2470.765277298654, 2513.1455305196137, 2760.254731222579, 2984.7761417893744, 14896.62758431037, 14970.47603333889, 15180.165090919994, 15270.923645381701, 15375.271927160875, 1992.9601407971904, 2003.8998050097582, 2024.2510271199603, 2092.476880779805, 2129.58473097746, 57796.13305800416, 70581.64709176472, 72577.6371118141, 79101.60449197717, 80460.59769701172, 10569.418681972566, 10859.619913302997, 10901.201301785117, 11125.944370278097, 11130.61042863512, 15231.314590843216, 15321.463748768963, 15364.154971476675, 15378.538643840702, 15394.23028848553, 9006.414583052212, 9212.447253164832, 9289.489078100769, 9319.487428191378, 9323.25413966881, 9177.128172823572, 9187.862182067274, 9211.447313161232, 9335.626574936927, 9354.345195836226, 6909.239983601799, 6947.0, 6984.615846128511, 6991.545549539263, 7084.964575177091, 2012.175008246612, 2025.696145578175, 2045.4784030072533, 2049.508118051687, 2069.544700165961, 1031.6234574380296, 1131.9377434241196, 1172.2556176827775, 1202.927824330543, 1245.9003279737599, 19741.605167896563, 19800.207991680458, 20172.19311227564, 20296.0, 20356.79643203549, 1136.2273653915252, 1152.7694461107812, 1161.355447726503, 1196.9281843089443, 1213.2841623442034, 11607.013403860597, 11620.76758464826, 11667.35829529367, 11725.589604363977, 11831.645050648322, 502974.0, 515845.0, 520981.0, 521634.0, 549680.0, 51152.74423627932, 57938.0, 80087.19912800915, 80124.19875801283, 90320.54839725891, 1138.5673444091192, 1161.0479406886272, 1163.2380790582183, 1163.4648061891626, 1187.780260651782, 16769.66460670804, 17456.825431746027, 18077.548061298574, 18432.907835460737, 18623.90688046551, 32244.516332254567, 34629.48055779115, 37103.0, 38988.0, 39939.80030099831, 50834.23748643847, 50928.490715092375, 51245.0, 52458.73770631122, 52648.73675631597, 8695.913040869764, 8971.955140224258, 9056.830109461636, 9177.403468774508, 9185.035571264922, 12289.324087175291, 12996.285204313854, 13235.338233088114, 13384.464621415424, 13400.262985535888, 11229.38238396896, 11695.649130526097, 11848.881511184778, 12157.392130393622, 12205.633830985085, 11809.409529523662, 11865.169438139248, 12066.276023438622, 12103.878961210627, 12263.877361226274, 12050.51797928073, 12109.455074521844, 12216.450259738156, 12341.321227332583, 12749.93625031869, 8941.0, 8960.462372257685, 9059.22996545301, 9063.365564410427, 9110.271178305853, 9233.399829011361, 12377.814332785196, 12505.062120340828, 12528.686782830502, 12699.492020319083], "value": 9698.69725144341, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.3866733972739, 1569.0272031340567, 1755.473357992602, 1881.680114380555, 1888.9716654250196, 7564.54612723237, 8315.501069935808, 8404.243618074372, 8528.658853645855, 8588.141185881408, 8215.71245006425, 8322.625481853316, 8388.203120703538, 8592.570371481432, 8615.483071015728, 2389.5220955808823, 2396.2332053742807, 2402.903883844644, 2408.1691816323428, 2423.612222044473, 2457.1154384421593, 2488.6267059940974, 2518.7481251874756, 2520.6723125993594, 2523.205190365038, 2437.695288088989, 2440.719317278509, 2444.9388765280924, 2462.6182941644074, 2469.5678256305073, 2414.130912871365, 2416.8429052111555, 2419.927402177929, 2423.2487928742057, 2445.0, 2438.67077944477, 2439.475512764764, 2446.425090103824, 2451.7793398594035, 2461.089396923132, 8580.227779499875, 8610.827783444358, 8614.138586141398, 8615.224629783286, 8617.09520500351, 5328.0, 5420.07858664028, 5466.945330546723, 5480.835574932758, 5508.614396992212, 3620.8913732588067, 3675.099600597844, 3743.1765011697385, 3792.6586607205486, 3840.1743625120453, 1215.7750816098962, 1229.3238718704677, 1242.142921384242, 1293.3597869054784, 2248.9437764055865, 12054.397280136045, 12212.511499540096, 12216.26702397859, 12217.816732749016, 12218.083643726755, 4716.764161791897, 4722.693024953367, 4757.048590281957, 4772.284157376422, 4820.807167713322, 10394.740131496621, 10402.947985260025, 10411.687649370531, 10421.53103110362, 10450.216233782498, 5378.327709036371, 5414.458554144633, 5416.241726158341, 5421.105517589633, 5454.972725136428, 4746.572808447257, 4867.610591152699, 4922.138625740481, 4928.926066109011, 4968.279599458058, 3879.6508314251287, 3894.182221733411, 3980.2636512245326, 4000.8599699010397, 4013.478247827822, 1194.3371428857067, 1218.6959952850543, 1228.1893949992962, 1229.237872519044, 1237.3852122979597, 876.5660997806127, 1023.672424824064, 1036.7459972306833, 1079.1690398393193, 1084.073117484555, 5752.913706294409, 5833.649981001154, 5894.145348924382, 5904.350521442638, 6019.638821670714, 979.7648564344506, 997.5211898288862, 1038.3510306058713, 1048.3750187209794, 1069.6951368859839, 3924.980375098163, 4005.379166229239, 4047.0894048838777, 4047.514298284225, 4062.431259623655, 10481.109105725945, 10771.730706732395, 10814.134869210444, 10832.620858269922, 10844.837327440095, 10641.521131548943, 10667.786644267071, 10670.413127278074, 10671.039606435457, 10686.412247326316, 8008.679652813822, 8198.754037378889, 8342.207490288412, 8347.791305217419, 8352.874706879402, 5735.627184233012, 5751.504608801658, 5864.706764661835, 5959.910601340896, 5981.983062879408, 9394.154526092685, 9532.95233523828, 9605.0, 9812.754681133028, 9816.607335706492, 9581.808363832824, 9729.318947673595, 9736.805263894825, 9800.901990979999, 9840.901590984286, 6530.869382612226, 6967.233604303624, 7096.680649370894, 7353.522021068614, 7460.738874139379, 8019.799505012421, 8073.636686349011, 8102.0277566692375, 8110.0, 8122.7157049502985, 7052.047973523714, 7249.673764680497, 7314.780556583311, 7318.377937875341, 7335.669894854637, 7148.213696493485, 7219.747308844166, 7317.5609463432365, 7339.926600733925, 7456.701731930879, 6867.587944723333, 6879.346462086094, 6949.652517374212, 6962.860742785218, 6964.825879353057, 4851.708897466164, 4920.778564964657, 4923.359963204761, 4934.7285899275885, 4938.925916111333, 5002.924956125588, 5005.774740136775, 5040.143175660073, 5101.418560246336, 5138.12651849179], "value": 4683.267589072405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.4795378862389, 351.4254194392168, 360.63575788453653, 361.77931461808294, 362.50699049292973, 6427.7750278740195, 6435.549511534195, 6655.467562594993, 6657.600543967365, 6672.466202703784, 6457.2896981332015, 6477.740890364392, 6520.0, 6526.934730652692, 6530.673466326676, 4705.341252224691, 4812.759362031902, 4909.042736666361, 4913.877153071184, 4925.310456536088, 4801.8079276828885, 4811.879703007417, 4816.518348165173, 4819.590334821544, 4841.080194763002, 4784.306275590037, 4805.135075686375, 4816.807327706888, 4817.181079216542, 4821.228603423453, 4807.062622788558, 4815.66290359675, 4816.44610869751, 4819.939613285072, 4831.685940413862, 4199.727017743837, 4200.327947528412, 4203.138356636882, 4203.243416185085, 4210.157968406331, 6254.8123556293385, 6258.843528911768, 6266.467350275232, 6267.247930248353, 6282.434580887742, 5513.972430137824, 5638.210650508932, 5690.516306113986, 5732.283464566929, 5742.2247996520355, 6786.626735529544, 6802.387785099315, 6820.249772525019, 6833.863322733568, 6834.316568343175, 4741.075490279397, 4750.928736068961, 4751.073540659573, 4752.5485078917445, 4759.762011899391, 7129.322714342129, 7132.6077065761365, 7188.388986936169, 7196.388306993859, 7210.170830354524, 4840.540148685869, 4873.561379475864, 4874.951250487521, 4875.463698993108, 4881.780319885614, 4740.739259340769, 4883.096627123993, 4922.1140194765285, 4926.433460152057, 4926.5073492650445, 5653.180288858092, 5683.715814209273, 5690.800821971211, 5696.287964004499, 5701.4013528579735, 6847.828804279933, 6872.175338959357, 6873.48448866337, 6877.4841886858685, 6891.138607674041, 1692.8561072308992, 1737.1574786228668, 1737.1922056243654, 1739.399907032072, 1744.6946784312695, 1109.1625822503959, 1136.9545218191179, 1144.6451600004025, 1146.4210573660248, 1161.4599211366756, 6635.86728265432, 6642.535022548375, 6647.069410282565, 6656.101426307483, 6658.600483970978, 7053.57678539279, 7060.505764596532, 7069.469789765685, 7071.186813516511, 7076.4692648051605, 6558.737650494022, 6642.6014439133805, 6643.900341494881, 6709.597424154566, 6751.797446076625, 3820.3505404081375, 3842.481265029185, 3847.2690188864585, 3850.172212974224, 3861.343571592836, 7329.486935914435, 7336.339729424378, 7347.118345798432, 7351.669174887143, 7353.669084891193, 7220.891686624705, 7271.127464704269, 7287.161976372679, 7292.416606671453, 7301.926980730231, 7107.324804143598, 7266.491345605757, 7313.780586582411, 7330.120385553661, 7334.339909408179, 7115.679794409368, 7134.60759658203, 7136.357727804522, 7140.285971402818, 7147.035150254649, 7034.437245020284, 7038.2609825969585, 7050.048243487064, 7068.469864760266, 7081.398081163159, 7322.670479828314, 7328.926710732824, 7331.74338898136, 7347.8530429392185, 7361.595112268877, 4690.249560070372, 4822.662413631152, 4846.442659094108, 4864.343313652612, 4873.95126048735, 7057.082579264663, 7089.680964356513, 7090.042844215965, 7096.787096387116, 7104.751333703295, 6813.7955861324235, 6823.38589526945, 6839.555428897106, 6854.897176542256, 6864.553804002724, 6816.931830681629, 6827.863442731018, 6831.760888368884, 6832.350926661959, 6840.110785597841, 6561.934380656132, 6710.563813352116, 6730.360615741497, 6738.528303018742, 6748.527603067738, 6873.20958089806, 6899.586024838526, 6906.929425938987, 6906.93093069083, 6923.307669233238, 6724.495662825406, 6727.428168605723, 6736.831579210363, 6738.157730283715, 6742.325767423218], "value": 5159.5768962341135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.3893691226878, 932.2728271947883, 932.3194068330118, 935.9298052646051, 942.4627962061619, 14871.628209294773, 15048.623784405381, 15166.62083447913, 15784.289706963185, 16288.511344659679, 15856.28646710898, 16006.19969001551, 16061.116638584874, 16093.517194484155, 16127.274272657729, 789.3606178995033, 848.4569875279826, 879.2877769007092, 888.5868071346822, 896.090468174803, 889.6975028490313, 897.6409436225497, 898.2230370729304, 905.3571963905634, 906.9863952040691, 938.8357037518441, 954.0888451528773, 963.5134257200104, 963.6482683820425, 964.3827950111934, 941.4774799986005, 943.2029934705198, 943.580106852451, 943.8253923024263, 946.9621215151386, 696.3489137656308, 698.5145323999823, 700.3066963705894, 701.3022043067181, 701.6807352654581, 15665.06009639414, 15718.921405393014, 15765.132917689523, 15788.526344209693, 15810.604734881605, 13664.863351366459, 13791.931040344834, 13972.93013534936, 14090.154590724487, 14318.0, 11565.0, 11674.883251167465, 11704.414779261004, 11708.882911170864, 12009.939950300193, 4004.9599504004877, 4030.7984600770137, 4093.406456063854, 4129.669626429878, 4131.690123240769, 56957.430425695624, 57061.14408283921, 57290.71354643242, 57297.42702572962, 57352.852942941325, 10874.075703565128, 10885.83671244932, 11121.777564448666, 11343.716407089889, 11479.770404591862, 20211.191552338038, 20287.492812679506, 20303.796962030487, 20352.592948140955, 20362.0, 8352.8329433411, 8366.414350995494, 8468.40721149526, 8496.617652205665, 8771.079036701181, 5039.44566097729, 5131.461196574306, 5173.939342434792, 5174.586033117342, 5175.404828444702, 3646.08847788053, 3655.2689462107683, 3685.8341374638208, 3692.5753538343433, 3697.5193224880595, 672.3343889549409, 675.9695813688396, 684.387473211473, 685.2838783471284, 689.1007235557545, 690.433844247712, 731.8426538294292, 819.868820988639, 824.1675907333516, 839.5760141128691, 9098.272138228926, 9787.314887957775, 9915.0, 9965.20278377728, 10031.899681003242, 809.0736107157272, 809.4900212865974, 814.385139219897, 817.207308910356, 827.6482494939627, 4383.430154079949, 4390.868273951786, 4529.116822219636, 4533.863984080483, 4680.81276748933, 59461.40538594559, 62012.0, 62039.06941395882, 62067.689661551405, 62251.377486225465, 57579.136312955336, 57922.84154316974, 58876.0, 59091.40908590859, 59390.0, 51510.48489515057, 51536.0, 52436.951260974565, 52520.47479525156, 52735.73632131892, 8662.740117796477, 8677.739667809976, 8926.196642301964, 8954.462732236087, 9245.306602004743, 38088.61911380962, 38486.615133849424, 39051.609483904795, 39362.40956385714, 40251.39622905717, 44367.0, 45386.0, 47569.28646070381, 48518.272225915935, 50012.74993625009, 10201.591936322464, 10971.286866353661, 11183.440827958731, 11365.147613928822, 13809.309534523032, 13766.31168441594, 13962.930185349009, 14009.719805603627, 14091.859081409055, 15049.398024078915, 12629.557965471164, 13217.273049981959, 13285.07004509675, 13465.528706495226, 13556.186628802303, 12518.374081295717, 13033.283169425773, 13063.0, 14336.068155569854, 14488.927555362156, 12294.0, 13019.47922083144, 13178.868211317764, 13870.722585548434, 14302.141871487744, 10761.623343182951, 10807.945960270463, 10881.836772448578, 11235.943820280847, 11263.09895208365, 10851.945740271249, 11179.66461006171, 11363.54545818158, 11481.483333249857, 11539.249948753304], "value": 7191.709943063472, "unit": "score"}], "name": "dromaeo_css", "value": 7654.561401802302, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 105.0, 111.0, 114.0, 112.0, 102.0, 111.0, 112.0, 114.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 156.0, 175.0, 136.0, 167.0, 153.0, 136.0, 192.0, 127.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 162.0, 162.0, 161.0, 162.0, 164.0, 162.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 179.0, 77.0, 74.0, 76.0, 78.0, 169.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 160.0, 94.0, 92.0, 93.0, 151.0, 93.0, 92.0, 141.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 120.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 148.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 53.0, 56.0, 54.0, 56.0, 56.0, 75.0, 57.0, 53.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0, 59.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 73.0, 74.0, 74.0, 74.0, 77.0, 74.0, 74.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 115.0, 113.0, 126.0, 122.0, 113.0, 120.0, 129.0, 130.0], "value": 120.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 158.0, 161.0, 158.0, 160.0, 156.0, 156.0, 157.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 70.0, 70.0, 68.0, 71.0, 68.0, 70.0, 70.0, 68.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1528.9, "alertThreshold": 2.0}]} 23:55:44 INFO - Return code: 0 23:55:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:55:44 ERROR - # TBPL SUCCESS # 23:55:44 INFO - Running post-action listener: _resource_record_post_action 23:55:44 INFO - Running post-run listener: _resource_record_post_run 23:55:45 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 28672; Write bytes: 464617472; Read time: 24; Write time: 388540 23:55:45 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242741248; Read time: 0; Write time: 279228 23:55:45 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221876224; Read time: 12; Write time: 109312 23:55:45 INFO - Running post-run listener: _upload_blobber_files 23:55:45 INFO - Blob upload gear active. 23:55:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:55:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:55:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:55:46 INFO - (blobuploader) - INFO - Open directory for files ... 23:55:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:55:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:55:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:55:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:55:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:55:47 INFO - (blobuploader) - INFO - Done attempting. 23:55:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:55:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:55:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:55:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:55:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:55:47 INFO - (blobuploader) - INFO - Done attempting. 23:55:47 INFO - (blobuploader) - INFO - Iteration through files over. 23:55:47 INFO - Return code: 0 23:55:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:55:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:55:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a79d3caecc67d06f8797b389bc4576fdb5adba2e12f5754c95e89c3e7da37d27310ae3f5daad6708e450e5aeb604f9ee54a5b4dde95e3b57ef4ca5522da7002", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0d626c4a272c71c84d406e5a716dc3b0d33e01e2ccee451d7c41f27a4cee8ce3f408955613f4a63effa32e801dbe86ff9a97fb781d99232f0d7a2e7927fe496"} 23:55:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:55:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:55:47 INFO - Contents: 23:55:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a79d3caecc67d06f8797b389bc4576fdb5adba2e12f5754c95e89c3e7da37d27310ae3f5daad6708e450e5aeb604f9ee54a5b4dde95e3b57ef4ca5522da7002", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0d626c4a272c71c84d406e5a716dc3b0d33e01e2ccee451d7c41f27a4cee8ce3f408955613f4a63effa32e801dbe86ff9a97fb781d99232f0d7a2e7927fe496"} 23:55:47 INFO - Running post-run listener: copy_logs_to_upload_dir 23:55:47 INFO - Copying logs to upload dir... 23:55:47 INFO - mkdir: /builds/slave/test/build/upload/logs 23:55:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.668439 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-06 23:55:47.768020) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:47.771433) ========= 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=0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a79d3caecc67d06f8797b389bc4576fdb5adba2e12f5754c95e89c3e7da37d27310ae3f5daad6708e450e5aeb604f9ee54a5b4dde95e3b57ef4ca5522da7002", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0d626c4a272c71c84d406e5a716dc3b0d33e01e2ccee451d7c41f27a4cee8ce3f408955613f4a63effa32e801dbe86ff9a97fb781d99232f0d7a2e7927fe496"} build_url:https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a79d3caecc67d06f8797b389bc4576fdb5adba2e12f5754c95e89c3e7da37d27310ae3f5daad6708e450e5aeb604f9ee54a5b4dde95e3b57ef4ca5522da7002", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0d626c4a272c71c84d406e5a716dc3b0d33e01e2ccee451d7c41f27a4cee8ce3f408955613f4a63effa32e801dbe86ff9a97fb781d99232f0d7a2e7927fe496"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:47.796579) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:47.796870) ========= 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=0e2a256762fed810e2f0f810000001b3-1467872481.370641-1186236310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004376 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:47.879607) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 23:55:47.879889) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 23:55:47.880169) ========= ========= Total master_lag: 0.23 =========