builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1463164572.42 results: success (0) buildid: 20160513090035 builduid: 5ba24935d4164d6f9036414264444526 revision: a225f011dec1e24bb17e9c3ab0df54ac95875d34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 11:36:12.416611) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 11:36:12.417123) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 11:36:12.417400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 11:36:12.433776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 11:36:12.434152) ========= 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=df17445c3590ff7897617a0e00000225-1463164572.518770-318654104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 11:36:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-05-13 11:36:13 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081365 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 11:36:12.528800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 11:36:12.529107) ========= 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=df17445c3590ff7897617a0e00000225-1463164572.518770-318654104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017309 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 11:36:12.578251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 11:36:12.578613) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a225f011dec1e24bb17e9c3ab0df54ac95875d34 --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 a225f011dec1e24bb17e9c3ab0df54ac95875d34 --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=df17445c3590ff7897617a0e00000225-1463164572.518770-318654104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 11:36:13,386 truncating revision to first 12 chars 2016-05-13 11:36:13,386 Setting DEBUG logging. 2016-05-13 11:36:13,386 attempt 1/10 2016-05-13 11:36:13,386 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a225f011dec1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 11:36:14,162 unpacking tar archive at: mozilla-beta-a225f011dec1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.044350 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 11:36:13.719329) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 11:36:13.719668) ========= script_repo_revision: a225f011dec1e24bb17e9c3ab0df54ac95875d34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 11:36:13.720093) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 11:36:13.720418) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 11:36:13.730740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-13 11:36:13.731045) ========= /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=df17445c3590ff7897617a0e00000225-1463164572.518770-318654104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:36:14 INFO - MultiFileLogger online at 20160513 11:36:14 in /builds/slave/test 11:36:14 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 11:36:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:36:14 INFO - {'append_to_log': False, 11:36:14 INFO - 'base_work_dir': '/builds/slave/test', 11:36:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:36:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:36:14 INFO - 'branch': 'Mozilla-Beta', 11:36:14 INFO - 'buildbot_json_path': 'buildprops.json', 11:36:14 INFO - 'config_files': ('talos/linux_config.py',), 11:36:14 INFO - 'default_actions': ('clobber', 11:36:14 INFO - 'read-buildbot-config', 11:36:14 INFO - 'download-and-extract', 11:36:14 INFO - 'populate-webroot', 11:36:14 INFO - 'create-virtualenv', 11:36:14 INFO - 'install', 11:36:14 INFO - 'run-tests'), 11:36:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:36:14 INFO - 'download_minidump_stackwalk': True, 11:36:14 INFO - 'download_symbols': 'ondemand', 11:36:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:36:14 INFO - 'tooltool.py': '/tools/tooltool.py', 11:36:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:36:14 INFO - '/tools/misc-python/virtualenv.py')}, 11:36:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:36:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:36:14 INFO - 'installer_path': 'installer.exe', 11:36:14 INFO - 'log_level': 'info', 11:36:14 INFO - 'log_name': 'talos', 11:36:14 INFO - 'log_to_console': True, 11:36:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:36:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:36:14 INFO - 'opt_config_files': (), 11:36:14 INFO - 'pip_index': False, 11:36:14 INFO - 'sps_profile': False, 11:36:14 INFO - 'sps_profile_interval': 0, 11:36:14 INFO - 'suite': 'dromaeojs-e10s', 11:36:14 INFO - 'system_bits': '32', 11:36:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:36:14 INFO - 'title': 'talos-linux64-ix-021', 11:36:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:36:14 INFO - 'use_talos_json': True, 11:36:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:36:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:36:14 INFO - 'work_dir': 'build'} 11:36:14 INFO - ##### 11:36:14 INFO - ##### Running clobber step. 11:36:14 INFO - ##### 11:36:14 INFO - Running pre-action listener: _resource_record_pre_action 11:36:14 INFO - Running main action method: clobber 11:36:14 INFO - rmtree: /builds/slave/test/build 11:36:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:36:15 INFO - Running post-action listener: _resource_record_post_action 11:36:15 INFO - ##### 11:36:15 INFO - ##### Running read-buildbot-config step. 11:36:15 INFO - ##### 11:36:15 INFO - Running pre-action listener: _resource_record_pre_action 11:36:15 INFO - Running main action method: read_buildbot_config 11:36:15 INFO - Using buildbot properties: 11:36:15 INFO - { 11:36:15 INFO - "project": "", 11:36:15 INFO - "product": "firefox", 11:36:15 INFO - "script_repo_revision": "production", 11:36:15 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:36:15 INFO - "repository": "", 11:36:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 11:36:15 INFO - "buildid": "20160513090035", 11:36:15 INFO - "pgo_build": "True", 11:36:15 INFO - "basedir": "/builds/slave/test", 11:36:15 INFO - "buildnumber": 14, 11:36:15 INFO - "slavename": "talos-linux64-ix-021", 11:36:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:36:15 INFO - "platform": "ubuntu64_hw", 11:36:15 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:36:15 INFO - "branch": "mozilla-beta", 11:36:15 INFO - "repo_path": "releases/mozilla-beta", 11:36:15 INFO - "revision": "a225f011dec1e24bb17e9c3ab0df54ac95875d34", 11:36:15 INFO - "stage_platform": "linux64-pgo", 11:36:15 INFO - "builduid": "5ba24935d4164d6f9036414264444526", 11:36:15 INFO - "slavebuilddir": "test" 11:36:15 INFO - } 11:36:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 11:36:15 INFO - Running post-action listener: _resource_record_post_action 11:36:15 INFO - ##### 11:36:15 INFO - ##### Running download-and-extract step. 11:36:15 INFO - ##### 11:36:15 INFO - Running pre-action listener: _resource_record_pre_action 11:36:15 INFO - Running main action method: download_and_extract 11:36:15 INFO - mkdir: /builds/slave/test/build/tests 11:36: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')]} 11:36:15 INFO - https://queue.taskcluster.net/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:36:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:36:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:36:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:36:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:36:16 INFO - Downloaded 1412 bytes. 11:36:16 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:36:16 INFO - Using the following test package requirements: 11:36:16 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:36:16 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:36:16 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:36:16 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:36:16 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 11:36:16 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:36:16 INFO - u'jsshell-linux-x86_64.zip'], 11:36:16 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:36:16 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:36:16 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:36:16 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:36:16 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 11:36:16 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:36:16 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 11:36:16 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:36:16 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:36:16 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:36:16 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:36:16 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:36:16 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:16 INFO - https://queue.taskcluster.net/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:36:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:36:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:36:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:36:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:36:17 INFO - Downloaded 23364646 bytes. 11:36:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:36:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:36:18 INFO - Return code: 0 11:36:18 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:36: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')]} 11:36:18 INFO - https://queue.taskcluster.net/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:36:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:36:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:36:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:36:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:36:19 INFO - Downloaded 23364646 bytes. 11:36:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:36:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:36:21 INFO - Return code: 0 11:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:21 INFO - https://queue.taskcluster.net/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:36:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:36:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:36:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:36:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:36:22 INFO - Downloaded 10845194 bytes. 11:36:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:36:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:36:22 INFO - Return code: 0 11:36:22 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')]} 11:36:22 INFO - https://queue.taskcluster.net/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:36:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:36:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:36:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:36:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:36:23 INFO - Downloaded 53790332 bytes. 11:36:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:36:23 INFO - mkdir: /builds/slave/test/properties 11:36:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:36:23 INFO - Writing to file /builds/slave/test/properties/build_url 11:36:23 INFO - Contents: 11:36:23 INFO - build_url:https://queue.taskcluster.net/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:36:24 INFO - Running post-action listener: _resource_record_post_action 11:36:24 INFO - Running post-action listener: set_extra_try_arguments 11:36:24 INFO - ##### 11:36:24 INFO - ##### Running populate-webroot step. 11:36:24 INFO - ##### 11:36:24 INFO - Running pre-action listener: _resource_record_pre_action 11:36:24 INFO - Running main action method: populate_webroot 11:36:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:36:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:36:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:36:24 INFO - '--tppagecycles', 11:36:24 INFO - '7'], 11:36:24 INFO - 'tests': ['tsvgm']}}, 11:36:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:36:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:36:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:36:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:36:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:36:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:36:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:36:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:24 INFO - 'talos_options': ['--e10s'], 11:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:36:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:24 INFO - 'tests': ['damp', 'tps']}, 11:36:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:24 INFO - 'talos_options': ['--e10s'], 11:36:24 INFO - 'tests': ['damp', 'tps']}, 11:36:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:36:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:36:24 INFO - 'other': {'tests': ['a11yr', 11:36:24 INFO - 'ts_paint', 11:36:24 INFO - 'tpaint', 11:36:24 INFO - 'sessionrestore', 11:36:24 INFO - 'sessionrestore_no_auto_restore', 11:36:24 INFO - 'tabpaint']}, 11:36:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:36:24 INFO - 'tests': ['a11yr', 11:36:24 INFO - 'ts_paint', 11:36:24 INFO - 'tpaint', 11:36:24 INFO - 'sessionrestore', 11:36:24 INFO - 'sessionrestore_no_auto_restore', 11:36:24 INFO - 'tabpaint']}, 11:36:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:36:24 INFO - 'tests': ['a11yr', 11:36:24 INFO - 'ts_paint', 11:36:24 INFO - 'tpaint', 11:36:24 INFO - 'sessionrestore', 11:36:24 INFO - 'sessionrestore_no_auto_restore', 11:36:24 INFO - 'tabpaint']}, 11:36:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:36:24 INFO - 'tests': ['a11yr', 11:36:24 INFO - 'ts_paint', 11:36:24 INFO - 'tpaint', 11:36:24 INFO - 'sessionrestore', 11:36:24 INFO - 'sessionrestore_no_auto_restore', 11:36:24 INFO - 'tabpaint']}, 11:36:24 INFO - 'other_l64': {'tests': ['a11yr', 11:36:24 INFO - 'ts_paint', 11:36:24 INFO - 'tpaint', 11:36:24 INFO - 'sessionrestore', 11:36:24 INFO - 'sessionrestore_no_auto_restore', 11:36:24 INFO - 'tabpaint']}, 11:36:24 INFO - 'other_nol64': {'tests': ['a11yr', 11:36:24 INFO - 'ts_paint', 11:36:24 INFO - 'tpaint', 11:36:24 INFO - 'sessionrestore', 11:36:24 INFO - 'sessionrestore_no_auto_restore', 11:36:24 INFO - 'tabpaint']}, 11:36:24 INFO - 'svgr': {'tests': ['tsvgx', 11:36:24 INFO - 'tsvgr_opacity', 11:36:24 INFO - 'tart', 11:36:24 INFO - 'tscrollx', 11:36:24 INFO - 'cart']}, 11:36:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:36:24 INFO - 'tests': ['tsvgx', 11:36:24 INFO - 'tsvgr_opacity', 11:36:24 INFO - 'tart', 11:36:24 INFO - 'tscrollx', 11:36:24 INFO - 'cart']}, 11:36:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:24 INFO - 'tests': ['tp5o']}, 11:36:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:24 INFO - 'talos_options': ['--e10s'], 11:36:24 INFO - 'tests': ['tp5o']}, 11:36:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:24 INFO - 'talos_options': ['--xperf_path', 11:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:36:24 INFO - 'tests': ['tp5n']}, 11:36:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:24 INFO - 'talos_options': ['--e10s', 11:36:24 INFO - '--xperf_path', 11:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:36:24 INFO - 'tests': ['tp5n']}}, 11:36:24 INFO - 'talos.zip': {'path': '', 11:36:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:36:24 INFO - Running post-action listener: _resource_record_post_action 11:36:24 INFO - ##### 11:36:24 INFO - ##### Running create-virtualenv step. 11:36:24 INFO - ##### 11:36:24 INFO - Running pre-action listener: _resource_record_pre_action 11:36:24 INFO - Running main action method: create_virtualenv 11:36:24 INFO - Creating virtualenv /builds/slave/test/build/venv 11:36:24 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 11:36:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:36:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:36:24 INFO - Using real prefix '/usr' 11:36:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:36:25 INFO - Installing distribute.............................................................................................................................................................................................done. 11:36:27 INFO - Installing pip.................done. 11:36:27 INFO - Return code: 0 11:36:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:27 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 0x7f978b58ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377160>, '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 0x2378060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23784f0>, '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': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', '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 11:36:27 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 11:36:27 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 11:36:27 INFO - Using env: {'DISPLAY': ':0', 11:36:27 INFO - 'HOME': '/home/cltbld', 11:36:27 INFO - 'LANG': 'en_US.UTF-8', 11:36:27 INFO - 'LANGUAGE': 'en_US:en', 11:36:27 INFO - 'LOGNAME': 'cltbld', 11:36:27 INFO - 'MAIL': '/var/mail/cltbld', 11:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:27 INFO - 'MOZ_NO_REMOTE': '1', 11:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:27 INFO - 'NO_EM_RESTART': '1', 11:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:27 INFO - 'PWD': '/builds/slave/test', 11:36:27 INFO - 'SHELL': '/bin/bash', 11:36:27 INFO - 'SHLVL': '1', 11:36:27 INFO - 'TERM': 'linux', 11:36:27 INFO - 'TMOUT': '86400', 11:36:27 INFO - 'USER': 'cltbld', 11:36:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', 11:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:27 INFO - '_': '/tools/buildbot/bin/python'} 11:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:27 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 11:36:27 INFO - Cleaning up... 11:36:27 INFO - Return code: 0 11:36:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:27 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 0x7f978b58ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377160>, '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 0x2378060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23784f0>, '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': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', '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 11:36:27 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 11:36:27 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 11:36:27 INFO - Using env: {'DISPLAY': ':0', 11:36:27 INFO - 'HOME': '/home/cltbld', 11:36:27 INFO - 'LANG': 'en_US.UTF-8', 11:36:27 INFO - 'LANGUAGE': 'en_US:en', 11:36:27 INFO - 'LOGNAME': 'cltbld', 11:36:27 INFO - 'MAIL': '/var/mail/cltbld', 11:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:27 INFO - 'MOZ_NO_REMOTE': '1', 11:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:27 INFO - 'NO_EM_RESTART': '1', 11:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:27 INFO - 'PWD': '/builds/slave/test', 11:36:27 INFO - 'SHELL': '/bin/bash', 11:36:27 INFO - 'SHLVL': '1', 11:36:27 INFO - 'TERM': 'linux', 11:36:27 INFO - 'TMOUT': '86400', 11:36:27 INFO - 'USER': 'cltbld', 11:36:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', 11:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:27 INFO - '_': '/tools/buildbot/bin/python'} 11:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:27 INFO - Downloading/unpacking psutil>=0.7.1 11:36:27 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 11:36:27 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 11:36:27 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 11:36:27 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 11:36:27 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 11:36:27 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 11:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:36:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:36:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:36:29 INFO - Installing collected packages: psutil 11:36:29 INFO - Running setup.py install for psutil 11:36:29 INFO - building 'psutil._psutil_linux' extension 11:36: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 11:36:29 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 11:36:29 INFO - building 'psutil._psutil_posix' extension 11:36:29 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 11:36: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 11:36:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:36:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:36:30 INFO - Successfully installed psutil 11:36:30 INFO - Cleaning up... 11:36:30 INFO - Return code: 0 11:36:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:36: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')]} 11:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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')]} 11:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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 0x7f978b58ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377160>, '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 0x2378060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23784f0>, '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': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', '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 11:36: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 11:36: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 11:36:30 INFO - Using env: {'DISPLAY': ':0', 11:36:30 INFO - 'HOME': '/home/cltbld', 11:36:30 INFO - 'LANG': 'en_US.UTF-8', 11:36:30 INFO - 'LANGUAGE': 'en_US:en', 11:36:30 INFO - 'LOGNAME': 'cltbld', 11:36:30 INFO - 'MAIL': '/var/mail/cltbld', 11:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:30 INFO - 'MOZ_NO_REMOTE': '1', 11:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:30 INFO - 'NO_EM_RESTART': '1', 11:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:30 INFO - 'PWD': '/builds/slave/test', 11:36:30 INFO - 'SHELL': '/bin/bash', 11:36:30 INFO - 'SHLVL': '1', 11:36:30 INFO - 'TERM': 'linux', 11:36:30 INFO - 'TMOUT': '86400', 11:36:30 INFO - 'USER': 'cltbld', 11:36:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', 11:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:30 INFO - '_': '/tools/buildbot/bin/python'} 11:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:36: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) 11:36:32 INFO - Installing collected packages: mozsystemmonitor 11:36:32 INFO - Running setup.py install for mozsystemmonitor 11:36:32 INFO - Successfully installed mozsystemmonitor 11:36:32 INFO - Cleaning up... 11:36:32 INFO - Return code: 0 11:36:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:36: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')]} 11:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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')]} 11:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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 0x7f978b58ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377160>, '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 0x2378060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23784f0>, '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': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', '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 11:36: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 11:36: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 11:36:32 INFO - Using env: {'DISPLAY': ':0', 11:36:32 INFO - 'HOME': '/home/cltbld', 11:36:32 INFO - 'LANG': 'en_US.UTF-8', 11:36:32 INFO - 'LANGUAGE': 'en_US:en', 11:36:32 INFO - 'LOGNAME': 'cltbld', 11:36:32 INFO - 'MAIL': '/var/mail/cltbld', 11:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:32 INFO - 'MOZ_NO_REMOTE': '1', 11:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:32 INFO - 'NO_EM_RESTART': '1', 11:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:32 INFO - 'PWD': '/builds/slave/test', 11:36:32 INFO - 'SHELL': '/bin/bash', 11:36:32 INFO - 'SHLVL': '1', 11:36:32 INFO - 'TERM': 'linux', 11:36:32 INFO - 'TMOUT': '86400', 11:36:32 INFO - 'USER': 'cltbld', 11:36:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', 11:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:32 INFO - '_': '/tools/buildbot/bin/python'} 11:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:32 INFO - Downloading/unpacking blobuploader==1.2.4 11:36:32 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 11:36:32 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 11:36:32 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 11:36:32 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 11:36:32 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 11:36:32 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 11:36:34 INFO - Downloading blobuploader-1.2.4.tar.gz 11:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:36:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:36:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:35 INFO - Downloading docopt-0.6.1.tar.gz 11:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:36:35 INFO - Installing collected packages: blobuploader, requests, docopt 11:36:35 INFO - Running setup.py install for blobuploader 11:36:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:36:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:36:35 INFO - Running setup.py install for requests 11:36:35 INFO - Running setup.py install for docopt 11:36:35 INFO - Successfully installed blobuploader requests docopt 11:36:35 INFO - Cleaning up... 11:36:35 INFO - Return code: 0 11:36:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:35 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')]} 11:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:35 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')]} 11:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:35 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 0x7f978b58ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377160>, '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 0x2378060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23784f0>, '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': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', '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 11:36:35 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 11:36:35 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 11:36:35 INFO - Using env: {'DISPLAY': ':0', 11:36:35 INFO - 'HOME': '/home/cltbld', 11:36:35 INFO - 'LANG': 'en_US.UTF-8', 11:36:35 INFO - 'LANGUAGE': 'en_US:en', 11:36:35 INFO - 'LOGNAME': 'cltbld', 11:36:35 INFO - 'MAIL': '/var/mail/cltbld', 11:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:35 INFO - 'MOZ_NO_REMOTE': '1', 11:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:35 INFO - 'NO_EM_RESTART': '1', 11:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:35 INFO - 'PWD': '/builds/slave/test', 11:36:35 INFO - 'SHELL': '/bin/bash', 11:36:35 INFO - 'SHLVL': '1', 11:36:35 INFO - 'TERM': 'linux', 11:36:35 INFO - 'TMOUT': '86400', 11:36:35 INFO - 'USER': 'cltbld', 11:36:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', 11:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:35 INFO - '_': '/tools/buildbot/bin/python'} 11:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:36 INFO - Running setup.py (path:/tmp/pip-LDuJ7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:36 INFO - Running setup.py (path:/tmp/pip-7xmtZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:36 INFO - Running setup.py (path:/tmp/pip-Ui86Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:36 INFO - Running setup.py (path:/tmp/pip-R2AKRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:36 INFO - Running setup.py (path:/tmp/pip-UCKOPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:36 INFO - Running setup.py (path:/tmp/pip-kNbUff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:36 INFO - Running setup.py (path:/tmp/pip-0aKENd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:36 INFO - Running setup.py (path:/tmp/pip-OCkYwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:36 INFO - Running setup.py (path:/tmp/pip-_zIPav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:36 INFO - Running setup.py (path:/tmp/pip-kUk_7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:36 INFO - Running setup.py (path:/tmp/pip-_eGUIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:37 INFO - Running setup.py (path:/tmp/pip-u2dC2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:37 INFO - Running setup.py (path:/tmp/pip-YVUtOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:37 INFO - Running setup.py (path:/tmp/pip-VhjPUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:37 INFO - Running setup.py (path:/tmp/pip-j2Xk7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:37 INFO - Running setup.py (path:/tmp/pip-HFC7_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:37 INFO - Running setup.py (path:/tmp/pip-rqWyoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:36:37 INFO - Running setup.py install for manifestparser 11:36:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:36:37 INFO - Running setup.py install for mozcrash 11:36:37 INFO - Running setup.py install for mozdebug 11:36:37 INFO - Running setup.py install for mozdevice 11:36:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:36:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:36:37 INFO - Running setup.py install for mozfile 11:36:37 INFO - Running setup.py install for mozhttpd 11:36:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Running setup.py install for mozinfo 11:36:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Running setup.py install for mozInstall 11:36:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Running setup.py install for mozleak 11:36:38 INFO - Running setup.py install for mozlog 11:36:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Running setup.py install for moznetwork 11:36:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Running setup.py install for mozprocess 11:36:38 INFO - Running setup.py install for mozprofile 11:36:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Running setup.py install for mozrunner 11:36:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:36:38 INFO - Running setup.py install for mozscreenshot 11:36:39 INFO - Running setup.py install for moztest 11:36:39 INFO - Running setup.py install for mozversion 11:36:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:36:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:36:39 INFO - Cleaning up... 11:36:39 INFO - Return code: 0 11:36:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36: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')]} 11:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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')]} 11:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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 0x7f978b58ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377160>, '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 0x2378060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23784f0>, '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': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', '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 11:36: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 11:36: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 11:36:39 INFO - Using env: {'DISPLAY': ':0', 11:36:39 INFO - 'HOME': '/home/cltbld', 11:36:39 INFO - 'LANG': 'en_US.UTF-8', 11:36:39 INFO - 'LANGUAGE': 'en_US:en', 11:36:39 INFO - 'LOGNAME': 'cltbld', 11:36:39 INFO - 'MAIL': '/var/mail/cltbld', 11:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:39 INFO - 'MOZ_NO_REMOTE': '1', 11:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:39 INFO - 'NO_EM_RESTART': '1', 11:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:39 INFO - 'PWD': '/builds/slave/test', 11:36:39 INFO - 'SHELL': '/bin/bash', 11:36:39 INFO - 'SHLVL': '1', 11:36:39 INFO - 'TERM': 'linux', 11:36:39 INFO - 'TMOUT': '86400', 11:36:39 INFO - 'USER': 'cltbld', 11:36:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', 11:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:39 INFO - '_': '/tools/buildbot/bin/python'} 11:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:39 INFO - Running setup.py (path:/tmp/pip-CWUCH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36: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)) 11:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:39 INFO - Running setup.py (path:/tmp/pip-u1pxFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36: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)) 11:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:39 INFO - Running setup.py (path:/tmp/pip-a5t8fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36: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)) 11:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:39 INFO - Running setup.py (path:/tmp/pip-oGCmpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:39 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)) 11:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:39 INFO - Running setup.py (path:/tmp/pip-t_mR1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:39 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)) 11:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:39 INFO - Running setup.py (path:/tmp/pip-twutzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:39 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)) 11:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:39 INFO - Running setup.py (path:/tmp/pip-YNB8gU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:39 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)) 11:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:39 INFO - Running setup.py (path:/tmp/pip-XxK6yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36: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)) 11:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:40 INFO - Running setup.py (path:/tmp/pip-HZFLes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36: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)) 11:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:40 INFO - Running setup.py (path:/tmp/pip-G9q2U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36: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)) 11:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:40 INFO - Running setup.py (path:/tmp/pip-LU2eSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36: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)) 11:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:40 INFO - Running setup.py (path:/tmp/pip-KhctXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36: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)) 11:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:40 INFO - Running setup.py (path:/tmp/pip-rj7fRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36: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)) 11:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:40 INFO - Running setup.py (path:/tmp/pip-gh4xWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36: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)) 11:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:40 INFO - Running setup.py (path:/tmp/pip-vP8j7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36: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)) 11:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:40 INFO - Running setup.py (path:/tmp/pip-h4MXq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36: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)) 11:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:40 INFO - Running setup.py (path:/tmp/pip-BCoojN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36: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)) 11:36: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)) 11:36: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)) 11:36: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)) 11:36: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)) 11:36: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)) 11:36:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:42 INFO - Downloading blessings-1.6.tar.gz 11:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:36:42 INFO - Installing collected packages: blessings 11:36:42 INFO - Running setup.py install for blessings 11:36:42 INFO - Successfully installed blessings 11:36:42 INFO - Cleaning up... 11:36:42 INFO - Return code: 0 11:36:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:36:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:43 INFO - Reading from file tmpfile_stdout 11:36:43 INFO - Current package versions: 11:36:43 INFO - argparse == 1.2.1 11:36:43 INFO - blessings == 1.6 11:36:43 INFO - blobuploader == 1.2.4 11:36:43 INFO - docopt == 0.6.1 11:36:43 INFO - manifestparser == 1.1 11:36:43 INFO - mozInstall == 1.12 11:36:43 INFO - mozcrash == 0.17 11:36:43 INFO - mozdebug == 0.1 11:36:43 INFO - mozdevice == 0.48 11:36:43 INFO - mozfile == 1.2 11:36:43 INFO - mozhttpd == 0.7 11:36:43 INFO - mozinfo == 0.9 11:36:43 INFO - mozleak == 0.1 11:36:43 INFO - mozlog == 3.1 11:36:43 INFO - moznetwork == 0.27 11:36:43 INFO - mozprocess == 0.22 11:36:43 INFO - mozprofile == 0.28 11:36:43 INFO - mozrunner == 6.11 11:36:43 INFO - mozscreenshot == 0.1 11:36:43 INFO - mozsystemmonitor == 0.0 11:36:43 INFO - moztest == 0.7 11:36:43 INFO - mozversion == 1.4 11:36:43 INFO - psutil == 3.1.1 11:36:43 INFO - requests == 1.2.3 11:36:43 INFO - wsgiref == 0.1.2 11:36:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36: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')]} 11:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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')]} 11:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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 0x7f978b58ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377160>, '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 0x2378060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23784f0>, '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': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', '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 11:36: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 11:36: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 11:36:43 INFO - Using env: {'DISPLAY': ':0', 11:36:43 INFO - 'HOME': '/home/cltbld', 11:36:43 INFO - 'LANG': 'en_US.UTF-8', 11:36:43 INFO - 'LANGUAGE': 'en_US:en', 11:36:43 INFO - 'LOGNAME': 'cltbld', 11:36:43 INFO - 'MAIL': '/var/mail/cltbld', 11:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:43 INFO - 'MOZ_NO_REMOTE': '1', 11:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:43 INFO - 'NO_EM_RESTART': '1', 11:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:43 INFO - 'PWD': '/builds/slave/test', 11:36:43 INFO - 'SHELL': '/bin/bash', 11:36:43 INFO - 'SHLVL': '1', 11:36:43 INFO - 'TERM': 'linux', 11:36:43 INFO - 'TMOUT': '86400', 11:36:43 INFO - 'USER': 'cltbld', 11:36:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', 11:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:43 INFO - '_': '/tools/buildbot/bin/python'} 11:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36: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)) 11:36: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)) 11:36: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)) 11:36: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)) 11:36: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)) 11:36: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)) 11:36: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)) 11:36: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)) 11:36: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)) 11:36: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)) 11:36: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)) 11:36:43 INFO - Cleaning up... 11:36:43 INFO - Return code: 0 11:36:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:36: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')]} 11:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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')]} 11:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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 0x7f978b58ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377160>, '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 0x2378060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23784f0>, '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': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', '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 11:36: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 11:36: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 11:36:43 INFO - Using env: {'DISPLAY': ':0', 11:36:43 INFO - 'HOME': '/home/cltbld', 11:36:43 INFO - 'LANG': 'en_US.UTF-8', 11:36:43 INFO - 'LANGUAGE': 'en_US:en', 11:36:43 INFO - 'LOGNAME': 'cltbld', 11:36:43 INFO - 'MAIL': '/var/mail/cltbld', 11:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:43 INFO - 'MOZ_NO_REMOTE': '1', 11:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:43 INFO - 'NO_EM_RESTART': '1', 11:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:43 INFO - 'PWD': '/builds/slave/test', 11:36:43 INFO - 'SHELL': '/bin/bash', 11:36:43 INFO - 'SHLVL': '1', 11:36:43 INFO - 'TERM': 'linux', 11:36:43 INFO - 'TMOUT': '86400', 11:36:43 INFO - 'USER': 'cltbld', 11:36:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', 11:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:43 INFO - '_': '/tools/buildbot/bin/python'} 11:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:43 INFO - Downloading/unpacking jsonschema 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:36:45 INFO - Downloading/unpacking functools32 (from jsonschema) 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:45 INFO - Downloading functools32-3.2.3-2.tar.gz 11:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:36:45 INFO - warning: no files found matching '*.txt' 11:36:45 INFO - no previously-included directories found matching 'build' 11:36:45 INFO - no previously-included directories found matching 'dist' 11:36:45 INFO - no previously-included directories found matching '.git*' 11:36:45 INFO - Installing collected packages: jsonschema, functools32 11:36:45 INFO - Running setup.py install for functools32 11:36:45 INFO - warning: no files found matching '*.txt' 11:36:45 INFO - no previously-included directories found matching 'build' 11:36:45 INFO - no previously-included directories found matching 'dist' 11:36:45 INFO - no previously-included directories found matching '.git*' 11:36:45 INFO - Successfully installed jsonschema functools32 11:36:45 INFO - Cleaning up... 11:36:45 INFO - Return code: 0 11:36:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:45 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 0x7f978b58ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377160>, '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 0x2378060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23784f0>, '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': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', '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 11:36:45 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 11:36:45 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 11:36:45 INFO - Using env: {'DISPLAY': ':0', 11:36:45 INFO - 'HOME': '/home/cltbld', 11:36:45 INFO - 'LANG': 'en_US.UTF-8', 11:36:45 INFO - 'LANGUAGE': 'en_US:en', 11:36:45 INFO - 'LOGNAME': 'cltbld', 11:36:45 INFO - 'MAIL': '/var/mail/cltbld', 11:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:45 INFO - 'MOZ_NO_REMOTE': '1', 11:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:45 INFO - 'NO_EM_RESTART': '1', 11:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:45 INFO - 'PWD': '/builds/slave/test', 11:36:45 INFO - 'SHELL': '/bin/bash', 11:36:45 INFO - 'SHLVL': '1', 11:36:45 INFO - 'TERM': 'linux', 11:36:45 INFO - 'TMOUT': '86400', 11:36:45 INFO - 'USER': 'cltbld', 11:36:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', 11:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:45 INFO - '_': '/tools/buildbot/bin/python'} 11:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:46 INFO - Downloading/unpacking flake8 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:36:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:36:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:36:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:36:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:36:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:36:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:36:48 INFO - no previously-included directories found matching 'docs/_build' 11:36:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:36:48 INFO - Running setup.py install for pep8 11:36:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:36:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:36:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:36:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:36:48 INFO - no previously-included directories found matching 'docs/_build' 11:36:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:36:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:36:48 INFO - Cleaning up... 11:36:48 INFO - Return code: 0 11:36:48 INFO - Running post-action listener: _resource_record_post_action 11:36:48 INFO - Running post-action listener: _start_resource_monitoring 11:36:48 INFO - Starting resource monitoring. 11:36:48 INFO - ##### 11:36:48 INFO - ##### Running install step. 11:36:48 INFO - ##### 11:36:48 INFO - Running pre-action listener: _resource_record_pre_action 11:36:48 INFO - Running main action method: install 11:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:49 INFO - Reading from file tmpfile_stdout 11:36:49 INFO - Detecting whether we're running mozinstall >=1.0... 11:36:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:36:49 INFO - Reading from file tmpfile_stdout 11:36:49 INFO - Output received: 11:36:49 INFO - Usage: mozinstall [options] installer 11:36:49 INFO - Options: 11:36:49 INFO - -h, --help show this help message and exit 11:36:49 INFO - -d DEST, --destination=DEST 11:36:49 INFO - Directory to install application into. [default: 11:36:49 INFO - "/builds/slave/test"] 11:36:49 INFO - --app=APP Application being installed. [default: firefox] 11:36:49 INFO - mkdir: /builds/slave/test/build/application 11:36:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:37:02 INFO - Reading from file tmpfile_stdout 11:37:02 INFO - Output received: 11:37:02 INFO - /builds/slave/test/build/application/firefox/firefox 11:37:02 INFO - Running post-action listener: _resource_record_post_action 11:37:02 INFO - ##### 11:37:02 INFO - ##### Running run-tests step. 11:37:02 INFO - ##### 11:37:02 INFO - Running pre-action listener: _resource_record_pre_action 11:37:02 INFO - Running main action method: run_tests 11:37:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:37:02 INFO - Python 2.7.3 11:37:02 INFO - Return code: 0 11:37:02 INFO - grabbing minidump binary from tooltool 11:37: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')]} 11:37: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 0x2377160>, '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 0x2378060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23784f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:37: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 11:37: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 11:37:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:37:02 INFO - Return code: 0 11:37:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:37:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:37:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:37:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:37:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:37:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:37:03 INFO - Return code: 0 11:37: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/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 11:37: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/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 11:37:03 INFO - Using env: {'DISPLAY': ':0', 11:37:03 INFO - 'HOME': '/home/cltbld', 11:37:03 INFO - 'LANG': 'en_US.UTF-8', 11:37:03 INFO - 'LANGUAGE': 'en_US:en', 11:37:03 INFO - 'LOGNAME': 'cltbld', 11:37:03 INFO - 'MAIL': '/var/mail/cltbld', 11:37:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:37:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:03 INFO - 'MOZ_NO_REMOTE': '1', 11:37:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:03 INFO - 'NO_EM_RESTART': '1', 11:37:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:03 INFO - 'PWD': '/builds/slave/test', 11:37:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:37:03 INFO - 'SHELL': '/bin/bash', 11:37:03 INFO - 'SHLVL': '1', 11:37:03 INFO - 'TERM': 'linux', 11:37:03 INFO - 'TMOUT': '86400', 11:37:03 INFO - 'USER': 'cltbld', 11:37:03 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463164572.518770-318654104', 11:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:03 INFO - '_': '/tools/buildbot/bin/python'} 11:37: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/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 11:37:04 INFO - mozversion application_buildid: 20160513090035 11:37:04 INFO - mozversion application_changeset: a225f011dec1e24bb17e9c3ab0df54ac95875d34 11:37:04 INFO - mozversion application_display_name: Firefox 11:37:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:37:04 INFO - mozversion application_name: Firefox 11:37:04 INFO - mozversion application_remotingname: firefox 11:37:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:37:04 INFO - mozversion application_vendor: Mozilla 11:37:04 INFO - mozversion application_version: 47.0 11:37:04 INFO - mozversion platform_buildid: 20160513090035 11:37:04 INFO - mozversion platform_changeset: a225f011dec1e24bb17e9c3ab0df54ac95875d34 11:37:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:37:04 INFO - mozversion platform_version: 47.0 11:37:04 INFO - using testdate: 1463164624 11:37:04 INFO - actual date: 1463164624 11:37:04 INFO - starting webserver on 'localhost:43368' 11:37:04 INFO - SUITE-START | Running 2 tests 11:37:04 INFO - TEST-START | dromaeo_css 11:37:04 INFO - operating with platform_type : linux_ 11:37:04 INFO - Initialising browser for dromaeo_css test... 11:37:04 INFO - TEST-INFO | started process 26413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoo2Bp8/profile http://localhost:43368/getInfo.html) 11:37:08 INFO - PROCESS | 26413 | 11:37:08 INFO - PROCESS | 26413 | (process:26488): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:37:09 INFO - PROCESS | 26413 | __metrics Screen width/height:1600/1200 11:37:09 INFO - PROCESS | 26413 | colorDepth:24 11:37:09 INFO - PROCESS | 26413 | Browser inner width/height: 1024/697 11:37:09 INFO - PROCESS | 26413 | __metrics 11:37:10 ERROR - PROCESS | 26413 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:37:11 INFO - TEST-INFO | 26413: exit 0 11:37:11 INFO - Browser initialized. 11:37:11 INFO - Running cycle 1/1 for dromaeo_css test... 11:37:11 INFO - TEST-INFO | started process 26538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoo2Bp8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:37:13 INFO - PROCESS | 26538 | 11:37:13 INFO - PROCESS | 26538 | (process:26607): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:37:23 INFO - PROCESS | 26538 | RSS: Main: 150454272 11:37:23 INFO - PROCESS | 26538 | 11:38:13 INFO - PROCESS | 26538 | 1463164693101 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] 11:40:20 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:43368/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43368/tests/dromaeo/cssquery-ext.html) 11:40:21 INFO - PROCESS | 26538 | RSS: Main: 154427392 11:40:21 INFO - PROCESS | 26538 | 11:43:23 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:43368/tests/dromaeo/cssquery-ext.html (next: http://localhost:43368/tests/dromaeo/cssquery-jquery.html) 11:43:24 INFO - PROCESS | 26538 | RSS: Main: 152178688 11:43:24 INFO - PROCESS | 26538 | 11:46:25 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:43368/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43368/tests/dromaeo/cssquery-mootools.html) 11:46:26 INFO - PROCESS | 26538 | RSS: Main: 151715840 11:46:26 INFO - PROCESS | 26538 | 11:49:28 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:43368/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43368/tests/dromaeo/cssquery-prototype.html) 11:49:28 INFO - PROCESS | 26538 | RSS: Main: 152416256 11:49:28 INFO - PROCESS | 26538 | 11:52:30 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:43368/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43368/tests/dromaeo/cssquery-yui.html) 11:52:31 INFO - PROCESS | 26538 | RSS: Main: 151412736 11:52:31 INFO - PROCESS | 26538 | 11:55:33 INFO - PROCESS | 26538 | Cycle 1(1): loaded http://localhost:43368/tests/dromaeo/cssquery-yui.html (next: http://localhost:43368/tests/dromaeo/cssquery-dojo.html) 11:55:33 INFO - PROCESS | 26538 | RSS: Main: 155611136 11:55:33 INFO - PROCESS | 26538 | 11:55:33 INFO - PROCESS | 26538 | __start_tp_report 11:55:33 INFO - PROCESS | 26538 | _x_x_mozilla_page_load 11:55:33 INFO - PROCESS | 26538 | _x_x_mozilla_page_load_details 11:55:33 INFO - PROCESS | 26538 | |i|pagename|runs| 11:55:33 INFO - PROCESS | 26538 | |0;dojo.html;3308.834558272086;3311.817850018248;3340.6826351496607;3341.3150304187643;3353.044382351029;5325.893482130355;5349.22436246744;5351.785928562863;5372.785088596456;5378.112611419111;5357.866053348668;5367.785288588461;5390.5418039466595;5398.811041613544;5413.864653383667;4939.876503087425;4967.801287948478;5019.949800502003;5039.521245481674;5149.974250128763;4909.607231421478;5013.724245166514;5036.395632524102;5090.872728181788;5103.770330335144;5077.64456488046;5078.949210507903;5135.922961155586;5143;5176.171812509999;4991.975040124812;5015.348004759395;5028.346314979066;5037.5214354636255;5076.289319495274;4961.454240033593;4969.453360130419;4984.750762461862;4989.501049895018;4998.375203099613;5295.179247216687;5311.867203319909;5312.495312945264;5316.813911513079;5317.813876514303;5987.37132601075;5996.310424301218;5998.220231369937;6002.699865006776;6004.669743164124;5983.1025346197985;6037.45662890342;6046.365131661156;6052.667103309316;6076.361981991916;5535.667859928417;5651.9152212716845;5660.2075709400715;5661.66030038199;5665.66006039639;5981.252343457068;6149.723262453201;6175.042868355412;6179.134921111048;6186.257649082139;5819.6508209507565;5880.26496687914;5885.323187833368;5891.440313170242;5908.261467316585;5959.404059594092;5967.19442875215;5970.462658360769;5978.730957106941;5980.910286345708;5837.708114594253;5926.1999630049395;5931.288245410578;5932.940670593325;5933.554983376264;6009.399060094043;6024.006039003515;6027.7287522061615;6033.034714445667;6061.454469097803;4556.498785133633;4569.840055598038;4582.083583283356;4584.679072464895;4606.884827879263;3980.641742243212;4014.9397759033636;4050.9392359114636;4117.958820411757;4132.793360331972;5613.635113717595;5700.458456446631;5766.971165144148;5797.072468405035;5802.796902108406;5863.413658634103;5865.589408741347;5869.765209391662;5875.265591801025;5878.735456904449;5646.9152962704775;5680.744366503517;5743.253377060955;5783.392743761844;5845.970770146122;5064.7214403207445;5096.949030509648;5102.770375333119;5104.566111880532;5105.897882042413;6103.664298463538;6114.419130182626;6136.355682653347;6139.293981192131;6161.137440758297;5975.462208401264;6041.909371359346;6047.0929360596265;6060.727267272895;6080.391960803884;6206.875862482635;6208.658523781055;6210.534209934182;6242.313345531897;6265.404786545271;5711.200431939449;5831.271091113611;5927.407259274038;5968.241924453463;5968.910466342922;5960.403959604178;5972.313183983723;5987.131865879336;5993.340732519332;6074.817755467343;5812.709364531841;5844.503217226414;5852.5317974561085;5855.3559108497175;5857.297124345106;5688.11834165705;5816.302043754607;5858.091995740667;5870.0607902735355;5875.030619947661;5584.832455026356;5613.971930140323;5662.85842853932;5676.687782171855;5705.857353566194;5707.971460142673;5759.280089988752;5783.710814459344;5789.218455508452;5817.563682723728;5563.666180029211;5693.345265294544;5740.483356497935;5798.10129429939;5830.912536311874 11:55:33 INFO - PROCESS | 26538 | |1;ext.html;529.3859123416837;563.9069553523668;573.6472069677145;581.0325807530462;588.2852334413686;36949.44575831361;38378.80810595946;38394.80802595983;38403.03992400191;38482.4227636585;40046.59953400465;40256.19487610246;40536.79731601345;40561;40612.39081413781;8769.99145098314;8959.5968181432;8961.372703910729;8977.506237156953;8978.730638080868;8744.344174186961;9110.407823491452;9111.316651251149;9156.22172115371;9175.908240917572;9156.359054866161;9193.264538836876;9232.122948319933;9238.122378374077;9270.07299270071;9094.909050909506;9139.497327646977;9172.266218702487;9182.219511341544;9194.310426717955;7962.880556791595;9021.954890225572;9026.729198124067;9033.63865445388;9046.502442365667;40090.799546002374;40551.18897622031;40567.18865622701;40634.18731625351;40685.1862962742;1672.3087674777025;3749.6062913393976;3776.376897811858;3970.920581588352;4559.430071241095;32599;32720;32869.50695739566;32959.67040329614;33571.664283357095;4195.643370313527;4228.281192197303;4233.597808208216;4311.676624253162;4367.825286988516;281439;281845;282087;283496;283783;47199.292010619865;47798.76100619475;48119.51880481221;58213;59100.70449647724;44622;45039.54960450353;45099.549004509536;45103.87240319018;45204.77397612991;16565.503034908972;16711.749323760152;16737.497875063767;16770.664586708197;16810;13214.405351759195;13257.138286011379;13306.800397994039;13364.933175334061;13380.464781408635;15494.690106197813;15721.68556628861;15816.76274855878;15839.287232074354;15841.128737919526;6089.725962331706;6112.938870611237;6216.533759968021;6221.8133455995485;6345.714442850082;1058.090042563395;1061.4321338084087;1093.191038631407;1116.625930313354;1135.8807325230896;30467.695323046486;30478.847605761828;30490.085297441114;30602.38795224083;30988.0703578893;1136.653320737183;1142.1433924556582;1166.9416529173507;1184.6919800851667;1202.971459402216;14979.40082396692;14987.335701332357;15219.847801521842;15486.303116359792;15499.225038748018;332258;526386;530493;531054;532199;57605.13592296119;57668.71165644145;58330.416695833344;58597.12104318439;58807;1487.5686051045293;1488.4790323386944;1491.2022068193464;1491.2469203052606;1491.873190778796;29907.252318692208;30516.542251865794;30721.078367649006;30764.077077687703;32479;51921;52222.21666674927;53091.4690853102;53092.4690753103;53102.734486327325;305067;306160;306519;309077;309940;45914;47138.76430617825;47603.28595071146;47835.76082119567;48194;45375.77312113418;45594.77202613965;45884.31173532333;46228;46234.768826157;37911.81044094762;38568;38657.2268554633;39795.40306895341;40552.188956221304;35641.46537801883;36055.27889442249;36202.45696314505;36523.26953460969;37185.44221836729;37334.439983400815;38006.619933800306;40113.79943100383;40133.397999030625;40174;35085.29829403346;35156.64843351636;35300.82349588236;35628.82185589056;35851;27190.72809271882;27669.95608575696;28017.439651206452;28021.299467513476;28197.71802281951 11:55:33 INFO - PROCESS | 26538 | |2;jquery.html;359.98020108894;362.9764065335753;363.31877729257644;378.1284140057167;379.3853956590324;17499;18284.90857545712;19874.105665245064;19882.105305261262;19989.800101998975;16506.25721842517;16618.418355357564;16643.25105370258;16677.83322166778;16691;5363.222332761757;5615.747291371898;5618.297712785902;5618.690971996539;5619.100943848985;5115.820946266881;5325.627206095575;5339.733013349336;5342.412334643186;5547.362053363854;5268.260504537639;5295.0468915595175;5318.228856815779;5319.122344813101;6146.7541298348015;6282.937170628281;6293.653849038301;6296.622202667854;6329.430351268408;6340.461060809836;5077.923831142536;5289;5594.524465420444;5617.550595952314;5637.238972738669;12422.192557483824;12563.434645440977;12598.244105353617;12607.684807879876;15296.923515382463;2218.3677651869302;2224.421650370899;2358.5636657218297;2416.4683769570665;2964.4515764583407;9514.38156519831;9805.656802011896;12455.314957677325;12711.61865144047;12936.611901642966;1931.94204173875;1961.9895753686862;1979.9902049954483;2009.276660402254;2060.1141509151057;63503.682481587755;64079.359206407804;65239.3476065238;65740.3425965739;69987.65006174987;10054.59781608742;10083.798324033478;10089.091981721533;10225.744356391;10321.174306055498;13908.582742517741;13982.091164074303;14002.43990240379;14023.719525609431;14036;7805.7078991746785;8066.83866322682;8125.715599954092;8164.183581641907;8178.059523154794;8015.83968320642;8071.83856322882;8182.631781569844;8194.05768336637;8207.630656620466;4212.978935105366;4275.572442755762;4328.8268469260875;4389.078293558388;4490.730556166641;1906.3804263614381;1982.345825877457;1993.1529100132386;2018.3642152721845;2023.9392818215476;957.1481381570408;1023.7798873242289;1055.3878750324793;1113.9832902506469;1139.5726602524053;17568.64862702739;17652;17698.380556680455;18042.09789510519;18174;1012.9746756331151;1021.3004092196869;1044.2220545693508;1073.0235485707967;1075.5052675769234;10000.299979001546;10358.896411035945;10434.478276086316;10437.895621043692;10536.631217907336;338287;345361;345428;427683;427902;78200.21799781929;79933.60033199796;82875.58562207271;83532.58233708914;84490;1051;1088.2110469909253;1097.4951522299832;1101.603422767819;1103.100972707241;16353.918230409248;16387.918060409622;16445.25996330144;16501.257443414834;16921.66156676835;33932.151696207795;34275;35069.64930350664;35410.645893540735;35999.28001440009;49851.50148498614;50420.74789626175;50534.241986369496;50782.23826642677;51226.74386628192;7724.729634462767;7866.056073271244;7972;8225.83548329018;8625.39622226438;11955;11961.760764784829;12201.02391808671;12290.877091229331;12511.12422130442;10006.199504039514;10793.244472886823;10799.784004320027;11047.171462140532;11232.887671123184;10380.792384152426;10743.140548756237;10990.780184396428;11007.889921100686;11065.170112241452;5439.809606663748;7721;9513;10842.241043126905;11058.778824423627;8504.10706875794;8650;8666.739997800076;8771.780705482413;8777.868331975153;11563.710907227387;11850.051995840484;11909.344986025852;11920.165588408729;12040.879591204326 11:55:33 INFO - PROCESS | 26538 | |3;mootools.html;1545.9922700386496;1564.4211641692573;1792.659394715004;1898.6487499812545;1937.4575118966677;7317.1219453665635;7829.256220659043;7888.56612886291;8039.316658084055;8066.395020373473;8254;8287.627056782445;8355.289800366976;8385.790355241123;8386.664533418656;2390.4023994001454;2417.1177520205174;2421.491486787768;2425.563398588253;2426.805855531562;2437.8049756019564;2443.0960544598524;2480.5038992201544;2485.9378515537073;2488.8880000400027;2387.522495500898;2413.4328432818274;2413.8793060347;2452.3010941881566;2461.5692253855505;2359.398353419867;2394.0423830467953;2413.734489206186;2425.042108367194;2426.599611064172;2361.515889242701;2388.8924998375114;2408.5182963407387;2417.359399759065;2426.2842461473906;8343.040550336667;8375.20435558621;8396.07643159252;8404.453710508797;8425.325973922072;5103.106956282672;5126.2054381570915;5178.249153872667;5212.296339994128;5229.973850130763;3149.669284725094;3180.6024246969127;3240.6111266647918;3242.3839470500766;3259.4295998200455;1016.9796604067877;1023.7184774187084;1030.8659874216303;1060.2366296266675;1067.023673338894;11597.6520704379;11653.300801951826;11660.125490588154;11667.416629168507;11695.181337306392;4520.276755719069;4581.885452863638;4621.329907163443;4655.068986202706;4662.95337046632;9584.424934503952;9742.853857192147;9785.951070244602;9800.90199098014;9808.21534277256;5247.10799164143;5248.186531087687;5257.395399529027;5302.390225124083;5303.602229832778;4564.543545645475;4659.464161621389;4671;4685.5782979532005;4788.521147885253;3853.479780229633;3923.352646813244;3957.604239576019;4004.559498455226;4015.1166743316426;1264.5321231144535;1273.853506846706;1283.0569531394417;1286.041898785392;1295.164618820874;1159.860816702001;1168.8480497535436;1179.1156632525606;1525.7558790593453;1532.3104602928727;7844.529328240324;7895.526268423913;8079.030516338077;8087.474314169678;8089.31240844523;1169.1465230381868;1219.3720234079456;1220.7060515853225;1241.30486927321;1259.238160912653;6121.632702037892;6186.19579454668;6205.844853878599;6264.310925798159;6265.843353916189;9555.474448905377;9785.706428807147;9844.950775246078;9970.900290997142;9993.100620944004;9774.95112524447;9792.804143917081;9802.117809397188;9896;9951.751206219902;7878.921210787933;7885.44801863864;7896.328812050925;7951.244631759973;8009.679612815538;7615;7658.4639075264195;7712.228777122243;7739.651715672696;7799.454038217497;8873.157050080232;9157.267418606629;9195.172434480928;9236.907630923604;9283.860742088738;9041.95479022627;9110.271178305853;9198.356115072149;9310.255179585482;9439.858402123837;6178.536609754196;6747.527673062838;6919.446444284345;7084.893726594002;7162.247963963709;7793.220677932161;7823.647935843014;7824.765257042298;7842.137364889743;7849.568273744999;6976.720931162697;6994.300569942965;6994.720211191496;7076.150861896605;7081.07945967021;6947.096877406107;6957.582545047313;7012.368886800213;7060.505764596429;7063.82340441493;7213.422926165999;7316.268373162641;7574.394048475999;7576.4317676173405;7616.619169041636;6595.241547221939;6808.863822723419;6812.693428795816;6846.4522838173825;6847.21257055445;6933.237343892067;7006.929930700628;7032.6132062735;7044.647767611496;7103 11:55:33 INFO - PROCESS | 26538 | |4;prototype.html;338.223776433086;339.4721208520751;339.9320135972806;342.6950014487107;346.8785924926276;6289.874202515947;6308.337624549419;6327.746890124396;6338.239411270642;6358.205224346951;6199.938000619993;6208.937910620893;6212.5029997600195;6241.750329986795;6254.499640028798;4653.581177694007;4764.666473346867;4796.640251981106;4803.927941080887;4816.494268101851;4772.952270477285;4784.78468468918;4791.041791641668;4798.160321943646;4798.7840547175465;4724.291356296549;4724.362211101509;4735.3370528125915;4740.502247264039;4745.549172828576;4676.438827340741;4735.124002059612;4737.976310118444;4745.193317136095;4749.596284315838;4074.225897079575;4081.673466122703;4084.693647976384;4091.2226676931286;4092.774897380643;6014.96992515039;6017.879642407172;6019.307779605358;6019.879602407927;6042.365551617105;5307.230451584537;5502.339719233718;5503.724813759336;5516.282883225195;5518.33779946405;6602.669866506655;6613.867722645568;6637.1703537057865;6641.335866413368;6644.036614690891;4477.597016268552;4478.149151661174;4481.843135490275;4481.955180448186;4485.237509623339;6880.346367095168;6926.134233220848;6988.301169882971;6991.161060672701;7002.229754726976;4567.063751930847;4568.451785785727;4570.88572785683;4573.519780423007;4578.015726618726;4500.797464114123;4637.814487420465;4639.141758774637;4645.9303110453375;4648.279516674921;5425.457454254543;5462;5465.508104270635;5466.453354664502;5477;6711.060451536789;6745.426638735762;6745.696443660047;6748.291429399842;6766.69549870257;1627.3978627907513;1646.2920943993959;1649.158928946246;1652.0996057148882;1653.2229851969555;1024.513356155835;1038.159091136182;1055.72551136705;1057.9682609521726;1062.766191437898;6641.435477984425;6645.501587380966;6649;6658.400743932973;6658.800235992928;6939.548929319578;6949.2008419031445;6965.373116419445;6990.266022067712;6991.580505169706;6616.536842420985;6653.234877988996;6740.056392105109;6770.4922130839395;6777.661116944133;3795.070207799107;3818.4654148419245;3824.579296277407;3825.7513261637905;3826.483424737625;7354;7391.260873912565;7402.222766609536;7416.147143078615;7441.8139546511775;7188.209296977328;7216.96391518039;7225.385842203472;7227.5302105364035;7233.710651573983;7122.28777122294;7346.338829505264;7378.889316660255;7396.593187374746;7431.591262480615;7111.075560177351;7119.75080872167;7124.679389427592;7153.141623005273;7153.785386438415;6915.377616014583;6919.965400172967;6941.583504989717;6979.40675042627;7001.229864714979;7383.224761399975;7394.2975417335265;7398.593077380796;7402.4078073755045;7438.330550250504;4480.036792089716;4609.492955774929;4638.1187574360765;4642.837500687459;4661.34741136248;6943.548669336477;6968.930310696828;6993.650317484004;6996.195437524546;7001.649917504206;6758.966205168943;6773.322667733188;6778.457723382019;6783.660816959034;6785.898211526733;6748.2576916538155;6764.323567643196;6770.52606317553;6777.593344399352;6789.558678685869;6517.804465866032;6615.305392933673;6631.502637302126;6633.336666333328;6651.567648102858;6788.049673045876;6795.89806152918;6799.082123913208;6805.8638827222185;6806.829829254309;6612.074309596756;6615.140031795836;6617.172853393326;6627.138471998609;6643.46852251809 11:55:33 INFO - PROCESS | 26538 | |5;yui.html;806.8628333183358;840.3277378097522;850.0054935725201;875.4047247871445;896.4755617963491;14361.856381436182;14687.412503499874;14738.852611473896;14750.557483275492;14774.187419691913;13457.663558411045;13849.446022159102;13875.375608097635;13877.791833122512;13879.375428105734;910.8087301666642;932.1936524905941;945.8817647794026;946.725449619613;952.2667545989618;917.495377542349;924.0389994405843;925.0379605210572;925.4678559828092;926.333040211047;983.3853841349156;983.6655537117379;983.9557219925085;984.1241295247236;984.7685793838442;971.946542940138;976.9071938165898;978.0952618827591;978.5254151736402;980.7008862296997;728.537378764483;728.7412968396249;729.9889652830815;731.853629274142;732.8644200822865;14920.552383428407;14932.178730169837;14955.775663365059;14964.251787410694;15001.024933379296;13525.797113043312;13552.796708049387;13632.863671363259;13701.109427887155;13730.313484325743;11706.180567360288;11805.291682498992;11866.58466953661;11906.285622862655;11916.165868389216;3842.231553689245;3880.185161116169;3883.650471457582;3918.960810391888;3932.3708206686792;53648.92702145935;53884.73057634726;53980.73009634966;54287.18569221465;54828.72585637086;10727.463626818628;10882.238243322892;11029.724256893482;11086.944565277283;11118.61084862026;19277.80722192788;19421.90289048574;19520.80479195218;19670.40988770339;19676.803231967497;8093.797655058553;8161.510309381456;8268.37987150966;8296.875546866802;8376.539290338967;4726.432828060655;4729.7398643074275;4748.264019077049;4915;5000.649954503223;3453.9827300863835;3484.1638006878165;3490.2495963367996;3491.755577109578;3499.4750787381586;599.484443378694;614.8186285045922;616.7378863982879;619.1332135011021;625.9374062593795;698.7973487688513;699.2448155991517;709.5033476566424;713.1050531582933;718.5114122396716;8334.291585215204;8418.368622353348;8472.152784721478;8504.44721093127;8596.226339629464;586.5952492779968;597.9671118088547;651.5633029170667;685.5989246290876;715.2025491576854;3982.7411218270718;4030.496187976503;4252.851150209728;4282.229198744256;4342.457192850894;56039.71980140073;57507.71246143826;58304;58466.70766646139;58501.414985849595;49704.75738106576;50332.74833625808;50857.23714144291;52739.472605273455;53694.46305536973;48403;48973.51026489832;49155.262671059965;49427;49640;8228.094909560063;8349.415540912078;8357.665693372197;8489.40574159803;8497.107803680525;35285.47071793977;36026.4596031065;36988.260234794616;37061.258774823815;37295.81352093222;41172.79413602913;41295.7935210334;44267.11465770731;45062;45097;10557.472126393803;10581.259311848096;10677.359358438518;10759.085477734166;10783.676489705322;12161.81757273624;12169.878301217228;12187.268763874195;12225.510979560719;13944.930275348559;11328.376939268419;11562.190646654653;11591;11598.94200528992;11866.76266474683;12239.20445171061;12438.129330946747;12509.374531273583;12604.49582016709;12693.365331733192;11655.18413711032;11709.648710538697;11858;11928.522859085886;11930.164888457724;10013.799724005625;10126.746831329276;10160.695179144637;10269.640562580274;10321.793564128826;9751.073648003428;9830.164436023018;10207.132393746318;10288.845667315147;10376.584936602452 11:55:33 INFO - PROCESS | 26538 | __end_tp_report 11:55:33 INFO - PROCESS | 26538 | __start_cc_report 11:55:33 INFO - PROCESS | 26538 | _x_x_mozilla_cycle_collect,324 11:55:33 INFO - PROCESS | 26538 | __end_cc_report 11:55:33 INFO - PROCESS | 26538 | __startTimestamp1463165733847__endTimestamp 11:55:33 INFO - PROCESS | 26538 | 11:55:33 INFO - PROCESS | 26538 | ------- Summary: start ------- 11:55:33 INFO - PROCESS | 26538 | Number of tests: 6 11:55:33 INFO - PROCESS | 26538 | 11:55:33 INFO - PROCESS | 26538 | [#0] dojo.html Cycles:165 Average:5525.44 Median:5766.97 stddev:629.46 (10.9%) stddev-sans-first:606.90 11:55:33 INFO - PROCESS | 26538 | Values: 3308.8 3311.8 3340.7 3341.3 3353.0 5325.9 5349.2 5351.8 5372.8 5378.1 5357.9 5367.8 5390.5 5398.8 5413.9 4939.9 4967.8 5019.9 5039.5 5150.0 4909.6 5013.7 5036.4 5090.9 5103.8 5077.6 5078.9 5135.9 5143.0 5176.2 4992.0 5015.3 5028.3 5037.5 5076.3 4961.5 4969.5 4984.8 4989.5 4998.4 5295.2 5311.9 5312.5 5316.8 5317.8 5987.4 5996.3 5998.2 6002.7 6004.7 5983.1 6037.5 6046.4 6052.7 6076.4 5535.7 5651.9 5660.2 5661.7 5665.7 5981.3 6149.7 6175.0 6179.1 6186.3 5819.7 5880.3 5885.3 5891.4 5908.3 5959.4 5967.2 5970.5 5978.7 5980.9 5837.7 5926.2 5931.3 5932.9 5933.6 6009.4 6024.0 6027.7 6033.0 6061.5 4556.5 4569.8 4582.1 4584.7 4606.9 3980.6 4014.9 4050.9 4118.0 4132.8 5613.6 5700.5 5767.0 5797.1 5802.8 5863.4 5865.6 5869.8 5875.3 5878.7 5646.9 5680.7 5743.3 5783.4 5846.0 5064.7 5096.9 5102.8 5104.6 5105.9 6103.7 6114.4 6136.4 6139.3 6161.1 5975.5 6041.9 6047.1 6060.7 6080.4 6206.9 6208.7 6210.5 6242.3 6265.4 5711.2 5831.3 5927.4 5968.2 5968.9 5960.4 5972.3 5987.1 5993.3 6074.8 5812.7 5844.5 5852.5 5855.4 5857.3 5688.1 5816.3 5858.1 5870.1 5875.0 5584.8 5614.0 5662.9 5676.7 5705.9 5708.0 5759.3 5783.7 5789.2 5817.6 5563.7 5693.3 5740.5 5798.1 5830.9 11:55:33 INFO - PROCESS | 26538 | 11:55:33 INFO - PROCESS | 26538 | [#1] ext.html Cycles:180 Average:52703.10 Median:39921.00 stddev:99150.20 (248.4%) stddev-sans-first:99350.96 11:55:33 INFO - PROCESS | 26538 | Values: 529.4 563.9 573.6 581.0 588.3 36949.4 38378.8 38394.8 38403.0 38482.4 40046.6 40256.2 40536.8 40561.0 40612.4 8770.0 8959.6 8961.4 8977.5 8978.7 8744.3 9110.4 9111.3 9156.2 9175.9 9156.4 9193.3 9232.1 9238.1 9270.1 9094.9 9139.5 9172.3 9182.2 9194.3 7962.9 9022.0 9026.7 9033.6 9046.5 40090.8 40551.2 40567.2 40634.2 40685.2 1672.3 3749.6 3776.4 3970.9 4559.4 32599.0 32720.0 32869.5 32959.7 33571.7 4195.6 4228.3 4233.6 4311.7 4367.8 281439.0 281845.0 282087.0 283496.0 283783.0 47199.3 47798.8 48119.5 58213.0 59100.7 44622.0 45039.5 45099.5 45103.9 45204.8 16565.5 16711.7 16737.5 16770.7 16810.0 13214.4 13257.1 13306.8 13364.9 13380.5 15494.7 15721.7 15816.8 15839.3 15841.1 6089.7 6112.9 6216.5 6221.8 6345.7 1058.1 1061.4 1093.2 1116.6 1135.9 30467.7 30478.8 30490.1 30602.4 30988.1 1136.7 1142.1 1166.9 1184.7 1203.0 14979.4 14987.3 15219.8 15486.3 15499.2 332258.0 526386.0 530493.0 531054.0 532199.0 57605.1 57668.7 58330.4 58597.1 58807.0 1487.6 1488.5 1491.2 1491.2 1491.9 29907.3 30516.5 30721.1 30764.1 32479.0 51921.0 52222.2 53091.5 53092.5 53102.7 305067.0 306160.0 306519.0 309077.0 309940.0 45914.0 47138.8 47603.3 47835.8 48194.0 45375.8 45594.8 45884.3 46228.0 46234.8 37911.8 38568.0 38657.2 39795.4 40552.2 35641.5 36055.3 36202.5 36523.3 37185.4 37334.4 38006.6 40113.8 40133.4 40174.0 35085.3 35156.6 35300.8 35628.8 35851.0 27190.7 27670.0 28017.4 28021.3 28197.7 11:55:33 INFO - PROCESS | 26538 | 11:55:33 INFO - PROCESS | 26538 | [#2] jquery.html Cycles:180 Average:24140.94 Median:2291.49 stddev:62679.53 (2735.3%) stddev-sans-first:62829.92 11:55:33 INFO - PROCESS | 26538 | Values: 360.0 363.0 363.3 378.1 379.4 17499.0 18284.9 19874.1 19882.1 19989.8 16506.3 16618.4 16643.3 16677.8 16691.0 5363.2 5615.7 5618.3 5618.7 5619.1 5115.8 5325.6 5339.7 5342.4 5547.4 5268.3 5295.0 5318.2 5319.1 6146.8 6282.9 6293.7 6296.6 6329.4 6340.5 5077.9 5289.0 5594.5 5617.6 5637.2 12422.2 12563.4 12598.2 12607.7 15296.9 2218.4 2224.4 2358.6 2416.5 2964.5 9514.4 9805.7 12455.3 12711.6 12936.6 1931.9 1962.0 1980.0 2009.3 2060.1 63503.7 64079.4 65239.3 65740.3 69987.7 10054.6 10083.8 10089.1 10225.7 10321.2 13908.6 13982.1 14002.4 14023.7 14036.0 7805.7 8066.8 8125.7 8164.2 8178.1 8015.8 8071.8 8182.6 8194.1 8207.6 4213.0 4275.6 4328.8 4389.1 4490.7 1906.4 1982.3 1993.2 2018.4 2023.9 957.1 1023.8 1055.4 1114.0 1139.6 17568.6 17652.0 17698.4 18042.1 18174.0 1013.0 1021.3 1044.2 1073.0 1075.5 10000.3 10358.9 10434.5 10437.9 10536.6 338287.0 345361.0 345428.0 427683.0 427902.0 78200.2 79933.6 82875.6 83532.6 84490.0 1051.0 1088.2 1097.5 1101.6 1103.1 16353.9 16387.9 16445.3 16501.3 16921.7 33932.2 34275.0 35069.6 35410.6 35999.3 49851.5 50420.7 50534.2 50782.2 51226.7 7724.7 7866.1 7972.0 8225.8 8625.4 11955.0 11961.8 12201.0 12290.9 12511.1 10006.2 10793.2 10799.8 11047.2 11232.9 10380.8 10743.1 10990.8 11007.9 11065.2 5439.8 7721.0 9513.0 10842.2 11058.8 8504.1 8650.0 8666.7 8771.8 8777.9 11563.7 11850.1 11909.3 11920.2 12040.9 11:55:33 INFO - PROCESS | 26538 | 11:55:33 INFO - PROCESS | 26538 | [#3] mootools.html Cycles:180 Average:5816.11 Median:6430.54 stddev:2992.32 (46.5%) stddev-sans-first:2983.50 11:55:33 INFO - PROCESS | 26538 | Values: 1546.0 1564.4 1792.7 1898.6 1937.5 7317.1 7829.3 7888.6 8039.3 8066.4 8254.0 8287.6 8355.3 8385.8 8386.7 2390.4 2417.1 2421.5 2425.6 2426.8 2437.8 2443.1 2480.5 2485.9 2488.9 2387.5 2413.4 2413.9 2452.3 2461.6 2359.4 2394.0 2413.7 2425.0 2426.6 2361.5 2388.9 2408.5 2417.4 2426.3 8343.0 8375.2 8396.1 8404.5 8425.3 5103.1 5126.2 5178.2 5212.3 5230.0 3149.7 3180.6 3240.6 3242.4 3259.4 1017.0 1023.7 1030.9 1060.2 1067.0 11597.7 11653.3 11660.1 11667.4 11695.2 4520.3 4581.9 4621.3 4655.1 4663.0 9584.4 9742.9 9786.0 9800.9 9808.2 5247.1 5248.2 5257.4 5302.4 5303.6 4564.5 4659.5 4671.0 4685.6 4788.5 3853.5 3923.4 3957.6 4004.6 4015.1 1264.5 1273.9 1283.1 1286.0 1295.2 1159.9 1168.8 1179.1 1525.8 1532.3 7844.5 7895.5 8079.0 8087.5 8089.3 1169.1 1219.4 1220.7 1241.3 1259.2 6121.6 6186.2 6205.8 6264.3 6265.8 9555.5 9785.7 9845.0 9970.9 9993.1 9775.0 9792.8 9802.1 9896.0 9951.8 7878.9 7885.4 7896.3 7951.2 8009.7 7615.0 7658.5 7712.2 7739.7 7799.5 8873.2 9157.3 9195.2 9236.9 9283.9 9042.0 9110.3 9198.4 9310.3 9439.9 6178.5 6747.5 6919.4 7084.9 7162.2 7793.2 7823.6 7824.8 7842.1 7849.6 6976.7 6994.3 6994.7 7076.2 7081.1 6947.1 6957.6 7012.4 7060.5 7063.8 7213.4 7316.3 7574.4 7576.4 7616.6 6595.2 6808.9 6812.7 6846.5 6847.2 6933.2 7006.9 7032.6 7044.6 7103.0 11:55:33 INFO - PROCESS | 26538 | 11:55:33 INFO - PROCESS | 26538 | [#4] prototype.html Cycles:180 Average:5621.92 Median:6560.24 stddev:1758.05 (26.8%) stddev-sans-first:1717.67 11:55:33 INFO - PROCESS | 26538 | Values: 338.2 339.5 339.9 342.7 346.9 6289.9 6308.3 6327.7 6338.2 6358.2 6199.9 6208.9 6212.5 6241.8 6254.5 4653.6 4764.7 4796.6 4803.9 4816.5 4773.0 4784.8 4791.0 4798.2 4798.8 4724.3 4724.4 4735.3 4740.5 4745.5 4676.4 4735.1 4738.0 4745.2 4749.6 4074.2 4081.7 4084.7 4091.2 4092.8 6015.0 6017.9 6019.3 6019.9 6042.4 5307.2 5502.3 5503.7 5516.3 5518.3 6602.7 6613.9 6637.2 6641.3 6644.0 4477.6 4478.1 4481.8 4482.0 4485.2 6880.3 6926.1 6988.3 6991.2 7002.2 4567.1 4568.5 4570.9 4573.5 4578.0 4500.8 4637.8 4639.1 4645.9 4648.3 5425.5 5462.0 5465.5 5466.5 5477.0 6711.1 6745.4 6745.7 6748.3 6766.7 1627.4 1646.3 1649.2 1652.1 1653.2 1024.5 1038.2 1055.7 1058.0 1062.8 6641.4 6645.5 6649.0 6658.4 6658.8 6939.5 6949.2 6965.4 6990.3 6991.6 6616.5 6653.2 6740.1 6770.5 6777.7 3795.1 3818.5 3824.6 3825.8 3826.5 7354.0 7391.3 7402.2 7416.1 7441.8 7188.2 7217.0 7225.4 7227.5 7233.7 7122.3 7346.3 7378.9 7396.6 7431.6 7111.1 7119.8 7124.7 7153.1 7153.8 6915.4 6920.0 6941.6 6979.4 7001.2 7383.2 7394.3 7398.6 7402.4 7438.3 4480.0 4609.5 4638.1 4642.8 4661.3 6943.5 6968.9 6993.7 6996.2 7001.6 6759.0 6773.3 6778.5 6783.7 6785.9 6748.3 6764.3 6770.5 6777.6 6789.6 6517.8 6615.3 6631.5 6633.3 6651.6 6788.0 6795.9 6799.1 6805.9 6806.8 6612.1 6615.1 6617.2 6627.1 6643.5 11:55:33 INFO - PROCESS | 26538 | 11:55:33 INFO - PROCESS | 26538 | [#5] yui.html Cycles:180 Average:14443.54 Median:44664.56 stddev:16450.69 (36.8%) stddev-sans-first:16464.96 11:55:33 INFO - PROCESS | 26538 | Values: 806.9 840.3 850.0 875.4 896.5 14361.9 14687.4 14738.9 14750.6 14774.2 13457.7 13849.4 13875.4 13877.8 13879.4 910.8 932.2 945.9 946.7 952.3 917.5 924.0 925.0 925.5 926.3 983.4 983.7 984.0 984.1 984.8 971.9 976.9 978.1 978.5 980.7 728.5 728.7 730.0 731.9 732.9 14920.6 14932.2 14955.8 14964.3 15001.0 13525.8 13552.8 13632.9 13701.1 13730.3 11706.2 11805.3 11866.6 11906.3 11916.2 3842.2 3880.2 3883.7 3919.0 3932.4 53648.9 53884.7 53980.7 54287.2 54828.7 10727.5 10882.2 11029.7 11086.9 11118.6 19277.8 19421.9 19520.8 19670.4 19676.8 8093.8 8161.5 8268.4 8296.9 8376.5 4726.4 4729.7 4748.3 4915.0 5000.6 3454.0 3484.2 3490.2 3491.8 3499.5 599.5 614.8 616.7 619.1 625.9 698.8 699.2 709.5 713.1 718.5 8334.3 8418.4 8472.2 8504.4 8596.2 586.6 598.0 651.6 685.6 715.2 3982.7 4030.5 4252.9 4282.2 4342.5 56039.7 57507.7 58304.0 58466.7 58501.4 49704.8 50332.7 50857.2 52739.5 53694.5 48403.0 48973.5 49155.3 49427.0 49640.0 8228.1 8349.4 8357.7 8489.4 8497.1 35285.5 36026.5 36988.3 37061.3 37295.8 41172.8 41295.8 44267.1 45062.0 45097.0 10557.5 10581.3 10677.4 10759.1 10783.7 12161.8 12169.9 12187.3 12225.5 13944.9 11328.4 11562.2 11591.0 11598.9 11866.8 12239.2 12438.1 12509.4 12604.5 12693.4 11655.2 11709.6 11858.0 11928.5 11930.2 10013.8 10126.7 10160.7 10269.6 10321.8 9751.1 9830.2 10207.1 10288.8 10376.6 11:55:33 INFO - PROCESS | 26538 | -------- Summary: end -------- 11:55:33 INFO - PROCESS | 26538 | 11:55:34 INFO - TEST-INFO | 26538: exit 0 11:55:34 INFO - TEST-OK | dromaeo_css | took 1110427ms 11:55:34 INFO - TEST-START | kraken 11:55:34 INFO - operating with platform_type : linux_ 11:55:34 INFO - Initialising browser for kraken test... 11:55:34 INFO - TEST-INFO | started process 26782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmNMUa_/profile http://localhost:43368/getInfo.html) 11:55:39 INFO - PROCESS | 26782 | 11:55:39 INFO - PROCESS | 26782 | (process:26857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:55:40 INFO - PROCESS | 26782 | __metrics Screen width/height:1600/1200 11:55:40 INFO - PROCESS | 26782 | colorDepth:24 11:55:40 INFO - PROCESS | 26782 | Browser inner width/height: 1024/697 11:55:40 INFO - PROCESS | 26782 | __metrics 11:55:40 ERROR - PROCESS | 26782 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:55:41 INFO - TEST-INFO | 26782: exit 0 11:55:41 INFO - Browser initialized. 11:55:41 INFO - Running cycle 1/1 for kraken test... 11:55:41 INFO - TEST-INFO | started process 26907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmNMUa_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:55:43 INFO - PROCESS | 26907 | 11:55:43 INFO - PROCESS | 26907 | (process:26976): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:55:53 INFO - PROCESS | 26907 | RSS: Main: 150179840 11:55:53 INFO - PROCESS | 26907 | 11:55:56 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43368/tests/kraken/driver.html?testName=audio-beat-detection) 11:55:56 INFO - PROCESS | 26907 | RSS: Main: 154648576 11:55:56 INFO - PROCESS | 26907 | 11:55:59 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43368/tests/kraken/driver.html?testName=audio-dft) 11:56:00 INFO - PROCESS | 26907 | RSS: Main: 154669056 11:56:00 INFO - PROCESS | 26907 | 11:56:03 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43368/tests/kraken/driver.html?testName=audio-fft) 11:56:03 INFO - PROCESS | 26907 | RSS: Main: 155074560 11:56:03 INFO - PROCESS | 26907 | 11:56:05 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43368/tests/kraken/driver.html?testName=audio-oscillator) 11:56:06 INFO - PROCESS | 26907 | RSS: Main: 154750976 11:56:06 INFO - PROCESS | 26907 | 11:56:08 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43368/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:56:09 INFO - PROCESS | 26907 | RSS: Main: 154947584 11:56:09 INFO - PROCESS | 26907 | 11:56:12 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43368/tests/kraken/driver.html?testName=imaging-darkroom) 11:56:12 INFO - PROCESS | 26907 | RSS: Main: 155811840 11:56:12 INFO - PROCESS | 26907 | 11:56:16 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43368/tests/kraken/driver.html?testName=imaging-desaturate) 11:56:16 INFO - PROCESS | 26907 | RSS: Main: 155394048 11:56:16 INFO - PROCESS | 26907 | 11:56:19 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43368/tests/kraken/driver.html?testName=json-parse-financial) 11:56:20 INFO - PROCESS | 26907 | RSS: Main: 155361280 11:56:20 INFO - PROCESS | 26907 | 11:56:21 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43368/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:56:22 INFO - PROCESS | 26907 | RSS: Main: 154857472 11:56:22 INFO - PROCESS | 26907 | 11:56:24 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43368/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:56:24 INFO - PROCESS | 26907 | RSS: Main: 155131904 11:56:24 INFO - PROCESS | 26907 | 11:56:26 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43368/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:56:27 INFO - PROCESS | 26907 | RSS: Main: 155492352 11:56:27 INFO - PROCESS | 26907 | 11:56:29 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:56:30 INFO - PROCESS | 26907 | RSS: Main: 155779072 11:56:30 INFO - PROCESS | 26907 | 11:56:32 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:56:33 INFO - PROCESS | 26907 | RSS: Main: 155652096 11:56:33 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | Cycle 1(1): loaded http://localhost:43368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43368/tests/kraken/driver.html?testName=ai-astar) 11:56:35 INFO - PROCESS | 26907 | RSS: Main: 157298688 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | __start_tp_report 11:56:35 INFO - PROCESS | 26907 | _x_x_mozilla_page_load 11:56:35 INFO - PROCESS | 26907 | _x_x_mozilla_page_load_details 11:56:35 INFO - PROCESS | 26907 | |i|pagename|runs| 11:56:35 INFO - PROCESS | 26907 | |0;ai-astar;113;107;111;113;113;122;110;110;112;110 11:56:35 INFO - PROCESS | 26907 | |1;audio-beat-detection;164;134;156;165;128;155;153;128;180;130 11:56:35 INFO - PROCESS | 26907 | |2;audio-dft;161;162;161;163;163;162;164;161;165;161 11:56:35 INFO - PROCESS | 26907 | |3;audio-fft;77;74;77;164;77;77;76;73;163;74 11:56:35 INFO - PROCESS | 26907 | |4;audio-oscillator;94;92;137;93;93;94;151;92;93;149 11:56:35 INFO - PROCESS | 26907 | |5;imaging-gaussian-blur;117;117;117;118;118;117;118;117;117;117 11:56:35 INFO - PROCESS | 26907 | |6;imaging-darkroom;146;146;146;147;147;146;145;147;146;149 11:56:35 INFO - PROCESS | 26907 | |7;imaging-desaturate;96;96;96;96;98;96;96;96;97;97 11:56:35 INFO - PROCESS | 26907 | |8;json-parse-financial;56;57;59;57;59;68;56;59;58;54 11:56:35 INFO - PROCESS | 26907 | |9;json-stringify-tinderbox;67;66;66;65;65;66;65;65;67;66 11:56:35 INFO - PROCESS | 26907 | |10;stanford-crypto-aes;79;80;83;80;82;88;80;90;80;79 11:56:35 INFO - PROCESS | 26907 | |11;stanford-crypto-ccm;120;113;118;117;114;121;125;125;115;113 11:56:35 INFO - PROCESS | 26907 | |12;stanford-crypto-pbkdf2;137;145;147;145;144;133;142;147;146;144 11:56:35 INFO - PROCESS | 26907 | |13;stanford-crypto-sha256-iterative;68;67;70;67;68;66;66;67;69;66 11:56:35 INFO - PROCESS | 26907 | __end_tp_report 11:56:35 INFO - PROCESS | 26907 | __start_cc_report 11:56:35 INFO - PROCESS | 26907 | _x_x_mozilla_cycle_collect,821 11:56:35 INFO - PROCESS | 26907 | __end_cc_report 11:56:35 INFO - PROCESS | 26907 | __startTimestamp1463165795340__endTimestamp 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | ------- Summary: start ------- 11:56:35 INFO - PROCESS | 26907 | Number of tests: 14 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:3.96 (3.5%) stddev-sans-first:4.18 11:56:35 INFO - PROCESS | 26907 | Values: 113.0 107.0 111.0 113.0 113.0 122.0 110.0 110.0 112.0 110.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:155.50 stddev:18.29 (11.8%) stddev-sans-first:18.61 11:56:35 INFO - PROCESS | 26907 | Values: 164.0 134.0 156.0 165.0 128.0 155.0 153.0 128.0 180.0 130.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.42 (0.9%) stddev-sans-first:1.42 11:56:35 INFO - PROCESS | 26907 | Values: 161.0 162.0 161.0 163.0 163.0 162.0 164.0 161.0 165.0 161.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.50 stddev:37.08 (48.5%) stddev-sans-first:38.87 11:56:35 INFO - PROCESS | 26907 | Values: 77.0 74.0 77.0 164.0 77.0 77.0 76.0 73.0 163.0 74.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:93.00 stddev:25.70 (27.6%) stddev-sans-first:26.69 11:56:35 INFO - PROCESS | 26907 | Values: 94.0 92.0 137.0 93.0 93.0 94.0 151.0 92.0 93.0 149.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:56:35 INFO - PROCESS | 26907 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 11:56:35 INFO - PROCESS | 26907 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 145.0 147.0 146.0 149.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 11:56:35 INFO - PROCESS | 26907 | Values: 96.0 96.0 96.0 96.0 98.0 96.0 96.0 96.0 97.0 97.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.50 stddev:3.77 (6.4%) stddev-sans-first:3.91 11:56:35 INFO - PROCESS | 26907 | Values: 56.0 57.0 59.0 57.0 59.0 68.0 56.0 59.0 58.0 54.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 11:56:35 INFO - PROCESS | 26907 | Values: 67.0 66.0 66.0 65.0 65.0 66.0 65.0 65.0 67.0 66.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:81.00 stddev:3.87 (4.8%) stddev-sans-first:3.94 11:56:35 INFO - PROCESS | 26907 | Values: 79.0 80.0 83.0 80.0 82.0 88.0 80.0 90.0 80.0 79.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:119.00 stddev:4.56 (3.8%) stddev-sans-first:4.78 11:56:35 INFO - PROCESS | 26907 | Values: 120.0 113.0 118.0 117.0 114.0 121.0 125.0 125.0 115.0 113.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:145.00 stddev:4.57 (3.2%) stddev-sans-first:4.30 11:56:35 INFO - PROCESS | 26907 | Values: 137.0 145.0 147.0 145.0 144.0 133.0 142.0 147.0 146.0 144.0 11:56:35 INFO - PROCESS | 26907 | 11:56:35 INFO - PROCESS | 26907 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.35 (2.0%) stddev-sans-first:1.41 11:56:35 INFO - PROCESS | 26907 | Values: 68.0 67.0 70.0 67.0 68.0 66.0 66.0 67.0 69.0 66.0 11:56:35 INFO - PROCESS | 26907 | -------- Summary: end -------- 11:56:35 INFO - PROCESS | 26907 | 11:56:36 INFO - TEST-INFO | 26907: exit 0 11:56:36 INFO - TEST-OK | kraken | took 61742ms 11:56:36 INFO - SUITE-END | took 1172s 11:56:36 INFO - Completed test suite (00:19:32) 11:56:36 INFO - javascript benchmark 11:56:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3308.834558272086, 3311.817850018248, 3340.6826351496607, 3341.3150304187643, 3353.044382351029, 5325.893482130355, 5349.22436246744, 5351.785928562863, 5372.785088596456, 5378.112611419111, 5357.866053348668, 5367.785288588461, 5390.5418039466595, 5398.811041613544, 5413.864653383667, 4939.876503087425, 4967.801287948478, 5019.949800502003, 5039.521245481674, 5149.974250128763, 4909.607231421478, 5013.724245166514, 5036.395632524102, 5090.872728181788, 5103.770330335144, 5077.64456488046, 5078.949210507903, 5135.922961155586, 5143.0, 5176.171812509999, 4991.975040124812, 5015.348004759395, 5028.346314979066, 5037.5214354636255, 5076.289319495274, 4961.454240033593, 4969.453360130419, 4984.750762461862, 4989.501049895018, 4998.375203099613, 5295.179247216687, 5311.867203319909, 5312.495312945264, 5316.813911513079, 5317.813876514303, 5987.37132601075, 5996.310424301218, 5998.220231369937, 6002.699865006776, 6004.669743164124, 5983.1025346197985, 6037.45662890342, 6046.365131661156, 6052.667103309316, 6076.361981991916, 5535.667859928417, 5651.9152212716845, 5660.2075709400715, 5661.66030038199, 5665.66006039639, 5981.252343457068, 6149.723262453201, 6175.042868355412, 6179.134921111048, 6186.257649082139, 5819.6508209507565, 5880.26496687914, 5885.323187833368, 5891.440313170242, 5908.261467316585, 5959.404059594092, 5967.19442875215, 5970.462658360769, 5978.730957106941, 5980.910286345708, 5837.708114594253, 5926.1999630049395, 5931.288245410578, 5932.940670593325, 5933.554983376264, 6009.399060094043, 6024.006039003515, 6027.7287522061615, 6033.034714445667, 6061.454469097803, 4556.498785133633, 4569.840055598038, 4582.083583283356, 4584.679072464895, 4606.884827879263, 3980.641742243212, 4014.9397759033636, 4050.9392359114636, 4117.958820411757, 4132.793360331972, 5613.635113717595, 5700.458456446631, 5766.971165144148, 5797.072468405035, 5802.796902108406, 5863.413658634103, 5865.589408741347, 5869.765209391662, 5875.265591801025, 5878.735456904449, 5646.9152962704775, 5680.744366503517, 5743.253377060955, 5783.392743761844, 5845.970770146122, 5064.7214403207445, 5096.949030509648, 5102.770375333119, 5104.566111880532, 5105.897882042413, 6103.664298463538, 6114.419130182626, 6136.355682653347, 6139.293981192131, 6161.137440758297, 5975.462208401264, 6041.909371359346, 6047.0929360596265, 6060.727267272895, 6080.391960803884, 6206.875862482635, 6208.658523781055, 6210.534209934182, 6242.313345531897, 6265.404786545271, 5711.200431939449, 5831.271091113611, 5927.407259274038, 5968.241924453463, 5968.910466342922, 5960.403959604178, 5972.313183983723, 5987.131865879336, 5993.340732519332, 6074.817755467343, 5812.709364531841, 5844.503217226414, 5852.5317974561085, 5855.3559108497175, 5857.297124345106, 5688.11834165705, 5816.302043754607, 5858.091995740667, 5870.0607902735355, 5875.030619947661, 5584.832455026356, 5613.971930140323, 5662.85842853932, 5676.687782171855, 5705.857353566194, 5707.971460142673, 5759.280089988752, 5783.710814459344, 5789.218455508452, 5817.563682723728, 5563.666180029211, 5693.345265294544, 5740.483356497935, 5798.10129429939, 5830.912536311874], "unit": "score", "name": "dojo.html", "value": 5483.80491778435}, {"lowerIsBetter": false, "replicates": [529.3859123416837, 563.9069553523668, 573.6472069677145, 581.0325807530462, 588.2852334413686, 36949.44575831361, 38378.80810595946, 38394.80802595983, 38403.03992400191, 38482.4227636585, 40046.59953400465, 40256.19487610246, 40536.79731601345, 40561.0, 40612.39081413781, 8769.99145098314, 8959.5968181432, 8961.372703910729, 8977.506237156953, 8978.730638080868, 8744.344174186961, 9110.407823491452, 9111.316651251149, 9156.22172115371, 9175.908240917572, 9156.359054866161, 9193.264538836876, 9232.122948319933, 9238.122378374077, 9270.07299270071, 9094.909050909506, 9139.497327646977, 9172.266218702487, 9182.219511341544, 9194.310426717955, 7962.880556791595, 9021.954890225572, 9026.729198124067, 9033.63865445388, 9046.502442365667, 40090.799546002374, 40551.18897622031, 40567.18865622701, 40634.18731625351, 40685.1862962742, 1672.3087674777025, 3749.6062913393976, 3776.376897811858, 3970.920581588352, 4559.430071241095, 32599.0, 32720.0, 32869.50695739566, 32959.67040329614, 33571.664283357095, 4195.643370313527, 4228.281192197303, 4233.597808208216, 4311.676624253162, 4367.825286988516, 281439.0, 281845.0, 282087.0, 283496.0, 283783.0, 47199.292010619865, 47798.76100619475, 48119.51880481221, 58213.0, 59100.70449647724, 44622.0, 45039.54960450353, 45099.549004509536, 45103.87240319018, 45204.77397612991, 16565.503034908972, 16711.749323760152, 16737.497875063767, 16770.664586708197, 16810.0, 13214.405351759195, 13257.138286011379, 13306.800397994039, 13364.933175334061, 13380.464781408635, 15494.690106197813, 15721.68556628861, 15816.76274855878, 15839.287232074354, 15841.128737919526, 6089.725962331706, 6112.938870611237, 6216.533759968021, 6221.8133455995485, 6345.714442850082, 1058.090042563395, 1061.4321338084087, 1093.191038631407, 1116.625930313354, 1135.8807325230896, 30467.695323046486, 30478.847605761828, 30490.085297441114, 30602.38795224083, 30988.0703578893, 1136.653320737183, 1142.1433924556582, 1166.9416529173507, 1184.6919800851667, 1202.971459402216, 14979.40082396692, 14987.335701332357, 15219.847801521842, 15486.303116359792, 15499.225038748018, 332258.0, 526386.0, 530493.0, 531054.0, 532199.0, 57605.13592296119, 57668.71165644145, 58330.416695833344, 58597.12104318439, 58807.0, 1487.5686051045293, 1488.4790323386944, 1491.2022068193464, 1491.2469203052606, 1491.873190778796, 29907.252318692208, 30516.542251865794, 30721.078367649006, 30764.077077687703, 32479.0, 51921.0, 52222.21666674927, 53091.4690853102, 53092.4690753103, 53102.734486327325, 305067.0, 306160.0, 306519.0, 309077.0, 309940.0, 45914.0, 47138.76430617825, 47603.28595071146, 47835.76082119567, 48194.0, 45375.77312113418, 45594.77202613965, 45884.31173532333, 46228.0, 46234.768826157, 37911.81044094762, 38568.0, 38657.2268554633, 39795.40306895341, 40552.188956221304, 35641.46537801883, 36055.27889442249, 36202.45696314505, 36523.26953460969, 37185.44221836729, 37334.439983400815, 38006.619933800306, 40113.79943100383, 40133.397999030625, 40174.0, 35085.29829403346, 35156.64843351636, 35300.82349588236, 35628.82185589056, 35851.0, 27190.72809271882, 27669.95608575696, 28017.439651206452, 28021.299467513476, 28197.71802281951], "unit": "score", "name": "ext.html", "value": 19402.415464730253}, {"lowerIsBetter": false, "replicates": [359.98020108894, 362.9764065335753, 363.31877729257644, 378.1284140057167, 379.3853956590324, 17499.0, 18284.90857545712, 19874.105665245064, 19882.105305261262, 19989.800101998975, 16506.25721842517, 16618.418355357564, 16643.25105370258, 16677.83322166778, 16691.0, 5363.222332761757, 5615.747291371898, 5618.297712785902, 5618.690971996539, 5619.100943848985, 5115.820946266881, 5325.627206095575, 5339.733013349336, 5342.412334643186, 5547.362053363854, 5268.260504537639, 5295.0468915595175, 5318.228856815779, 5319.122344813101, 6146.7541298348015, 6282.937170628281, 6293.653849038301, 6296.622202667854, 6329.430351268408, 6340.461060809836, 5077.923831142536, 5289.0, 5594.524465420444, 5617.550595952314, 5637.238972738669, 12422.192557483824, 12563.434645440977, 12598.244105353617, 12607.684807879876, 15296.923515382463, 2218.3677651869302, 2224.421650370899, 2358.5636657218297, 2416.4683769570665, 2964.4515764583407, 9514.38156519831, 9805.656802011896, 12455.314957677325, 12711.61865144047, 12936.611901642966, 1931.94204173875, 1961.9895753686862, 1979.9902049954483, 2009.276660402254, 2060.1141509151057, 63503.682481587755, 64079.359206407804, 65239.3476065238, 65740.3425965739, 69987.65006174987, 10054.59781608742, 10083.798324033478, 10089.091981721533, 10225.744356391, 10321.174306055498, 13908.582742517741, 13982.091164074303, 14002.43990240379, 14023.719525609431, 14036.0, 7805.7078991746785, 8066.83866322682, 8125.715599954092, 8164.183581641907, 8178.059523154794, 8015.83968320642, 8071.83856322882, 8182.631781569844, 8194.05768336637, 8207.630656620466, 4212.978935105366, 4275.572442755762, 4328.8268469260875, 4389.078293558388, 4490.730556166641, 1906.3804263614381, 1982.345825877457, 1993.1529100132386, 2018.3642152721845, 2023.9392818215476, 957.1481381570408, 1023.7798873242289, 1055.3878750324793, 1113.9832902506469, 1139.5726602524053, 17568.64862702739, 17652.0, 17698.380556680455, 18042.09789510519, 18174.0, 1012.9746756331151, 1021.3004092196869, 1044.2220545693508, 1073.0235485707967, 1075.5052675769234, 10000.299979001546, 10358.896411035945, 10434.478276086316, 10437.895621043692, 10536.631217907336, 338287.0, 345361.0, 345428.0, 427683.0, 427902.0, 78200.21799781929, 79933.60033199796, 82875.58562207271, 83532.58233708914, 84490.0, 1051.0, 1088.2110469909253, 1097.4951522299832, 1101.603422767819, 1103.100972707241, 16353.918230409248, 16387.918060409622, 16445.25996330144, 16501.257443414834, 16921.66156676835, 33932.151696207795, 34275.0, 35069.64930350664, 35410.645893540735, 35999.28001440009, 49851.50148498614, 50420.74789626175, 50534.241986369496, 50782.23826642677, 51226.74386628192, 7724.729634462767, 7866.056073271244, 7972.0, 8225.83548329018, 8625.39622226438, 11955.0, 11961.760764784829, 12201.02391808671, 12290.877091229331, 12511.12422130442, 10006.199504039514, 10793.244472886823, 10799.784004320027, 11047.171462140532, 11232.887671123184, 10380.792384152426, 10743.140548756237, 10990.780184396428, 11007.889921100686, 11065.170112241452, 5439.809606663748, 7721.0, 9513.0, 10842.241043126905, 11058.778824423627, 8504.10706875794, 8650.0, 8666.739997800076, 8771.780705482413, 8777.868331975153, 11563.710907227387, 11850.051995840484, 11909.344986025852, 11920.165588408729, 12040.879591204326], "unit": "score", "name": "jquery.html", "value": 8646.680671777916}, {"lowerIsBetter": false, "replicates": [1545.9922700386496, 1564.4211641692573, 1792.659394715004, 1898.6487499812545, 1937.4575118966677, 7317.1219453665635, 7829.256220659043, 7888.56612886291, 8039.316658084055, 8066.395020373473, 8254.0, 8287.627056782445, 8355.289800366976, 8385.790355241123, 8386.664533418656, 2390.4023994001454, 2417.1177520205174, 2421.491486787768, 2425.563398588253, 2426.805855531562, 2437.8049756019564, 2443.0960544598524, 2480.5038992201544, 2485.9378515537073, 2488.8880000400027, 2387.522495500898, 2413.4328432818274, 2413.8793060347, 2452.3010941881566, 2461.5692253855505, 2359.398353419867, 2394.0423830467953, 2413.734489206186, 2425.042108367194, 2426.599611064172, 2361.515889242701, 2388.8924998375114, 2408.5182963407387, 2417.359399759065, 2426.2842461473906, 8343.040550336667, 8375.20435558621, 8396.07643159252, 8404.453710508797, 8425.325973922072, 5103.106956282672, 5126.2054381570915, 5178.249153872667, 5212.296339994128, 5229.973850130763, 3149.669284725094, 3180.6024246969127, 3240.6111266647918, 3242.3839470500766, 3259.4295998200455, 1016.9796604067877, 1023.7184774187084, 1030.8659874216303, 1060.2366296266675, 1067.023673338894, 11597.6520704379, 11653.300801951826, 11660.125490588154, 11667.416629168507, 11695.181337306392, 4520.276755719069, 4581.885452863638, 4621.329907163443, 4655.068986202706, 4662.95337046632, 9584.424934503952, 9742.853857192147, 9785.951070244602, 9800.90199098014, 9808.21534277256, 5247.10799164143, 5248.186531087687, 5257.395399529027, 5302.390225124083, 5303.602229832778, 4564.543545645475, 4659.464161621389, 4671.0, 4685.5782979532005, 4788.521147885253, 3853.479780229633, 3923.352646813244, 3957.604239576019, 4004.559498455226, 4015.1166743316426, 1264.5321231144535, 1273.853506846706, 1283.0569531394417, 1286.041898785392, 1295.164618820874, 1159.860816702001, 1168.8480497535436, 1179.1156632525606, 1525.7558790593453, 1532.3104602928727, 7844.529328240324, 7895.526268423913, 8079.030516338077, 8087.474314169678, 8089.31240844523, 1169.1465230381868, 1219.3720234079456, 1220.7060515853225, 1241.30486927321, 1259.238160912653, 6121.632702037892, 6186.19579454668, 6205.844853878599, 6264.310925798159, 6265.843353916189, 9555.474448905377, 9785.706428807147, 9844.950775246078, 9970.900290997142, 9993.100620944004, 9774.95112524447, 9792.804143917081, 9802.117809397188, 9896.0, 9951.751206219902, 7878.921210787933, 7885.44801863864, 7896.328812050925, 7951.244631759973, 8009.679612815538, 7615.0, 7658.4639075264195, 7712.228777122243, 7739.651715672696, 7799.454038217497, 8873.157050080232, 9157.267418606629, 9195.172434480928, 9236.907630923604, 9283.860742088738, 9041.95479022627, 9110.271178305853, 9198.356115072149, 9310.255179585482, 9439.858402123837, 6178.536609754196, 6747.527673062838, 6919.446444284345, 7084.893726594002, 7162.247963963709, 7793.220677932161, 7823.647935843014, 7824.765257042298, 7842.137364889743, 7849.568273744999, 6976.720931162697, 6994.300569942965, 6994.720211191496, 7076.150861896605, 7081.07945967021, 6947.096877406107, 6957.582545047313, 7012.368886800213, 7060.505764596429, 7063.82340441493, 7213.422926165999, 7316.268373162641, 7574.394048475999, 7576.4317676173405, 7616.619169041636, 6595.241547221939, 6808.863822723419, 6812.693428795816, 6846.4522838173825, 6847.21257055445, 6933.237343892067, 7006.929930700628, 7032.6132062735, 7044.647767611496, 7103.0], "unit": "score", "name": "mootools.html", "value": 4799.887216454}, {"lowerIsBetter": false, "replicates": [338.223776433086, 339.4721208520751, 339.9320135972806, 342.6950014487107, 346.8785924926276, 6289.874202515947, 6308.337624549419, 6327.746890124396, 6338.239411270642, 6358.205224346951, 6199.938000619993, 6208.937910620893, 6212.5029997600195, 6241.750329986795, 6254.499640028798, 4653.581177694007, 4764.666473346867, 4796.640251981106, 4803.927941080887, 4816.494268101851, 4772.952270477285, 4784.78468468918, 4791.041791641668, 4798.160321943646, 4798.7840547175465, 4724.291356296549, 4724.362211101509, 4735.3370528125915, 4740.502247264039, 4745.549172828576, 4676.438827340741, 4735.124002059612, 4737.976310118444, 4745.193317136095, 4749.596284315838, 4074.225897079575, 4081.673466122703, 4084.693647976384, 4091.2226676931286, 4092.774897380643, 6014.96992515039, 6017.879642407172, 6019.307779605358, 6019.879602407927, 6042.365551617105, 5307.230451584537, 5502.339719233718, 5503.724813759336, 5516.282883225195, 5518.33779946405, 6602.669866506655, 6613.867722645568, 6637.1703537057865, 6641.335866413368, 6644.036614690891, 4477.597016268552, 4478.149151661174, 4481.843135490275, 4481.955180448186, 4485.237509623339, 6880.346367095168, 6926.134233220848, 6988.301169882971, 6991.161060672701, 7002.229754726976, 4567.063751930847, 4568.451785785727, 4570.88572785683, 4573.519780423007, 4578.015726618726, 4500.797464114123, 4637.814487420465, 4639.141758774637, 4645.9303110453375, 4648.279516674921, 5425.457454254543, 5462.0, 5465.508104270635, 5466.453354664502, 5477.0, 6711.060451536789, 6745.426638735762, 6745.696443660047, 6748.291429399842, 6766.69549870257, 1627.3978627907513, 1646.2920943993959, 1649.158928946246, 1652.0996057148882, 1653.2229851969555, 1024.513356155835, 1038.159091136182, 1055.72551136705, 1057.9682609521726, 1062.766191437898, 6641.435477984425, 6645.501587380966, 6649.0, 6658.400743932973, 6658.800235992928, 6939.548929319578, 6949.2008419031445, 6965.373116419445, 6990.266022067712, 6991.580505169706, 6616.536842420985, 6653.234877988996, 6740.056392105109, 6770.4922130839395, 6777.661116944133, 3795.070207799107, 3818.4654148419245, 3824.579296277407, 3825.7513261637905, 3826.483424737625, 7354.0, 7391.260873912565, 7402.222766609536, 7416.147143078615, 7441.8139546511775, 7188.209296977328, 7216.96391518039, 7225.385842203472, 7227.5302105364035, 7233.710651573983, 7122.28777122294, 7346.338829505264, 7378.889316660255, 7396.593187374746, 7431.591262480615, 7111.075560177351, 7119.75080872167, 7124.679389427592, 7153.141623005273, 7153.785386438415, 6915.377616014583, 6919.965400172967, 6941.583504989717, 6979.40675042627, 7001.229864714979, 7383.224761399975, 7394.2975417335265, 7398.593077380796, 7402.4078073755045, 7438.330550250504, 4480.036792089716, 4609.492955774929, 4638.1187574360765, 4642.837500687459, 4661.34741136248, 6943.548669336477, 6968.930310696828, 6993.650317484004, 6996.195437524546, 7001.649917504206, 6758.966205168943, 6773.322667733188, 6778.457723382019, 6783.660816959034, 6785.898211526733, 6748.2576916538155, 6764.323567643196, 6770.52606317553, 6777.593344399352, 6789.558678685869, 6517.804465866032, 6615.305392933673, 6631.502637302126, 6633.336666333328, 6651.567648102858, 6788.049673045876, 6795.89806152918, 6799.082123913208, 6805.8638827222185, 6806.829829254309, 6612.074309596756, 6615.140031795836, 6617.172853393326, 6627.138471998609, 6643.46852251809], "unit": "score", "name": "prototype.html", "value": 5038.92592846521}, {"lowerIsBetter": false, "replicates": [806.8628333183358, 840.3277378097522, 850.0054935725201, 875.4047247871445, 896.4755617963491, 14361.856381436182, 14687.412503499874, 14738.852611473896, 14750.557483275492, 14774.187419691913, 13457.663558411045, 13849.446022159102, 13875.375608097635, 13877.791833122512, 13879.375428105734, 910.8087301666642, 932.1936524905941, 945.8817647794026, 946.725449619613, 952.2667545989618, 917.495377542349, 924.0389994405843, 925.0379605210572, 925.4678559828092, 926.333040211047, 983.3853841349156, 983.6655537117379, 983.9557219925085, 984.1241295247236, 984.7685793838442, 971.946542940138, 976.9071938165898, 978.0952618827591, 978.5254151736402, 980.7008862296997, 728.537378764483, 728.7412968396249, 729.9889652830815, 731.853629274142, 732.8644200822865, 14920.552383428407, 14932.178730169837, 14955.775663365059, 14964.251787410694, 15001.024933379296, 13525.797113043312, 13552.796708049387, 13632.863671363259, 13701.109427887155, 13730.313484325743, 11706.180567360288, 11805.291682498992, 11866.58466953661, 11906.285622862655, 11916.165868389216, 3842.231553689245, 3880.185161116169, 3883.650471457582, 3918.960810391888, 3932.3708206686792, 53648.92702145935, 53884.73057634726, 53980.73009634966, 54287.18569221465, 54828.72585637086, 10727.463626818628, 10882.238243322892, 11029.724256893482, 11086.944565277283, 11118.61084862026, 19277.80722192788, 19421.90289048574, 19520.80479195218, 19670.40988770339, 19676.803231967497, 8093.797655058553, 8161.510309381456, 8268.37987150966, 8296.875546866802, 8376.539290338967, 4726.432828060655, 4729.7398643074275, 4748.264019077049, 4915.0, 5000.649954503223, 3453.9827300863835, 3484.1638006878165, 3490.2495963367996, 3491.755577109578, 3499.4750787381586, 599.484443378694, 614.8186285045922, 616.7378863982879, 619.1332135011021, 625.9374062593795, 698.7973487688513, 699.2448155991517, 709.5033476566424, 713.1050531582933, 718.5114122396716, 8334.291585215204, 8418.368622353348, 8472.152784721478, 8504.44721093127, 8596.226339629464, 586.5952492779968, 597.9671118088547, 651.5633029170667, 685.5989246290876, 715.2025491576854, 3982.7411218270718, 4030.496187976503, 4252.851150209728, 4282.229198744256, 4342.457192850894, 56039.71980140073, 57507.71246143826, 58304.0, 58466.70766646139, 58501.414985849595, 49704.75738106576, 50332.74833625808, 50857.23714144291, 52739.472605273455, 53694.46305536973, 48403.0, 48973.51026489832, 49155.262671059965, 49427.0, 49640.0, 8228.094909560063, 8349.415540912078, 8357.665693372197, 8489.40574159803, 8497.107803680525, 35285.47071793977, 36026.4596031065, 36988.260234794616, 37061.258774823815, 37295.81352093222, 41172.79413602913, 41295.7935210334, 44267.11465770731, 45062.0, 45097.0, 10557.472126393803, 10581.259311848096, 10677.359358438518, 10759.085477734166, 10783.676489705322, 12161.81757273624, 12169.878301217228, 12187.268763874195, 12225.510979560719, 13944.930275348559, 11328.376939268419, 11562.190646654653, 11591.0, 11598.94200528992, 11866.76266474683, 12239.20445171061, 12438.129330946747, 12509.374531273583, 12604.49582016709, 12693.365331733192, 11655.18413711032, 11709.648710538697, 11858.0, 11928.522859085886, 11930.164888457724, 10013.799724005625, 10126.746831329276, 10160.695179144637, 10269.640562580274, 10321.793564128826, 9751.073648003428, 9830.164436023018, 10207.132393746318, 10288.845667315147, 10376.584936602452], "unit": "score", "name": "yui.html", "value": 6752.556856618824}], "name": "dromaeo_css", "value": 7291.38414827539}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 111.0, 113.0, 113.0, 122.0, 110.0, 110.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [164.0, 134.0, 156.0, 165.0, 128.0, 155.0, 153.0, 128.0, 180.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 149.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 163.0, 163.0, 162.0, 164.0, 161.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 77.0, 164.0, 77.0, 77.0, 76.0, 73.0, 163.0, 74.0], "unit": "score", "name": "audio-fft", "value": 93.2}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 137.0, 93.0, 93.0, 94.0, 151.0, 92.0, 93.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 145.0, 147.0, 146.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 59.0, 57.0, 59.0, 68.0, 56.0, 59.0, 58.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.8}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 83.0, 80.0, 82.0, 88.0, 80.0, 90.0, 80.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.1}, {"lowerIsBetter": true, "replicates": [120.0, 113.0, 118.0, 117.0, 114.0, 121.0, 125.0, 125.0, 115.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.1}, {"lowerIsBetter": true, "replicates": [137.0, 145.0, 147.0, 145.0, 144.0, 133.0, 142.0, 147.0, 146.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 70.0, 67.0, 68.0, 66.0, 66.0, 67.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1520.5999999999997}]} 11:56:36 INFO - Return code: 0 11:56:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:56:36 ERROR - # TBPL SUCCESS # 11:56:36 INFO - Running post-action listener: _resource_record_post_action 11:56:36 INFO - Running post-run listener: _resource_record_post_run 11:56:37 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 16384; Write bytes: 464244736; Read time: 28; Write time: 1621772 11:56:37 INFO - install - Wall time: 14s; CPU: 23.0%; Read bytes: 0; Write bytes: 250773504; Read time: 0; Write time: 1360496 11:56:37 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 16384; Write bytes: 213041152; Read time: 28; Write time: 260752 11:56:37 INFO - Running post-run listener: _upload_blobber_files 11:56:37 INFO - Blob upload gear active. 11:56:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:56:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:56:37 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'] 11:56:37 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 11:56:38 INFO - (blobuploader) - INFO - Open directory for files ... 11:56:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:56:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:56:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:40 INFO - (blobuploader) - INFO - Done attempting. 11:56:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:56:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:56:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:42 INFO - (blobuploader) - INFO - Done attempting. 11:56:42 INFO - (blobuploader) - INFO - Iteration through files over. 11:56:42 INFO - Return code: 0 11:56:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:56:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:56:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63375158f0f2a587ca1ac7177fd1570fe149880e0bbcbbe6cffc44a17b42540299a4af94fb5163f80b070b3d47d3c27737ce5b15ca82f9cfeb25088c24bb0fed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cec5b6b3f4e65e432b39d21c055150b8591ed5524c3cf776e6ae2cc6de1d827dffaec4d8e7aaf7c7432dd4c763a4bc3eddbc4dabd0a35e4f14e3e7cbedf3b8c"} 11:56:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:56:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:56:42 INFO - Contents: 11:56:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63375158f0f2a587ca1ac7177fd1570fe149880e0bbcbbe6cffc44a17b42540299a4af94fb5163f80b070b3d47d3c27737ce5b15ca82f9cfeb25088c24bb0fed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cec5b6b3f4e65e432b39d21c055150b8591ed5524c3cf776e6ae2cc6de1d827dffaec4d8e7aaf7c7432dd4c763a4bc3eddbc4dabd0a35e4f14e3e7cbedf3b8c"} 11:56:42 INFO - Running post-run listener: copy_logs_to_upload_dir 11:56:42 INFO - Copying logs to upload dir... 11:56:42 INFO - mkdir: /builds/slave/test/build/upload/logs 11:56:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.642151 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-13 11:56:41.387108) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 11:56:41.390894) ========= 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=df17445c3590ff7897617a0e00000225-1463164572.518770-318654104 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/63375158f0f2a587ca1ac7177fd1570fe149880e0bbcbbe6cffc44a17b42540299a4af94fb5163f80b070b3d47d3c27737ce5b15ca82f9cfeb25088c24bb0fed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cec5b6b3f4e65e432b39d21c055150b8591ed5524c3cf776e6ae2cc6de1d827dffaec4d8e7aaf7c7432dd4c763a4bc3eddbc4dabd0a35e4f14e3e7cbedf3b8c"} build_url:https://queue.taskcluster.net/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/To-ghP-2QPyM52VuoMmyOg/artifacts/public/build/firefox-47.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/63375158f0f2a587ca1ac7177fd1570fe149880e0bbcbbe6cffc44a17b42540299a4af94fb5163f80b070b3d47d3c27737ce5b15ca82f9cfeb25088c24bb0fed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cec5b6b3f4e65e432b39d21c055150b8591ed5524c3cf776e6ae2cc6de1d827dffaec4d8e7aaf7c7432dd4c763a4bc3eddbc4dabd0a35e4f14e3e7cbedf3b8c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 11:56:41.415665) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 11:56:41.415979) ========= 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=df17445c3590ff7897617a0e00000225-1463164572.518770-318654104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 11:56:41.497553) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 11:56:41.497889) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 11:56:41.498190) ========= ========= Total master_lag: 0.25 =========