builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1469617290.1 results: success (0) buildid: 20160726073802 builduid: 6c72781d2b374e1f98a541c9c018fb4c revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.101477) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.101941) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.102213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.116810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.117133) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 04:01:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-27 04:01:30 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103716 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.234356) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.234656) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018982 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.283478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.283811) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 958cee08361af9ed370be06695973bcda3d3aa46 --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 958cee08361af9ed370be06695973bcda3d3aa46 --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=5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 04:01:30,857 truncating revision to first 12 chars 2016-07-27 04:01:30,857 Setting DEBUG logging. 2016-07-27 04:01:30,857 attempt 1/10 2016-07-27 04:01:30,857 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/958cee08361a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 04:01:31,157 unpacking tar archive at: mozilla-beta-958cee08361a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636221 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.933323) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.933640) ========= script_repo_revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.934028) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.934326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:30.944674) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-07-27 04:01:30.944966) ========= /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=5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:01:31 INFO - MultiFileLogger online at 20160727 04:01:31 in /builds/slave/test 04:01:31 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 04:01:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:01:31 INFO - {'append_to_log': False, 04:01:31 INFO - 'base_work_dir': '/builds/slave/test', 04:01:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:01:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:01:31 INFO - 'branch': 'Mozilla-Beta', 04:01:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:01:31 INFO - 'config_files': ('talos/linux_config.py',), 04:01:31 INFO - 'default_actions': ('clobber', 04:01:31 INFO - 'read-buildbot-config', 04:01:31 INFO - 'download-and-extract', 04:01:31 INFO - 'populate-webroot', 04:01:31 INFO - 'create-virtualenv', 04:01:31 INFO - 'install', 04:01:31 INFO - 'run-tests'), 04:01:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:01:31 INFO - 'download_minidump_stackwalk': True, 04:01:31 INFO - 'download_symbols': 'ondemand', 04:01:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:01:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:01:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:01:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:01:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:01:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:01:31 INFO - 'installer_path': 'installer.exe', 04:01:31 INFO - 'log_level': 'info', 04:01:31 INFO - 'log_name': 'talos', 04:01:31 INFO - 'log_to_console': True, 04:01:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:01:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:01:31 INFO - 'opt_config_files': (), 04:01:31 INFO - 'pip_index': False, 04:01:31 INFO - 'sps_profile': False, 04:01:31 INFO - 'sps_profile_interval': 0, 04:01:31 INFO - 'suite': 'dromaeojs-e10s', 04:01:31 INFO - 'system_bits': '32', 04:01:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:01:31 INFO - 'title': 'talos-linux64-ix-011', 04:01:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:01:31 INFO - 'use_talos_json': True, 04:01:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:01:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:01:31 INFO - 'work_dir': 'build'} 04:01:31 INFO - ##### 04:01:31 INFO - ##### Running clobber step. 04:01:31 INFO - ##### 04:01:31 INFO - Running pre-action listener: _resource_record_pre_action 04:01:31 INFO - Running main action method: clobber 04:01:31 INFO - rmtree: /builds/slave/test/build 04:01:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:01:32 INFO - Running post-action listener: _resource_record_post_action 04:01:32 INFO - ##### 04:01:32 INFO - ##### Running read-buildbot-config step. 04:01:32 INFO - ##### 04:01:32 INFO - Running pre-action listener: _resource_record_pre_action 04:01:32 INFO - Running main action method: read_buildbot_config 04:01:32 INFO - Using buildbot properties: 04:01:32 INFO - { 04:01:32 INFO - "project": "", 04:01:32 INFO - "product": "firefox", 04:01:32 INFO - "script_repo_revision": "production", 04:01:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 04:01:32 INFO - "repository": "", 04:01:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 04:01:32 INFO - "buildid": "20160726073802", 04:01:32 INFO - "pgo_build": "True", 04:01:32 INFO - "basedir": "/builds/slave/test", 04:01:32 INFO - "buildnumber": 59, 04:01:32 INFO - "slavename": "talos-linux64-ix-011", 04:01:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:01:32 INFO - "platform": "ubuntu64_hw", 04:01:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:01:32 INFO - "branch": "mozilla-beta", 04:01:32 INFO - "repo_path": "releases/mozilla-beta", 04:01:32 INFO - "revision": "958cee08361af9ed370be06695973bcda3d3aa46", 04:01:32 INFO - "stage_platform": "linux64-pgo", 04:01:32 INFO - "builduid": "6c72781d2b374e1f98a541c9c018fb4c", 04:01:32 INFO - "slavebuilddir": "test" 04:01:32 INFO - } 04:01:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 04:01:32 INFO - Running post-action listener: _resource_record_post_action 04:01:32 INFO - ##### 04:01:32 INFO - ##### Running download-and-extract step. 04:01:32 INFO - ##### 04:01:32 INFO - Running pre-action listener: _resource_record_pre_action 04:01:32 INFO - Running main action method: download_and_extract 04:01:32 INFO - mkdir: /builds/slave/test/build/tests 04:01: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')]} 04:01:32 INFO - https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:01:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:01:32 INFO - Downloaded 1327 bytes. 04:01:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:32 INFO - Using the following test package requirements: 04:01:32 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:01:32 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:32 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:01:32 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:32 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 04:01:32 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:32 INFO - u'jsshell-linux-x86_64.zip'], 04:01:32 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:32 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:01:32 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:01:32 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:32 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 04:01:32 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:32 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 04:01:32 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:32 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:01:32 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:32 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:01:32 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:01: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')]} 04:01:32 INFO - https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:01:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:01:35 INFO - Downloaded 24199952 bytes. 04:01:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:01:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:01:36 INFO - Return code: 0 04:01:36 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:36 INFO - https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:01:38 INFO - Downloaded 24199952 bytes. 04:01:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:01:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:01:39 INFO - Return code: 0 04:01: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')]} 04:01:39 INFO - https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:01:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:01:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:01:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:01:40 INFO - Downloaded 10840145 bytes. 04:01:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:01:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:01:40 INFO - Return code: 0 04:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:40 INFO - https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:01:42 INFO - Downloaded 56024276 bytes. 04:01:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:42 INFO - mkdir: /builds/slave/test/properties 04:01:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:42 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:42 INFO - Contents: 04:01:42 INFO - build_url:https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:01:42 INFO - Running post-action listener: _resource_record_post_action 04:01:42 INFO - Running post-action listener: set_extra_try_arguments 04:01:42 INFO - ##### 04:01:42 INFO - ##### Running populate-webroot step. 04:01:42 INFO - ##### 04:01:42 INFO - Running pre-action listener: _resource_record_pre_action 04:01:42 INFO - Running main action method: populate_webroot 04:01:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:01:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:01:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:01:42 INFO - '--tppagecycles', 04:01:42 INFO - '7'], 04:01:42 INFO - 'tests': ['tsvgm']}}, 04:01:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:01:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:01:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:01:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:01:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:01:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:01:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:42 INFO - 'talos_options': ['--disable-e10s'], 04:01:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:42 INFO - 'talos_options': ['--disable-e10s'], 04:01:42 INFO - 'tests': ['damp', 'tps']}, 04:01:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:42 INFO - 'tests': ['damp', 'tps']}, 04:01:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:01:42 INFO - 'tests': ['dromaeo_dom']}, 04:01:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:01:42 INFO - 'tests': ['a11yr', 04:01:42 INFO - 'ts_paint', 04:01:42 INFO - 'tpaint', 04:01:42 INFO - 'sessionrestore', 04:01:42 INFO - 'sessionrestore_no_auto_restore', 04:01:42 INFO - 'tabpaint']}, 04:01:42 INFO - 'other-e10s': {'tests': ['a11yr', 04:01:42 INFO - 'ts_paint', 04:01:42 INFO - 'tpaint', 04:01:42 INFO - 'sessionrestore', 04:01:42 INFO - 'sessionrestore_no_auto_restore', 04:01:42 INFO - 'tabpaint']}, 04:01:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:01:42 INFO - 'ts_paint', 04:01:42 INFO - 'tpaint', 04:01:42 INFO - 'sessionrestore', 04:01:42 INFO - 'sessionrestore_no_auto_restore', 04:01:42 INFO - 'tabpaint']}, 04:01:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:01:42 INFO - 'ts_paint', 04:01:42 INFO - 'tpaint', 04:01:42 INFO - 'sessionrestore', 04:01:42 INFO - 'sessionrestore_no_auto_restore', 04:01:42 INFO - 'tabpaint']}, 04:01:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:01:42 INFO - 'tests': ['a11yr', 04:01:42 INFO - 'ts_paint', 04:01:42 INFO - 'tpaint', 04:01:42 INFO - 'sessionrestore', 04:01:42 INFO - 'sessionrestore_no_auto_restore', 04:01:42 INFO - 'tabpaint']}, 04:01:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:01:42 INFO - 'tests': ['a11yr', 04:01:42 INFO - 'ts_paint', 04:01:42 INFO - 'tpaint', 04:01:42 INFO - 'sessionrestore', 04:01:42 INFO - 'sessionrestore_no_auto_restore', 04:01:42 INFO - 'tabpaint']}, 04:01:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:01:42 INFO - 'tests': ['tsvgx', 04:01:42 INFO - 'tsvgr_opacity', 04:01:42 INFO - 'tart', 04:01:42 INFO - 'tscrollx', 04:01:42 INFO - 'cart']}, 04:01:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:01:42 INFO - 'tsvgr_opacity', 04:01:42 INFO - 'tart', 04:01:42 INFO - 'tscrollx', 04:01:42 INFO - 'cart']}, 04:01:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:42 INFO - 'talos_options': ['--disable-e10s'], 04:01:42 INFO - 'tests': ['tp5o']}, 04:01:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:42 INFO - 'tests': ['tp5o']}, 04:01:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:42 INFO - 'talos_options': ['--disable-e10s', 04:01:42 INFO - '--xperf_path', 04:01:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:42 INFO - 'tests': ['tp5n']}, 04:01:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:42 INFO - 'talos_options': ['--xperf_path', 04:01:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:42 INFO - 'tests': ['tp5n']}}, 04:01:42 INFO - 'talos.zip': {'path': '', 04:01:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:01:42 INFO - Running post-action listener: _resource_record_post_action 04:01:42 INFO - ##### 04:01:42 INFO - ##### Running create-virtualenv step. 04:01:42 INFO - ##### 04:01:42 INFO - Running pre-action listener: _resource_record_pre_action 04:01:42 INFO - Running main action method: create_virtualenv 04:01:42 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01:42 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 04:01:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:01:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:42 INFO - Using real prefix '/usr' 04:01:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:43 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:45 INFO - Installing pip.................done. 04:01:45 INFO - Return code: 0 04:01:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f906c550f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', '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 04:01: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', 'pip>=1.5'] in /builds/slave/test/build 04:01: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 pip>=1.5 04:01:45 INFO - Using env: {'DISPLAY': ':0', 04:01:45 INFO - 'HOME': '/home/cltbld', 04:01:45 INFO - 'LANG': 'en_US.UTF-8', 04:01:45 INFO - 'LANGUAGE': 'en_US:en', 04:01:45 INFO - 'LOGNAME': 'cltbld', 04:01:45 INFO - 'MAIL': '/var/mail/cltbld', 04:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:45 INFO - 'MOZ_NO_REMOTE': '1', 04:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:45 INFO - 'NO_EM_RESTART': '1', 04:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:45 INFO - 'PWD': '/builds/slave/test', 04:01:45 INFO - 'SHELL': '/bin/bash', 04:01:45 INFO - 'SHLVL': '1', 04:01:45 INFO - 'TERM': 'linux', 04:01:45 INFO - 'TMOUT': '86400', 04:01:45 INFO - 'USER': 'cltbld', 04:01:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', 04:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:45 INFO - '_': '/tools/buildbot/bin/python'} 04:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:45 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 04:01:45 INFO - Cleaning up... 04:01:45 INFO - Return code: 0 04:01:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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', '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 0x7f906c550f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', '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 04:01: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:01: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 psutil>=0.7.1 04:01:45 INFO - Using env: {'DISPLAY': ':0', 04:01:45 INFO - 'HOME': '/home/cltbld', 04:01:45 INFO - 'LANG': 'en_US.UTF-8', 04:01:45 INFO - 'LANGUAGE': 'en_US:en', 04:01:45 INFO - 'LOGNAME': 'cltbld', 04:01:45 INFO - 'MAIL': '/var/mail/cltbld', 04:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:45 INFO - 'MOZ_NO_REMOTE': '1', 04:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:45 INFO - 'NO_EM_RESTART': '1', 04:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:45 INFO - 'PWD': '/builds/slave/test', 04:01:45 INFO - 'SHELL': '/bin/bash', 04:01:45 INFO - 'SHLVL': '1', 04:01:45 INFO - 'TERM': 'linux', 04:01:45 INFO - 'TMOUT': '86400', 04:01:45 INFO - 'USER': 'cltbld', 04:01:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', 04:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:45 INFO - '_': '/tools/buildbot/bin/python'} 04:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:45 INFO - Downloading/unpacking psutil>=0.7.1 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:47 INFO - Installing collected packages: psutil 04:01:47 INFO - Running setup.py install for psutil 04:01:47 INFO - building 'psutil._psutil_linux' extension 04:01:47 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 04:01:48 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 04:01:48 INFO - building 'psutil._psutil_posix' extension 04:01:48 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 04:01:48 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 04:01:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:48 INFO - Successfully installed psutil 04:01:48 INFO - Cleaning up... 04:01:48 INFO - Return code: 0 04:01:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:01:48 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')]} 04:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:48 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')]} 04:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:48 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 0x7f906c550f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', '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 04:01:48 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 04:01:48 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 04:01:48 INFO - Using env: {'DISPLAY': ':0', 04:01:48 INFO - 'HOME': '/home/cltbld', 04:01:48 INFO - 'LANG': 'en_US.UTF-8', 04:01:48 INFO - 'LANGUAGE': 'en_US:en', 04:01:48 INFO - 'LOGNAME': 'cltbld', 04:01:48 INFO - 'MAIL': '/var/mail/cltbld', 04:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:48 INFO - 'MOZ_NO_REMOTE': '1', 04:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:48 INFO - 'NO_EM_RESTART': '1', 04:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:48 INFO - 'PWD': '/builds/slave/test', 04:01:48 INFO - 'SHELL': '/bin/bash', 04:01:48 INFO - 'SHLVL': '1', 04:01:48 INFO - 'TERM': 'linux', 04:01:48 INFO - 'TMOUT': '86400', 04:01:48 INFO - 'USER': 'cltbld', 04:01:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', 04:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:48 INFO - '_': '/tools/buildbot/bin/python'} 04:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01: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 04:01:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:01:50 INFO - Installing collected packages: mozsystemmonitor 04:01:50 INFO - Running setup.py install for mozsystemmonitor 04:01:50 INFO - Successfully installed mozsystemmonitor 04:01:50 INFO - Cleaning up... 04:01:50 INFO - Return code: 0 04:01:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:50 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 0x7f906c550f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', '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 04:01:50 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 04:01:50 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 04:01:50 INFO - Using env: {'DISPLAY': ':0', 04:01:50 INFO - 'HOME': '/home/cltbld', 04:01:50 INFO - 'LANG': 'en_US.UTF-8', 04:01:50 INFO - 'LANGUAGE': 'en_US:en', 04:01:50 INFO - 'LOGNAME': 'cltbld', 04:01:50 INFO - 'MAIL': '/var/mail/cltbld', 04:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:50 INFO - 'MOZ_NO_REMOTE': '1', 04:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:50 INFO - 'NO_EM_RESTART': '1', 04:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:50 INFO - 'PWD': '/builds/slave/test', 04:01:50 INFO - 'SHELL': '/bin/bash', 04:01:50 INFO - 'SHLVL': '1', 04:01:50 INFO - 'TERM': 'linux', 04:01:50 INFO - 'TMOUT': '86400', 04:01:50 INFO - 'USER': 'cltbld', 04:01:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', 04:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:50 INFO - '_': '/tools/buildbot/bin/python'} 04:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:50 INFO - Downloading/unpacking blobuploader==1.2.4 04:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:01:53 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 04:01:53 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 04:01:53 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 04:01:53 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 04:01:53 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 04:01:53 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 04:01:53 INFO - Downloading docopt-0.6.1.tar.gz 04:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:53 INFO - Running setup.py install for blobuploader 04:01:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:53 INFO - Running setup.py install for requests 04:01:53 INFO - Running setup.py install for docopt 04:01:54 INFO - Successfully installed blobuploader requests docopt 04:01:54 INFO - Cleaning up... 04:01:54 INFO - Return code: 0 04:01:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:54 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 0x7f906c550f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', '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 04:01:54 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 04:01:54 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 04:01:54 INFO - Using env: {'DISPLAY': ':0', 04:01:54 INFO - 'HOME': '/home/cltbld', 04:01:54 INFO - 'LANG': 'en_US.UTF-8', 04:01:54 INFO - 'LANGUAGE': 'en_US:en', 04:01:54 INFO - 'LOGNAME': 'cltbld', 04:01:54 INFO - 'MAIL': '/var/mail/cltbld', 04:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:54 INFO - 'MOZ_NO_REMOTE': '1', 04:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:54 INFO - 'NO_EM_RESTART': '1', 04:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:54 INFO - 'PWD': '/builds/slave/test', 04:01:54 INFO - 'SHELL': '/bin/bash', 04:01:54 INFO - 'SHLVL': '1', 04:01:54 INFO - 'TERM': 'linux', 04:01:54 INFO - 'TMOUT': '86400', 04:01:54 INFO - 'USER': 'cltbld', 04:01:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', 04:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:54 INFO - '_': '/tools/buildbot/bin/python'} 04:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:54 INFO - Running setup.py (path:/tmp/pip-k53iZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:54 INFO - Running setup.py (path:/tmp/pip-pxvCRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:54 INFO - Running setup.py (path:/tmp/pip-JjJThn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:54 INFO - Running setup.py (path:/tmp/pip-jqinp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:54 INFO - Running setup.py (path:/tmp/pip-biBm3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:54 INFO - Running setup.py (path:/tmp/pip-Umsodg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:54 INFO - Running setup.py (path:/tmp/pip-lKiPEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:54 INFO - Running setup.py (path:/tmp/pip-r0_K8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:54 INFO - Running setup.py (path:/tmp/pip-ZwGKL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:55 INFO - Running setup.py (path:/tmp/pip-q_OANJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:55 INFO - Running setup.py (path:/tmp/pip-ofyZm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:55 INFO - Running setup.py (path:/tmp/pip-fb6hQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:55 INFO - Running setup.py (path:/tmp/pip-gLBoE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:55 INFO - Running setup.py (path:/tmp/pip-DaS8vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:55 INFO - Running setup.py (path:/tmp/pip-j3YflK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:55 INFO - Running setup.py (path:/tmp/pip-CXiDh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:55 INFO - Running setup.py (path:/tmp/pip-jWNdTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:55 INFO - Running setup.py install for manifestparser 04:01:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:55 INFO - Running setup.py install for mozcrash 04:01:55 INFO - Running setup.py install for mozdebug 04:01:55 INFO - Running setup.py install for mozdevice 04:01:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Running setup.py install for mozfile 04:01:56 INFO - Running setup.py install for mozhttpd 04:01:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Running setup.py install for mozinfo 04:01:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Running setup.py install for mozInstall 04:01:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Running setup.py install for mozleak 04:01:56 INFO - Running setup.py install for mozlog 04:01:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Running setup.py install for moznetwork 04:01:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Running setup.py install for mozprocess 04:01:56 INFO - Running setup.py install for mozprofile 04:01:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:56 INFO - Running setup.py install for mozrunner 04:01:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:57 INFO - Running setup.py install for mozscreenshot 04:01:57 INFO - Running setup.py install for moztest 04:01:57 INFO - Running setup.py install for mozversion 04:01:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:57 INFO - Cleaning up... 04:01:57 INFO - Return code: 0 04:01:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:57 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 0x7f906c550f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', '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 04:01:57 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 04:01:57 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 04:01:57 INFO - Using env: {'DISPLAY': ':0', 04:01:57 INFO - 'HOME': '/home/cltbld', 04:01:57 INFO - 'LANG': 'en_US.UTF-8', 04:01:57 INFO - 'LANGUAGE': 'en_US:en', 04:01:57 INFO - 'LOGNAME': 'cltbld', 04:01:57 INFO - 'MAIL': '/var/mail/cltbld', 04:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:57 INFO - 'MOZ_NO_REMOTE': '1', 04:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:57 INFO - 'NO_EM_RESTART': '1', 04:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:57 INFO - 'PWD': '/builds/slave/test', 04:01:57 INFO - 'SHELL': '/bin/bash', 04:01:57 INFO - 'SHLVL': '1', 04:01:57 INFO - 'TERM': 'linux', 04:01:57 INFO - 'TMOUT': '86400', 04:01:57 INFO - 'USER': 'cltbld', 04:01:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', 04:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:57 INFO - '_': '/tools/buildbot/bin/python'} 04:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:57 INFO - Running setup.py (path:/tmp/pip-qAsi9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:57 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)) 04:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:57 INFO - Running setup.py (path:/tmp/pip-5ZAssw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:57 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)) 04:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:57 INFO - Running setup.py (path:/tmp/pip-IHaypy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:57 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)) 04:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:57 INFO - Running setup.py (path:/tmp/pip-tPvrjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:57 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)) 04:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:57 INFO - Running setup.py (path:/tmp/pip-cuwMzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:57 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)) 04:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:57 INFO - Running setup.py (path:/tmp/pip-9izxJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:58 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)) 04:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:58 INFO - Running setup.py (path:/tmp/pip-I7nT3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:58 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)) 04:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:58 INFO - Running setup.py (path:/tmp/pip-PuZ4E7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:58 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)) 04:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:58 INFO - Running setup.py (path:/tmp/pip-MoXqYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:58 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)) 04:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:58 INFO - Running setup.py (path:/tmp/pip-yGMN0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:58 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)) 04:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:58 INFO - Running setup.py (path:/tmp/pip-mpkfQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:58 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)) 04:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:58 INFO - Running setup.py (path:/tmp/pip-qGl56b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:58 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)) 04:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:58 INFO - Running setup.py (path:/tmp/pip-6ZBxT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:58 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)) 04:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:58 INFO - Running setup.py (path:/tmp/pip-p81RPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:58 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)) 04:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:58 INFO - Running setup.py (path:/tmp/pip-aQNOyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:58 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)) 04:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:58 INFO - Running setup.py (path:/tmp/pip-yhukYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:58 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)) 04:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:58 INFO - Running setup.py (path:/tmp/pip-q7aSmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:58 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)) 04:01:58 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)) 04:01:58 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)) 04:01:58 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)) 04:01:58 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)) 04:01:58 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)) 04:01:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:58 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 04:01:58 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 04:01:58 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 04:01:58 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 04:01:58 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 04:01:58 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 04:02:00 INFO - Downloading blessings-1.6.tar.gz 04:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:02:00 INFO - Installing collected packages: blessings 04:02:00 INFO - Running setup.py install for blessings 04:02:00 INFO - Successfully installed blessings 04:02:00 INFO - Cleaning up... 04:02:01 INFO - Return code: 0 04:02:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:02:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:01 INFO - Reading from file tmpfile_stdout 04:02:01 INFO - Current package versions: 04:02:01 INFO - argparse == 1.2.1 04:02:01 INFO - blessings == 1.6 04:02:01 INFO - blobuploader == 1.2.4 04:02:01 INFO - docopt == 0.6.1 04:02:01 INFO - manifestparser == 1.1 04:02:01 INFO - mozInstall == 1.12 04:02:01 INFO - mozcrash == 0.17 04:02:01 INFO - mozdebug == 0.1 04:02:01 INFO - mozdevice == 0.48 04:02:01 INFO - mozfile == 1.2 04:02:01 INFO - mozhttpd == 0.7 04:02:01 INFO - mozinfo == 0.9 04:02:01 INFO - mozleak == 0.1 04:02:01 INFO - mozlog == 3.1 04:02:01 INFO - moznetwork == 0.27 04:02:01 INFO - mozprocess == 0.22 04:02:01 INFO - mozprofile == 0.28 04:02:01 INFO - mozrunner == 6.11 04:02:01 INFO - mozscreenshot == 0.1 04:02:01 INFO - mozsystemmonitor == 0.0 04:02:01 INFO - moztest == 0.7 04:02:01 INFO - mozversion == 1.4 04:02:01 INFO - psutil == 3.1.1 04:02:01 INFO - requests == 1.2.3 04:02:01 INFO - wsgiref == 0.1.2 04:02:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:01 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')]} 04:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:01 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')]} 04:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:01 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 0x7f906c550f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', '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 04:02:01 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 04:02:01 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 04:02:01 INFO - Using env: {'DISPLAY': ':0', 04:02:01 INFO - 'HOME': '/home/cltbld', 04:02:01 INFO - 'LANG': 'en_US.UTF-8', 04:02:01 INFO - 'LANGUAGE': 'en_US:en', 04:02:01 INFO - 'LOGNAME': 'cltbld', 04:02:01 INFO - 'MAIL': '/var/mail/cltbld', 04:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:01 INFO - 'MOZ_NO_REMOTE': '1', 04:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:01 INFO - 'NO_EM_RESTART': '1', 04:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:01 INFO - 'PWD': '/builds/slave/test', 04:02:01 INFO - 'SHELL': '/bin/bash', 04:02:01 INFO - 'SHLVL': '1', 04:02:01 INFO - 'TERM': 'linux', 04:02:01 INFO - 'TMOUT': '86400', 04:02:01 INFO - 'USER': 'cltbld', 04:02:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', 04:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:01 INFO - '_': '/tools/buildbot/bin/python'} 04:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:01 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)) 04:02:01 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)) 04:02:01 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)) 04:02:01 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)) 04:02:01 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)) 04:02:01 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)) 04:02:01 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)) 04:02:01 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)) 04:02:01 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)) 04:02:01 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)) 04:02:01 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)) 04:02:01 INFO - Cleaning up... 04:02:01 INFO - Return code: 0 04:02:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:02:01 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')]} 04:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:01 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')]} 04:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:01 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 0x7f906c550f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', '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 04:02:01 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 04:02:01 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 04:02:01 INFO - Using env: {'DISPLAY': ':0', 04:02:01 INFO - 'HOME': '/home/cltbld', 04:02:01 INFO - 'LANG': 'en_US.UTF-8', 04:02:01 INFO - 'LANGUAGE': 'en_US:en', 04:02:01 INFO - 'LOGNAME': 'cltbld', 04:02:01 INFO - 'MAIL': '/var/mail/cltbld', 04:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:01 INFO - 'MOZ_NO_REMOTE': '1', 04:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:01 INFO - 'NO_EM_RESTART': '1', 04:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:01 INFO - 'PWD': '/builds/slave/test', 04:02:01 INFO - 'SHELL': '/bin/bash', 04:02:01 INFO - 'SHLVL': '1', 04:02:01 INFO - 'TERM': 'linux', 04:02:01 INFO - 'TMOUT': '86400', 04:02:01 INFO - 'USER': 'cltbld', 04:02:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', 04:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:01 INFO - '_': '/tools/buildbot/bin/python'} 04:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:01 INFO - Downloading/unpacking jsonschema 04:02:01 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 04:02:01 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 04:02:01 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 04:02:01 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 04:02:01 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 04:02:01 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 04:02:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:02:03 INFO - Downloading/unpacking functools32 (from jsonschema) 04:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:03 INFO - Downloading functools32-3.2.3-2.tar.gz 04:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:03 INFO - warning: no files found matching '*.txt' 04:02:03 INFO - no previously-included directories found matching 'build' 04:02:03 INFO - no previously-included directories found matching 'dist' 04:02:03 INFO - no previously-included directories found matching '.git*' 04:02:03 INFO - Installing collected packages: jsonschema, functools32 04:02:04 INFO - Running setup.py install for functools32 04:02:04 INFO - warning: no files found matching '*.txt' 04:02:04 INFO - no previously-included directories found matching 'build' 04:02:04 INFO - no previously-included directories found matching 'dist' 04:02:04 INFO - no previously-included directories found matching '.git*' 04:02:04 INFO - Successfully installed jsonschema functools32 04:02:04 INFO - Cleaning up... 04:02:04 INFO - Return code: 0 04:02:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:02:04 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')]} 04:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:04 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')]} 04:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:04 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 0x7f906c550f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', '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 04:02:04 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 04:02:04 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 04:02:04 INFO - Using env: {'DISPLAY': ':0', 04:02:04 INFO - 'HOME': '/home/cltbld', 04:02:04 INFO - 'LANG': 'en_US.UTF-8', 04:02:04 INFO - 'LANGUAGE': 'en_US:en', 04:02:04 INFO - 'LOGNAME': 'cltbld', 04:02:04 INFO - 'MAIL': '/var/mail/cltbld', 04:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:04 INFO - 'MOZ_NO_REMOTE': '1', 04:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:04 INFO - 'NO_EM_RESTART': '1', 04:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:04 INFO - 'PWD': '/builds/slave/test', 04:02:04 INFO - 'SHELL': '/bin/bash', 04:02:04 INFO - 'SHLVL': '1', 04:02:04 INFO - 'TERM': 'linux', 04:02:04 INFO - 'TMOUT': '86400', 04:02:04 INFO - 'USER': 'cltbld', 04:02:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', 04:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:04 INFO - '_': '/tools/buildbot/bin/python'} 04:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:04 INFO - Downloading/unpacking flake8 04:02:04 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 04:02:04 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 04:02:04 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 04:02:04 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 04:02:04 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 04:02:04 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 04:02:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:02:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:02:06 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 04:02:06 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 04:02:06 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 04:02:06 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 04:02:06 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 04:02:06 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 04:02:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:02:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:02:06 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 04:02:06 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 04:02:06 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 04:02:06 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 04:02:06 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 04:02:06 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 04:02:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:02:06 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 04:02:06 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 04:02:06 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 04:02:06 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 04:02:06 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 04:02:06 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 04:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:02:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:07 INFO - no previously-included directories found matching 'docs/_build' 04:02:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:02:07 INFO - Running setup.py install for pep8 04:02:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:07 INFO - no previously-included directories found matching 'docs/_build' 04:02:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:02:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:02:07 INFO - Cleaning up... 04:02:07 INFO - Return code: 0 04:02:07 INFO - Running post-action listener: _resource_record_post_action 04:02:07 INFO - Running post-action listener: _start_resource_monitoring 04:02:07 INFO - Starting resource monitoring. 04:02:07 INFO - ##### 04:02:07 INFO - ##### Running install step. 04:02:07 INFO - ##### 04:02:07 INFO - Running pre-action listener: _resource_record_pre_action 04:02:07 INFO - Running main action method: install 04:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:07 INFO - Reading from file tmpfile_stdout 04:02:07 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:07 INFO - Reading from file tmpfile_stdout 04:02:07 INFO - Output received: 04:02:07 INFO - Usage: mozinstall [options] installer 04:02:07 INFO - Options: 04:02:07 INFO - -h, --help show this help message and exit 04:02:07 INFO - -d DEST, --destination=DEST 04:02:07 INFO - Directory to install application into. [default: 04:02:07 INFO - "/builds/slave/test"] 04:02:07 INFO - --app=APP Application being installed. [default: firefox] 04:02:07 INFO - mkdir: /builds/slave/test/build/application 04:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:02:20 INFO - Reading from file tmpfile_stdout 04:02:20 INFO - Output received: 04:02:20 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:20 INFO - Running post-action listener: _resource_record_post_action 04:02:20 INFO - ##### 04:02:20 INFO - ##### Running run-tests step. 04:02:20 INFO - ##### 04:02:20 INFO - Running pre-action listener: _resource_record_pre_action 04:02:20 INFO - Running main action method: run_tests 04:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:20 INFO - Python 2.7.3 04:02:20 INFO - Return code: 0 04:02:20 INFO - grabbing minidump binary from tooltool 04:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:20 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 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:20 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 04:02:20 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 04:02:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:20 INFO - Return code: 0 04:02:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:02:21 INFO - Return code: 0 04:02:21 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/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 04:02:21 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/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 04:02:21 INFO - Using env: {'DISPLAY': ':0', 04:02:21 INFO - 'HOME': '/home/cltbld', 04:02:21 INFO - 'LANG': 'en_US.UTF-8', 04:02:21 INFO - 'LANGUAGE': 'en_US:en', 04:02:21 INFO - 'LOGNAME': 'cltbld', 04:02:21 INFO - 'MAIL': '/var/mail/cltbld', 04:02:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:21 INFO - 'MOZ_NO_REMOTE': '1', 04:02:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:21 INFO - 'NO_EM_RESTART': '1', 04:02:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:21 INFO - 'PWD': '/builds/slave/test', 04:02:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:21 INFO - 'SHELL': '/bin/bash', 04:02:21 INFO - 'SHLVL': '1', 04:02:21 INFO - 'TERM': 'linux', 04:02:21 INFO - 'TMOUT': '86400', 04:02:21 INFO - 'USER': 'cltbld', 04:02:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099', 04:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:21 INFO - '_': '/tools/buildbot/bin/python'} 04:02:21 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/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 04:02:22 INFO - mozversion application_buildid: 20160726073802 04:02:22 INFO - mozversion application_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:02:22 INFO - mozversion application_display_name: Firefox 04:02:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:22 INFO - mozversion application_name: Firefox 04:02:22 INFO - mozversion application_remotingname: firefox 04:02:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:02:22 INFO - mozversion application_vendor: Mozilla 04:02:22 INFO - mozversion application_version: 48.0 04:02:22 INFO - mozversion platform_buildid: 20160726073802 04:02:22 INFO - mozversion platform_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:02:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:02:22 INFO - mozversion platform_version: 48.0 04:02:22 INFO - using testdate: 1469617342 04:02:22 INFO - actual date: 1469617342 04:02:22 INFO - starting webserver on 'localhost:50416' 04:02:22 INFO - SUITE-START | Running 2 tests 04:02:22 INFO - TEST-START | dromaeo_css 04:02:22 INFO - operating with platform_type : linux_ 04:02:22 INFO - Initialising browser for dromaeo_css test... 04:02:22 INFO - TEST-INFO | started process 14165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdOH16w/profile http://localhost:50416/getInfo.html) 04:02:26 INFO - PROCESS | 14165 | 04:02:26 INFO - PROCESS | 14165 | (process:14244): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:02:27 INFO - PROCESS | 14165 | __metrics Screen width/height:1600/1200 04:02:27 INFO - PROCESS | 14165 | colorDepth:24 04:02:27 INFO - PROCESS | 14165 | Browser inner width/height: 1024/697 04:02:27 INFO - PROCESS | 14165 | __metrics 04:02:28 ERROR - PROCESS | 14165 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:02:29 INFO - TEST-INFO | 14165: exit 0 04:02:29 INFO - Browser initialized. 04:02:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:29 INFO - TEST-INFO | started process 14294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdOH16w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:31 INFO - PROCESS | 14294 | 04:02:31 INFO - PROCESS | 14294 | (process:14364): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:02:41 INFO - PROCESS | 14294 | RSS: Main: 150761472 04:02:41 INFO - PROCESS | 14294 | 04:03:30 INFO - PROCESS | 14294 | 1469617410709 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] 04:05:37 INFO - PROCESS | 14294 | Cycle 1(1): loaded http://localhost:50416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50416/tests/dromaeo/cssquery-ext.html) 04:05:38 INFO - PROCESS | 14294 | RSS: Main: 154312704 04:05:38 INFO - PROCESS | 14294 | 04:08:40 INFO - PROCESS | 14294 | Cycle 1(1): loaded http://localhost:50416/tests/dromaeo/cssquery-ext.html (next: http://localhost:50416/tests/dromaeo/cssquery-jquery.html) 04:08:41 INFO - PROCESS | 14294 | RSS: Main: 152469504 04:08:41 INFO - PROCESS | 14294 | 04:11:42 INFO - PROCESS | 14294 | Cycle 1(1): loaded http://localhost:50416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50416/tests/dromaeo/cssquery-mootools.html) 04:11:43 INFO - PROCESS | 14294 | RSS: Main: 151736320 04:11:43 INFO - PROCESS | 14294 | 04:14:45 INFO - PROCESS | 14294 | Cycle 1(1): loaded http://localhost:50416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50416/tests/dromaeo/cssquery-prototype.html) 04:14:45 INFO - PROCESS | 14294 | RSS: Main: 153440256 04:14:45 INFO - PROCESS | 14294 | 04:17:48 INFO - PROCESS | 14294 | Cycle 1(1): loaded http://localhost:50416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50416/tests/dromaeo/cssquery-yui.html) 04:17:48 INFO - PROCESS | 14294 | RSS: Main: 152338432 04:17:48 INFO - PROCESS | 14294 | 04:20:50 INFO - PROCESS | 14294 | Cycle 1(1): loaded http://localhost:50416/tests/dromaeo/cssquery-yui.html (next: http://localhost:50416/tests/dromaeo/cssquery-dojo.html) 04:20:51 INFO - PROCESS | 14294 | RSS: Main: 156332032 04:20:51 INFO - PROCESS | 14294 | 04:20:51 INFO - PROCESS | 14294 | __start_tp_report 04:20:51 INFO - PROCESS | 14294 | _x_x_mozilla_page_load 04:20:51 INFO - PROCESS | 14294 | _x_x_mozilla_page_load_details 04:20:51 INFO - PROCESS | 14294 | |i|pagename|runs| 04:20:51 INFO - PROCESS | 14294 | |0;dojo.html;3333.633300336963;3371.983140084299;3390.135515443561;3420.43562812136;3423.9486407703903;5549.805756798512;5566.109422492402;5575.749091290892;5585.245991791102;5603.327600687918;5521.5306698930635;5530.032244357241;5590.748416321265;5613.719314034292;5620.4098569650105;5052.06536790694;5114.811621218838;5120.795168193268;5130.794768209267;5164.147915593922;4987;5082.364704411949;5215.322008138955;5221.947780522203;5268.973655131719;5102.617303702219;5127.077126117298;5147.202183661539;5160.148575485059;5167.767450464738;5067.1385864402955;5070.797168113289;5076.416212135578;5078.4413714491375;5119.078565858144;4937.703737775709;4980.327655766461;4991.750412479361;5014.924776128361;5023.095842748304;5425.104857698475;5432.239486471897;5438.021156191884;5449.128139497661;5460.672359658433;5947.613405128653;5950.761969521214;5952.375000624916;5956.404359564052;5958.880822383528;5864.413558644102;5898.734556944948;5927.970360148215;5941.732622032019;5952.1964534787685;5598.944010559883;5615.522680572156;5619.353774315965;5619.381867994517;5639.548836093144;5890.410958904075;5907.409259074058;6052.939470605237;6086.756529738761;6096.634201947897;5771.769129234867;5776.508996735324;5793.2179155814265;5801.796937107181;5808.07070868659;5846.94153058464;5850.707464626752;5856.824295271149;5858.209141765892;5866.73599688015;5752.654840709571;5796.478316951495;5841.50347220491;5849.766009359663;5855.3559108498885;5866.266716660418;5872.354041055481;5873.089671100901;5880.647161170344;5899.115132730039;4542.091581683677;4543.7728113594185;4563.041761230113;4570.954290457053;4592.012717265737;4022.879313620596;4069.9389509157386;4092.5498195198506;4104.261232978092;4132.752034877917;5669.40471250521;5677.602567820296;5711.914321285184;5722.4277572242445;5802.361740208574;5831.504322132581;5958.970205149033;5959.165716799652;5965.492933100648;5998.640081595118;5661.688607126565;5723.7996670116345;5742.799002034909;5755.712214389264;5767.077267637158;5084.313617661643;5096.108181068298;5107.7446127693465;5124.666896651705;5163.715995620202;6224.564280500322;6246.3753624637175;6250.74997000124;6253.437190652772;6265.060240963892;5899.646021238739;5917.260342457193;5967.045272756425;5990.9101363479585;5997.310309314485;6200.131981522501;6236.314005459487;6237.220347456568;6238.189035425366;6242.625442473466;5857.4435428634215;5866.266716660418;5874.206982057368;5894.38108998549;5898.852528686645;5824.126381042877;5858.326292476249;5946.672932988728;5961.225040744675;5972;5797.188393624981;5810.7094645266725;5812.709364531672;5814.04068328738;5814.796482123105;5736.053551164178;5754.395788442153;5781.566382521243;5796.507296879812;5818.505427038749;5555.444455554412;5658.321001479849;5720.02759530889;5743.655380677173;5772.451617096369;5852.531797456279;5859.472647461749;5859.824205273849;5894.2926848778425;5900;5666.575006874418;5755.107958266475;5777.595568310178;5780.132980053026;5796.82609521715 04:20:51 INFO - PROCESS | 14294 | |1;ext.html;647.715005397625;664.5979182594527;682.6586706646676;711.9038929744486;747.4879707400431;35827;35931;36351.818240908826;36416.271674566495;36578.451323230176;47224;48031;48129.75935120328;48210.27684584725;48253;8929.73210803677;9128.634854605842;9148.222401095914;9158.679446219383;9159.816803663924;9063.50150741709;9166.037566055567;9172;9174;9192.126747958933;9202.447853128833;9255.722328330161;9261.490618016007;9268.351215414923;9288.303377246733;9126.680566180152;9138;9139.543022848897;9148.908510914905;9167.26661867049;8868.246199073086;9000.504972226525;9045.819083618357;9059.864102038475;9061.320400969953;43525.78237108826;44118.558814411765;44178.779106104266;44219.557804422184;44262.557374426164;3811.3901775715754;3879.515060617423;3996.0209748611487;4223.239816832969;4544.954550454486;30673.846630766926;33044;33141.34293285326;33251.66748332534;34226;4411.735295882225;4441.045175287297;4486.977565112186;4537.77311134442;4564.589186973155;319132;319522;321189;323044;323439;40554.18891622151;41181.38227926583;61851;62747.6862615684;62819;37711.62288377081;37738.811305943294;37783.81108094497;37842;37953.2409351817;16732.916335418246;16823.242954067096;16931.83068169327;16933;16939.068351240552;13991.580252592235;14006.719865602834;14027.298635068206;14055.578332650037;14172.574822755334;9378.85931711025;9391.201747851372;9468.857967130498;9498.287628427895;9591.90408095924;3678.3746763050344;3743.737938344344;3787.242551489713;3798.2783271178387;3825.980870095632;1107.307932542161;1142.3260276436943;1157.2998336006763;1197.658667279821;1228.8648248692637;33039.3392132156;33105.50341744876;33176.66823331784;33227.837025703986;33909.32181356359;1187.9524819007315;1224.5101959216206;1260.5335327848418;1289.2522337044493;1333.9533116341076;17066.48800535986;17182.570435739206;17341.479755607354;17583.384581539583;17727.822721772875;488904;495433;536064;555668;567853;56825.43174568284;58453.41546584565;58520.12219816706;58532.70733646305;59046.11430828541;1528.5032364481588;1529.9847001529843;1533.5092770313393;1539.6689711712036;1551.9224038798015;30349.241268968453;30541.788914439632;30933.69066309398;31152.221194469414;33415.83292083524;54583.45416545943;55413.44586554083;55450.16824747713;55466.44533554613;55675.72162139163;430443;431690;433342;433620;438837;31082.22294442657;46489.535104649876;47117.29324060073;47391.763041184575;47918.76040619775;44754.3796639936;45164.774176130224;45187.77406112949;45828.31257531073;46176.7691161542;38015.429768554044;38539.42190867195;41704.58295417007;42588.36117458303;43487.56512434835;40639.79680101581;40800.1839963205;41334.37998429966;42014.36978445387;42281.57718422776;41462;42630.36054459248;42899.57100428956;43001.3549796747;43047.78476107599;35143;35465.46801798027;35607.82196089003;36670.633293667786;36711.449328260635;28045.719542805127;28594.195103488648;28842.21413369907;29138.7086129136;29429.411411771216 04:20:51 INFO - PROCESS | 14294 | |2;jquery.html;412.38966329831857;424.5520975370984;426.73755640281234;427.6792405695728;429.07320188393055;16841.83158168418;18629.627407451844;19394.22423103076;19418.611627767437;19567.510812229702;18308.359207427744;18392.172352244146;18532.629347413043;18607.813921860776;18693.62612747744;5199.974000129994;5588.748506317215;5764.55174995322;5852.824415267549;5886.117082437626;5849.064149736043;5905.852353691149;5915.260592425947;5923.170756094129;5946.108083787423;5741.253637027181;5881.558883083786;5885.705714714269;5931.317898441691;5969.462748352647;5776.8844623107725;5792.4497172768515;5814.069748840187;5826.213461182729;5867.207926929874;5162.664426812245;5200.76596553156;5231.189165679326;5246.108161612497;5277.788888444457;22722.431939201488;22895.656565151538;23078.76921230783;23121.884390578107;23189.76810231893;2479.8301486199575;2511.1336588876807;2540.707818600866;2545.8345207561633;3264.1023718477372;14066.091882376999;14792.18642974636;14822.110673359633;14891.627709307246;14990.175540345277;2059.1763294682096;2064.9070791814256;2065.2874758208395;2076.4497408186844;2123.384218576611;77943;78632.75198640725;79668.60165699135;80040.19959800386;81171.59414202892;10486.895131048745;11050.115990720724;11125.888741112647;11221.438928053565;11475.368854712904;13731.24478153711;15076.773848392064;15517.767233491506;15571.299291531908;15595.610109747347;8663.306935445149;8923.821523569623;8995.865062024075;9062;9156.084391560924;8318.750437486886;8806.471611703319;9228.5847136879;9271.490068046322;9424.811503769886;7114.715411383487;7182.174049984319;7185.245549217257;7209.567425954459;7271.745488907863;2000.8299294559833;2033.1257559249368;2040.6734922412343;2041.6018876318976;2052.6613108837173;963.643451922793;1014.2545229256491;1104.1608377633056;1131.3890499130378;1141.720278531765;17045.23296451663;18254.54363640893;18334;18833.340833070775;18981.145848436852;1136.7385501334738;1157.484919210943;1165.0621249893916;1173.747644256489;1210.4069006186905;10167.44079075658;10495;10537.315074520286;10537.367757934395;10552.525136368882;504922;512763;513927;525037;525132;94883;97317;98058.50970745101;98219.50890245503;98394.50802746083;1123.1913022623698;1217.6651420859334;1220.2678392964328;1251.4681260464267;1251.9812202816966;16905.901116427394;16972.40596579114;16999.745003824704;17210.91394543019;17212.569685757957;40944;41086.589134108275;41088.178236434505;41407.37888931729;42114.368284475146;59233.70383148057;59396;59483.405165949516;59860;60187.39812601818;8722.084181160886;8940.776480588038;8957.865632015395;9037.50293733851;9126.863097053681;12626.36868156607;12744.872551274739;13003.349832508147;13183.67040823987;13267.40296686632;11688.590899318484;11967.700807479883;11976.640700778991;12125.636230913087;12218.51125954952;11862.347570883685;11900.285982841056;11984.940075299568;12030.518779249081;12299.200551964093;12057.397130143283;12102.75794484123;12105.878941210474;12124.211926224767;12145.757084858431;8238.423310368216;8275.917240827755;8401.873971890303;8452.450590711584;8572.142785721378;8382;11520.13598980063;11972.16194866351;12063.879361206276;12132.211406258564 04:20:51 INFO - PROCESS | 14294 | |3;mootools.html;1557.205825029235;1603.126296168588;1814.2924259538781;1943;1961.2253160001808;7110.964445177779;7212.531185472941;8113.148119447462;8250.876236856451;8294.170582941702;7928.563928983918;8189.467684600511;8209.548474833897;8209.91790082099;8210.466319689216;2363.6809030780796;2374.0622454130607;2382.642603609455;2387.916422925198;2390.4740956989435;2372.240882917467;2375.2043065572966;2411.131992482705;2413.9758602414013;2417.492326611414;2372.95254094918;2383.511380167062;2401.3516350585332;2401.4956859059616;2415.710114786228;2355.222776483756;2363.763623637631;2372.9169479068237;2383.904643814254;2391.7249516305674;2325.441893945441;2330.277613939684;2330.6970093887685;2332.1371092695813;2340.204330527629;8304.543250121242;8347.749567512985;8371.288440482565;8376.246137847624;8382.497050176948;5211.843644690627;5291.682499050031;5304.124819404794;5339.145736682112;5342.759575819097;3313.718333941618;3337.2824842658947;3411.2836304375865;3437.364087643794;3465.8093804840723;998.8451789972565;1018.1040684197859;1021.1218352217087;1027.753339198587;1107.734143805481;11821.468033938494;11824.349660768654;11887.940560297144;11929.224600401032;11950.88049119515;4596.149712303235;4663.533646635309;4721.315409265637;4726.243800991893;4728.290756386569;9355.719328420158;9378.812423751488;9398.060193980684;9439.386439881386;9442.197413219816;5219.8434046978655;5220.477952204749;5227.398849132398;5244.108501554745;5248.186531087687;4614.607758340579;4704.764761761899;4769.642276829251;4785.856424307276;4889.144399730033;3851.9422208666333;3886.844526218976;3910.2375036868107;3949.071968087497;3979.224051309967;1178.251810100575;1178.9705257368635;1180.533689192764;1190.6130507584896;1194.8088305871192;1065.4459680965854;1081.1837063017372;1088.8094583448024;1089.553283153903;1100.5872797700863;6043.214382130295;6048.092786082035;6142.508599312045;6172.969135154295;6212.4408803207925;484.9539293767157;485.6988667026466;490.0590865538175;499.0991260774337;505.2068252843001;4167.270727622654;4197.790110494463;4209.410682504452;4266.232078225887;4284.078923031563;10141.594336226615;10445.216608754374;10535.104516116216;10541.631042913461;10656.20078494116;9822.852657210147;10116;10116.949415253024;10334.173266138841;10482.947585262025;7960.960195198987;8048.235417635316;8069.394795390369;8081.393895457864;8108.9594552026865;5766.798162064308;5853.64878107315;5890.587658863838;5948.434898684618;6008.1588577598295;9088.63645454201;9125.269978401579;9279.489628070522;9379.531023448937;9387.718368448684;8787.297016238814;8854.158854908774;9021.00768915432;9313.25493960495;9523.428594284365;7354.77935661931;7463.104427468738;7539.886901696369;7546.358559522282;7683.769486915401;8070.47541909774;8084.272415482635;8111.472754270953;8120.918790812017;8129.674813007414;7243.7464688735645;7396.778096657109;7412.740554080581;7503.062117235346;7538.434617403826;7044.084269044992;7174.210836808052;7232;7250.564966102051;7309.049823522908;6994.685239164148;7012.158540975116;7078.292170782881;7087;7088.964555177191;5103.030424219386;5224.320838290998;5328.227407026037;5334.199870019528;5390.434004429479;5037.118504261813;5228.288633461096;5229.346331708536;5233.633645644768;5309.415964243853 04:20:51 INFO - PROCESS | 14294 | |4;prototype.html;360.211137608637;361.09365492613546;363.46026151165523;364.35872863759806;366.98532058717655;6437.517186211029;6509.088727578142;6521.413072823439;6530.444912182465;6555.049517819925;6481.222253329607;6494.44797192238;6500.804975850732;6509.153810004705;6514.706838192281;4768.427788665365;4854.660173787836;4881.975590122044;4894.681845680019;4896.951030489703;4848.7090774553635;4857.757112144379;4874.390701162355;4875.8781030474165;4884.877878053059;4816.97591512042;4834.299026641135;4838.709677419349;4840.394950631171;4840.975795121037;4837.129316722989;4849.393825771778;4855.223164293714;4865.099956508022;4896;4271;4276;4277;4277.721948073366;4283.65730741543;6090.969545152246;6179.19670442844;6235.688215589203;6236.064590311489;6236.906446403307;5637.8590535236945;5671.829845104653;5675.914861277084;5681.914771278434;5687.744051517691;6781.22015968165;6782.423494003016;6786.898196527056;6791.694373753193;6792;4690.5778479936625;4695.530446955311;4695.835645752382;4696.459907110692;4700.083483720676;7054.823629409306;7066.0814094167945;7102.467314951399;7120.750773722947;7132.465065120085;4708.9058218835435;4793.544613261734;4802.8799280018275;4806.086843499724;4816.229403295456;4853.611711063107;4863.416390033219;4866.78099485524;4878.268259761065;4879.1461494238365;5608.9719551402795;5611.579131565149;5622.690752008597;5633.0705433603;5657.12314591239;6821.147356580427;6845.965770171118;6859.691313890887;6860.897086543706;6865.27914568973;1697.7283634618402;1719.5787032176947;1720.4580557124466;1721.1308289313815;1722.7846519185102;1094.1574987259764;1123.2811000959393;1125.2966895690195;1133.5125895864692;1140.9087273018138;6730.057791909038;6748.426383757337;6751.628660423626;6764.864702706017;6770.763023294161;6988.825279368057;7062;7063.858722825515;7065.8802359292;7071.398931090812;6620.86758264832;6823.795286141423;6835.077264569319;6841.281665425158;6850.897236541456;3794.0704527390967;3846.1730727893637;3846.4038074098557;3849.01850028241;3853.865114720971;7485.7754267372065;7499.437542184358;7514.436417268617;7514.624268786648;7517.774466765896;7139.178994415709;7264.963675181591;7266.491345605863;7273.23631018746;7282.198958114604;7495.55026698389;7506.84986300271;7510.248975102555;7513.549187048685;7514.211007844207;7099.254578269208;7110.862262038049;7112.50212485121;7124.964375178091;7131.393831524379;7049.7885063448175;7056.294370562902;7060.929390706233;7061.364477197077;7061.964690176516;7346.595937223504;7451.813704657427;7484.176740558643;7492.62536873165;7503.624818759149;4749.7625118743235;4754.857354279377;4779.187538118459;4788.257820037899;4789.736564488847;7061.752838650623;7064.894026589708;7087.787366379017;7090.858182836418;7098.467614928798;6896.724131034903;6897.068895699016;6897.793066208022;6920.342567456084;6923.030775691306;6679.465642748665;6834.487413444111;6847.965760171167;6864.656767161722;6870.656467176521;6796.4902632303765;6809.046733457419;6816.659167041529;6822.931770682229;6823.215330236888;6962.721491140298;6971.3028697129885;6978.302169783185;6982.301769822977;6989.8951515726285;6786.966065169642;6811.523193376416;6813.454923606;6815.148106486689;6815.897761533482 04:20:51 INFO - PROCESS | 14294 | |5;yui.html;820.2084987986595;827.6110228192747;856.4989481153525;912.3932584831088;971.4171497101736;13999.720005599895;17053.40313089042;17570.82429175708;17665.29338826447;17749.37877174299;15058.472953446631;15111.319990600421;15123.168225747608;15173.317200725965;15198.54404367868;907.9364444488889;912.1425859691885;920.3419555018161;925.2228128372166;928.6749637626845;926.5506229478698;927.2211342472322;929.2333824594702;929.3169520402499;930.8371035068869;938.5448057692014;949.8480243161096;950.4392408478996;950.6102497975832;952;941.5386460634274;943.9716808495688;944.5182956692103;944.8346539355654;946.1768261612373;701.828052127227;703.8627467643812;704.1936982155455;704.9506534542584;706.6254884911006;15071.698566028617;15140.167290799001;15209;15220.162891040989;15225.467108651255;13668.726625467534;13713.588592342247;13835;13867.791983120262;13874.583762487142;12047.638570842888;12127.39363031845;12153.392330383534;12242.143049986504;12276.508939642403;4009.7794621295816;4013;4026.335654616985;4078.2455245779624;4084.019835239551;55965;56061.15908261379;56172;56344.154837677466;57415.425845741425;11257.15571332137;11508.712282193012;11524;11682.47428865686;11749.588764393206;20566.38300850977;20580.073896674385;20615.38153855387;20622.38132856017;20644.17423303081;8556.401051926305;8609.096044915319;8691.34814888886;8693.826123477495;8820.073892241351;4814.831480898151;4875.975620121948;4966.106100901872;4970.428400733889;5014.7994080236385;3424.0583839444353;3460.2041530448137;3469.37551240774;3476.89569312921;3482.7562070654812;621.8756248750268;627.5293529852611;629.7669862151033;632.9905051424232;645.9547831651739;698.3435570563654;763.2024534361606;786.3787607789782;822.7778499805019;829.867221244598;8854.601542930584;9349.39228950116;9361.906380936103;9383.95308023469;9386.530673466299;720.0567256893486;799.3365506629484;801.7995501124719;803.8030682482829;831.7005877883956;4028.5367182774357;4294.26997410441;4324.286492728727;4355.60799528044;4406.317020861771;63693.36306636967;64734;65219.67390163019;65399.346006540276;65515.67242163759;54188.72905635525;54298.18552721712;54570.45429545654;56044;56102.719486403126;50182.996340073;50581.49418505768;50662.240066399034;50987;51255;8691.91308086911;8725.171108744658;8747.781305467413;8811.779705507413;8874.378793484653;37463;37562.62437375591;38027.42958855675;38165.809170953966;38918.6108138915;44275.33586996133;44371.77814110909;46924.76537617427;50733;50894.23658645049;11915.702107447383;12137.635870923887;12548.874511254771;12928.418221179882;13174.473021079433;14092.295385230493;14172.574822755334;14218.502352417616;14237.359318830884;14414.85585144135;12633.115681902545;13347.933260333637;14004.579862604138;14005.859941400455;14082.647933801327;13849.16904985704;13849.861501384858;13952.023358364817;13975.790363144764;14068.859311406755;13696.452141914211;13757.17456952586;13800.309984500534;13854.445822167403;14064.437422502986;10860.891391086305;10994.615188468686;11170;11209.439528023404;11293.491792869505;11593.884061159617;11604.767904642029;11665.183437159656;11723;11922.284662920252 04:20:51 INFO - PROCESS | 14294 | __end_tp_report 04:20:51 INFO - PROCESS | 14294 | __start_cc_report 04:20:51 INFO - PROCESS | 14294 | _x_x_mozilla_cycle_collect,325 04:20:51 INFO - PROCESS | 14294 | __end_cc_report 04:20:51 INFO - PROCESS | 14294 | __startTimestamp1469618451031__endTimestamp 04:20:51 INFO - PROCESS | 14294 | 04:20:51 INFO - PROCESS | 14294 | ------- Summary: start ------- 04:20:51 INFO - PROCESS | 14294 | Number of tests: 6 04:20:51 INFO - PROCESS | 14294 | 04:20:51 INFO - PROCESS | 14294 | [#0] dojo.html Cycles:165 Average:5532.90 Median:5767.08 stddev:599.35 (10.4%) stddev-sans-first:575.82 04:20:51 INFO - PROCESS | 14294 | Values: 3333.6 3372.0 3390.1 3420.4 3423.9 5549.8 5566.1 5575.7 5585.2 5603.3 5521.5 5530.0 5590.7 5613.7 5620.4 5052.1 5114.8 5120.8 5130.8 5164.1 4987.0 5082.4 5215.3 5221.9 5269.0 5102.6 5127.1 5147.2 5160.1 5167.8 5067.1 5070.8 5076.4 5078.4 5119.1 4937.7 4980.3 4991.8 5014.9 5023.1 5425.1 5432.2 5438.0 5449.1 5460.7 5947.6 5950.8 5952.4 5956.4 5958.9 5864.4 5898.7 5928.0 5941.7 5952.2 5598.9 5615.5 5619.4 5619.4 5639.5 5890.4 5907.4 6052.9 6086.8 6096.6 5771.8 5776.5 5793.2 5801.8 5808.1 5846.9 5850.7 5856.8 5858.2 5866.7 5752.7 5796.5 5841.5 5849.8 5855.4 5866.3 5872.4 5873.1 5880.6 5899.1 4542.1 4543.8 4563.0 4571.0 4592.0 4022.9 4069.9 4092.5 4104.3 4132.8 5669.4 5677.6 5711.9 5722.4 5802.4 5831.5 5959.0 5959.2 5965.5 5998.6 5661.7 5723.8 5742.8 5755.7 5767.1 5084.3 5096.1 5107.7 5124.7 5163.7 6224.6 6246.4 6250.7 6253.4 6265.1 5899.6 5917.3 5967.0 5990.9 5997.3 6200.1 6236.3 6237.2 6238.2 6242.6 5857.4 5866.3 5874.2 5894.4 5898.9 5824.1 5858.3 5946.7 5961.2 5972.0 5797.2 5810.7 5812.7 5814.0 5814.8 5736.1 5754.4 5781.6 5796.5 5818.5 5555.4 5658.3 5720.0 5743.7 5772.5 5852.5 5859.5 5859.8 5894.3 5900.0 5666.6 5755.1 5777.6 5780.1 5796.8 04:20:51 INFO - PROCESS | 14294 | 04:20:51 INFO - PROCESS | 14294 | [#1] ext.html Cycles:180 Average:58723.06 Median:42434.97 stddev:115795.55 (272.9%) stddev-sans-first:116038.29 04:20:51 INFO - PROCESS | 14294 | Values: 647.7 664.6 682.7 711.9 747.5 35827.0 35931.0 36351.8 36416.3 36578.5 47224.0 48031.0 48129.8 48210.3 48253.0 8929.7 9128.6 9148.2 9158.7 9159.8 9063.5 9166.0 9172.0 9174.0 9192.1 9202.4 9255.7 9261.5 9268.4 9288.3 9126.7 9138.0 9139.5 9148.9 9167.3 8868.2 9000.5 9045.8 9059.9 9061.3 43525.8 44118.6 44178.8 44219.6 44262.6 3811.4 3879.5 3996.0 4223.2 4545.0 30673.8 33044.0 33141.3 33251.7 34226.0 4411.7 4441.0 4487.0 4537.8 4564.6 319132.0 319522.0 321189.0 323044.0 323439.0 40554.2 41181.4 61851.0 62747.7 62819.0 37711.6 37738.8 37783.8 37842.0 37953.2 16732.9 16823.2 16931.8 16933.0 16939.1 13991.6 14006.7 14027.3 14055.6 14172.6 9378.9 9391.2 9468.9 9498.3 9591.9 3678.4 3743.7 3787.2 3798.3 3826.0 1107.3 1142.3 1157.3 1197.7 1228.9 33039.3 33105.5 33176.7 33227.8 33909.3 1188.0 1224.5 1260.5 1289.3 1334.0 17066.5 17182.6 17341.5 17583.4 17727.8 488904.0 495433.0 536064.0 555668.0 567853.0 56825.4 58453.4 58520.1 58532.7 59046.1 1528.5 1530.0 1533.5 1539.7 1551.9 30349.2 30541.8 30933.7 31152.2 33415.8 54583.5 55413.4 55450.2 55466.4 55675.7 430443.0 431690.0 433342.0 433620.0 438837.0 31082.2 46489.5 47117.3 47391.8 47918.8 44754.4 45164.8 45187.8 45828.3 46176.8 38015.4 38539.4 41704.6 42588.4 43487.6 40639.8 40800.2 41334.4 42014.4 42281.6 41462.0 42630.4 42899.6 43001.4 43047.8 35143.0 35465.5 35607.8 36670.6 36711.4 28045.7 28594.2 28842.2 29138.7 29429.4 04:20:51 INFO - PROCESS | 14294 | 04:20:51 INFO - PROCESS | 14294 | [#2] jquery.html Cycles:180 Average:30086.15 Median:23100.33 stddev:85051.94 (368.2%) stddev-sans-first:85261.35 04:20:51 INFO - PROCESS | 14294 | Values: 412.4 424.6 426.7 427.7 429.1 16841.8 18629.6 19394.2 19418.6 19567.5 18308.4 18392.2 18532.6 18607.8 18693.6 5200.0 5588.7 5764.6 5852.8 5886.1 5849.1 5905.9 5915.3 5923.2 5946.1 5741.3 5881.6 5885.7 5931.3 5969.5 5776.9 5792.4 5814.1 5826.2 5867.2 5162.7 5200.8 5231.2 5246.1 5277.8 22722.4 22895.7 23078.8 23121.9 23189.8 2479.8 2511.1 2540.7 2545.8 3264.1 14066.1 14792.2 14822.1 14891.6 14990.2 2059.2 2064.9 2065.3 2076.4 2123.4 77943.0 78632.8 79668.6 80040.2 81171.6 10486.9 11050.1 11125.9 11221.4 11475.4 13731.2 15076.8 15517.8 15571.3 15595.6 8663.3 8923.8 8995.9 9062.0 9156.1 8318.8 8806.5 9228.6 9271.5 9424.8 7114.7 7182.2 7185.2 7209.6 7271.7 2000.8 2033.1 2040.7 2041.6 2052.7 963.6 1014.3 1104.2 1131.4 1141.7 17045.2 18254.5 18334.0 18833.3 18981.1 1136.7 1157.5 1165.1 1173.7 1210.4 10167.4 10495.0 10537.3 10537.4 10552.5 504922.0 512763.0 513927.0 525037.0 525132.0 94883.0 97317.0 98058.5 98219.5 98394.5 1123.2 1217.7 1220.3 1251.5 1252.0 16905.9 16972.4 16999.7 17210.9 17212.6 40944.0 41086.6 41088.2 41407.4 42114.4 59233.7 59396.0 59483.4 59860.0 60187.4 8722.1 8940.8 8957.9 9037.5 9126.9 12626.4 12744.9 13003.3 13183.7 13267.4 11688.6 11967.7 11976.6 12125.6 12218.5 11862.3 11900.3 11984.9 12030.5 12299.2 12057.4 12102.8 12105.9 12124.2 12145.8 8238.4 8275.9 8401.9 8452.5 8572.1 8382.0 11520.1 11972.2 12063.9 12132.2 04:20:51 INFO - PROCESS | 14294 | 04:20:51 INFO - PROCESS | 14294 | [#3] mootools.html Cycles:180 Average:5593.94 Median:5215.84 stddev:3049.72 (58.5%) stddev-sans-first:3043.18 04:20:51 INFO - PROCESS | 14294 | Values: 1557.2 1603.1 1814.3 1943.0 1961.2 7111.0 7212.5 8113.1 8250.9 8294.2 7928.6 8189.5 8209.5 8209.9 8210.5 2363.7 2374.1 2382.6 2387.9 2390.5 2372.2 2375.2 2411.1 2414.0 2417.5 2373.0 2383.5 2401.4 2401.5 2415.7 2355.2 2363.8 2372.9 2383.9 2391.7 2325.4 2330.3 2330.7 2332.1 2340.2 8304.5 8347.7 8371.3 8376.2 8382.5 5211.8 5291.7 5304.1 5339.1 5342.8 3313.7 3337.3 3411.3 3437.4 3465.8 998.8 1018.1 1021.1 1027.8 1107.7 11821.5 11824.3 11887.9 11929.2 11950.9 4596.1 4663.5 4721.3 4726.2 4728.3 9355.7 9378.8 9398.1 9439.4 9442.2 5219.8 5220.5 5227.4 5244.1 5248.2 4614.6 4704.8 4769.6 4785.9 4889.1 3851.9 3886.8 3910.2 3949.1 3979.2 1178.3 1179.0 1180.5 1190.6 1194.8 1065.4 1081.2 1088.8 1089.6 1100.6 6043.2 6048.1 6142.5 6173.0 6212.4 485.0 485.7 490.1 499.1 505.2 4167.3 4197.8 4209.4 4266.2 4284.1 10141.6 10445.2 10535.1 10541.6 10656.2 9822.9 10116.0 10116.9 10334.2 10482.9 7961.0 8048.2 8069.4 8081.4 8109.0 5766.8 5853.6 5890.6 5948.4 6008.2 9088.6 9125.3 9279.5 9379.5 9387.7 8787.3 8854.2 9021.0 9313.3 9523.4 7354.8 7463.1 7539.9 7546.4 7683.8 8070.5 8084.3 8111.5 8120.9 8129.7 7243.7 7396.8 7412.7 7503.1 7538.4 7044.1 7174.2 7232.0 7250.6 7309.0 6994.7 7012.2 7078.3 7087.0 7089.0 5103.0 5224.3 5328.2 5334.2 5390.4 5037.1 5228.3 5229.3 5233.6 5309.4 04:20:51 INFO - PROCESS | 14294 | 04:20:51 INFO - PROCESS | 14294 | [#4] prototype.html Cycles:180 Average:5749.80 Median:6650.17 stddev:1766.23 (26.6%) stddev-sans-first:1724.24 04:20:51 INFO - PROCESS | 14294 | Values: 360.2 361.1 363.5 364.4 367.0 6437.5 6509.1 6521.4 6530.4 6555.0 6481.2 6494.4 6500.8 6509.2 6514.7 4768.4 4854.7 4882.0 4894.7 4897.0 4848.7 4857.8 4874.4 4875.9 4884.9 4817.0 4834.3 4838.7 4840.4 4841.0 4837.1 4849.4 4855.2 4865.1 4896.0 4271.0 4276.0 4277.0 4277.7 4283.7 6091.0 6179.2 6235.7 6236.1 6236.9 5637.9 5671.8 5675.9 5681.9 5687.7 6781.2 6782.4 6786.9 6791.7 6792.0 4690.6 4695.5 4695.8 4696.5 4700.1 7054.8 7066.1 7102.5 7120.8 7132.5 4708.9 4793.5 4802.9 4806.1 4816.2 4853.6 4863.4 4866.8 4878.3 4879.1 5609.0 5611.6 5622.7 5633.1 5657.1 6821.1 6846.0 6859.7 6860.9 6865.3 1697.7 1719.6 1720.5 1721.1 1722.8 1094.2 1123.3 1125.3 1133.5 1140.9 6730.1 6748.4 6751.6 6764.9 6770.8 6988.8 7062.0 7063.9 7065.9 7071.4 6620.9 6823.8 6835.1 6841.3 6850.9 3794.1 3846.2 3846.4 3849.0 3853.9 7485.8 7499.4 7514.4 7514.6 7517.8 7139.2 7265.0 7266.5 7273.2 7282.2 7495.6 7506.8 7510.2 7513.5 7514.2 7099.3 7110.9 7112.5 7125.0 7131.4 7049.8 7056.3 7060.9 7061.4 7062.0 7346.6 7451.8 7484.2 7492.6 7503.6 4749.8 4754.9 4779.2 4788.3 4789.7 7061.8 7064.9 7087.8 7090.9 7098.5 6896.7 6897.1 6897.8 6920.3 6923.0 6679.5 6834.5 6848.0 6864.7 6870.7 6796.5 6809.0 6816.7 6822.9 6823.2 6962.7 6971.3 6978.3 6982.3 6989.9 6787.0 6811.5 6813.5 6815.1 6815.9 04:20:51 INFO - PROCESS | 14294 | 04:20:51 INFO - PROCESS | 14294 | [#5] yui.html Cycles:180 Average:15546.87 Median:44323.56 stddev:17647.79 (39.8%) stddev-sans-first:17662.64 04:20:51 INFO - PROCESS | 14294 | Values: 820.2 827.6 856.5 912.4 971.4 13999.7 17053.4 17570.8 17665.3 17749.4 15058.5 15111.3 15123.2 15173.3 15198.5 907.9 912.1 920.3 925.2 928.7 926.6 927.2 929.2 929.3 930.8 938.5 949.8 950.4 950.6 952.0 941.5 944.0 944.5 944.8 946.2 701.8 703.9 704.2 705.0 706.6 15071.7 15140.2 15209.0 15220.2 15225.5 13668.7 13713.6 13835.0 13867.8 13874.6 12047.6 12127.4 12153.4 12242.1 12276.5 4009.8 4013.0 4026.3 4078.2 4084.0 55965.0 56061.2 56172.0 56344.2 57415.4 11257.2 11508.7 11524.0 11682.5 11749.6 20566.4 20580.1 20615.4 20622.4 20644.2 8556.4 8609.1 8691.3 8693.8 8820.1 4814.8 4876.0 4966.1 4970.4 5014.8 3424.1 3460.2 3469.4 3476.9 3482.8 621.9 627.5 629.8 633.0 646.0 698.3 763.2 786.4 822.8 829.9 8854.6 9349.4 9361.9 9384.0 9386.5 720.1 799.3 801.8 803.8 831.7 4028.5 4294.3 4324.3 4355.6 4406.3 63693.4 64734.0 65219.7 65399.3 65515.7 54188.7 54298.2 54570.5 56044.0 56102.7 50183.0 50581.5 50662.2 50987.0 51255.0 8691.9 8725.2 8747.8 8811.8 8874.4 37463.0 37562.6 38027.4 38165.8 38918.6 44275.3 44371.8 46924.8 50733.0 50894.2 11915.7 12137.6 12548.9 12928.4 13174.5 14092.3 14172.6 14218.5 14237.4 14414.9 12633.1 13347.9 14004.6 14005.9 14082.6 13849.2 13849.9 13952.0 13975.8 14068.9 13696.5 13757.2 13800.3 13854.4 14064.4 10860.9 10994.6 11170.0 11209.4 11293.5 11593.9 11604.8 11665.2 11723.0 11922.3 04:20:51 INFO - PROCESS | 14294 | -------- Summary: end -------- 04:20:51 INFO - PROCESS | 14294 | 04:20:51 INFO - TEST-INFO | 14294: exit 0 04:20:51 INFO - TEST-OK | dromaeo_css | took 1109613ms 04:20:51 INFO - TEST-START | kraken 04:20:51 INFO - operating with platform_type : linux_ 04:20:51 INFO - Initialising browser for kraken test... 04:20:51 INFO - TEST-INFO | started process 14539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEito0y/profile http://localhost:50416/getInfo.html) 04:20:56 INFO - PROCESS | 14539 | 04:20:56 INFO - PROCESS | 14539 | (process:14617): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:20:57 INFO - PROCESS | 14539 | __metrics Screen width/height:1600/1200 04:20:57 INFO - PROCESS | 14539 | colorDepth:24 04:20:57 INFO - PROCESS | 14539 | Browser inner width/height: 1024/697 04:20:57 INFO - PROCESS | 14539 | __metrics 04:20:58 ERROR - PROCESS | 14539 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:20:58 INFO - TEST-INFO | 14539: exit 0 04:20:58 INFO - Browser initialized. 04:20:58 INFO - Running cycle 1/1 for kraken test... 04:20:58 INFO - TEST-INFO | started process 14667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEito0y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:00 INFO - PROCESS | 14667 | 04:21:00 INFO - PROCESS | 14667 | (process:14735): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:21:10 INFO - PROCESS | 14667 | RSS: Main: 150900736 04:21:10 INFO - PROCESS | 14667 | 04:21:13 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50416/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:13 INFO - PROCESS | 14667 | RSS: Main: 155762688 04:21:13 INFO - PROCESS | 14667 | 04:21:16 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50416/tests/kraken/driver.html?testName=audio-dft) 04:21:17 INFO - PROCESS | 14667 | RSS: Main: 155926528 04:21:17 INFO - PROCESS | 14667 | 04:21:20 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50416/tests/kraken/driver.html?testName=audio-fft) 04:21:20 INFO - PROCESS | 14667 | RSS: Main: 156221440 04:21:20 INFO - PROCESS | 14667 | 04:21:22 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50416/tests/kraken/driver.html?testName=audio-oscillator) 04:21:23 INFO - PROCESS | 14667 | RSS: Main: 156114944 04:21:23 INFO - PROCESS | 14667 | 04:21:25 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:26 INFO - PROCESS | 14667 | RSS: Main: 156463104 04:21:26 INFO - PROCESS | 14667 | 04:21:29 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50416/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:29 INFO - PROCESS | 14667 | RSS: Main: 156835840 04:21:29 INFO - PROCESS | 14667 | 04:21:33 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50416/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:33 INFO - PROCESS | 14667 | RSS: Main: 156389376 04:21:33 INFO - PROCESS | 14667 | 04:21:36 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50416/tests/kraken/driver.html?testName=json-parse-financial) 04:21:37 INFO - PROCESS | 14667 | RSS: Main: 156119040 04:21:37 INFO - PROCESS | 14667 | 04:21:38 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:39 INFO - PROCESS | 14667 | RSS: Main: 155828224 04:21:39 INFO - PROCESS | 14667 | 04:21:41 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50416/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:41 INFO - PROCESS | 14667 | RSS: Main: 156155904 04:21:41 INFO - PROCESS | 14667 | 04:21:43 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:44 INFO - PROCESS | 14667 | RSS: Main: 156643328 04:21:44 INFO - PROCESS | 14667 | 04:21:46 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:47 INFO - PROCESS | 14667 | RSS: Main: 156827648 04:21:47 INFO - PROCESS | 14667 | 04:21:50 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:50 INFO - PROCESS | 14667 | RSS: Main: 156958720 04:21:50 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | Cycle 1(1): loaded http://localhost:50416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50416/tests/kraken/driver.html?testName=ai-astar) 04:21:52 INFO - PROCESS | 14667 | RSS: Main: 158593024 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | __start_tp_report 04:21:52 INFO - PROCESS | 14667 | _x_x_mozilla_page_load 04:21:52 INFO - PROCESS | 14667 | _x_x_mozilla_page_load_details 04:21:52 INFO - PROCESS | 14667 | |i|pagename|runs| 04:21:52 INFO - PROCESS | 14667 | |0;ai-astar;108;112;105;110;113;111;103;118;111;112 04:21:52 INFO - PROCESS | 14667 | |1;audio-beat-detection;164;128;160;184;134;168;157;127;177;129 04:21:52 INFO - PROCESS | 14667 | |2;audio-dft;164;161;163;162;162;164;163;162;161;163 04:21:52 INFO - PROCESS | 14667 | |3;audio-fft;86;77;76;168;76;74;75;79;158;76 04:21:52 INFO - PROCESS | 14667 | |4;audio-oscillator;92;92;162;92;92;91;151;91;92;144 04:21:52 INFO - PROCESS | 14667 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;116 04:21:52 INFO - PROCESS | 14667 | |6;imaging-darkroom;146;146;146;146;147;148;146;146;147;145 04:21:52 INFO - PROCESS | 14667 | |7;imaging-desaturate;94;95;95;96;95;95;95;95;95;94 04:21:52 INFO - PROCESS | 14667 | |8;json-parse-financial;57;55;56;58;56;56;54;76;54;54 04:21:52 INFO - PROCESS | 14667 | |9;json-stringify-tinderbox;58;58;57;58;58;57;58;58;57;58 04:21:52 INFO - PROCESS | 14667 | |10;stanford-crypto-aes;74;74;74;75;75;75;75;74;75;74 04:21:52 INFO - PROCESS | 14667 | |11;stanford-crypto-ccm;113;115;113;123;115;127;115;117;136;134 04:21:52 INFO - PROCESS | 14667 | |12;stanford-crypto-pbkdf2;161;174;165;165;165;162;159;159;162;159 04:21:52 INFO - PROCESS | 14667 | |13;stanford-crypto-sha256-iterative;68;68;67;66;67;67;73;68;72;69 04:21:52 INFO - PROCESS | 14667 | __end_tp_report 04:21:52 INFO - PROCESS | 14667 | __start_cc_report 04:21:52 INFO - PROCESS | 14667 | _x_x_mozilla_cycle_collect,839 04:21:52 INFO - PROCESS | 14667 | __end_cc_report 04:21:52 INFO - PROCESS | 14667 | __startTimestamp1469618512666__endTimestamp 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | ------- Summary: start ------- 04:21:52 INFO - PROCESS | 14667 | Number of tests: 14 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:4.22 (3.8%) stddev-sans-first:4.39 04:21:52 INFO - PROCESS | 14667 | Values: 108.0 112.0 105.0 110.0 113.0 111.0 103.0 118.0 111.0 112.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#1] audio-beat-detection Cycles:10 Average:152.80 Median:162.00 stddev:21.57 (13.3%) stddev-sans-first:22.49 04:21:52 INFO - PROCESS | 14667 | Values: 164.0 128.0 160.0 184.0 134.0 168.0 157.0 127.0 177.0 129.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 04:21:52 INFO - PROCESS | 14667 | Values: 164.0 161.0 163.0 162.0 162.0 164.0 163.0 162.0 161.0 163.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:36.33 (47.8%) stddev-sans-first:38.41 04:21:52 INFO - PROCESS | 14667 | Values: 86.0 77.0 76.0 168.0 76.0 74.0 75.0 79.0 158.0 76.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.00 stddev:29.60 (32.2%) stddev-sans-first:30.67 04:21:52 INFO - PROCESS | 14667 | Values: 92.0 92.0 162.0 92.0 92.0 91.0 151.0 91.0 92.0 144.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:21:52 INFO - PROCESS | 14667 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 116.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:21:52 INFO - PROCESS | 14667 | Values: 146.0 146.0 146.0 146.0 147.0 148.0 146.0 146.0 147.0 145.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 04:21:52 INFO - PROCESS | 14667 | Values: 94.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:56.00 stddev:6.60 (11.8%) stddev-sans-first:7.00 04:21:52 INFO - PROCESS | 14667 | Values: 57.0 55.0 56.0 58.0 56.0 56.0 54.0 76.0 54.0 54.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:21:52 INFO - PROCESS | 14667 | Values: 58.0 58.0 57.0 58.0 58.0 57.0 58.0 58.0 57.0 58.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:75.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 04:21:52 INFO - PROCESS | 14667 | Values: 74.0 74.0 74.0 75.0 75.0 75.0 75.0 74.0 75.0 74.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:120.00 stddev:8.73 (7.3%) stddev-sans-first:8.79 04:21:52 INFO - PROCESS | 14667 | Values: 113.0 115.0 113.0 123.0 115.0 127.0 115.0 117.0 136.0 134.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:163.50 stddev:4.56 (2.8%) stddev-sans-first:4.77 04:21:52 INFO - PROCESS | 14667 | Values: 161.0 174.0 165.0 165.0 165.0 162.0 159.0 159.0 162.0 159.0 04:21:52 INFO - PROCESS | 14667 | 04:21:52 INFO - PROCESS | 14667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:2.27 (3.3%) stddev-sans-first:2.40 04:21:52 INFO - PROCESS | 14667 | Values: 68.0 68.0 67.0 66.0 67.0 67.0 73.0 68.0 72.0 69.0 04:21:52 INFO - PROCESS | 14667 | -------- Summary: end -------- 04:21:52 INFO - PROCESS | 14667 | 04:21:53 INFO - TEST-INFO | 14667: exit 0 04:21:53 INFO - TEST-OK | kraken | took 61881ms 04:21:53 INFO - SUITE-END | took 1171s 04:21:53 INFO - Completed test suite (00:19:31) 04:21:53 INFO - javascript benchmark 04:21:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.633300336963, 3371.983140084299, 3390.135515443561, 3420.43562812136, 3423.9486407703903, 5549.805756798512, 5566.109422492402, 5575.749091290892, 5585.245991791102, 5603.327600687918, 5521.5306698930635, 5530.032244357241, 5590.748416321265, 5613.719314034292, 5620.4098569650105, 5052.06536790694, 5114.811621218838, 5120.795168193268, 5130.794768209267, 5164.147915593922, 4987.0, 5082.364704411949, 5215.322008138955, 5221.947780522203, 5268.973655131719, 5102.617303702219, 5127.077126117298, 5147.202183661539, 5160.148575485059, 5167.767450464738, 5067.1385864402955, 5070.797168113289, 5076.416212135578, 5078.4413714491375, 5119.078565858144, 4937.703737775709, 4980.327655766461, 4991.750412479361, 5014.924776128361, 5023.095842748304, 5425.104857698475, 5432.239486471897, 5438.021156191884, 5449.128139497661, 5460.672359658433, 5947.613405128653, 5950.761969521214, 5952.375000624916, 5956.404359564052, 5958.880822383528, 5864.413558644102, 5898.734556944948, 5927.970360148215, 5941.732622032019, 5952.1964534787685, 5598.944010559883, 5615.522680572156, 5619.353774315965, 5619.381867994517, 5639.548836093144, 5890.410958904075, 5907.409259074058, 6052.939470605237, 6086.756529738761, 6096.634201947897, 5771.769129234867, 5776.508996735324, 5793.2179155814265, 5801.796937107181, 5808.07070868659, 5846.94153058464, 5850.707464626752, 5856.824295271149, 5858.209141765892, 5866.73599688015, 5752.654840709571, 5796.478316951495, 5841.50347220491, 5849.766009359663, 5855.3559108498885, 5866.266716660418, 5872.354041055481, 5873.089671100901, 5880.647161170344, 5899.115132730039, 4542.091581683677, 4543.7728113594185, 4563.041761230113, 4570.954290457053, 4592.012717265737, 4022.879313620596, 4069.9389509157386, 4092.5498195198506, 4104.261232978092, 4132.752034877917, 5669.40471250521, 5677.602567820296, 5711.914321285184, 5722.4277572242445, 5802.361740208574, 5831.504322132581, 5958.970205149033, 5959.165716799652, 5965.492933100648, 5998.640081595118, 5661.688607126565, 5723.7996670116345, 5742.799002034909, 5755.712214389264, 5767.077267637158, 5084.313617661643, 5096.108181068298, 5107.7446127693465, 5124.666896651705, 5163.715995620202, 6224.564280500322, 6246.3753624637175, 6250.74997000124, 6253.437190652772, 6265.060240963892, 5899.646021238739, 5917.260342457193, 5967.045272756425, 5990.9101363479585, 5997.310309314485, 6200.131981522501, 6236.314005459487, 6237.220347456568, 6238.189035425366, 6242.625442473466, 5857.4435428634215, 5866.266716660418, 5874.206982057368, 5894.38108998549, 5898.852528686645, 5824.126381042877, 5858.326292476249, 5946.672932988728, 5961.225040744675, 5972.0, 5797.188393624981, 5810.7094645266725, 5812.709364531672, 5814.04068328738, 5814.796482123105, 5736.053551164178, 5754.395788442153, 5781.566382521243, 5796.507296879812, 5818.505427038749, 5555.444455554412, 5658.321001479849, 5720.02759530889, 5743.655380677173, 5772.451617096369, 5852.531797456279, 5859.472647461749, 5859.824205273849, 5894.2926848778425, 5900.0, 5666.575006874418, 5755.107958266475, 5777.595568310178, 5780.132980053026, 5796.82609521715], "value": 5494.935285309762, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.715005397625, 664.5979182594527, 682.6586706646676, 711.9038929744486, 747.4879707400431, 35827.0, 35931.0, 36351.818240908826, 36416.271674566495, 36578.451323230176, 47224.0, 48031.0, 48129.75935120328, 48210.27684584725, 48253.0, 8929.73210803677, 9128.634854605842, 9148.222401095914, 9158.679446219383, 9159.816803663924, 9063.50150741709, 9166.037566055567, 9172.0, 9174.0, 9192.126747958933, 9202.447853128833, 9255.722328330161, 9261.490618016007, 9268.351215414923, 9288.303377246733, 9126.680566180152, 9138.0, 9139.543022848897, 9148.908510914905, 9167.26661867049, 8868.246199073086, 9000.504972226525, 9045.819083618357, 9059.864102038475, 9061.320400969953, 43525.78237108826, 44118.558814411765, 44178.779106104266, 44219.557804422184, 44262.557374426164, 3811.3901775715754, 3879.515060617423, 3996.0209748611487, 4223.239816832969, 4544.954550454486, 30673.846630766926, 33044.0, 33141.34293285326, 33251.66748332534, 34226.0, 4411.735295882225, 4441.045175287297, 4486.977565112186, 4537.77311134442, 4564.589186973155, 319132.0, 319522.0, 321189.0, 323044.0, 323439.0, 40554.18891622151, 41181.38227926583, 61851.0, 62747.6862615684, 62819.0, 37711.62288377081, 37738.811305943294, 37783.81108094497, 37842.0, 37953.2409351817, 16732.916335418246, 16823.242954067096, 16931.83068169327, 16933.0, 16939.068351240552, 13991.580252592235, 14006.719865602834, 14027.298635068206, 14055.578332650037, 14172.574822755334, 9378.85931711025, 9391.201747851372, 9468.857967130498, 9498.287628427895, 9591.90408095924, 3678.3746763050344, 3743.737938344344, 3787.242551489713, 3798.2783271178387, 3825.980870095632, 1107.307932542161, 1142.3260276436943, 1157.2998336006763, 1197.658667279821, 1228.8648248692637, 33039.3392132156, 33105.50341744876, 33176.66823331784, 33227.837025703986, 33909.32181356359, 1187.9524819007315, 1224.5101959216206, 1260.5335327848418, 1289.2522337044493, 1333.9533116341076, 17066.48800535986, 17182.570435739206, 17341.479755607354, 17583.384581539583, 17727.822721772875, 488904.0, 495433.0, 536064.0, 555668.0, 567853.0, 56825.43174568284, 58453.41546584565, 58520.12219816706, 58532.70733646305, 59046.11430828541, 1528.5032364481588, 1529.9847001529843, 1533.5092770313393, 1539.6689711712036, 1551.9224038798015, 30349.241268968453, 30541.788914439632, 30933.69066309398, 31152.221194469414, 33415.83292083524, 54583.45416545943, 55413.44586554083, 55450.16824747713, 55466.44533554613, 55675.72162139163, 430443.0, 431690.0, 433342.0, 433620.0, 438837.0, 31082.22294442657, 46489.535104649876, 47117.29324060073, 47391.763041184575, 47918.76040619775, 44754.3796639936, 45164.774176130224, 45187.77406112949, 45828.31257531073, 46176.7691161542, 38015.429768554044, 38539.42190867195, 41704.58295417007, 42588.36117458303, 43487.56512434835, 40639.79680101581, 40800.1839963205, 41334.37998429966, 42014.36978445387, 42281.57718422776, 41462.0, 42630.36054459248, 42899.57100428956, 43001.3549796747, 43047.78476107599, 35143.0, 35465.46801798027, 35607.82196089003, 36670.633293667786, 36711.449328260635, 28045.719542805127, 28594.195103488648, 28842.21413369907, 29138.7086129136, 29429.411411771216], "value": 19831.531553540088, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.38966329831857, 424.5520975370984, 426.73755640281234, 427.6792405695728, 429.07320188393055, 16841.83158168418, 18629.627407451844, 19394.22423103076, 19418.611627767437, 19567.510812229702, 18308.359207427744, 18392.172352244146, 18532.629347413043, 18607.813921860776, 18693.62612747744, 5199.974000129994, 5588.748506317215, 5764.55174995322, 5852.824415267549, 5886.117082437626, 5849.064149736043, 5905.852353691149, 5915.260592425947, 5923.170756094129, 5946.108083787423, 5741.253637027181, 5881.558883083786, 5885.705714714269, 5931.317898441691, 5969.462748352647, 5776.8844623107725, 5792.4497172768515, 5814.069748840187, 5826.213461182729, 5867.207926929874, 5162.664426812245, 5200.76596553156, 5231.189165679326, 5246.108161612497, 5277.788888444457, 22722.431939201488, 22895.656565151538, 23078.76921230783, 23121.884390578107, 23189.76810231893, 2479.8301486199575, 2511.1336588876807, 2540.707818600866, 2545.8345207561633, 3264.1023718477372, 14066.091882376999, 14792.18642974636, 14822.110673359633, 14891.627709307246, 14990.175540345277, 2059.1763294682096, 2064.9070791814256, 2065.2874758208395, 2076.4497408186844, 2123.384218576611, 77943.0, 78632.75198640725, 79668.60165699135, 80040.19959800386, 81171.59414202892, 10486.895131048745, 11050.115990720724, 11125.888741112647, 11221.438928053565, 11475.368854712904, 13731.24478153711, 15076.773848392064, 15517.767233491506, 15571.299291531908, 15595.610109747347, 8663.306935445149, 8923.821523569623, 8995.865062024075, 9062.0, 9156.084391560924, 8318.750437486886, 8806.471611703319, 9228.5847136879, 9271.490068046322, 9424.811503769886, 7114.715411383487, 7182.174049984319, 7185.245549217257, 7209.567425954459, 7271.745488907863, 2000.8299294559833, 2033.1257559249368, 2040.6734922412343, 2041.6018876318976, 2052.6613108837173, 963.643451922793, 1014.2545229256491, 1104.1608377633056, 1131.3890499130378, 1141.720278531765, 17045.23296451663, 18254.54363640893, 18334.0, 18833.340833070775, 18981.145848436852, 1136.7385501334738, 1157.484919210943, 1165.0621249893916, 1173.747644256489, 1210.4069006186905, 10167.44079075658, 10495.0, 10537.315074520286, 10537.367757934395, 10552.525136368882, 504922.0, 512763.0, 513927.0, 525037.0, 525132.0, 94883.0, 97317.0, 98058.50970745101, 98219.50890245503, 98394.50802746083, 1123.1913022623698, 1217.6651420859334, 1220.2678392964328, 1251.4681260464267, 1251.9812202816966, 16905.901116427394, 16972.40596579114, 16999.745003824704, 17210.91394543019, 17212.569685757957, 40944.0, 41086.589134108275, 41088.178236434505, 41407.37888931729, 42114.368284475146, 59233.70383148057, 59396.0, 59483.405165949516, 59860.0, 60187.39812601818, 8722.084181160886, 8940.776480588038, 8957.865632015395, 9037.50293733851, 9126.863097053681, 12626.36868156607, 12744.872551274739, 13003.349832508147, 13183.67040823987, 13267.40296686632, 11688.590899318484, 11967.700807479883, 11976.640700778991, 12125.636230913087, 12218.51125954952, 11862.347570883685, 11900.285982841056, 11984.940075299568, 12030.518779249081, 12299.200551964093, 12057.397130143283, 12102.75794484123, 12105.878941210474, 12124.211926224767, 12145.757084858431, 8238.423310368216, 8275.917240827755, 8401.873971890303, 8452.450590711584, 8572.142785721378, 8382.0, 11520.13598980063, 11972.16194866351, 12063.879361206276, 12132.211406258564], "value": 9675.326196625185, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.205825029235, 1603.126296168588, 1814.2924259538781, 1943.0, 1961.2253160001808, 7110.964445177779, 7212.531185472941, 8113.148119447462, 8250.876236856451, 8294.170582941702, 7928.563928983918, 8189.467684600511, 8209.548474833897, 8209.91790082099, 8210.466319689216, 2363.6809030780796, 2374.0622454130607, 2382.642603609455, 2387.916422925198, 2390.4740956989435, 2372.240882917467, 2375.2043065572966, 2411.131992482705, 2413.9758602414013, 2417.492326611414, 2372.95254094918, 2383.511380167062, 2401.3516350585332, 2401.4956859059616, 2415.710114786228, 2355.222776483756, 2363.763623637631, 2372.9169479068237, 2383.904643814254, 2391.7249516305674, 2325.441893945441, 2330.277613939684, 2330.6970093887685, 2332.1371092695813, 2340.204330527629, 8304.543250121242, 8347.749567512985, 8371.288440482565, 8376.246137847624, 8382.497050176948, 5211.843644690627, 5291.682499050031, 5304.124819404794, 5339.145736682112, 5342.759575819097, 3313.718333941618, 3337.2824842658947, 3411.2836304375865, 3437.364087643794, 3465.8093804840723, 998.8451789972565, 1018.1040684197859, 1021.1218352217087, 1027.753339198587, 1107.734143805481, 11821.468033938494, 11824.349660768654, 11887.940560297144, 11929.224600401032, 11950.88049119515, 4596.149712303235, 4663.533646635309, 4721.315409265637, 4726.243800991893, 4728.290756386569, 9355.719328420158, 9378.812423751488, 9398.060193980684, 9439.386439881386, 9442.197413219816, 5219.8434046978655, 5220.477952204749, 5227.398849132398, 5244.108501554745, 5248.186531087687, 4614.607758340579, 4704.764761761899, 4769.642276829251, 4785.856424307276, 4889.144399730033, 3851.9422208666333, 3886.844526218976, 3910.2375036868107, 3949.071968087497, 3979.224051309967, 1178.251810100575, 1178.9705257368635, 1180.533689192764, 1190.6130507584896, 1194.8088305871192, 1065.4459680965854, 1081.1837063017372, 1088.8094583448024, 1089.553283153903, 1100.5872797700863, 6043.214382130295, 6048.092786082035, 6142.508599312045, 6172.969135154295, 6212.4408803207925, 484.9539293767157, 485.6988667026466, 490.0590865538175, 499.0991260774337, 505.2068252843001, 4167.270727622654, 4197.790110494463, 4209.410682504452, 4266.232078225887, 4284.078923031563, 10141.594336226615, 10445.216608754374, 10535.104516116216, 10541.631042913461, 10656.20078494116, 9822.852657210147, 10116.0, 10116.949415253024, 10334.173266138841, 10482.947585262025, 7960.960195198987, 8048.235417635316, 8069.394795390369, 8081.393895457864, 8108.9594552026865, 5766.798162064308, 5853.64878107315, 5890.587658863838, 5948.434898684618, 6008.1588577598295, 9088.63645454201, 9125.269978401579, 9279.489628070522, 9379.531023448937, 9387.718368448684, 8787.297016238814, 8854.158854908774, 9021.00768915432, 9313.25493960495, 9523.428594284365, 7354.77935661931, 7463.104427468738, 7539.886901696369, 7546.358559522282, 7683.769486915401, 8070.47541909774, 8084.272415482635, 8111.472754270953, 8120.918790812017, 8129.674813007414, 7243.7464688735645, 7396.778096657109, 7412.740554080581, 7503.062117235346, 7538.434617403826, 7044.084269044992, 7174.210836808052, 7232.0, 7250.564966102051, 7309.049823522908, 6994.685239164148, 7012.158540975116, 7078.292170782881, 7087.0, 7088.964555177191, 5103.030424219386, 5224.320838290998, 5328.227407026037, 5334.199870019528, 5390.434004429479, 5037.118504261813, 5228.288633461096, 5229.346331708536, 5233.633645644768, 5309.415964243853], "value": 4488.354468659752, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.211137608637, 361.09365492613546, 363.46026151165523, 364.35872863759806, 366.98532058717655, 6437.517186211029, 6509.088727578142, 6521.413072823439, 6530.444912182465, 6555.049517819925, 6481.222253329607, 6494.44797192238, 6500.804975850732, 6509.153810004705, 6514.706838192281, 4768.427788665365, 4854.660173787836, 4881.975590122044, 4894.681845680019, 4896.951030489703, 4848.7090774553635, 4857.757112144379, 4874.390701162355, 4875.8781030474165, 4884.877878053059, 4816.97591512042, 4834.299026641135, 4838.709677419349, 4840.394950631171, 4840.975795121037, 4837.129316722989, 4849.393825771778, 4855.223164293714, 4865.099956508022, 4896.0, 4271.0, 4276.0, 4277.0, 4277.721948073366, 4283.65730741543, 6090.969545152246, 6179.19670442844, 6235.688215589203, 6236.064590311489, 6236.906446403307, 5637.8590535236945, 5671.829845104653, 5675.914861277084, 5681.914771278434, 5687.744051517691, 6781.22015968165, 6782.423494003016, 6786.898196527056, 6791.694373753193, 6792.0, 4690.5778479936625, 4695.530446955311, 4695.835645752382, 4696.459907110692, 4700.083483720676, 7054.823629409306, 7066.0814094167945, 7102.467314951399, 7120.750773722947, 7132.465065120085, 4708.9058218835435, 4793.544613261734, 4802.8799280018275, 4806.086843499724, 4816.229403295456, 4853.611711063107, 4863.416390033219, 4866.78099485524, 4878.268259761065, 4879.1461494238365, 5608.9719551402795, 5611.579131565149, 5622.690752008597, 5633.0705433603, 5657.12314591239, 6821.147356580427, 6845.965770171118, 6859.691313890887, 6860.897086543706, 6865.27914568973, 1697.7283634618402, 1719.5787032176947, 1720.4580557124466, 1721.1308289313815, 1722.7846519185102, 1094.1574987259764, 1123.2811000959393, 1125.2966895690195, 1133.5125895864692, 1140.9087273018138, 6730.057791909038, 6748.426383757337, 6751.628660423626, 6764.864702706017, 6770.763023294161, 6988.825279368057, 7062.0, 7063.858722825515, 7065.8802359292, 7071.398931090812, 6620.86758264832, 6823.795286141423, 6835.077264569319, 6841.281665425158, 6850.897236541456, 3794.0704527390967, 3846.1730727893637, 3846.4038074098557, 3849.01850028241, 3853.865114720971, 7485.7754267372065, 7499.437542184358, 7514.436417268617, 7514.624268786648, 7517.774466765896, 7139.178994415709, 7264.963675181591, 7266.491345605863, 7273.23631018746, 7282.198958114604, 7495.55026698389, 7506.84986300271, 7510.248975102555, 7513.549187048685, 7514.211007844207, 7099.254578269208, 7110.862262038049, 7112.50212485121, 7124.964375178091, 7131.393831524379, 7049.7885063448175, 7056.294370562902, 7060.929390706233, 7061.364477197077, 7061.964690176516, 7346.595937223504, 7451.813704657427, 7484.176740558643, 7492.62536873165, 7503.624818759149, 4749.7625118743235, 4754.857354279377, 4779.187538118459, 4788.257820037899, 4789.736564488847, 7061.752838650623, 7064.894026589708, 7087.787366379017, 7090.858182836418, 7098.467614928798, 6896.724131034903, 6897.068895699016, 6897.793066208022, 6920.342567456084, 6923.030775691306, 6679.465642748665, 6834.487413444111, 6847.965760171167, 6864.656767161722, 6870.656467176521, 6796.4902632303765, 6809.046733457419, 6816.659167041529, 6822.931770682229, 6823.215330236888, 6962.721491140298, 6971.3028697129885, 6978.302169783185, 6982.301769822977, 6989.8951515726285, 6786.966065169642, 6811.523193376416, 6813.454923606, 6815.148106486689, 6815.897761533482], "value": 5172.400510636406, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.2084987986595, 827.6110228192747, 856.4989481153525, 912.3932584831088, 971.4171497101736, 13999.720005599895, 17053.40313089042, 17570.82429175708, 17665.29338826447, 17749.37877174299, 15058.472953446631, 15111.319990600421, 15123.168225747608, 15173.317200725965, 15198.54404367868, 907.9364444488889, 912.1425859691885, 920.3419555018161, 925.2228128372166, 928.6749637626845, 926.5506229478698, 927.2211342472322, 929.2333824594702, 929.3169520402499, 930.8371035068869, 938.5448057692014, 949.8480243161096, 950.4392408478996, 950.6102497975832, 952.0, 941.5386460634274, 943.9716808495688, 944.5182956692103, 944.8346539355654, 946.1768261612373, 701.828052127227, 703.8627467643812, 704.1936982155455, 704.9506534542584, 706.6254884911006, 15071.698566028617, 15140.167290799001, 15209.0, 15220.162891040989, 15225.467108651255, 13668.726625467534, 13713.588592342247, 13835.0, 13867.791983120262, 13874.583762487142, 12047.638570842888, 12127.39363031845, 12153.392330383534, 12242.143049986504, 12276.508939642403, 4009.7794621295816, 4013.0, 4026.335654616985, 4078.2455245779624, 4084.019835239551, 55965.0, 56061.15908261379, 56172.0, 56344.154837677466, 57415.425845741425, 11257.15571332137, 11508.712282193012, 11524.0, 11682.47428865686, 11749.588764393206, 20566.38300850977, 20580.073896674385, 20615.38153855387, 20622.38132856017, 20644.17423303081, 8556.401051926305, 8609.096044915319, 8691.34814888886, 8693.826123477495, 8820.073892241351, 4814.831480898151, 4875.975620121948, 4966.106100901872, 4970.428400733889, 5014.7994080236385, 3424.0583839444353, 3460.2041530448137, 3469.37551240774, 3476.89569312921, 3482.7562070654812, 621.8756248750268, 627.5293529852611, 629.7669862151033, 632.9905051424232, 645.9547831651739, 698.3435570563654, 763.2024534361606, 786.3787607789782, 822.7778499805019, 829.867221244598, 8854.601542930584, 9349.39228950116, 9361.906380936103, 9383.95308023469, 9386.530673466299, 720.0567256893486, 799.3365506629484, 801.7995501124719, 803.8030682482829, 831.7005877883956, 4028.5367182774357, 4294.26997410441, 4324.286492728727, 4355.60799528044, 4406.317020861771, 63693.36306636967, 64734.0, 65219.67390163019, 65399.346006540276, 65515.67242163759, 54188.72905635525, 54298.18552721712, 54570.45429545654, 56044.0, 56102.719486403126, 50182.996340073, 50581.49418505768, 50662.240066399034, 50987.0, 51255.0, 8691.91308086911, 8725.171108744658, 8747.781305467413, 8811.779705507413, 8874.378793484653, 37463.0, 37562.62437375591, 38027.42958855675, 38165.809170953966, 38918.6108138915, 44275.33586996133, 44371.77814110909, 46924.76537617427, 50733.0, 50894.23658645049, 11915.702107447383, 12137.635870923887, 12548.874511254771, 12928.418221179882, 13174.473021079433, 14092.295385230493, 14172.574822755334, 14218.502352417616, 14237.359318830884, 14414.85585144135, 12633.115681902545, 13347.933260333637, 14004.579862604138, 14005.859941400455, 14082.647933801327, 13849.16904985704, 13849.861501384858, 13952.023358364817, 13975.790363144764, 14068.859311406755, 13696.452141914211, 13757.17456952586, 13800.309984500534, 13854.445822167403, 14064.437422502986, 10860.891391086305, 10994.615188468686, 11170.0, 11209.439528023404, 11293.491792869505, 11593.884061159617, 11604.767904642029, 11665.183437159656, 11723.0, 11922.284662920252], "value": 7182.234234897428, "unit": "score"}], "name": "dromaeo_css", "value": 7484.745341084945, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 105.0, 110.0, 113.0, 111.0, 103.0, 118.0, 111.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 128.0, 160.0, 184.0, 134.0, 168.0, 157.0, 127.0, 177.0, 129.0], "value": 152.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 163.0, 162.0, 162.0, 164.0, 163.0, 162.0, 161.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 77.0, 76.0, 168.0, 76.0, 74.0, 75.0, 79.0, 158.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 162.0, 92.0, 92.0, 91.0, 151.0, 91.0, 92.0, 144.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0, 147.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 58.0, 56.0, 56.0, 54.0, 76.0, 54.0, 54.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 58.0, 57.0, 58.0, 58.0, 57.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 75.0, 75.0, 75.0, 75.0, 74.0, 75.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 123.0, 115.0, 127.0, 115.0, 117.0, 136.0, 134.0], "value": 120.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 174.0, 165.0, 165.0, 165.0, 162.0, 159.0, 159.0, 162.0, 159.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 66.0, 67.0, 67.0, 73.0, 68.0, 72.0, 69.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1530.3999999999999, "alertThreshold": 2.0}]} 04:21:53 INFO - Return code: 0 04:21:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:21:53 ERROR - # TBPL SUCCESS # 04:21:53 INFO - Running post-action listener: _resource_record_post_action 04:21:53 INFO - Running post-run listener: _resource_record_post_run 04:21:55 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 459390976; Read time: 20; Write time: 750856 04:21:55 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 242376704; Read time: 0; Write time: 457292 04:21:55 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 217014272; Read time: 20; Write time: 293564 04:21:55 INFO - Running post-run listener: _upload_blobber_files 04:21:55 INFO - Blob upload gear active. 04:21:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:55 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 04:21:55 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'] 04:21:55 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 04:21:55 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:21:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:21:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:56 INFO - (blobuploader) - INFO - Done attempting. 04:21:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:21:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:21:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:57 INFO - (blobuploader) - INFO - Done attempting. 04:21:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:57 INFO - Return code: 0 04:21:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18bbe6b6d354c7593f4608a5bbf0498670a22a7b00c27c0b85fa6383445ed3e35aa6e93c5c724b24dc67e5a1a36b469ac0b63cd6a18e36957626805e4773604f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c3fec5de7cb90f2a261e8a8e9efcae1c9af4aa51f6d9525c620fa470579f09692a2d27b01c8dccd619721af64dcf70c4a34533472bd10c52fd429c4a0f67014"} 04:21:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:57 INFO - Contents: 04:21:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18bbe6b6d354c7593f4608a5bbf0498670a22a7b00c27c0b85fa6383445ed3e35aa6e93c5c724b24dc67e5a1a36b469ac0b63cd6a18e36957626805e4773604f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c3fec5de7cb90f2a261e8a8e9efcae1c9af4aa51f6d9525c620fa470579f09692a2d27b01c8dccd619721af64dcf70c4a34533472bd10c52fd429c4a0f67014"} 04:21:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:57 INFO - Copying logs to upload dir... 04:21:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:21:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.898585 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-07-27 04:21:56.861316) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:56.864302) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099 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/18bbe6b6d354c7593f4608a5bbf0498670a22a7b00c27c0b85fa6383445ed3e35aa6e93c5c724b24dc67e5a1a36b469ac0b63cd6a18e36957626805e4773604f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c3fec5de7cb90f2a261e8a8e9efcae1c9af4aa51f6d9525c620fa470579f09692a2d27b01c8dccd619721af64dcf70c4a34533472bd10c52fd429c4a0f67014"} build_url:https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/JumRTWjCTlefRBTOeD0XUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18bbe6b6d354c7593f4608a5bbf0498670a22a7b00c27c0b85fa6383445ed3e35aa6e93c5c724b24dc67e5a1a36b469ac0b63cd6a18e36957626805e4773604f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c3fec5de7cb90f2a261e8a8e9efcae1c9af4aa51f6d9525c620fa470579f09692a2d27b01c8dccd619721af64dcf70c4a34533472bd10c52fd429c4a0f67014"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:56.889603) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:56.889899) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469617289.931171-1420363099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004739 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:56.971552) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:21:56.971853) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:21:56.972137) ========= ========= Total master_lag: 0.17 =========