builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1467739920.23 results: success (0) buildid: 20160705073512 builduid: f11ef69a890b45a9a24f57495fa5e290 revision: 059550e65473bb4a1cbb53c963e7ac7bc24b778a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:00.229985) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:00.230478) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:00.230772) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:00.250074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:00.250350) ========= 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=00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 10:32:00-- 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% 228M=0s 2016-07-05 10:32:00 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162942 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:00.427699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:00.428026) ========= 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=00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.052322 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:00.492709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:00.496070) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 059550e65473bb4a1cbb53c963e7ac7bc24b778a --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 059550e65473bb4a1cbb53c963e7ac7bc24b778a --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=00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 10:32:00,556 truncating revision to first 12 chars 2016-07-05 10:32:00,556 Setting DEBUG logging. 2016-07-05 10:32:00,556 attempt 1/10 2016-07-05 10:32:00,556 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/059550e65473?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 10:32:00,926 unpacking tar archive at: mozilla-beta-059550e65473/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712875 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:01.222609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:01.222912) ========= script_repo_revision: 059550e65473bb4a1cbb53c963e7ac7bc24b778a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:01.223308) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:01.223569) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:32:01.232122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-05 10:32:01.232387) ========= /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=00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:32:01 INFO - MultiFileLogger online at 20160705 10:32:01 in /builds/slave/test 10:32:01 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 10:32:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:32:01 INFO - {'append_to_log': False, 10:32:01 INFO - 'base_work_dir': '/builds/slave/test', 10:32:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:32:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:32:01 INFO - 'branch': 'Mozilla-Beta', 10:32:01 INFO - 'buildbot_json_path': 'buildprops.json', 10:32:01 INFO - 'config_files': ('talos/linux_config.py',), 10:32:01 INFO - 'default_actions': ('clobber', 10:32:01 INFO - 'read-buildbot-config', 10:32:01 INFO - 'download-and-extract', 10:32:01 INFO - 'populate-webroot', 10:32:01 INFO - 'create-virtualenv', 10:32:01 INFO - 'install', 10:32:01 INFO - 'run-tests'), 10:32:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:32:01 INFO - 'download_minidump_stackwalk': True, 10:32:01 INFO - 'download_symbols': 'ondemand', 10:32:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:32:01 INFO - 'tooltool.py': '/tools/tooltool.py', 10:32:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:32:01 INFO - '/tools/misc-python/virtualenv.py')}, 10:32:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:32:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:32:01 INFO - 'installer_path': 'installer.exe', 10:32:01 INFO - 'log_level': 'info', 10:32:01 INFO - 'log_name': 'talos', 10:32:01 INFO - 'log_to_console': True, 10:32:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:32:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:32:01 INFO - 'opt_config_files': (), 10:32:01 INFO - 'pip_index': False, 10:32:01 INFO - 'sps_profile': False, 10:32:01 INFO - 'sps_profile_interval': 0, 10:32:01 INFO - 'suite': 'dromaeojs-e10s', 10:32:01 INFO - 'system_bits': '32', 10:32:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:32:01 INFO - 'title': 'talos-linux64-ix-016', 10:32:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:32:01 INFO - 'use_talos_json': True, 10:32:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:32:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:32:01 INFO - 'work_dir': 'build'} 10:32:01 INFO - ##### 10:32:01 INFO - ##### Running clobber step. 10:32:01 INFO - ##### 10:32:01 INFO - Running pre-action listener: _resource_record_pre_action 10:32:01 INFO - Running main action method: clobber 10:32:01 INFO - rmtree: /builds/slave/test/build 10:32:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:32:12 INFO - Running post-action listener: _resource_record_post_action 10:32:12 INFO - ##### 10:32:12 INFO - ##### Running read-buildbot-config step. 10:32:12 INFO - ##### 10:32:12 INFO - Running pre-action listener: _resource_record_pre_action 10:32:12 INFO - Running main action method: read_buildbot_config 10:32:12 INFO - Using buildbot properties: 10:32:12 INFO - { 10:32:12 INFO - "project": "", 10:32:12 INFO - "product": "firefox", 10:32:12 INFO - "script_repo_revision": "production", 10:32:12 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:32:12 INFO - "repository": "", 10:32:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 10:32:12 INFO - "buildid": "20160705073512", 10:32:12 INFO - "pgo_build": "True", 10:32:12 INFO - "basedir": "/builds/slave/test", 10:32:12 INFO - "buildnumber": 166, 10:32:12 INFO - "slavename": "talos-linux64-ix-016", 10:32:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:32:12 INFO - "platform": "ubuntu64_hw", 10:32:12 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:32:12 INFO - "branch": "mozilla-beta", 10:32:12 INFO - "repo_path": "releases/mozilla-beta", 10:32:12 INFO - "revision": "059550e65473bb4a1cbb53c963e7ac7bc24b778a", 10:32:12 INFO - "stage_platform": "linux64-pgo", 10:32:12 INFO - "builduid": "f11ef69a890b45a9a24f57495fa5e290", 10:32:12 INFO - "slavebuilddir": "test" 10:32:12 INFO - } 10:32:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 10:32:12 INFO - Running post-action listener: _resource_record_post_action 10:32:12 INFO - ##### 10:32:12 INFO - ##### Running download-and-extract step. 10:32:12 INFO - ##### 10:32:12 INFO - Running pre-action listener: _resource_record_pre_action 10:32:12 INFO - Running main action method: download_and_extract 10:32:12 INFO - mkdir: /builds/slave/test/build/tests 10:32: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')]} 10:32:12 INFO - https://queue.taskcluster.net/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:32:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:32:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:32:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/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 10:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/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 10:32:13 INFO - Downloaded 1327 bytes. 10:32:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:32:13 INFO - Using the following test package requirements: 10:32:13 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:32:13 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:32:13 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:32:13 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:32:13 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 10:32:13 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:32:13 INFO - u'jsshell-linux-x86_64.zip'], 10:32:13 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:32:13 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:32:13 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:32:13 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:32:13 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 10:32:13 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:32:13 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 10:32:13 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:32:13 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:32:13 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:32:13 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:32:13 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:13 INFO - https://queue.taskcluster.net/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:32:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:32:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:32:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/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 10:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/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 10:32:14 INFO - Downloaded 24236019 bytes. 10:32:14 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'] 10:32:14 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 10:32:15 INFO - Return code: 0 10:32:15 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 10:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:15 INFO - https://queue.taskcluster.net/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/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 10:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/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 10:32:16 INFO - Downloaded 24236019 bytes. 10:32: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'] 10:32: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 10:32:18 INFO - Return code: 0 10:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:18 INFO - https://queue.taskcluster.net/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:32:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:32:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:32:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/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 10:32:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/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 10:32:19 INFO - Downloaded 10840145 bytes. 10:32:19 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'] 10:32:19 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 10:32:19 INFO - Return code: 0 10:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:19 INFO - https://queue.taskcluster.net/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:32:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:32:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:32:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/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 10:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cdKL0_XrQbCnB95-kUd_zw/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 10:32:21 INFO - Downloaded 56030013 bytes. 10:32:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:32:21 INFO - mkdir: /builds/slave/test/properties 10:32:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:32:21 INFO - Writing to file /builds/slave/test/properties/build_url 10:32:21 INFO - Contents: 10:32:21 INFO - build_url:https://queue.taskcluster.net/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:32:21 INFO - Running post-action listener: _resource_record_post_action 10:32:21 INFO - Running post-action listener: set_extra_try_arguments 10:32:21 INFO - ##### 10:32:21 INFO - ##### Running populate-webroot step. 10:32:21 INFO - ##### 10:32:21 INFO - Running pre-action listener: _resource_record_pre_action 10:32:21 INFO - Running main action method: populate_webroot 10:32:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:32:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:32:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:32:22 INFO - '--tppagecycles', 10:32:22 INFO - '7'], 10:32:22 INFO - 'tests': ['tsvgm']}}, 10:32:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:32:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:32:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:32:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:32:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:32:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:32:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:22 INFO - 'talos_options': ['--disable-e10s'], 10:32:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:22 INFO - 'talos_options': ['--disable-e10s'], 10:32:22 INFO - 'tests': ['damp', 'tps']}, 10:32:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:22 INFO - 'tests': ['damp', 'tps']}, 10:32:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:32:22 INFO - 'tests': ['dromaeo_dom']}, 10:32:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:32:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:32:22 INFO - 'tests': ['a11yr', 10:32:22 INFO - 'ts_paint', 10:32:22 INFO - 'tpaint', 10:32:22 INFO - 'sessionrestore', 10:32:22 INFO - 'sessionrestore_no_auto_restore', 10:32:22 INFO - 'tabpaint']}, 10:32:22 INFO - 'other-e10s': {'tests': ['a11yr', 10:32:22 INFO - 'ts_paint', 10:32:22 INFO - 'tpaint', 10:32:22 INFO - 'sessionrestore', 10:32:22 INFO - 'sessionrestore_no_auto_restore', 10:32:22 INFO - 'tabpaint']}, 10:32:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:32:22 INFO - 'ts_paint', 10:32:22 INFO - 'tpaint', 10:32:22 INFO - 'sessionrestore', 10:32:22 INFO - 'sessionrestore_no_auto_restore', 10:32:22 INFO - 'tabpaint']}, 10:32:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:32:22 INFO - 'ts_paint', 10:32:22 INFO - 'tpaint', 10:32:22 INFO - 'sessionrestore', 10:32:22 INFO - 'sessionrestore_no_auto_restore', 10:32:22 INFO - 'tabpaint']}, 10:32:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:32:22 INFO - 'tests': ['a11yr', 10:32:22 INFO - 'ts_paint', 10:32:22 INFO - 'tpaint', 10:32:22 INFO - 'sessionrestore', 10:32:22 INFO - 'sessionrestore_no_auto_restore', 10:32:22 INFO - 'tabpaint']}, 10:32:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:32:22 INFO - 'tests': ['a11yr', 10:32:22 INFO - 'ts_paint', 10:32:22 INFO - 'tpaint', 10:32:22 INFO - 'sessionrestore', 10:32:22 INFO - 'sessionrestore_no_auto_restore', 10:32:22 INFO - 'tabpaint']}, 10:32:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:32:22 INFO - 'tests': ['tsvgx', 10:32:22 INFO - 'tsvgr_opacity', 10:32:22 INFO - 'tart', 10:32:22 INFO - 'tscrollx', 10:32:22 INFO - 'cart']}, 10:32:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:32:22 INFO - 'tsvgr_opacity', 10:32:22 INFO - 'tart', 10:32:22 INFO - 'tscrollx', 10:32:22 INFO - 'cart']}, 10:32:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:22 INFO - 'talos_options': ['--disable-e10s'], 10:32:22 INFO - 'tests': ['tp5o']}, 10:32:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:22 INFO - 'tests': ['tp5o']}, 10:32:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:22 INFO - 'talos_options': ['--disable-e10s', 10:32:22 INFO - '--xperf_path', 10:32:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:22 INFO - 'tests': ['tp5n']}, 10:32:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:22 INFO - 'talos_options': ['--xperf_path', 10:32:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:22 INFO - 'tests': ['tp5n']}}, 10:32:22 INFO - 'talos.zip': {'path': '', 10:32:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:32:22 INFO - Running post-action listener: _resource_record_post_action 10:32:22 INFO - ##### 10:32:22 INFO - ##### Running create-virtualenv step. 10:32:22 INFO - ##### 10:32:22 INFO - Running pre-action listener: _resource_record_pre_action 10:32:22 INFO - Running main action method: create_virtualenv 10:32:22 INFO - Creating virtualenv /builds/slave/test/build/venv 10:32:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:32:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:32:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:32:22 INFO - Using real prefix '/usr' 10:32:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:32:23 INFO - Installing distribute.............................................................................................................................................................................................done. 10:32:25 INFO - Installing pip.................done. 10:32:25 INFO - Return code: 0 10:32:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:25 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 0x7fec9763ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae410>, '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 0x1aaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7a0>, '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': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:32:25 INFO - Using env: {'DISPLAY': ':0', 10:32:25 INFO - 'HOME': '/home/cltbld', 10:32:25 INFO - 'LANG': 'en_US.UTF-8', 10:32:25 INFO - 'LANGUAGE': 'en_US:en', 10:32:25 INFO - 'LOGNAME': 'cltbld', 10:32:25 INFO - 'MAIL': '/var/mail/cltbld', 10:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:25 INFO - 'MOZ_NO_REMOTE': '1', 10:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:25 INFO - 'NO_EM_RESTART': '1', 10:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:25 INFO - 'PWD': '/builds/slave/test', 10:32:25 INFO - 'SHELL': '/bin/bash', 10:32:25 INFO - 'SHLVL': '1', 10:32:25 INFO - 'TERM': 'linux', 10:32:25 INFO - 'TMOUT': '86400', 10:32:25 INFO - 'USER': 'cltbld', 10:32:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 10:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:25 INFO - '_': '/tools/buildbot/bin/python'} 10:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:32:25 INFO - Cleaning up... 10:32:25 INFO - Return code: 0 10:32:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:25 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 0x7fec9763ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae410>, '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 0x1aaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7a0>, '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': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:32:25 INFO - Using env: {'DISPLAY': ':0', 10:32:25 INFO - 'HOME': '/home/cltbld', 10:32:25 INFO - 'LANG': 'en_US.UTF-8', 10:32:25 INFO - 'LANGUAGE': 'en_US:en', 10:32:25 INFO - 'LOGNAME': 'cltbld', 10:32:25 INFO - 'MAIL': '/var/mail/cltbld', 10:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:25 INFO - 'MOZ_NO_REMOTE': '1', 10:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:25 INFO - 'NO_EM_RESTART': '1', 10:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:25 INFO - 'PWD': '/builds/slave/test', 10:32:25 INFO - 'SHELL': '/bin/bash', 10:32:25 INFO - 'SHLVL': '1', 10:32:25 INFO - 'TERM': 'linux', 10:32:25 INFO - 'TMOUT': '86400', 10:32:25 INFO - 'USER': 'cltbld', 10:32:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 10:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:25 INFO - '_': '/tools/buildbot/bin/python'} 10:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:25 INFO - Downloading/unpacking psutil>=0.7.1 10:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:32:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:29 INFO - Installing collected packages: psutil 10:32:29 INFO - Running setup.py install for psutil 10:32:29 INFO - building 'psutil._psutil_linux' extension 10:32:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:32:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:32:30 INFO - building 'psutil._psutil_posix' extension 10:32:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:32:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:32:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:30 INFO - Successfully installed psutil 10:32:30 INFO - Cleaning up... 10:32:30 INFO - Return code: 0 10:32:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:30 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 0x7fec9763ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae410>, '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 0x1aaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7a0>, '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': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:32:30 INFO - Using env: {'DISPLAY': ':0', 10:32:30 INFO - 'HOME': '/home/cltbld', 10:32:30 INFO - 'LANG': 'en_US.UTF-8', 10:32:30 INFO - 'LANGUAGE': 'en_US:en', 10:32:30 INFO - 'LOGNAME': 'cltbld', 10:32:30 INFO - 'MAIL': '/var/mail/cltbld', 10:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:30 INFO - 'MOZ_NO_REMOTE': '1', 10:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:30 INFO - 'NO_EM_RESTART': '1', 10:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:30 INFO - 'PWD': '/builds/slave/test', 10:32:30 INFO - 'SHELL': '/bin/bash', 10:32:30 INFO - 'SHLVL': '1', 10:32:30 INFO - 'TERM': 'linux', 10:32:30 INFO - 'TMOUT': '86400', 10:32:30 INFO - 'USER': 'cltbld', 10:32:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 10:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:30 INFO - '_': '/tools/buildbot/bin/python'} 10:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:32:32 INFO - Installing collected packages: mozsystemmonitor 10:32:32 INFO - Running setup.py install for mozsystemmonitor 10:32:32 INFO - Successfully installed mozsystemmonitor 10:32:32 INFO - Cleaning up... 10:32:32 INFO - Return code: 0 10:32:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:32 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 0x7fec9763ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae410>, '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 0x1aaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7a0>, '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': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:32:32 INFO - Using env: {'DISPLAY': ':0', 10:32:32 INFO - 'HOME': '/home/cltbld', 10:32:32 INFO - 'LANG': 'en_US.UTF-8', 10:32:32 INFO - 'LANGUAGE': 'en_US:en', 10:32:32 INFO - 'LOGNAME': 'cltbld', 10:32:32 INFO - 'MAIL': '/var/mail/cltbld', 10:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:32 INFO - 'MOZ_NO_REMOTE': '1', 10:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:32 INFO - 'NO_EM_RESTART': '1', 10:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:32 INFO - 'PWD': '/builds/slave/test', 10:32:32 INFO - 'SHELL': '/bin/bash', 10:32:32 INFO - 'SHLVL': '1', 10:32:32 INFO - 'TERM': 'linux', 10:32:32 INFO - 'TMOUT': '86400', 10:32:32 INFO - 'USER': 'cltbld', 10:32:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 10:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:32 INFO - '_': '/tools/buildbot/bin/python'} 10:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:33 INFO - Downloading/unpacking blobuploader==1.2.4 10:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:34 INFO - Downloading blobuploader-1.2.4.tar.gz 10:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:32:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:32:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:35 INFO - Downloading docopt-0.6.1.tar.gz 10:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:32:35 INFO - Installing collected packages: blobuploader, requests, docopt 10:32:35 INFO - Running setup.py install for blobuploader 10:32:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:32:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:32:35 INFO - Running setup.py install for requests 10:32:36 INFO - Running setup.py install for docopt 10:32:36 INFO - Successfully installed blobuploader requests docopt 10:32:36 INFO - Cleaning up... 10:32:36 INFO - Return code: 0 10:32:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:36 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 0x7fec9763ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae410>, '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 0x1aaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7a0>, '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': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:32:36 INFO - Using env: {'DISPLAY': ':0', 10:32:36 INFO - 'HOME': '/home/cltbld', 10:32:36 INFO - 'LANG': 'en_US.UTF-8', 10:32:36 INFO - 'LANGUAGE': 'en_US:en', 10:32:36 INFO - 'LOGNAME': 'cltbld', 10:32:36 INFO - 'MAIL': '/var/mail/cltbld', 10:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:36 INFO - 'MOZ_NO_REMOTE': '1', 10:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:36 INFO - 'NO_EM_RESTART': '1', 10:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:36 INFO - 'PWD': '/builds/slave/test', 10:32:36 INFO - 'SHELL': '/bin/bash', 10:32:36 INFO - 'SHLVL': '1', 10:32:36 INFO - 'TERM': 'linux', 10:32:36 INFO - 'TMOUT': '86400', 10:32:36 INFO - 'USER': 'cltbld', 10:32:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 10:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:36 INFO - '_': '/tools/buildbot/bin/python'} 10:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:36 INFO - Running setup.py (path:/tmp/pip-ppJllg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:36 INFO - Running setup.py (path:/tmp/pip-9krAnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:36 INFO - Running setup.py (path:/tmp/pip-tyWqg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:36 INFO - Running setup.py (path:/tmp/pip-YX8ZgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:36 INFO - Running setup.py (path:/tmp/pip-WYdcQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:36 INFO - Running setup.py (path:/tmp/pip-fHIeVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:36 INFO - Running setup.py (path:/tmp/pip-b5uk6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:36 INFO - Running setup.py (path:/tmp/pip-kGmDdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:37 INFO - Running setup.py (path:/tmp/pip-pcmntb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:37 INFO - Running setup.py (path:/tmp/pip-sfXeoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:37 INFO - Running setup.py (path:/tmp/pip-qFPMbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:37 INFO - Running setup.py (path:/tmp/pip-MoDc6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:37 INFO - Running setup.py (path:/tmp/pip-6VrZ_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:37 INFO - Running setup.py (path:/tmp/pip-iPWRgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:37 INFO - Running setup.py (path:/tmp/pip-o_zy0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:37 INFO - Running setup.py (path:/tmp/pip-BonR_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:37 INFO - Running setup.py (path:/tmp/pip-oe8i90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:32:37 INFO - Running setup.py install for manifestparser 10:32:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:32:37 INFO - Running setup.py install for mozcrash 10:32:37 INFO - Running setup.py install for mozdebug 10:32:38 INFO - Running setup.py install for mozdevice 10:32:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:32:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:32:38 INFO - Running setup.py install for mozfile 10:32:38 INFO - Running setup.py install for mozhttpd 10:32:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:32:38 INFO - Running setup.py install for mozinfo 10:32:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:32:38 INFO - Running setup.py install for mozInstall 10:32:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:32:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:32:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:32:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:32:38 INFO - Running setup.py install for mozleak 10:32:38 INFO - Running setup.py install for mozlog 10:32:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:32:38 INFO - Running setup.py install for moznetwork 10:32:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:32:38 INFO - Running setup.py install for mozprocess 10:32:38 INFO - Running setup.py install for mozprofile 10:32:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:32:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:32:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:32:39 INFO - Running setup.py install for mozrunner 10:32:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:32:39 INFO - Running setup.py install for mozscreenshot 10:32:39 INFO - Running setup.py install for moztest 10:32:39 INFO - Running setup.py install for mozversion 10:32:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:32:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:32:39 INFO - Cleaning up... 10:32:39 INFO - Return code: 0 10:32:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:39 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 0x7fec9763ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae410>, '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 0x1aaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7a0>, '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': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:32:39 INFO - Using env: {'DISPLAY': ':0', 10:32:39 INFO - 'HOME': '/home/cltbld', 10:32:39 INFO - 'LANG': 'en_US.UTF-8', 10:32:39 INFO - 'LANGUAGE': 'en_US:en', 10:32:39 INFO - 'LOGNAME': 'cltbld', 10:32:39 INFO - 'MAIL': '/var/mail/cltbld', 10:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:39 INFO - 'MOZ_NO_REMOTE': '1', 10:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:39 INFO - 'NO_EM_RESTART': '1', 10:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:39 INFO - 'PWD': '/builds/slave/test', 10:32:39 INFO - 'SHELL': '/bin/bash', 10:32:39 INFO - 'SHLVL': '1', 10:32:39 INFO - 'TERM': 'linux', 10:32:39 INFO - 'TMOUT': '86400', 10:32:39 INFO - 'USER': 'cltbld', 10:32:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 10:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:39 INFO - '_': '/tools/buildbot/bin/python'} 10:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:39 INFO - Running setup.py (path:/tmp/pip-ztn4y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:39 INFO - Running setup.py (path:/tmp/pip-MVXRCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:39 INFO - Running setup.py (path:/tmp/pip-ppFRI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:39 INFO - Running setup.py (path:/tmp/pip-887uWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:40 INFO - Running setup.py (path:/tmp/pip-xT5q_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:40 INFO - Running setup.py (path:/tmp/pip-lHvLy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:40 INFO - Running setup.py (path:/tmp/pip-vxbgI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:40 INFO - Running setup.py (path:/tmp/pip-VIK8YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:40 INFO - Running setup.py (path:/tmp/pip-bEVz2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:40 INFO - Running setup.py (path:/tmp/pip-Ct2UWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:40 INFO - Running setup.py (path:/tmp/pip-D7J4el-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:40 INFO - Running setup.py (path:/tmp/pip-sHqLgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:40 INFO - Running setup.py (path:/tmp/pip-dkr2Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:40 INFO - Running setup.py (path:/tmp/pip-kOkN3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:40 INFO - Running setup.py (path:/tmp/pip-Jozfd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:40 INFO - Running setup.py (path:/tmp/pip-xEEbuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:40 INFO - Running setup.py (path:/tmp/pip-r6Rqvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:32:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:42 INFO - Downloading blessings-1.6.tar.gz 10:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:32:42 INFO - Installing collected packages: blessings 10:32:42 INFO - Running setup.py install for blessings 10:32:43 INFO - Successfully installed blessings 10:32:43 INFO - Cleaning up... 10:32:43 INFO - Return code: 0 10:32:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:32:43 INFO - Reading from file tmpfile_stdout 10:32:43 INFO - Current package versions: 10:32:43 INFO - argparse == 1.2.1 10:32:43 INFO - blessings == 1.6 10:32:43 INFO - blobuploader == 1.2.4 10:32:43 INFO - docopt == 0.6.1 10:32:43 INFO - manifestparser == 1.1 10:32:43 INFO - mozInstall == 1.12 10:32:43 INFO - mozcrash == 0.17 10:32:43 INFO - mozdebug == 0.1 10:32:43 INFO - mozdevice == 0.48 10:32:43 INFO - mozfile == 1.2 10:32:43 INFO - mozhttpd == 0.7 10:32:43 INFO - mozinfo == 0.9 10:32:43 INFO - mozleak == 0.1 10:32:43 INFO - mozlog == 3.1 10:32:43 INFO - moznetwork == 0.27 10:32:43 INFO - mozprocess == 0.22 10:32:43 INFO - mozprofile == 0.28 10:32:43 INFO - mozrunner == 6.11 10:32:43 INFO - mozscreenshot == 0.1 10:32:43 INFO - mozsystemmonitor == 0.0 10:32:43 INFO - moztest == 0.7 10:32:43 INFO - mozversion == 1.4 10:32:43 INFO - psutil == 3.1.1 10:32:43 INFO - requests == 1.2.3 10:32:43 INFO - wsgiref == 0.1.2 10:32:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:43 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 0x7fec9763ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae410>, '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 0x1aaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7a0>, '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': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:32:43 INFO - Using env: {'DISPLAY': ':0', 10:32:43 INFO - 'HOME': '/home/cltbld', 10:32:43 INFO - 'LANG': 'en_US.UTF-8', 10:32:43 INFO - 'LANGUAGE': 'en_US:en', 10:32:43 INFO - 'LOGNAME': 'cltbld', 10:32:43 INFO - 'MAIL': '/var/mail/cltbld', 10:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:43 INFO - 'MOZ_NO_REMOTE': '1', 10:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:43 INFO - 'NO_EM_RESTART': '1', 10:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:43 INFO - 'PWD': '/builds/slave/test', 10:32:43 INFO - 'SHELL': '/bin/bash', 10:32:43 INFO - 'SHLVL': '1', 10:32:43 INFO - 'TERM': 'linux', 10:32:43 INFO - 'TMOUT': '86400', 10:32:43 INFO - 'USER': 'cltbld', 10:32:43 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 10:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:43 INFO - '_': '/tools/buildbot/bin/python'} 10:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:32:43 INFO - Cleaning up... 10:32:43 INFO - Return code: 0 10:32:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:43 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 0x7fec9763ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae410>, '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 0x1aaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7a0>, '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': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:32:43 INFO - Using env: {'DISPLAY': ':0', 10:32:43 INFO - 'HOME': '/home/cltbld', 10:32:43 INFO - 'LANG': 'en_US.UTF-8', 10:32:43 INFO - 'LANGUAGE': 'en_US:en', 10:32:43 INFO - 'LOGNAME': 'cltbld', 10:32:43 INFO - 'MAIL': '/var/mail/cltbld', 10:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:43 INFO - 'MOZ_NO_REMOTE': '1', 10:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:43 INFO - 'NO_EM_RESTART': '1', 10:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:43 INFO - 'PWD': '/builds/slave/test', 10:32:43 INFO - 'SHELL': '/bin/bash', 10:32:43 INFO - 'SHLVL': '1', 10:32:43 INFO - 'TERM': 'linux', 10:32:43 INFO - 'TMOUT': '86400', 10:32:43 INFO - 'USER': 'cltbld', 10:32:43 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 10:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:43 INFO - '_': '/tools/buildbot/bin/python'} 10:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:43 INFO - Downloading/unpacking jsonschema 10:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:32:45 INFO - Downloading/unpacking functools32 (from jsonschema) 10:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:45 INFO - Downloading functools32-3.2.3-2.tar.gz 10:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:32:45 INFO - warning: no files found matching '*.txt' 10:32:45 INFO - no previously-included directories found matching 'build' 10:32:45 INFO - no previously-included directories found matching 'dist' 10:32:45 INFO - no previously-included directories found matching '.git*' 10:32:45 INFO - Installing collected packages: jsonschema, functools32 10:32:46 INFO - Running setup.py install for functools32 10:32:46 INFO - warning: no files found matching '*.txt' 10:32:46 INFO - no previously-included directories found matching 'build' 10:32:46 INFO - no previously-included directories found matching 'dist' 10:32:46 INFO - no previously-included directories found matching '.git*' 10:32:46 INFO - Successfully installed jsonschema functools32 10:32:46 INFO - Cleaning up... 10:32:46 INFO - Return code: 0 10:32:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:46 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 0x7fec9763ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae410>, '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 0x1aaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7a0>, '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': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:32:46 INFO - Using env: {'DISPLAY': ':0', 10:32:46 INFO - 'HOME': '/home/cltbld', 10:32:46 INFO - 'LANG': 'en_US.UTF-8', 10:32:46 INFO - 'LANGUAGE': 'en_US:en', 10:32:46 INFO - 'LOGNAME': 'cltbld', 10:32:46 INFO - 'MAIL': '/var/mail/cltbld', 10:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:46 INFO - 'MOZ_NO_REMOTE': '1', 10:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:46 INFO - 'NO_EM_RESTART': '1', 10:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:46 INFO - 'PWD': '/builds/slave/test', 10:32:46 INFO - 'SHELL': '/bin/bash', 10:32:46 INFO - 'SHLVL': '1', 10:32:46 INFO - 'TERM': 'linux', 10:32:46 INFO - 'TMOUT': '86400', 10:32:46 INFO - 'USER': 'cltbld', 10:32:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 10:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:46 INFO - '_': '/tools/buildbot/bin/python'} 10:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:46 INFO - Downloading/unpacking flake8 10:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:32:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:32:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:32:48 INFO - no previously-included directories found matching 'docs/_build' 10:32:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:32:49 INFO - Running setup.py install for pep8 10:32:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:32:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:32:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:32:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:32:49 INFO - no previously-included directories found matching 'docs/_build' 10:32:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:32:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:32:49 INFO - Cleaning up... 10:32:49 INFO - Return code: 0 10:32:49 INFO - Running post-action listener: _resource_record_post_action 10:32:49 INFO - Running post-action listener: _start_resource_monitoring 10:32:49 INFO - Starting resource monitoring. 10:32:49 INFO - ##### 10:32:49 INFO - ##### Running install step. 10:32:49 INFO - ##### 10:32:49 INFO - Running pre-action listener: _resource_record_pre_action 10:32:49 INFO - Running main action method: install 10:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:32:49 INFO - Reading from file tmpfile_stdout 10:32:49 INFO - Detecting whether we're running mozinstall >=1.0... 10:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:32:49 INFO - Reading from file tmpfile_stdout 10:32:49 INFO - Output received: 10:32:49 INFO - Usage: mozinstall [options] installer 10:32:49 INFO - Options: 10:32:49 INFO - -h, --help show this help message and exit 10:32:49 INFO - -d DEST, --destination=DEST 10:32:49 INFO - Directory to install application into. [default: 10:32:49 INFO - "/builds/slave/test"] 10:32:49 INFO - --app=APP Application being installed. [default: firefox] 10:32:49 INFO - mkdir: /builds/slave/test/build/application 10:32:49 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'] 10:32:49 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 10:33:02 INFO - Reading from file tmpfile_stdout 10:33:02 INFO - Output received: 10:33:02 INFO - /builds/slave/test/build/application/firefox/firefox 10:33:02 INFO - Running post-action listener: _resource_record_post_action 10:33:02 INFO - ##### 10:33:02 INFO - ##### Running run-tests step. 10:33:02 INFO - ##### 10:33:02 INFO - Running pre-action listener: _resource_record_pre_action 10:33:02 INFO - Running main action method: run_tests 10:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:33:02 INFO - Python 2.7.3 10:33:02 INFO - Return code: 0 10:33:02 INFO - grabbing minidump binary from tooltool 10:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:02 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 0x1aae410>, '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 0x1aaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:33:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:33:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:33:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:33:02 INFO - Return code: 0 10:33:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:33:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:33:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:33:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:33:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:33:03 INFO - Return code: 0 10:33:03 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/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:33:03 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/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:33:03 INFO - Using env: {'DISPLAY': ':0', 10:33:03 INFO - 'HOME': '/home/cltbld', 10:33:03 INFO - 'LANG': 'en_US.UTF-8', 10:33:03 INFO - 'LANGUAGE': 'en_US:en', 10:33:03 INFO - 'LOGNAME': 'cltbld', 10:33:03 INFO - 'MAIL': '/var/mail/cltbld', 10:33:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:33:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:03 INFO - 'MOZ_NO_REMOTE': '1', 10:33:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:03 INFO - 'NO_EM_RESTART': '1', 10:33:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:03 INFO - 'PWD': '/builds/slave/test', 10:33:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:33:03 INFO - 'SHELL': '/bin/bash', 10:33:03 INFO - 'SHLVL': '1', 10:33:03 INFO - 'TERM': 'linux', 10:33:03 INFO - 'TMOUT': '86400', 10:33:03 INFO - 'USER': 'cltbld', 10:33:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311', 10:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:03 INFO - '_': '/tools/buildbot/bin/python'} 10:33:03 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/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:33:04 INFO - mozversion application_buildid: 20160705073512 10:33:04 INFO - mozversion application_changeset: 059550e65473bb4a1cbb53c963e7ac7bc24b778a 10:33:04 INFO - mozversion application_display_name: Firefox 10:33:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:33:04 INFO - mozversion application_name: Firefox 10:33:04 INFO - mozversion application_remotingname: firefox 10:33:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:33:04 INFO - mozversion application_vendor: Mozilla 10:33:04 INFO - mozversion application_version: 48.0 10:33:04 INFO - mozversion platform_buildid: 20160705073512 10:33:04 INFO - mozversion platform_changeset: 059550e65473bb4a1cbb53c963e7ac7bc24b778a 10:33:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:33:04 INFO - mozversion platform_version: 48.0 10:33:04 INFO - using testdate: 1467739984 10:33:04 INFO - actual date: 1467739984 10:33:04 INFO - starting webserver on 'localhost:50560' 10:33:04 INFO - SUITE-START | Running 2 tests 10:33:04 INFO - TEST-START | dromaeo_css 10:33:04 INFO - operating with platform_type : linux_ 10:33:04 INFO - Initialising browser for dromaeo_css test... 10:33:04 INFO - TEST-INFO | started process 3351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_ieUAA/profile http://localhost:50560/getInfo.html) 10:33:07 INFO - PROCESS | 3351 | 10:33:07 INFO - PROCESS | 3351 | (process:3431): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:33:08 INFO - PROCESS | 3351 | __metrics Screen width/height:1600/1200 10:33:08 INFO - PROCESS | 3351 | colorDepth:24 10:33:08 INFO - PROCESS | 3351 | Browser inner width/height: 1024/697 10:33:08 INFO - PROCESS | 3351 | __metrics 10:33:09 ERROR - PROCESS | 3351 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:33:10 INFO - TEST-INFO | 3351: exit 0 10:33:10 INFO - Browser initialized. 10:33:10 INFO - Running cycle 1/1 for dromaeo_css test... 10:33:10 INFO - TEST-INFO | started process 3481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_ieUAA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:11 INFO - PROCESS | 3481 | 10:33:11 INFO - PROCESS | 3481 | (process:3553): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:33:21 INFO - PROCESS | 3481 | RSS: Main: 150757376 10:33:21 INFO - PROCESS | 3481 | 10:34:11 INFO - PROCESS | 3481 | 1467740051383 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:36:18 INFO - PROCESS | 3481 | Cycle 1(1): loaded http://localhost:50560/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50560/tests/dromaeo/cssquery-ext.html) 10:36:19 INFO - PROCESS | 3481 | RSS: Main: 154226688 10:36:19 INFO - PROCESS | 3481 | 10:39:21 INFO - PROCESS | 3481 | Cycle 1(1): loaded http://localhost:50560/tests/dromaeo/cssquery-ext.html (next: http://localhost:50560/tests/dromaeo/cssquery-jquery.html) 10:39:22 INFO - PROCESS | 3481 | RSS: Main: 152600576 10:39:22 INFO - PROCESS | 3481 | 10:42:23 INFO - PROCESS | 3481 | Cycle 1(1): loaded http://localhost:50560/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50560/tests/dromaeo/cssquery-mootools.html) 10:42:24 INFO - PROCESS | 3481 | RSS: Main: 152453120 10:42:24 INFO - PROCESS | 3481 | 10:45:25 INFO - PROCESS | 3481 | Cycle 1(1): loaded http://localhost:50560/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50560/tests/dromaeo/cssquery-prototype.html) 10:45:26 INFO - PROCESS | 3481 | RSS: Main: 154005504 10:45:26 INFO - PROCESS | 3481 | 10:48:28 INFO - PROCESS | 3481 | Cycle 1(1): loaded http://localhost:50560/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50560/tests/dromaeo/cssquery-yui.html) 10:48:29 INFO - PROCESS | 3481 | RSS: Main: 152383488 10:48:29 INFO - PROCESS | 3481 | 10:51:31 INFO - PROCESS | 3481 | Cycle 1(1): loaded http://localhost:50560/tests/dromaeo/cssquery-yui.html (next: http://localhost:50560/tests/dromaeo/cssquery-dojo.html) 10:51:31 INFO - PROCESS | 3481 | RSS: Main: 156020736 10:51:31 INFO - PROCESS | 3481 | 10:51:31 INFO - PROCESS | 3481 | __start_tp_report 10:51:31 INFO - PROCESS | 3481 | _x_x_mozilla_page_load 10:51:31 INFO - PROCESS | 3481 | _x_x_mozilla_page_load_details 10:51:31 INFO - PROCESS | 3481 | |i|pagename|runs| 10:51:31 INFO - PROCESS | 3481 | |0;dojo.html;3282.425575524283;3317.618473875505;3321.2527181384175;3339.8330083495835;3361.932761344773;5450.509454149126;5499.642523235992;5518.668879867206;5528.917066244005;5545.445455454453;5500.972495137528;5523.7790488380515;5545.861353466165;5559.749811258493;5573.331200255965;5005.399352077756;5016.247562865572;5070.366204224472;5079.720615366154;5101.311322971407;5007.223880298559;5039.6976181429045;5075.441701412841;5125.231215317714;5163.690178589278;5043.445221025684;5118.539331460168;5123.666961647499;5145.614078944075;5146.150885103972;5138.100832354342;5157.587393008569;5158.664686795346;5172.560332371753;5201.427842937273;4904.656674032819;4982.90034199314;5016.924746128811;5056.570191533688;5061.544460998491;5395.379531353905;5456.345238571397;5462.672239665632;5483.616146869721;5493.478119578634;5913.586048976574;5922.141289512996;5932.79235226765;5943;5945.762169513214;5873.500752436048;5883.646981181143;5902.911456328158;5961;5985.790497332572;5462.6995515246645;5532.695701736403;5543.307086614173;5545.61180717354;5606.915896261559;5887.676177810176;5925.111233315038;5926.140709597171;5935.940640593539;5938.406159384027;5715.5427565794635;5721.084626459747;5728.226689396962;5761.567882408836;5801.448862358069;5876.1479585459865;5885.14665373527;5888.941110588925;5898.203742494708;5916.142159386951;5873.20711703923;5874.794382196688;5879.206307148565;5885.823425297248;5886.646801191942;5792.739326730307;5924.081767326072;5981.850453738692;5988.461038506555;5996.490298324691;4486.910261794746;4516.16450956574;4531.478879928784;4534.161180181677;4549.6360291176625;3953.347697629859;4057.2899742544937;4073.2260870434525;4099.221147981874;4108.712390132662;5562.3047119110115;5653.519450846642;5680.857978550569;5732.598718089694;5780.335261444903;5786.623869448473;5797.159411885337;5810.854728631733;5819.272590926134;5840.5035571976005;5580.609357345028;5583.69289689071;5585.553155747531;5585.58108141891;5724.656520608777;4999.675021123688;5012.348394708737;5043.52086551777;5051.318072060299;5074.771635276422;6210.875782484325;6236.03341482071;6261.342559031327;6267.96866015667;6269.279032911182;5657.15142728594;5912.793052243151;5964.821055368346;5988.640681559121;6007.669578173068;6063.211782468251;6078.118672792509;6092.482139018056;6097.75608975636;6127.080937859178;5673.943260567342;5717.571182161271;5724.227229323988;5741.110127930177;5744.396838332083;5780.21967034445;5804.419558044162;5819.76720931158;5827.854303642273;5867.354590994902;5787.536997040311;5822.5633077518505;5826.73779679907;5835.854103647443;5841.357450680507;5752.6836024019085;5788.82633520995;5815.883682326415;5830.387809279964;5835.212246346859;5486.369067557282;5535.723213839373;5570.19232211319;5582;5610.074337734228;5702.885942281048;5734.913976290276;5758.712064396847;5772.422757724194;5776.508996735157;5608.383077861514;5634.352049514358;5641.351244606759;5645.181448689999;5648.915266271091 10:51:31 INFO - PROCESS | 3481 | |1;ext.html;620.6090163197185;638.3839594791026;662.6024385368779;675.8310422394403;684.127737135153;39243;40236.798816005954;40242.19515609686;40500.18999620006;40539.39190912139;42837.571624283744;43755;43823;43869.341959870544;43996.780016099954;8745.912540874606;8822.955885220565;8851.77870553238;8865.246454051414;8910.910890891106;8705.129487051276;8773.078826723198;8780.25367843734;8787.868181977276;8806.251468625143;9031.41295815773;9035.638574457014;9056.094390560924;9071.274298056172;9075.773105672344;8961.95519022404;9001.729948101567;9019.503927283997;9022.639094436214;9074.183323500916;8924.821503569958;9060.139286767746;9061.093890610951;9079.546022698838;9088.863667045;43199.78400108011;43373.34939975903;43709.78145109254;43749.34375984363;43874.341884871756;3763.5483741950866;3814.16088460541;3857.112864041258;3859.939617178854;3911.9608803912165;32684.836575817208;33028.50457243143;33085.83457082723;33443.33113337744;33516.49725254123;4328.523862375137;4556.954430455686;4629.213033784265;4637.582617564435;4652.837150699709;314808;316794;317851;318518;318869;61827.6908615463;62743.6862815683;62781.372186278466;62793.058104128475;62829.37170628235;68906.310936891;69700.3029969704;70144.64927675329;70234;70498;18789.906050469934;18929.337473188647;19000.429987100408;19037.14332855025;19119.330823421114;14791.556253312418;14860.405583776745;14875.479358222627;14878.776818347733;14937.551873443814;19872.60254794925;19993.300234491722;20105.497362566053;20144.89927550353;20723.378298651063;7273.745418910418;7534.321911028033;7654.196309387434;7993.480423772552;8048.235417635316;1070.8500809886623;1075.102289588187;1106.1040557148735;1159.1074872348245;1167.1246565076192;32682.836585817393;32798.836005819816;32884;33039.66960330414;33173;1223.816427535859;1245.9127861049822;1251.4368534159482;1256.1458208418362;1258.7608354412632;16719.582010449594;16838.326466941184;17030.829691703173;17078.91460542714;17164.656706865793;479989.6000519975;488087;569595;834820;849120;61387;62276.37723622796;62767.686161569814;62873;62879;1533.9002964807253;1533.9002964807253;1536.5313579358403;1537.4465192530456;1566.326479613777;31919.68080319167;31970;32323.838380808887;32681.509777353833;32971.83514082414;53657.46342536525;54390.45609543854;54447.72776136094;54710;54819.17771233355;433838;440957;441827;441839;441911;30708.692913070583;30919.381612368077;31149.532757008208;31185.53221701631;31365.843170784;48574.27138592995;49143.754281228365;49271.753641233;49459;49482;40718.79640601896;40953;41478.37782433326;42593.5740642602;42652.5734742661;40420.595794042856;40976.1804763909;41838.581614183466;42697.35953960631;43103;42948;43600.78199608982;43628.12743745171;43637;43898.34152487779;35215.647843521234;35576;35990.8200458996;37055.258894822495;38017.809910950265;27237.591436128077;27291.181264562096;27492.862535687993;27651.446971060064;27713.584296235975 10:51:31 INFO - PROCESS | 3481 | |2;jquery.html;434.86084452975024;435.69936743646883;439.3453753906678;442.7498463368197;450.4616982705668;18453.907730461346;18893.99999999998;19485.318013869517;20510.17959281627;20559.794402055973;19719.408417747454;20055.097520611573;20111.698324525107;20378.082986265617;20393;5590.776368945238;5618.606697531174;5822.53419726423;5827.271591051119;5830.3586605473365;4299.634531064848;5453.527047055393;5765.740541675614;5765.855853603652;6204.410580994799;6131.14164017038;6155.446009859112;6177;6179.629222246657;6200.224971878515;5715.0855863061915;5972.044472884361;5972.820815375546;5979.581429299951;5980.6112602680905;5733.3406658234;5793.044147715622;5814.534837213055;5838.941610583882;5841.649501029951;21752.89123554388;22081.779182208134;23796.405089872893;23881.880590596935;23894.402639934142;2489.6887889013874;2593.481303739241;2814.352698879269;2964.8910230519514;3139.9843000785077;10246.231532635082;10746.301490403177;10746.785064298749;10756.247062705614;10964.396958167297;1969.9113539890739;2044.31515442327;2143.7856214378594;2159.276642324823;2167.5014746608213;80089.59955200244;83803;87601;87608.56195719044;90655.54672226662;11160.720981975353;11378.658640240807;11448.885511144948;11778.469968851423;11780.764384712258;15904.602384940237;15909.284082216329;15991.28039238237;16003.839961600468;16061.598460038593;8497.957510212409;8959.776005599912;9059.547022648841;9137.360384773003;9197.678081267124;9046.366754327266;9058.139476749699;9063.864042039375;9064.728058158265;9119.133682300171;5077.568406685473;5081.974590127025;5127.384713834289;5134.640575159703;5154.845354639367;2081.469225347527;2093.968590471144;2138.5936672032576;2153.171029153787;2157.2018353209414;1016.3343010328247;1019.6686077024848;1033.5452400943561;1073.5759375046812;1123.7920984617708;18530;18879.339223127125;18882.905585471985;19325;19719;1126.4649291586431;1128.6331942118845;1146.3064845768356;1173.3077484284313;1208.8428504294561;10725.356478611153;10975.396353200491;10975.670729878117;11023.228374013743;11036.392998385167;506796;513404;524457;544089;544763;59247.40752592419;95204.52397738106;95479;95848.52075739716;97069.5146524277;1094.272308914563;1106.0101209417526;1173.6831055614937;1174.929504229749;1191.7854786138405;16925.74611380855;16933.576660583585;16959.406420775213;17044.914775426045;17082;40609.18781624292;41097.178056438104;41201;41448;42151.57848421599;57473.42526574681;60412.395876040675;61199.38800611937;61382.69308653428;61487;8684.652613895374;8895.822083558422;8951.507667078113;9071.682491112779;9270.953645231732;12760.596334403022;13052.934735326262;13188.80216796768;13213.867861321263;13437.86562134366;11373.43132843338;11562.421878906189;11621.76756464883;11754.412279386168;11790.528378864748;5282.418933917343;6193.907091393723;8362.498250105013;11884;11990.100742444525;12294.631161065183;12444.191127576678;12496;12536.937315313366;12886.806697899352;8946.86579701318;8973.416727912665;9136.771580710536;9227.261819054325;9236.168744813;11736.94131529371;11810.645680629596;11826.315946972987;11884.227525210834;12079.637610871689 10:51:31 INFO - PROCESS | 3481 | |3;mootools.html;1594.617291849956;1622.675464907019;1840.6870831958574;1942.0581018206176;1960.1473359088789;7613.8477230455355;8201.343892488601;8344.91655083449;8353.248207661309;8400.537970411626;8407.411481196319;8412.95793521033;8470.957645211765;8496.575171241444;8497.405181637288;2419.0323870451784;2426.5268272686744;2432.5378178146098;2436.049940523197;2450.068973789966;2363.196513185517;2367.5146594948083;2419.7822196002357;2432.501337225873;2434.3548959525738;2438.6829712137396;2451.5464639041834;2474.010395841669;2478.08310924958;2478.876056197192;2332.486852892361;2335.0309621507054;2335.241046659834;2426.793722533569;2484.838485498437;2466.802655787533;2472.950540989188;2473.789727873133;2477.157766359446;2479.404942813712;8702.47785132894;8753.562321883881;8760.474371537664;8806.339524535686;8809.779755506164;5498.917516237259;5597.580181486404;5624.015797235467;5651.9152212716845;5652.406497317764;3478.0609235506527;3492.2840817632323;3541.8760343388117;3663.285659296438;3665.4685070664873;1174.6006357838376;1178.6581891251612;1202.5610652111916;1203.175824560179;1215.1190386969465;12239;12267.447964841604;12279.93860030703;12297.877021229762;12360.938195309056;4670.929936050962;4827.42070951488;4835.492273311252;4836.830710925171;4921.729304888194;10499.422531760827;10507.474626268657;10517.158627309796;10517.316374435637;10522.368657880552;5528.281323427928;5563.8887222256135;5574.9721251393485;5583.134614134816;5583.525400340935;4804.447488538863;4964.081644895706;4973.577245934136;4996.775145118479;5087.97456012725;3953.802309884494;3971.225611005884;3985.92028159441;3993.4209539616595;4096.05790668148;1212.2423485321674;1226.8711785262597;1229.8647148813623;1230.1819290172114;1231.2243286729304;1014.1481155829139;1024.5082360467018;1029.6705054382676;1043.3635482355758;1073.9140868730483;5724.026556612241;5962.850928726816;6068.6358818471035;6105.481034112061;6206.627602343874;453.62802501948744;466.53113620811547;474.8171953797744;487.3883276487985;1129.5877004893155;4097.44684467593;4161.500619925568;4241.957580424218;4273.508546517128;4293.785310734451;10434.530446129942;10680.839787403194;10817.567297308176;10831;10860.61987830438;10509.9474502627;10575.841362379571;10719.303245289031;10750.838737418944;10895.128389728803;8195.262426381654;8287.295579875778;8295.129011453831;8347.749567512985;8439.915600844035;5962.8968640801595;5995.700214989321;6027.21646185993;6072.605280656743;6129.4483496483745;9423.905760942303;9564.378315409476;9617.23062155012;9647.179989700953;9721.56252968604;9087.863682044643;9345.205657518914;9425.905740942502;9562.521873906417;9755.170810481188;7685.730999414994;7950.40371972116;7979.521228726295;8197.83604327922;8331.291840193651;8102.351811855156;8111.634976426193;8122;8143.959280203561;8152.103268640326;7219.241979592067;7273.272672732896;7323.304286092813;7458.813529661802;7531.661075251736;7102.360787529147;7180.5691658500655;7265.636718164176;7322.707091716272;7359.411247100326;7188.388986936169;7193.928060719326;7205.279472052753;7209.531380460253;7216.422686185198;5271.65734227274;5292.311999440049;5327.573794096385;5483.616146869681;5492.642978206404;5215.113430716863;5221.608379371486;5260.526552610283;5285.656432331886;5353.411124776194 10:51:31 INFO - PROCESS | 3481 | |4;prototype.html;352.9047157267538;361.50834864584164;362.7207050571061;363.3786225554302;365.47736736466874;6305.117283580296;6415.967920160404;6418.069379939906;6421.13314702515;6444.291127975925;6268.623882567038;6319.368063193679;6328.33552476989;6349;6359.745610175587;4713.622910167179;4812.831550895719;4860.3195552622665;4865.051314993578;4882.121218180726;4829.975850120762;4840;4841.975790121044;4857.927131093019;4863.246196839478;4804;4812.061647978646;4813.205821039524;4816.470188279286;4830.3720516333005;4813.422389313269;4814.253790662436;4822.324874517571;4831;4837.129316722989;4235.75045361616;4241.618254357092;4247.511536173349;4250.149970006011;4251.681123915688;6095.542834287447;6132.110843927606;6147.600405973598;6160.84597885052;6170.2904166021035;5439.156930675712;5580.218769372291;5586.832395028156;5630.380658127603;5640.125780504029;6650.833729156761;6680.231773346079;6686.83282917926;6712.5301228913995;6725;4651.488336283006;4659.534046595347;4661.953380466186;4664.973705784756;4667.649926255511;7012.684429200698;7076.292370762934;7088.787336379917;7096.893546596805;7127.572345659225;4761.928571071437;4774.546418090275;4779.569838714463;4784.114938736345;4786.473487916326;4753.4295884493395;4863.562279394871;4864.343313652683;4866.221404575251;4872.756362181947;5573.442655734475;5615.18579805934;5619.775208991677;5623.5220006299105;5626.578006649518;6760.222574404006;6812.318768123148;6827.863442731117;6828.487863410165;6842.04211410393;1693.4750227429536;1722.070082155647;1722.1733567887484;1723.4054251283537;1729.1872819774685;1105.8562386889653;1122.1583812140893;1127.926684765504;1129.7796929598649;1139.202558209257;6643.10318107059;6670.332966703291;6673.699683514254;6674.365935236145;6693.698783554752;7042.471814613925;7045.0489183960535;7047.859042819115;7053.153621565445;7053.294670532906;6523.380278873595;6679.732810687616;6695.665216739144;6765;6780.525363224527;3806.1626442182674;3830.0807806126886;3831.061389959422;3843.3466310727244;3851.672607828366;7480.700771969169;7496.362809161174;7498.550086994798;7508.361789247866;7520.435967302475;7222.927770722331;7232.566046037255;7243.022192004012;7243.818904527429;7246.855062898712;7150.284971502808;7355.705771769176;7363.7422690205585;7389.852202956018;7470.589117598475;7047.08387909589;7058.576485410892;7089.326513981164;7090.007398964252;7102.431805455654;6971.26801685836;6976.476764242803;6979.616121113388;6989.930100698928;7007.789766307019;7461.403087753075;7478.775636730907;7478.850422991619;7485.588292643957;7486.176520582622;4720.5043470436485;4755.453122890912;4795.424549054136;4822.059698358787;4832;7014.824629384306;7020.911758677413;7043.295670432915;7062.117235345582;7063.117110361205;6848.452123829982;6860.656967151523;6860.828479288058;6868.656567171522;6869.862602748017;6799.048133261446;6815.045893575003;6838.829029274308;6853.451723862178;6863.245043045161;6639.767608133692;6650.46796256308;6700;6727.663616819237;6743.9325606743305;6865.828354291183;6897.7585784497305;6900.516963812485;6900.516963812685;6909.067275917687;6741.1910570731825;6745.662716864235;6752.358525940028;6753.020811982334;6759.188897332351 10:51:31 INFO - PROCESS | 3481 | |5;yui.html;810.2424233341826;825.2490233887164;837.8785076163955;868.1882439918677;939.7744541310079;15134.394624215032;15241;15290.847091529082;15342.84657153428;15364.53906382809;12429.937850310758;13730;13744.381502832372;13759.862401375984;13856.861431385683;882.2368651116786;894.0880302091863;894.7449976756626;897.0580890065438;898.7169041751828;874.0298268921492;878.1174919206189;894.6153154143716;896.1934259166737;897.9191872731453;917.5595714057257;927.1979737527024;936.4802534593298;936.494293081735;938.3994243684048;909.9181073703365;928.5914197753001;930.0978051290238;936.6628013915054;937.5640327247862;688.5008368932534;689;690.1959217511593;692.560224257595;694.7464175575928;15334.23328833554;15372.00081994678;15383.461578844686;15424.151671658054;15438.691226175413;13918.930405347908;13942.163470191821;14127.293635318296;14159.929200353932;14260.28698565078;11761;12003.759924801456;12011.339376334297;12074.456649450707;12425.192362496498;3968.4245784361397;3973.662238709713;3993.1414745829784;4020.19596080785;4072.9389059164137;56970.715146424416;57058.42941570573;57394;57469;57513.712431437576;11380.089592832554;11830;11847.288303985597;11884.227525211007;12062.638120856389;21358.145674172858;21362.679559806616;21401.14395424197;21481.248156314454;21560.676589851166;8294.253517183482;8366.707165249187;8523.147685231428;8582.098879617675;8694.91305086941;4887.780049897763;4918.43438004634;5017.096922553902;5027.396712394536;5093.363329583802;3620.167361506868;3668.523091998023;3680.7607505512055;3682.245139746399;3694.2057457646733;693.1820451866745;694.0456871801273;698.1656919980676;706.0221593093603;714.5744240240753;672.4989882537443;696.8919817428307;732.6117157906318;736.569107072358;757.5757575757483;9348.57931393089;9780.364276322016;9805.411675299505;10128.746781330527;10140.949295253624;695.5861262548775;733.186163358682;744.9515781474187;751.1737089201835;760.6196901549225;4344.304911214191;4570.428696412949;4634.165850146938;4647.581717645428;4696.694714843524;67900.66049669818;68581.3141868585;68755.31244687489;68830;69160;59268.110978334495;60893;61520.38479615146;62107.06839397413;62388.37611623826;53668.19497707616;54642.180367294524;54759.45240547544;54880.72559637176;55652.72173639106;9089.681861134828;9234.30742694314;9325.300602454707;9364.344495885223;9410.905890941276;38748.225035499694;39178.80410597929;39225;39267.60732392639;40269.79865100656;50189;51878;51968;52397.21404178864;52788.736056319474;11363.48864301125;11459.19785614999;11579.8263026053;11594.47824847867;11723.531058757555;12643.557475488315;12729.29988850622;12754.808677870025;12981.870181298065;13219;11664.183507154758;11695.245460358778;11729.592448906185;11856.347900865536;12236.327002014974;12038.638840834788;12041.81937270924;12135.150539462153;12224.938875305566;12359.876401235873;11500.654980350602;11676.70808229801;12486.250824950532;12816.55142070023;12820.551280705131;10293.073623373633;10469.476526173814;10565;10810;10814.837777433188;10455.215858810467;10636.031724800803;11083.612073577386;11161.888381116085;11199.440027998404 10:51:31 INFO - PROCESS | 3481 | __end_tp_report 10:51:31 INFO - PROCESS | 3481 | __start_cc_report 10:51:31 INFO - PROCESS | 3481 | _x_x_mozilla_cycle_collect,334 10:51:31 INFO - PROCESS | 3481 | __end_cc_report 10:51:31 INFO - PROCESS | 3481 | __startTimestamp1467741091935__endTimestamp 10:51:31 INFO - PROCESS | 3481 | 10:51:31 INFO - PROCESS | 3481 | ------- Summary: start ------- 10:51:31 INFO - PROCESS | 3481 | Number of tests: 6 10:51:31 INFO - PROCESS | 3481 | 10:51:31 INFO - PROCESS | 3481 | [#0] dojo.html Cycles:165 Average:5487.97 Median:5673.94 stddev:596.24 (10.5%) stddev-sans-first:572.42 10:51:31 INFO - PROCESS | 3481 | Values: 3282.4 3317.6 3321.3 3339.8 3361.9 5450.5 5499.6 5518.7 5528.9 5545.4 5501.0 5523.8 5545.9 5559.7 5573.3 5005.4 5016.2 5070.4 5079.7 5101.3 5007.2 5039.7 5075.4 5125.2 5163.7 5043.4 5118.5 5123.7 5145.6 5146.2 5138.1 5157.6 5158.7 5172.6 5201.4 4904.7 4982.9 5016.9 5056.6 5061.5 5395.4 5456.3 5462.7 5483.6 5493.5 5913.6 5922.1 5932.8 5943.0 5945.8 5873.5 5883.6 5902.9 5961.0 5985.8 5462.7 5532.7 5543.3 5545.6 5606.9 5887.7 5925.1 5926.1 5935.9 5938.4 5715.5 5721.1 5728.2 5761.6 5801.4 5876.1 5885.1 5888.9 5898.2 5916.1 5873.2 5874.8 5879.2 5885.8 5886.6 5792.7 5924.1 5981.9 5988.5 5996.5 4486.9 4516.2 4531.5 4534.2 4549.6 3953.3 4057.3 4073.2 4099.2 4108.7 5562.3 5653.5 5680.9 5732.6 5780.3 5786.6 5797.2 5810.9 5819.3 5840.5 5580.6 5583.7 5585.6 5585.6 5724.7 4999.7 5012.3 5043.5 5051.3 5074.8 6210.9 6236.0 6261.3 6268.0 6269.3 5657.2 5912.8 5964.8 5988.6 6007.7 6063.2 6078.1 6092.5 6097.8 6127.1 5673.9 5717.6 5724.2 5741.1 5744.4 5780.2 5804.4 5819.8 5827.9 5867.4 5787.5 5822.6 5826.7 5835.9 5841.4 5752.7 5788.8 5815.9 5830.4 5835.2 5486.4 5535.7 5570.2 5582.0 5610.1 5702.9 5734.9 5758.7 5772.4 5776.5 5608.4 5634.4 5641.4 5645.2 5648.9 10:51:31 INFO - PROCESS | 3481 | 10:51:31 INFO - PROCESS | 3481 | [#1] ext.html Cycles:180 Average:63456.20 Median:43025.50 stddev:132506.00 (308.0%) stddev-sans-first:132793.73 10:51:31 INFO - PROCESS | 3481 | Values: 620.6 638.4 662.6 675.8 684.1 39243.0 40236.8 40242.2 40500.2 40539.4 42837.6 43755.0 43823.0 43869.3 43996.8 8745.9 8823.0 8851.8 8865.2 8910.9 8705.1 8773.1 8780.3 8787.9 8806.3 9031.4 9035.6 9056.1 9071.3 9075.8 8962.0 9001.7 9019.5 9022.6 9074.2 8924.8 9060.1 9061.1 9079.5 9088.9 43199.8 43373.3 43709.8 43749.3 43874.3 3763.5 3814.2 3857.1 3859.9 3912.0 32684.8 33028.5 33085.8 33443.3 33516.5 4328.5 4557.0 4629.2 4637.6 4652.8 314808.0 316794.0 317851.0 318518.0 318869.0 61827.7 62743.7 62781.4 62793.1 62829.4 68906.3 69700.3 70144.6 70234.0 70498.0 18789.9 18929.3 19000.4 19037.1 19119.3 14791.6 14860.4 14875.5 14878.8 14937.6 19872.6 19993.3 20105.5 20144.9 20723.4 7273.7 7534.3 7654.2 7993.5 8048.2 1070.9 1075.1 1106.1 1159.1 1167.1 32682.8 32798.8 32884.0 33039.7 33173.0 1223.8 1245.9 1251.4 1256.1 1258.8 16719.6 16838.3 17030.8 17078.9 17164.7 479989.6 488087.0 569595.0 834820.0 849120.0 61387.0 62276.4 62767.7 62873.0 62879.0 1533.9 1533.9 1536.5 1537.4 1566.3 31919.7 31970.0 32323.8 32681.5 32971.8 53657.5 54390.5 54447.7 54710.0 54819.2 433838.0 440957.0 441827.0 441839.0 441911.0 30708.7 30919.4 31149.5 31185.5 31365.8 48574.3 49143.8 49271.8 49459.0 49482.0 40718.8 40953.0 41478.4 42593.6 42652.6 40420.6 40976.2 41838.6 42697.4 43103.0 42948.0 43600.8 43628.1 43637.0 43898.3 35215.6 35576.0 35990.8 37055.3 38017.8 27237.6 27291.2 27492.9 27651.4 27713.6 10:51:31 INFO - PROCESS | 3481 | 10:51:31 INFO - PROCESS | 3481 | [#2] jquery.html Cycles:180 Average:30276.96 Median:23888.14 stddev:86731.82 (363.1%) stddev-sans-first:86946.18 10:51:31 INFO - PROCESS | 3481 | Values: 434.9 435.7 439.3 442.7 450.5 18453.9 18894.0 19485.3 20510.2 20559.8 19719.4 20055.1 20111.7 20378.1 20393.0 5590.8 5618.6 5822.5 5827.3 5830.4 4299.6 5453.5 5765.7 5765.9 6204.4 6131.1 6155.4 6177.0 6179.6 6200.2 5715.1 5972.0 5972.8 5979.6 5980.6 5733.3 5793.0 5814.5 5838.9 5841.6 21752.9 22081.8 23796.4 23881.9 23894.4 2489.7 2593.5 2814.4 2964.9 3140.0 10246.2 10746.3 10746.8 10756.2 10964.4 1969.9 2044.3 2143.8 2159.3 2167.5 80089.6 83803.0 87601.0 87608.6 90655.5 11160.7 11378.7 11448.9 11778.5 11780.8 15904.6 15909.3 15991.3 16003.8 16061.6 8498.0 8959.8 9059.5 9137.4 9197.7 9046.4 9058.1 9063.9 9064.7 9119.1 5077.6 5082.0 5127.4 5134.6 5154.8 2081.5 2094.0 2138.6 2153.2 2157.2 1016.3 1019.7 1033.5 1073.6 1123.8 18530.0 18879.3 18882.9 19325.0 19719.0 1126.5 1128.6 1146.3 1173.3 1208.8 10725.4 10975.4 10975.7 11023.2 11036.4 506796.0 513404.0 524457.0 544089.0 544763.0 59247.4 95204.5 95479.0 95848.5 97069.5 1094.3 1106.0 1173.7 1174.9 1191.8 16925.7 16933.6 16959.4 17044.9 17082.0 40609.2 41097.2 41201.0 41448.0 42151.6 57473.4 60412.4 61199.4 61382.7 61487.0 8684.7 8895.8 8951.5 9071.7 9271.0 12760.6 13052.9 13188.8 13213.9 13437.9 11373.4 11562.4 11621.8 11754.4 11790.5 5282.4 6193.9 8362.5 11884.0 11990.1 12294.6 12444.2 12496.0 12536.9 12886.8 8946.9 8973.4 9136.8 9227.3 9236.2 11736.9 11810.6 11826.3 11884.2 12079.6 10:51:31 INFO - PROCESS | 3481 | 10:51:31 INFO - PROCESS | 3481 | [#3] mootools.html Cycles:180 Average:5788.09 Median:4942.91 stddev:3184.13 (64.4%) stddev-sans-first:3177.47 10:51:31 INFO - PROCESS | 3481 | Values: 1594.6 1622.7 1840.7 1942.1 1960.1 7613.8 8201.3 8344.9 8353.2 8400.5 8407.4 8413.0 8471.0 8496.6 8497.4 2419.0 2426.5 2432.5 2436.0 2450.1 2363.2 2367.5 2419.8 2432.5 2434.4 2438.7 2451.5 2474.0 2478.1 2478.9 2332.5 2335.0 2335.2 2426.8 2484.8 2466.8 2473.0 2473.8 2477.2 2479.4 8702.5 8753.6 8760.5 8806.3 8809.8 5498.9 5597.6 5624.0 5651.9 5652.4 3478.1 3492.3 3541.9 3663.3 3665.5 1174.6 1178.7 1202.6 1203.2 1215.1 12239.0 12267.4 12279.9 12297.9 12360.9 4670.9 4827.4 4835.5 4836.8 4921.7 10499.4 10507.5 10517.2 10517.3 10522.4 5528.3 5563.9 5575.0 5583.1 5583.5 4804.4 4964.1 4973.6 4996.8 5088.0 3953.8 3971.2 3985.9 3993.4 4096.1 1212.2 1226.9 1229.9 1230.2 1231.2 1014.1 1024.5 1029.7 1043.4 1073.9 5724.0 5962.9 6068.6 6105.5 6206.6 453.6 466.5 474.8 487.4 1129.6 4097.4 4161.5 4242.0 4273.5 4293.8 10434.5 10680.8 10817.6 10831.0 10860.6 10509.9 10575.8 10719.3 10750.8 10895.1 8195.3 8287.3 8295.1 8347.7 8439.9 5962.9 5995.7 6027.2 6072.6 6129.4 9423.9 9564.4 9617.2 9647.2 9721.6 9087.9 9345.2 9425.9 9562.5 9755.2 7685.7 7950.4 7979.5 8197.8 8331.3 8102.4 8111.6 8122.0 8144.0 8152.1 7219.2 7273.3 7323.3 7458.8 7531.7 7102.4 7180.6 7265.6 7322.7 7359.4 7188.4 7193.9 7205.3 7209.5 7216.4 5271.7 5292.3 5327.6 5483.6 5492.6 5215.1 5221.6 5260.5 5285.7 5353.4 10:51:31 INFO - PROCESS | 3481 | 10:51:31 INFO - PROCESS | 3481 | [#4] prototype.html Cycles:180 Average:5705.82 Median:6581.57 stddev:1748.29 (26.6%) stddev-sans-first:1706.40 10:51:31 INFO - PROCESS | 3481 | Values: 352.9 361.5 362.7 363.4 365.5 6305.1 6416.0 6418.1 6421.1 6444.3 6268.6 6319.4 6328.3 6349.0 6359.7 4713.6 4812.8 4860.3 4865.1 4882.1 4830.0 4840.0 4842.0 4857.9 4863.2 4804.0 4812.1 4813.2 4816.5 4830.4 4813.4 4814.3 4822.3 4831.0 4837.1 4235.8 4241.6 4247.5 4250.1 4251.7 6095.5 6132.1 6147.6 6160.8 6170.3 5439.2 5580.2 5586.8 5630.4 5640.1 6650.8 6680.2 6686.8 6712.5 6725.0 4651.5 4659.5 4662.0 4665.0 4667.6 7012.7 7076.3 7088.8 7096.9 7127.6 4761.9 4774.5 4779.6 4784.1 4786.5 4753.4 4863.6 4864.3 4866.2 4872.8 5573.4 5615.2 5619.8 5623.5 5626.6 6760.2 6812.3 6827.9 6828.5 6842.0 1693.5 1722.1 1722.2 1723.4 1729.2 1105.9 1122.2 1127.9 1129.8 1139.2 6643.1 6670.3 6673.7 6674.4 6693.7 7042.5 7045.0 7047.9 7053.2 7053.3 6523.4 6679.7 6695.7 6765.0 6780.5 3806.2 3830.1 3831.1 3843.3 3851.7 7480.7 7496.4 7498.6 7508.4 7520.4 7222.9 7232.6 7243.0 7243.8 7246.9 7150.3 7355.7 7363.7 7389.9 7470.6 7047.1 7058.6 7089.3 7090.0 7102.4 6971.3 6976.5 6979.6 6989.9 7007.8 7461.4 7478.8 7478.9 7485.6 7486.2 4720.5 4755.5 4795.4 4822.1 4832.0 7014.8 7020.9 7043.3 7062.1 7063.1 6848.5 6860.7 6860.8 6868.7 6869.9 6799.0 6815.0 6838.8 6853.5 6863.2 6639.8 6650.5 6700.0 6727.7 6743.9 6865.8 6897.8 6900.5 6900.5 6909.1 6741.2 6745.7 6752.4 6753.0 6759.2 10:51:31 INFO - PROCESS | 3481 | 10:51:31 INFO - PROCESS | 3481 | [#5] yui.html Cycles:180 Average:15860.42 Median:4672.14 stddev:18923.89 (405.0%) stddev-sans-first:18943.23 10:51:31 INFO - PROCESS | 3481 | Values: 810.2 825.2 837.9 868.2 939.8 15134.4 15241.0 15290.8 15342.8 15364.5 12429.9 13730.0 13744.4 13759.9 13856.9 882.2 894.1 894.7 897.1 898.7 874.0 878.1 894.6 896.2 897.9 917.6 927.2 936.5 936.5 938.4 909.9 928.6 930.1 936.7 937.6 688.5 689.0 690.2 692.6 694.7 15334.2 15372.0 15383.5 15424.2 15438.7 13918.9 13942.2 14127.3 14159.9 14260.3 11761.0 12003.8 12011.3 12074.5 12425.2 3968.4 3973.7 3993.1 4020.2 4072.9 56970.7 57058.4 57394.0 57469.0 57513.7 11380.1 11830.0 11847.3 11884.2 12062.6 21358.1 21362.7 21401.1 21481.2 21560.7 8294.3 8366.7 8523.1 8582.1 8694.9 4887.8 4918.4 5017.1 5027.4 5093.4 3620.2 3668.5 3680.8 3682.2 3694.2 693.2 694.0 698.2 706.0 714.6 672.5 696.9 732.6 736.6 757.6 9348.6 9780.4 9805.4 10128.7 10140.9 695.6 733.2 745.0 751.2 760.6 4344.3 4570.4 4634.2 4647.6 4696.7 67900.7 68581.3 68755.3 68830.0 69160.0 59268.1 60893.0 61520.4 62107.1 62388.4 53668.2 54642.2 54759.5 54880.7 55652.7 9089.7 9234.3 9325.3 9364.3 9410.9 38748.2 39178.8 39225.0 39267.6 40269.8 50189.0 51878.0 51968.0 52397.2 52788.7 11363.5 11459.2 11579.8 11594.5 11723.5 12643.6 12729.3 12754.8 12981.9 13219.0 11664.2 11695.2 11729.6 11856.3 12236.3 12038.6 12041.8 12135.2 12224.9 12359.9 11500.7 11676.7 12486.3 12816.6 12820.6 10293.1 10469.5 10565.0 10810.0 10814.8 10455.2 10636.0 11083.6 11161.9 11199.4 10:51:31 INFO - PROCESS | 3481 | -------- Summary: end -------- 10:51:31 INFO - PROCESS | 3481 | 10:51:32 INFO - TEST-INFO | 3481: exit 0 10:51:32 INFO - TEST-OK | dromaeo_css | took 1108407ms 10:51:32 INFO - TEST-START | kraken 10:51:32 INFO - operating with platform_type : linux_ 10:51:32 INFO - Initialising browser for kraken test... 10:51:32 INFO - TEST-INFO | started process 3723 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_t94tz/profile http://localhost:50560/getInfo.html) 10:51:35 INFO - PROCESS | 3723 | 10:51:35 INFO - PROCESS | 3723 | (process:3800): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:51:36 INFO - PROCESS | 3723 | __metrics Screen width/height:1600/1200 10:51:36 INFO - PROCESS | 3723 | colorDepth:24 10:51:36 INFO - PROCESS | 3723 | Browser inner width/height: 1024/697 10:51:36 INFO - PROCESS | 3723 | __metrics 10:51:37 ERROR - PROCESS | 3723 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:51:37 INFO - TEST-INFO | 3723: exit 0 10:51:37 INFO - Browser initialized. 10:51:37 INFO - Running cycle 1/1 for kraken test... 10:51:37 INFO - TEST-INFO | started process 3850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_t94tz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:39 INFO - PROCESS | 3850 | 10:51:39 INFO - PROCESS | 3850 | (process:3920): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:51:49 INFO - PROCESS | 3850 | RSS: Main: 150958080 10:51:49 INFO - PROCESS | 3850 | 10:51:52 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50560/tests/kraken/driver.html?testName=audio-beat-detection) 10:51:53 INFO - PROCESS | 3850 | RSS: Main: 156164096 10:51:53 INFO - PROCESS | 3850 | 10:51:55 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50560/tests/kraken/driver.html?testName=audio-dft) 10:51:56 INFO - PROCESS | 3850 | RSS: Main: 155934720 10:51:56 INFO - PROCESS | 3850 | 10:51:59 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50560/tests/kraken/driver.html?testName=audio-fft) 10:51:59 INFO - PROCESS | 3850 | RSS: Main: 156102656 10:51:59 INFO - PROCESS | 3850 | 10:52:01 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50560/tests/kraken/driver.html?testName=audio-oscillator) 10:52:02 INFO - PROCESS | 3850 | RSS: Main: 156487680 10:52:02 INFO - PROCESS | 3850 | 10:52:04 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50560/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:52:05 INFO - PROCESS | 3850 | RSS: Main: 155656192 10:52:05 INFO - PROCESS | 3850 | 10:52:08 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50560/tests/kraken/driver.html?testName=imaging-darkroom) 10:52:08 INFO - PROCESS | 3850 | RSS: Main: 156024832 10:52:08 INFO - PROCESS | 3850 | 10:52:12 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50560/tests/kraken/driver.html?testName=imaging-desaturate) 10:52:12 INFO - PROCESS | 3850 | RSS: Main: 156385280 10:52:12 INFO - PROCESS | 3850 | 10:52:15 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50560/tests/kraken/driver.html?testName=json-parse-financial) 10:52:16 INFO - PROCESS | 3850 | RSS: Main: 156323840 10:52:16 INFO - PROCESS | 3850 | 10:52:17 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50560/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:52:18 INFO - PROCESS | 3850 | RSS: Main: 155942912 10:52:18 INFO - PROCESS | 3850 | 10:52:20 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:52:20 INFO - PROCESS | 3850 | RSS: Main: 156286976 10:52:20 INFO - PROCESS | 3850 | 10:52:22 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:52:23 INFO - PROCESS | 3850 | RSS: Main: 156651520 10:52:23 INFO - PROCESS | 3850 | 10:52:25 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:52:26 INFO - PROCESS | 3850 | RSS: Main: 157208576 10:52:26 INFO - PROCESS | 3850 | 10:52:29 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:52:29 INFO - PROCESS | 3850 | RSS: Main: 157188096 10:52:29 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:50560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50560/tests/kraken/driver.html?testName=ai-astar) 10:52:31 INFO - PROCESS | 3850 | RSS: Main: 158375936 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | __start_tp_report 10:52:31 INFO - PROCESS | 3850 | _x_x_mozilla_page_load 10:52:31 INFO - PROCESS | 3850 | _x_x_mozilla_page_load_details 10:52:31 INFO - PROCESS | 3850 | |i|pagename|runs| 10:52:31 INFO - PROCESS | 3850 | |0;ai-astar;109;112;107;111;113;112;101;111;110;111 10:52:31 INFO - PROCESS | 3850 | |1;audio-beat-detection;162;126;166;181;136;165;156;131;176;123 10:52:31 INFO - PROCESS | 3850 | |2;audio-dft;162;162;163;163;162;161;161;161;160;161 10:52:31 INFO - PROCESS | 3850 | |3;audio-fft;77;77;76;184;76;77;73;74;183;77 10:52:31 INFO - PROCESS | 3850 | |4;audio-oscillator;94;92;153;92;93;91;149;93;92;156 10:52:31 INFO - PROCESS | 3850 | |5;imaging-gaussian-blur;117;119;117;117;117;117;118;117;117;118 10:52:31 INFO - PROCESS | 3850 | |6;imaging-darkroom;148;146;146;146;149;148;146;146;147;146 10:52:31 INFO - PROCESS | 3850 | |7;imaging-desaturate;95;95;96;96;95;95;95;95;95;95 10:52:31 INFO - PROCESS | 3850 | |8;json-parse-financial;55;55;57;56;58;56;54;77;59;54 10:52:31 INFO - PROCESS | 3850 | |9;json-stringify-tinderbox;57;58;58;58;58;57;57;58;58;59 10:52:31 INFO - PROCESS | 3850 | |10;stanford-crypto-aes;74;74;75;76;77;77;83;76;75;76 10:52:31 INFO - PROCESS | 3850 | |11;stanford-crypto-ccm;123;115;118;117;115;112;116;114;127;135 10:52:31 INFO - PROCESS | 3850 | |12;stanford-crypto-pbkdf2;166;162;164;163;165;162;168;166;162;169 10:52:31 INFO - PROCESS | 3850 | |13;stanford-crypto-sha256-iterative;68;70;67;69;70;68;67;67;67;77 10:52:31 INFO - PROCESS | 3850 | __end_tp_report 10:52:31 INFO - PROCESS | 3850 | __start_cc_report 10:52:31 INFO - PROCESS | 3850 | _x_x_mozilla_cycle_collect,818 10:52:31 INFO - PROCESS | 3850 | __end_cc_report 10:52:31 INFO - PROCESS | 3850 | __startTimestamp1467741151823__endTimestamp 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | ------- Summary: start ------- 10:52:31 INFO - PROCESS | 3850 | Number of tests: 14 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.50 (3.2%) stddev-sans-first:3.70 10:52:31 INFO - PROCESS | 3850 | Values: 109.0 112.0 107.0 111.0 113.0 112.0 101.0 111.0 110.0 111.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:163.50 stddev:21.37 (13.1%) stddev-sans-first:22.37 10:52:31 INFO - PROCESS | 3850 | Values: 162.0 126.0 166.0 181.0 136.0 165.0 156.0 131.0 176.0 123.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 10:52:31 INFO - PROCESS | 3850 | Values: 162.0 162.0 163.0 163.0 162.0 161.0 161.0 161.0 160.0 161.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#3] audio-fft Cycles:10 Average:97.40 Median:76.50 stddev:45.40 (59.3%) stddev-sans-first:47.55 10:52:31 INFO - PROCESS | 3850 | Values: 77.0 77.0 76.0 184.0 76.0 77.0 73.0 74.0 183.0 77.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:92.00 stddev:29.16 (31.7%) stddev-sans-first:30.31 10:52:31 INFO - PROCESS | 3850 | Values: 94.0 92.0 153.0 92.0 93.0 91.0 149.0 93.0 92.0 156.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 10:52:31 INFO - PROCESS | 3850 | Values: 117.0 119.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:146.50 stddev:1.14 (0.8%) stddev-sans-first:1.12 10:52:31 INFO - PROCESS | 3850 | Values: 148.0 146.0 146.0 146.0 149.0 148.0 146.0 146.0 147.0 146.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:52:31 INFO - PROCESS | 3850 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:56.50 stddev:6.84 (12.1%) stddev-sans-first:7.16 10:52:31 INFO - PROCESS | 3850 | Values: 55.0 55.0 57.0 56.0 58.0 56.0 54.0 77.0 59.0 54.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 10:52:31 INFO - PROCESS | 3850 | Values: 57.0 58.0 58.0 58.0 58.0 57.0 57.0 58.0 58.0 59.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:2.58 (3.4%) stddev-sans-first:2.60 10:52:31 INFO - PROCESS | 3850 | Values: 74.0 74.0 75.0 76.0 77.0 77.0 83.0 76.0 75.0 76.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:117.50 stddev:7.11 (6.1%) stddev-sans-first:7.41 10:52:31 INFO - PROCESS | 3850 | Values: 123.0 115.0 118.0 117.0 115.0 112.0 116.0 114.0 127.0 135.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.50 stddev:2.54 (1.5%) stddev-sans-first:2.65 10:52:31 INFO - PROCESS | 3850 | Values: 166.0 162.0 164.0 163.0 165.0 162.0 168.0 166.0 162.0 169.0 10:52:31 INFO - PROCESS | 3850 | 10:52:31 INFO - PROCESS | 3850 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:3.06 (4.5%) stddev-sans-first:3.22 10:52:31 INFO - PROCESS | 3850 | Values: 68.0 70.0 67.0 69.0 70.0 68.0 67.0 67.0 67.0 77.0 10:52:31 INFO - PROCESS | 3850 | -------- Summary: end -------- 10:52:31 INFO - PROCESS | 3850 | 10:52:32 INFO - TEST-INFO | 3850: exit 0 10:52:32 INFO - TEST-OK | kraken | took 60153ms 10:52:32 INFO - SUITE-END | took 1168s 10:52:32 INFO - Completed test suite (00:19:28) 10:52:32 INFO - javascript benchmark 10:52:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3282.425575524283, 3317.618473875505, 3321.2527181384175, 3339.8330083495835, 3361.932761344773, 5450.509454149126, 5499.642523235992, 5518.668879867206, 5528.917066244005, 5545.445455454453, 5500.972495137528, 5523.7790488380515, 5545.861353466165, 5559.749811258493, 5573.331200255965, 5005.399352077756, 5016.247562865572, 5070.366204224472, 5079.720615366154, 5101.311322971407, 5007.223880298559, 5039.6976181429045, 5075.441701412841, 5125.231215317714, 5163.690178589278, 5043.445221025684, 5118.539331460168, 5123.666961647499, 5145.614078944075, 5146.150885103972, 5138.100832354342, 5157.587393008569, 5158.664686795346, 5172.560332371753, 5201.427842937273, 4904.656674032819, 4982.90034199314, 5016.924746128811, 5056.570191533688, 5061.544460998491, 5395.379531353905, 5456.345238571397, 5462.672239665632, 5483.616146869721, 5493.478119578634, 5913.586048976574, 5922.141289512996, 5932.79235226765, 5943.0, 5945.762169513214, 5873.500752436048, 5883.646981181143, 5902.911456328158, 5961.0, 5985.790497332572, 5462.6995515246645, 5532.695701736403, 5543.307086614173, 5545.61180717354, 5606.915896261559, 5887.676177810176, 5925.111233315038, 5926.140709597171, 5935.940640593539, 5938.406159384027, 5715.5427565794635, 5721.084626459747, 5728.226689396962, 5761.567882408836, 5801.448862358069, 5876.1479585459865, 5885.14665373527, 5888.941110588925, 5898.203742494708, 5916.142159386951, 5873.20711703923, 5874.794382196688, 5879.206307148565, 5885.823425297248, 5886.646801191942, 5792.739326730307, 5924.081767326072, 5981.850453738692, 5988.461038506555, 5996.490298324691, 4486.910261794746, 4516.16450956574, 4531.478879928784, 4534.161180181677, 4549.6360291176625, 3953.347697629859, 4057.2899742544937, 4073.2260870434525, 4099.221147981874, 4108.712390132662, 5562.3047119110115, 5653.519450846642, 5680.857978550569, 5732.598718089694, 5780.335261444903, 5786.623869448473, 5797.159411885337, 5810.854728631733, 5819.272590926134, 5840.5035571976005, 5580.609357345028, 5583.69289689071, 5585.553155747531, 5585.58108141891, 5724.656520608777, 4999.675021123688, 5012.348394708737, 5043.52086551777, 5051.318072060299, 5074.771635276422, 6210.875782484325, 6236.03341482071, 6261.342559031327, 6267.96866015667, 6269.279032911182, 5657.15142728594, 5912.793052243151, 5964.821055368346, 5988.640681559121, 6007.669578173068, 6063.211782468251, 6078.118672792509, 6092.482139018056, 6097.75608975636, 6127.080937859178, 5673.943260567342, 5717.571182161271, 5724.227229323988, 5741.110127930177, 5744.396838332083, 5780.21967034445, 5804.419558044162, 5819.76720931158, 5827.854303642273, 5867.354590994902, 5787.536997040311, 5822.5633077518505, 5826.73779679907, 5835.854103647443, 5841.357450680507, 5752.6836024019085, 5788.82633520995, 5815.883682326415, 5830.387809279964, 5835.212246346859, 5486.369067557282, 5535.723213839373, 5570.19232211319, 5582.0, 5610.074337734228, 5702.885942281048, 5734.913976290276, 5758.712064396847, 5772.422757724194, 5776.508996735157, 5608.383077861514, 5634.352049514358, 5641.351244606759, 5645.181448689999, 5648.915266271091], "value": 5449.9283715232505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.6090163197185, 638.3839594791026, 662.6024385368779, 675.8310422394403, 684.127737135153, 39243.0, 40236.798816005954, 40242.19515609686, 40500.18999620006, 40539.39190912139, 42837.571624283744, 43755.0, 43823.0, 43869.341959870544, 43996.780016099954, 8745.912540874606, 8822.955885220565, 8851.77870553238, 8865.246454051414, 8910.910890891106, 8705.129487051276, 8773.078826723198, 8780.25367843734, 8787.868181977276, 8806.251468625143, 9031.41295815773, 9035.638574457014, 9056.094390560924, 9071.274298056172, 9075.773105672344, 8961.95519022404, 9001.729948101567, 9019.503927283997, 9022.639094436214, 9074.183323500916, 8924.821503569958, 9060.139286767746, 9061.093890610951, 9079.546022698838, 9088.863667045, 43199.78400108011, 43373.34939975903, 43709.78145109254, 43749.34375984363, 43874.341884871756, 3763.5483741950866, 3814.16088460541, 3857.112864041258, 3859.939617178854, 3911.9608803912165, 32684.836575817208, 33028.50457243143, 33085.83457082723, 33443.33113337744, 33516.49725254123, 4328.523862375137, 4556.954430455686, 4629.213033784265, 4637.582617564435, 4652.837150699709, 314808.0, 316794.0, 317851.0, 318518.0, 318869.0, 61827.6908615463, 62743.6862815683, 62781.372186278466, 62793.058104128475, 62829.37170628235, 68906.310936891, 69700.3029969704, 70144.64927675329, 70234.0, 70498.0, 18789.906050469934, 18929.337473188647, 19000.429987100408, 19037.14332855025, 19119.330823421114, 14791.556253312418, 14860.405583776745, 14875.479358222627, 14878.776818347733, 14937.551873443814, 19872.60254794925, 19993.300234491722, 20105.497362566053, 20144.89927550353, 20723.378298651063, 7273.745418910418, 7534.321911028033, 7654.196309387434, 7993.480423772552, 8048.235417635316, 1070.8500809886623, 1075.102289588187, 1106.1040557148735, 1159.1074872348245, 1167.1246565076192, 32682.836585817393, 32798.836005819816, 32884.0, 33039.66960330414, 33173.0, 1223.816427535859, 1245.9127861049822, 1251.4368534159482, 1256.1458208418362, 1258.7608354412632, 16719.582010449594, 16838.326466941184, 17030.829691703173, 17078.91460542714, 17164.656706865793, 479989.6000519975, 488087.0, 569595.0, 834820.0, 849120.0, 61387.0, 62276.37723622796, 62767.686161569814, 62873.0, 62879.0, 1533.9002964807253, 1533.9002964807253, 1536.5313579358403, 1537.4465192530456, 1566.326479613777, 31919.68080319167, 31970.0, 32323.838380808887, 32681.509777353833, 32971.83514082414, 53657.46342536525, 54390.45609543854, 54447.72776136094, 54710.0, 54819.17771233355, 433838.0, 440957.0, 441827.0, 441839.0, 441911.0, 30708.692913070583, 30919.381612368077, 31149.532757008208, 31185.53221701631, 31365.843170784, 48574.27138592995, 49143.754281228365, 49271.753641233, 49459.0, 49482.0, 40718.79640601896, 40953.0, 41478.37782433326, 42593.5740642602, 42652.5734742661, 40420.595794042856, 40976.1804763909, 41838.581614183466, 42697.35953960631, 43103.0, 42948.0, 43600.78199608982, 43628.12743745171, 43637.0, 43898.34152487779, 35215.647843521234, 35576.0, 35990.8200458996, 37055.258894822495, 38017.809910950265, 27237.591436128077, 27291.181264562096, 27492.862535687993, 27651.446971060064, 27713.584296235975], "value": 21059.397836401295, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.86084452975024, 435.69936743646883, 439.3453753906678, 442.7498463368197, 450.4616982705668, 18453.907730461346, 18893.99999999998, 19485.318013869517, 20510.17959281627, 20559.794402055973, 19719.408417747454, 20055.097520611573, 20111.698324525107, 20378.082986265617, 20393.0, 5590.776368945238, 5618.606697531174, 5822.53419726423, 5827.271591051119, 5830.3586605473365, 4299.634531064848, 5453.527047055393, 5765.740541675614, 5765.855853603652, 6204.410580994799, 6131.14164017038, 6155.446009859112, 6177.0, 6179.629222246657, 6200.224971878515, 5715.0855863061915, 5972.044472884361, 5972.820815375546, 5979.581429299951, 5980.6112602680905, 5733.3406658234, 5793.044147715622, 5814.534837213055, 5838.941610583882, 5841.649501029951, 21752.89123554388, 22081.779182208134, 23796.405089872893, 23881.880590596935, 23894.402639934142, 2489.6887889013874, 2593.481303739241, 2814.352698879269, 2964.8910230519514, 3139.9843000785077, 10246.231532635082, 10746.301490403177, 10746.785064298749, 10756.247062705614, 10964.396958167297, 1969.9113539890739, 2044.31515442327, 2143.7856214378594, 2159.276642324823, 2167.5014746608213, 80089.59955200244, 83803.0, 87601.0, 87608.56195719044, 90655.54672226662, 11160.720981975353, 11378.658640240807, 11448.885511144948, 11778.469968851423, 11780.764384712258, 15904.602384940237, 15909.284082216329, 15991.28039238237, 16003.839961600468, 16061.598460038593, 8497.957510212409, 8959.776005599912, 9059.547022648841, 9137.360384773003, 9197.678081267124, 9046.366754327266, 9058.139476749699, 9063.864042039375, 9064.728058158265, 9119.133682300171, 5077.568406685473, 5081.974590127025, 5127.384713834289, 5134.640575159703, 5154.845354639367, 2081.469225347527, 2093.968590471144, 2138.5936672032576, 2153.171029153787, 2157.2018353209414, 1016.3343010328247, 1019.6686077024848, 1033.5452400943561, 1073.5759375046812, 1123.7920984617708, 18530.0, 18879.339223127125, 18882.905585471985, 19325.0, 19719.0, 1126.4649291586431, 1128.6331942118845, 1146.3064845768356, 1173.3077484284313, 1208.8428504294561, 10725.356478611153, 10975.396353200491, 10975.670729878117, 11023.228374013743, 11036.392998385167, 506796.0, 513404.0, 524457.0, 544089.0, 544763.0, 59247.40752592419, 95204.52397738106, 95479.0, 95848.52075739716, 97069.5146524277, 1094.272308914563, 1106.0101209417526, 1173.6831055614937, 1174.929504229749, 1191.7854786138405, 16925.74611380855, 16933.576660583585, 16959.406420775213, 17044.914775426045, 17082.0, 40609.18781624292, 41097.178056438104, 41201.0, 41448.0, 42151.57848421599, 57473.42526574681, 60412.395876040675, 61199.38800611937, 61382.69308653428, 61487.0, 8684.652613895374, 8895.822083558422, 8951.507667078113, 9071.682491112779, 9270.953645231732, 12760.596334403022, 13052.934735326262, 13188.80216796768, 13213.867861321263, 13437.86562134366, 11373.43132843338, 11562.421878906189, 11621.76756464883, 11754.412279386168, 11790.528378864748, 5282.418933917343, 6193.907091393723, 8362.498250105013, 11884.0, 11990.100742444525, 12294.631161065183, 12444.191127576678, 12496.0, 12536.937315313366, 12886.806697899352, 8946.86579701318, 8973.416727912665, 9136.771580710536, 9227.261819054325, 9236.168744813, 11736.94131529371, 11810.645680629596, 11826.315946972987, 11884.227525210834, 12079.637610871689], "value": 9589.808229626562, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1594.617291849956, 1622.675464907019, 1840.6870831958574, 1942.0581018206176, 1960.1473359088789, 7613.8477230455355, 8201.343892488601, 8344.91655083449, 8353.248207661309, 8400.537970411626, 8407.411481196319, 8412.95793521033, 8470.957645211765, 8496.575171241444, 8497.405181637288, 2419.0323870451784, 2426.5268272686744, 2432.5378178146098, 2436.049940523197, 2450.068973789966, 2363.196513185517, 2367.5146594948083, 2419.7822196002357, 2432.501337225873, 2434.3548959525738, 2438.6829712137396, 2451.5464639041834, 2474.010395841669, 2478.08310924958, 2478.876056197192, 2332.486852892361, 2335.0309621507054, 2335.241046659834, 2426.793722533569, 2484.838485498437, 2466.802655787533, 2472.950540989188, 2473.789727873133, 2477.157766359446, 2479.404942813712, 8702.47785132894, 8753.562321883881, 8760.474371537664, 8806.339524535686, 8809.779755506164, 5498.917516237259, 5597.580181486404, 5624.015797235467, 5651.9152212716845, 5652.406497317764, 3478.0609235506527, 3492.2840817632323, 3541.8760343388117, 3663.285659296438, 3665.4685070664873, 1174.6006357838376, 1178.6581891251612, 1202.5610652111916, 1203.175824560179, 1215.1190386969465, 12239.0, 12267.447964841604, 12279.93860030703, 12297.877021229762, 12360.938195309056, 4670.929936050962, 4827.42070951488, 4835.492273311252, 4836.830710925171, 4921.729304888194, 10499.422531760827, 10507.474626268657, 10517.158627309796, 10517.316374435637, 10522.368657880552, 5528.281323427928, 5563.8887222256135, 5574.9721251393485, 5583.134614134816, 5583.525400340935, 4804.447488538863, 4964.081644895706, 4973.577245934136, 4996.775145118479, 5087.97456012725, 3953.802309884494, 3971.225611005884, 3985.92028159441, 3993.4209539616595, 4096.05790668148, 1212.2423485321674, 1226.8711785262597, 1229.8647148813623, 1230.1819290172114, 1231.2243286729304, 1014.1481155829139, 1024.5082360467018, 1029.6705054382676, 1043.3635482355758, 1073.9140868730483, 5724.026556612241, 5962.850928726816, 6068.6358818471035, 6105.481034112061, 6206.627602343874, 453.62802501948744, 466.53113620811547, 474.8171953797744, 487.3883276487985, 1129.5877004893155, 4097.44684467593, 4161.500619925568, 4241.957580424218, 4273.508546517128, 4293.785310734451, 10434.530446129942, 10680.839787403194, 10817.567297308176, 10831.0, 10860.61987830438, 10509.9474502627, 10575.841362379571, 10719.303245289031, 10750.838737418944, 10895.128389728803, 8195.262426381654, 8287.295579875778, 8295.129011453831, 8347.749567512985, 8439.915600844035, 5962.8968640801595, 5995.700214989321, 6027.21646185993, 6072.605280656743, 6129.4483496483745, 9423.905760942303, 9564.378315409476, 9617.23062155012, 9647.179989700953, 9721.56252968604, 9087.863682044643, 9345.205657518914, 9425.905740942502, 9562.521873906417, 9755.170810481188, 7685.730999414994, 7950.40371972116, 7979.521228726295, 8197.83604327922, 8331.291840193651, 8102.351811855156, 8111.634976426193, 8122.0, 8143.959280203561, 8152.103268640326, 7219.241979592067, 7273.272672732896, 7323.304286092813, 7458.813529661802, 7531.661075251736, 7102.360787529147, 7180.5691658500655, 7265.636718164176, 7322.707091716272, 7359.411247100326, 7188.388986936169, 7193.928060719326, 7205.279472052753, 7209.531380460253, 7216.422686185198, 5271.65734227274, 5292.311999440049, 5327.573794096385, 5483.616146869681, 5492.642978206404, 5215.113430716863, 5221.608379371486, 5260.526552610283, 5285.656432331886, 5353.411124776194], "value": 4653.076612131314, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.9047157267538, 361.50834864584164, 362.7207050571061, 363.3786225554302, 365.47736736466874, 6305.117283580296, 6415.967920160404, 6418.069379939906, 6421.13314702515, 6444.291127975925, 6268.623882567038, 6319.368063193679, 6328.33552476989, 6349.0, 6359.745610175587, 4713.622910167179, 4812.831550895719, 4860.3195552622665, 4865.051314993578, 4882.121218180726, 4829.975850120762, 4840.0, 4841.975790121044, 4857.927131093019, 4863.246196839478, 4804.0, 4812.061647978646, 4813.205821039524, 4816.470188279286, 4830.3720516333005, 4813.422389313269, 4814.253790662436, 4822.324874517571, 4831.0, 4837.129316722989, 4235.75045361616, 4241.618254357092, 4247.511536173349, 4250.149970006011, 4251.681123915688, 6095.542834287447, 6132.110843927606, 6147.600405973598, 6160.84597885052, 6170.2904166021035, 5439.156930675712, 5580.218769372291, 5586.832395028156, 5630.380658127603, 5640.125780504029, 6650.833729156761, 6680.231773346079, 6686.83282917926, 6712.5301228913995, 6725.0, 4651.488336283006, 4659.534046595347, 4661.953380466186, 4664.973705784756, 4667.649926255511, 7012.684429200698, 7076.292370762934, 7088.787336379917, 7096.893546596805, 7127.572345659225, 4761.928571071437, 4774.546418090275, 4779.569838714463, 4784.114938736345, 4786.473487916326, 4753.4295884493395, 4863.562279394871, 4864.343313652683, 4866.221404575251, 4872.756362181947, 5573.442655734475, 5615.18579805934, 5619.775208991677, 5623.5220006299105, 5626.578006649518, 6760.222574404006, 6812.318768123148, 6827.863442731117, 6828.487863410165, 6842.04211410393, 1693.4750227429536, 1722.070082155647, 1722.1733567887484, 1723.4054251283537, 1729.1872819774685, 1105.8562386889653, 1122.1583812140893, 1127.926684765504, 1129.7796929598649, 1139.202558209257, 6643.10318107059, 6670.332966703291, 6673.699683514254, 6674.365935236145, 6693.698783554752, 7042.471814613925, 7045.0489183960535, 7047.859042819115, 7053.153621565445, 7053.294670532906, 6523.380278873595, 6679.732810687616, 6695.665216739144, 6765.0, 6780.525363224527, 3806.1626442182674, 3830.0807806126886, 3831.061389959422, 3843.3466310727244, 3851.672607828366, 7480.700771969169, 7496.362809161174, 7498.550086994798, 7508.361789247866, 7520.435967302475, 7222.927770722331, 7232.566046037255, 7243.022192004012, 7243.818904527429, 7246.855062898712, 7150.284971502808, 7355.705771769176, 7363.7422690205585, 7389.852202956018, 7470.589117598475, 7047.08387909589, 7058.576485410892, 7089.326513981164, 7090.007398964252, 7102.431805455654, 6971.26801685836, 6976.476764242803, 6979.616121113388, 6989.930100698928, 7007.789766307019, 7461.403087753075, 7478.775636730907, 7478.850422991619, 7485.588292643957, 7486.176520582622, 4720.5043470436485, 4755.453122890912, 4795.424549054136, 4822.059698358787, 4832.0, 7014.824629384306, 7020.911758677413, 7043.295670432915, 7062.117235345582, 7063.117110361205, 6848.452123829982, 6860.656967151523, 6860.828479288058, 6868.656567171522, 6869.862602748017, 6799.048133261446, 6815.045893575003, 6838.829029274308, 6853.451723862178, 6863.245043045161, 6639.767608133692, 6650.46796256308, 6700.0, 6727.663616819237, 6743.9325606743305, 6865.828354291183, 6897.7585784497305, 6900.516963812485, 6900.516963812685, 6909.067275917687, 6741.1910570731825, 6745.662716864235, 6752.358525940028, 6753.020811982334, 6759.188897332351], "value": 5136.064967623668, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.2424233341826, 825.2490233887164, 837.8785076163955, 868.1882439918677, 939.7744541310079, 15134.394624215032, 15241.0, 15290.847091529082, 15342.84657153428, 15364.53906382809, 12429.937850310758, 13730.0, 13744.381502832372, 13759.862401375984, 13856.861431385683, 882.2368651116786, 894.0880302091863, 894.7449976756626, 897.0580890065438, 898.7169041751828, 874.0298268921492, 878.1174919206189, 894.6153154143716, 896.1934259166737, 897.9191872731453, 917.5595714057257, 927.1979737527024, 936.4802534593298, 936.494293081735, 938.3994243684048, 909.9181073703365, 928.5914197753001, 930.0978051290238, 936.6628013915054, 937.5640327247862, 688.5008368932534, 689.0, 690.1959217511593, 692.560224257595, 694.7464175575928, 15334.23328833554, 15372.00081994678, 15383.461578844686, 15424.151671658054, 15438.691226175413, 13918.930405347908, 13942.163470191821, 14127.293635318296, 14159.929200353932, 14260.28698565078, 11761.0, 12003.759924801456, 12011.339376334297, 12074.456649450707, 12425.192362496498, 3968.4245784361397, 3973.662238709713, 3993.1414745829784, 4020.19596080785, 4072.9389059164137, 56970.715146424416, 57058.42941570573, 57394.0, 57469.0, 57513.712431437576, 11380.089592832554, 11830.0, 11847.288303985597, 11884.227525211007, 12062.638120856389, 21358.145674172858, 21362.679559806616, 21401.14395424197, 21481.248156314454, 21560.676589851166, 8294.253517183482, 8366.707165249187, 8523.147685231428, 8582.098879617675, 8694.91305086941, 4887.780049897763, 4918.43438004634, 5017.096922553902, 5027.396712394536, 5093.363329583802, 3620.167361506868, 3668.523091998023, 3680.7607505512055, 3682.245139746399, 3694.2057457646733, 693.1820451866745, 694.0456871801273, 698.1656919980676, 706.0221593093603, 714.5744240240753, 672.4989882537443, 696.8919817428307, 732.6117157906318, 736.569107072358, 757.5757575757483, 9348.57931393089, 9780.364276322016, 9805.411675299505, 10128.746781330527, 10140.949295253624, 695.5861262548775, 733.186163358682, 744.9515781474187, 751.1737089201835, 760.6196901549225, 4344.304911214191, 4570.428696412949, 4634.165850146938, 4647.581717645428, 4696.694714843524, 67900.66049669818, 68581.3141868585, 68755.31244687489, 68830.0, 69160.0, 59268.110978334495, 60893.0, 61520.38479615146, 62107.06839397413, 62388.37611623826, 53668.19497707616, 54642.180367294524, 54759.45240547544, 54880.72559637176, 55652.72173639106, 9089.681861134828, 9234.30742694314, 9325.300602454707, 9364.344495885223, 9410.905890941276, 38748.225035499694, 39178.80410597929, 39225.0, 39267.60732392639, 40269.79865100656, 50189.0, 51878.0, 51968.0, 52397.21404178864, 52788.736056319474, 11363.48864301125, 11459.19785614999, 11579.8263026053, 11594.47824847867, 11723.531058757555, 12643.557475488315, 12729.29988850622, 12754.808677870025, 12981.870181298065, 13219.0, 11664.183507154758, 11695.245460358778, 11729.592448906185, 11856.347900865536, 12236.327002014974, 12038.638840834788, 12041.81937270924, 12135.150539462153, 12224.938875305566, 12359.876401235873, 11500.654980350602, 11676.70808229801, 12486.250824950532, 12816.55142070023, 12820.551280705131, 10293.073623373633, 10469.476526173814, 10565.0, 10810.0, 10814.837777433188, 10455.215858810467, 10636.031724800803, 11083.612073577386, 11161.888381116085, 11199.440027998404], "value": 7099.015012199863, "unit": "score"}], "name": "dromaeo_css", "value": 7560.361779983425, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 107.0, 111.0, 113.0, 112.0, 101.0, 111.0, 110.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 126.0, 166.0, 181.0, 136.0, 165.0, 156.0, 131.0, 176.0, 123.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 184.0, 76.0, 77.0, 73.0, 74.0, 183.0, 77.0], "value": 97.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 153.0, 92.0, 93.0, 91.0, 149.0, 93.0, 92.0, 156.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 146.0, 149.0, 148.0, 146.0, 146.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.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": [55.0, 55.0, 57.0, 56.0, 58.0, 56.0, 54.0, 77.0, 59.0, 54.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0, 58.0, 59.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 76.0, 77.0, 77.0, 83.0, 76.0, 75.0, 76.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 115.0, 118.0, 117.0, 115.0, 112.0, 116.0, 114.0, 127.0, 135.0], "value": 119.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 164.0, 163.0, 165.0, 162.0, 168.0, 166.0, 162.0, 169.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 69.0, 70.0, 68.0, 67.0, 67.0, 67.0, 77.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1535.8999999999999, "alertThreshold": 2.0}]} 10:52:33 INFO - Return code: 0 10:52:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:52:33 ERROR - # TBPL SUCCESS # 10:52:33 INFO - Running post-action listener: _resource_record_post_action 10:52:33 INFO - Running post-run listener: _resource_record_post_run 10:52:34 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 8679424; Write bytes: 358989824; Read time: 1316; Write time: 230388 10:52:34 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 1101824; Write bytes: 13672448; Read time: 140; Write time: 2656 10:52:34 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 5816320; Write bytes: 343556096; Read time: 1136; Write time: 227200 10:52:34 INFO - Running post-run listener: _upload_blobber_files 10:52:34 INFO - Blob upload gear active. 10:52:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:52:34 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 10:52:34 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'] 10:52:34 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 10:52:34 INFO - (blobuploader) - INFO - Open directory for files ... 10:52:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:52:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:52:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:35 INFO - (blobuploader) - INFO - Done attempting. 10:52:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:52:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:52:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:36 INFO - (blobuploader) - INFO - Done attempting. 10:52:36 INFO - (blobuploader) - INFO - Iteration through files over. 10:52:36 INFO - Return code: 0 10:52:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:52:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:52:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c7748ecbee0bf302db81db5f4095648d9bd8c3b50794b160e012d6afe0ed771717ed76ec70bbe7aec858ca34752948ad605502f0abe4cda104ce514b0093fba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e97adc0691937235d61d541f7dc48a6f2d2a4314f301d4e78f07eaf89b93c5e9a41e271262df5ad507f20a9db90bf3370259f98e3f944c389f10be6e99b5452b"} 10:52:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:52:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:52:36 INFO - Contents: 10:52:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c7748ecbee0bf302db81db5f4095648d9bd8c3b50794b160e012d6afe0ed771717ed76ec70bbe7aec858ca34752948ad605502f0abe4cda104ce514b0093fba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e97adc0691937235d61d541f7dc48a6f2d2a4314f301d4e78f07eaf89b93c5e9a41e271262df5ad507f20a9db90bf3370259f98e3f944c389f10be6e99b5452b"} 10:52:36 INFO - Running post-run listener: copy_logs_to_upload_dir 10:52:36 INFO - Copying logs to upload dir... 10:52:36 INFO - mkdir: /builds/slave/test/build/upload/logs 10:52:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.048088 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-05 10:52:36.304062) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:52:36.307443) ========= 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=00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311 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/1c7748ecbee0bf302db81db5f4095648d9bd8c3b50794b160e012d6afe0ed771717ed76ec70bbe7aec858ca34752948ad605502f0abe4cda104ce514b0093fba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e97adc0691937235d61d541f7dc48a6f2d2a4314f301d4e78f07eaf89b93c5e9a41e271262df5ad507f20a9db90bf3370259f98e3f944c389f10be6e99b5452b"} build_url:https://queue.taskcluster.net/v1/task/cdKL0_XrQbCnB95-kUd_zw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011138 build_url: 'https://queue.taskcluster.net/v1/task/cdKL0_XrQbCnB95-kUd_zw/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/1c7748ecbee0bf302db81db5f4095648d9bd8c3b50794b160e012d6afe0ed771717ed76ec70bbe7aec858ca34752948ad605502f0abe4cda104ce514b0093fba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e97adc0691937235d61d541f7dc48a6f2d2a4314f301d4e78f07eaf89b93c5e9a41e271262df5ad507f20a9db90bf3370259f98e3f944c389f10be6e99b5452b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:52:36.332344) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:52:36.332636) ========= 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=00204705a9daa57ed339a427000001b9-1467739918.794492-1961235311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:52:36.414525) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:52:36.414809) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:52:36.415091) ========= ========= Total master_lag: 0.16 =========