builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1469617291.41 results: success (0) buildid: 20160726073802 builduid: 6c72781d2b374e1f98a541c9c018fb4c revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:31.413993) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:31.414479) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:31.414963) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:31.430198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:31.430634) ========= 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=836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 04:01:32-- 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% 67.0M=0s 2016-07-27 04:01:32 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.296600 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:31.742203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:31.742540) ========= 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=836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019191 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:31.792223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:31.792583) ========= 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=836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 04:01:32,493 truncating revision to first 12 chars 2016-07-27 04:01:32,493 Setting DEBUG logging. 2016-07-27 04:01:32,493 attempt 1/10 2016-07-27 04:01:32,493 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:32,806 unpacking tar archive at: mozilla-beta-958cee08361a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:32.459906) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:32.460237) ========= script_repo_revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:32.460649) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:32.460933) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:01:32.470130) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-07-27 04:01:32.470538) ========= /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=836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:01:33 INFO - MultiFileLogger online at 20160727 04:01:33 in /builds/slave/test 04:01:33 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:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:01:33 INFO - {'append_to_log': False, 04:01:33 INFO - 'base_work_dir': '/builds/slave/test', 04:01:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:01:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:01:33 INFO - 'branch': 'Mozilla-Beta', 04:01:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:01:33 INFO - 'config_files': ('talos/linux_config.py',), 04:01:33 INFO - 'default_actions': ('clobber', 04:01:33 INFO - 'read-buildbot-config', 04:01:33 INFO - 'download-and-extract', 04:01:33 INFO - 'populate-webroot', 04:01:33 INFO - 'create-virtualenv', 04:01:33 INFO - 'install', 04:01:33 INFO - 'run-tests'), 04:01:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:01:33 INFO - 'download_minidump_stackwalk': True, 04:01:33 INFO - 'download_symbols': 'ondemand', 04:01:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:01:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:01:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:01:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:01:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:01:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:01:33 INFO - 'installer_path': 'installer.exe', 04:01:33 INFO - 'log_level': 'info', 04:01:33 INFO - 'log_name': 'talos', 04:01:33 INFO - 'log_to_console': True, 04:01:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:01:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:01:33 INFO - 'opt_config_files': (), 04:01:33 INFO - 'pip_index': False, 04:01:33 INFO - 'sps_profile': False, 04:01:33 INFO - 'sps_profile_interval': 0, 04:01:33 INFO - 'suite': 'dromaeojs-e10s', 04:01:33 INFO - 'system_bits': '32', 04:01:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:01:33 INFO - 'title': 'talos-linux64-ix-028', 04:01:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:01:33 INFO - 'use_talos_json': True, 04:01:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:01:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:01:33 INFO - 'work_dir': 'build'} 04:01:33 INFO - ##### 04:01:33 INFO - ##### Running clobber step. 04:01:33 INFO - ##### 04:01:33 INFO - Running pre-action listener: _resource_record_pre_action 04:01:33 INFO - Running main action method: clobber 04:01:33 INFO - rmtree: /builds/slave/test/build 04:01:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:01:33 INFO - Running post-action listener: _resource_record_post_action 04:01:33 INFO - ##### 04:01:33 INFO - ##### Running read-buildbot-config step. 04:01:33 INFO - ##### 04:01:33 INFO - Running pre-action listener: _resource_record_pre_action 04:01:33 INFO - Running main action method: read_buildbot_config 04:01:33 INFO - Using buildbot properties: 04:01:33 INFO - { 04:01:33 INFO - "project": "", 04:01:33 INFO - "product": "firefox", 04:01:33 INFO - "script_repo_revision": "production", 04:01:33 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 04:01:33 INFO - "repository": "", 04:01:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 04:01:33 INFO - "buildid": "20160726073802", 04:01:33 INFO - "pgo_build": "True", 04:01:33 INFO - "basedir": "/builds/slave/test", 04:01:33 INFO - "buildnumber": 188, 04:01:33 INFO - "slavename": "talos-linux64-ix-028", 04:01:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:01:33 INFO - "platform": "ubuntu64_hw", 04:01:33 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:01:33 INFO - "branch": "mozilla-beta", 04:01:33 INFO - "repo_path": "releases/mozilla-beta", 04:01:33 INFO - "revision": "958cee08361af9ed370be06695973bcda3d3aa46", 04:01:33 INFO - "stage_platform": "linux64-pgo", 04:01:33 INFO - "builduid": "6c72781d2b374e1f98a541c9c018fb4c", 04:01:33 INFO - "slavebuilddir": "test" 04:01:33 INFO - } 04:01:33 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:33 INFO - Running post-action listener: _resource_record_post_action 04:01:33 INFO - ##### 04:01:33 INFO - ##### Running download-and-extract step. 04:01:33 INFO - ##### 04:01:33 INFO - Running pre-action listener: _resource_record_pre_action 04:01:33 INFO - Running main action method: download_and_extract 04:01:33 INFO - mkdir: /builds/slave/test/build/tests 04:01:33 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:33 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:33 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:33 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:33 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:33 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:34 INFO - Downloaded 1327 bytes. 04:01:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:01:34 INFO - Using the following test package requirements: 04:01:34 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:01:34 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:34 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:01:34 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:34 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 04:01:34 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:34 INFO - u'jsshell-linux-x86_64.zip'], 04:01:34 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:34 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:01:34 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:01:34 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:34 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 04:01:34 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:34 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 04:01:34 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:34 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:01:34 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:01:34 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:01:34 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:34 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:34 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:34 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:34 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:34 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:37 INFO - Downloaded 24199952 bytes. 04:01:37 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:37 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:38 INFO - Return code: 0 04:01:38 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:38 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:38 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:38 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:38 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:38 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:38 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:39 INFO - Downloaded 24199952 bytes. 04:01:39 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:39 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:41 INFO - Return code: 0 04:01:41 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:41 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:41 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:41 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:41 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:41 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:42 INFO - Downloaded 10840145 bytes. 04:01:42 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:42 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:42 INFO - Return code: 0 04:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:42 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:42 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:42 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:42 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:42 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:43 INFO - Downloaded 56024276 bytes. 04:01:43 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:43 INFO - mkdir: /builds/slave/test/properties 04:01:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:43 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:43 INFO - Contents: 04:01:43 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:44 INFO - Running post-action listener: _resource_record_post_action 04:01:44 INFO - Running post-action listener: set_extra_try_arguments 04:01:44 INFO - ##### 04:01:44 INFO - ##### Running populate-webroot step. 04:01:44 INFO - ##### 04:01:44 INFO - Running pre-action listener: _resource_record_pre_action 04:01:44 INFO - Running main action method: populate_webroot 04:01:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:01:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:01:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:01:44 INFO - '--tppagecycles', 04:01:44 INFO - '7'], 04:01:44 INFO - 'tests': ['tsvgm']}}, 04:01:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:01:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:01:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:01:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:01:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:01:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:01:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:44 INFO - 'talos_options': ['--disable-e10s'], 04:01:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:44 INFO - 'talos_options': ['--disable-e10s'], 04:01:44 INFO - 'tests': ['damp', 'tps']}, 04:01:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:44 INFO - 'tests': ['damp', 'tps']}, 04:01:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:01:44 INFO - 'tests': ['dromaeo_dom']}, 04:01:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:01:44 INFO - 'tests': ['a11yr', 04:01:44 INFO - 'ts_paint', 04:01:44 INFO - 'tpaint', 04:01:44 INFO - 'sessionrestore', 04:01:44 INFO - 'sessionrestore_no_auto_restore', 04:01:44 INFO - 'tabpaint']}, 04:01:44 INFO - 'other-e10s': {'tests': ['a11yr', 04:01:44 INFO - 'ts_paint', 04:01:44 INFO - 'tpaint', 04:01:44 INFO - 'sessionrestore', 04:01:44 INFO - 'sessionrestore_no_auto_restore', 04:01:44 INFO - 'tabpaint']}, 04:01:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:01:44 INFO - 'ts_paint', 04:01:44 INFO - 'tpaint', 04:01:44 INFO - 'sessionrestore', 04:01:44 INFO - 'sessionrestore_no_auto_restore', 04:01:44 INFO - 'tabpaint']}, 04:01:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:01:44 INFO - 'ts_paint', 04:01:44 INFO - 'tpaint', 04:01:44 INFO - 'sessionrestore', 04:01:44 INFO - 'sessionrestore_no_auto_restore', 04:01:44 INFO - 'tabpaint']}, 04:01:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:01:44 INFO - 'tests': ['a11yr', 04:01:44 INFO - 'ts_paint', 04:01:44 INFO - 'tpaint', 04:01:44 INFO - 'sessionrestore', 04:01:44 INFO - 'sessionrestore_no_auto_restore', 04:01:44 INFO - 'tabpaint']}, 04:01:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:01:44 INFO - 'tests': ['a11yr', 04:01:44 INFO - 'ts_paint', 04:01:44 INFO - 'tpaint', 04:01:44 INFO - 'sessionrestore', 04:01:44 INFO - 'sessionrestore_no_auto_restore', 04:01:44 INFO - 'tabpaint']}, 04:01:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:01:44 INFO - 'tests': ['tsvgx', 04:01:44 INFO - 'tsvgr_opacity', 04:01:44 INFO - 'tart', 04:01:44 INFO - 'tscrollx', 04:01:44 INFO - 'cart']}, 04:01:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:01:44 INFO - 'tsvgr_opacity', 04:01:44 INFO - 'tart', 04:01:44 INFO - 'tscrollx', 04:01:44 INFO - 'cart']}, 04:01:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:44 INFO - 'talos_options': ['--disable-e10s'], 04:01:44 INFO - 'tests': ['tp5o']}, 04:01:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:44 INFO - 'tests': ['tp5o']}, 04:01:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:44 INFO - 'talos_options': ['--disable-e10s', 04:01:44 INFO - '--xperf_path', 04:01:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:44 INFO - 'tests': ['tp5n']}, 04:01:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:44 INFO - 'talos_options': ['--xperf_path', 04:01:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:44 INFO - 'tests': ['tp5n']}}, 04:01:44 INFO - 'talos.zip': {'path': '', 04:01:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:01:44 INFO - Running post-action listener: _resource_record_post_action 04:01:44 INFO - ##### 04:01:44 INFO - ##### Running create-virtualenv step. 04:01:44 INFO - ##### 04:01:44 INFO - Running pre-action listener: _resource_record_pre_action 04:01:44 INFO - Running main action method: create_virtualenv 04:01:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:01:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:01:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:44 INFO - Using real prefix '/usr' 04:01:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:47 INFO - Installing pip.................done. 04:01:47 INFO - Return code: 0 04:01:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5a7010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1510640>, '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 0x1511540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15119d0>, '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': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', '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:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:01:47 INFO - Using env: {'DISPLAY': ':0', 04:01:47 INFO - 'HOME': '/home/cltbld', 04:01:47 INFO - 'LANG': 'en_US.UTF-8', 04:01:47 INFO - 'LANGUAGE': 'en_US:en', 04:01:47 INFO - 'LOGNAME': 'cltbld', 04:01:47 INFO - 'MAIL': '/var/mail/cltbld', 04:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:47 INFO - 'MOZ_NO_REMOTE': '1', 04:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:47 INFO - 'NO_EM_RESTART': '1', 04:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:47 INFO - 'PWD': '/builds/slave/test', 04:01:47 INFO - 'SHELL': '/bin/bash', 04:01:47 INFO - 'SHLVL': '1', 04:01:47 INFO - 'TERM': 'linux', 04:01:47 INFO - 'TMOUT': '86400', 04:01:47 INFO - 'USER': 'cltbld', 04:01:47 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', 04:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:47 INFO - '_': '/tools/buildbot/bin/python'} 04:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:01:47 INFO - Cleaning up... 04:01:47 INFO - Return code: 0 04:01:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5a7010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1510640>, '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 0x1511540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15119d0>, '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': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', '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:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:01:47 INFO - Using env: {'DISPLAY': ':0', 04:01:47 INFO - 'HOME': '/home/cltbld', 04:01:47 INFO - 'LANG': 'en_US.UTF-8', 04:01:47 INFO - 'LANGUAGE': 'en_US:en', 04:01:47 INFO - 'LOGNAME': 'cltbld', 04:01:47 INFO - 'MAIL': '/var/mail/cltbld', 04:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:47 INFO - 'MOZ_NO_REMOTE': '1', 04:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:47 INFO - 'NO_EM_RESTART': '1', 04:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:47 INFO - 'PWD': '/builds/slave/test', 04:01:47 INFO - 'SHELL': '/bin/bash', 04:01:47 INFO - 'SHLVL': '1', 04:01:47 INFO - 'TERM': 'linux', 04:01:47 INFO - 'TMOUT': '86400', 04:01:47 INFO - 'USER': 'cltbld', 04:01:47 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', 04:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:47 INFO - '_': '/tools/buildbot/bin/python'} 04:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:47 INFO - Downloading/unpacking psutil>=0.7.1 04:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:49 INFO - Installing collected packages: psutil 04:01:49 INFO - Running setup.py install for psutil 04:01:49 INFO - building 'psutil._psutil_linux' extension 04:01:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:01:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:01:49 INFO - building 'psutil._psutil_posix' extension 04:01:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:01:50 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:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:50 INFO - Successfully installed psutil 04:01:50 INFO - Cleaning up... 04:01:50 INFO - Return code: 0 04:01:50 INFO - Installing mozsystemmonitor==0.0.0 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', '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 0x7fb5a7010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1510640>, '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 0x1511540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15119d0>, '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': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', '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', 'mozsystemmonitor==0.0.0'] 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 mozsystemmonitor==0.0.0 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': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', 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 mozsystemmonitor==0.0.0 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 mozsystemmonitor-0.0.tar.gz 04:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:01:52 INFO - Installing collected packages: mozsystemmonitor 04:01:52 INFO - Running setup.py install for mozsystemmonitor 04:01:52 INFO - Successfully installed mozsystemmonitor 04:01:52 INFO - Cleaning up... 04:01:52 INFO - Return code: 0 04:01:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5a7010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1510640>, '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 0x1511540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15119d0>, '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': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', '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:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:01:52 INFO - Using env: {'DISPLAY': ':0', 04:01:52 INFO - 'HOME': '/home/cltbld', 04:01:52 INFO - 'LANG': 'en_US.UTF-8', 04:01:52 INFO - 'LANGUAGE': 'en_US:en', 04:01:52 INFO - 'LOGNAME': 'cltbld', 04:01:52 INFO - 'MAIL': '/var/mail/cltbld', 04:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:52 INFO - 'MOZ_NO_REMOTE': '1', 04:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:52 INFO - 'NO_EM_RESTART': '1', 04:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:52 INFO - 'PWD': '/builds/slave/test', 04:01:52 INFO - 'SHELL': '/bin/bash', 04:01:52 INFO - 'SHLVL': '1', 04:01:52 INFO - 'TERM': 'linux', 04:01:52 INFO - 'TMOUT': '86400', 04:01:52 INFO - 'USER': 'cltbld', 04:01:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', 04:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:52 INFO - '_': '/tools/buildbot/bin/python'} 04:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:52 INFO - Downloading/unpacking 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:54 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:55 INFO - Downloading docopt-0.6.1.tar.gz 04:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:55 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:55 INFO - Running setup.py install for blobuploader 04:01:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:55 INFO - Running setup.py install for requests 04:01:55 INFO - Running setup.py install for docopt 04:01:55 INFO - Successfully installed blobuploader requests docopt 04:01:55 INFO - Cleaning up... 04:01:55 INFO - Return code: 0 04:01:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5a7010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1510640>, '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 0x1511540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15119d0>, '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': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', '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:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:01:55 INFO - Using env: {'DISPLAY': ':0', 04:01:55 INFO - 'HOME': '/home/cltbld', 04:01:55 INFO - 'LANG': 'en_US.UTF-8', 04:01:55 INFO - 'LANGUAGE': 'en_US:en', 04:01:55 INFO - 'LOGNAME': 'cltbld', 04:01:55 INFO - 'MAIL': '/var/mail/cltbld', 04:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:55 INFO - 'MOZ_NO_REMOTE': '1', 04:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:55 INFO - 'NO_EM_RESTART': '1', 04:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:55 INFO - 'PWD': '/builds/slave/test', 04:01:55 INFO - 'SHELL': '/bin/bash', 04:01:55 INFO - 'SHLVL': '1', 04:01:55 INFO - 'TERM': 'linux', 04:01:55 INFO - 'TMOUT': '86400', 04:01:55 INFO - 'USER': 'cltbld', 04:01:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', 04:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:55 INFO - '_': '/tools/buildbot/bin/python'} 04:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:56 INFO - Running setup.py (path:/tmp/pip-ZTFAHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:56 INFO - Running setup.py (path:/tmp/pip-9FO0bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:56 INFO - Running setup.py (path:/tmp/pip-MoSCUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:56 INFO - Running setup.py (path:/tmp/pip-ln4Z56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:56 INFO - Running setup.py (path:/tmp/pip-0oe6Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:56 INFO - Running setup.py (path:/tmp/pip-tPegPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:56 INFO - Running setup.py (path:/tmp/pip-nwfTfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:56 INFO - Running setup.py (path:/tmp/pip-ufaDqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:56 INFO - Running setup.py (path:/tmp/pip-BLlQml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:56 INFO - Running setup.py (path:/tmp/pip-D5muxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:56 INFO - Running setup.py (path:/tmp/pip-rC_WvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:56 INFO - Running setup.py (path:/tmp/pip-Qn0zkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:57 INFO - Running setup.py (path:/tmp/pip-RmVFbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:57 INFO - Running setup.py (path:/tmp/pip-q4SRIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:57 INFO - Running setup.py (path:/tmp/pip-PZDjoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:57 INFO - Running setup.py (path:/tmp/pip-f55yx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:57 INFO - Running setup.py (path:/tmp/pip-Ou8QE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:57 INFO - Running setup.py install for manifestparser 04:01:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:57 INFO - Running setup.py install for mozcrash 04:01:57 INFO - Running setup.py install for mozdebug 04:01:57 INFO - Running setup.py install for mozdevice 04:01:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:57 INFO - Running setup.py install for mozfile 04:01:57 INFO - Running setup.py install for mozhttpd 04:01:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:58 INFO - Running setup.py install for mozinfo 04:01:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:58 INFO - Running setup.py install for mozInstall 04:01:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:58 INFO - Running setup.py install for mozleak 04:01:58 INFO - Running setup.py install for mozlog 04:01:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:58 INFO - Running setup.py install for moznetwork 04:01:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:58 INFO - Running setup.py install for mozprocess 04:01:58 INFO - Running setup.py install for mozprofile 04:01:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:58 INFO - Running setup.py install for mozrunner 04:01:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:58 INFO - Running setup.py install for mozscreenshot 04:01:58 INFO - Running setup.py install for moztest 04:01:59 INFO - Running setup.py install for mozversion 04:01:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:59 INFO - Cleaning up... 04:01:59 INFO - Return code: 0 04:01:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5a7010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1510640>, '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 0x1511540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15119d0>, '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': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', '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:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:01:59 INFO - Using env: {'DISPLAY': ':0', 04:01:59 INFO - 'HOME': '/home/cltbld', 04:01:59 INFO - 'LANG': 'en_US.UTF-8', 04:01:59 INFO - 'LANGUAGE': 'en_US:en', 04:01:59 INFO - 'LOGNAME': 'cltbld', 04:01:59 INFO - 'MAIL': '/var/mail/cltbld', 04:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:59 INFO - 'MOZ_NO_REMOTE': '1', 04:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:59 INFO - 'NO_EM_RESTART': '1', 04:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:59 INFO - 'PWD': '/builds/slave/test', 04:01:59 INFO - 'SHELL': '/bin/bash', 04:01:59 INFO - 'SHLVL': '1', 04:01:59 INFO - 'TERM': 'linux', 04:01:59 INFO - 'TMOUT': '86400', 04:01:59 INFO - 'USER': 'cltbld', 04:01:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', 04:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:59 INFO - '_': '/tools/buildbot/bin/python'} 04:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:59 INFO - Running setup.py (path:/tmp/pip-e9Qql5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:59 INFO - Running setup.py (path:/tmp/pip-3usYJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:59 INFO - Running setup.py (path:/tmp/pip-NohjcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:59 INFO - Running setup.py (path:/tmp/pip-RaKHQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:59 INFO - Running setup.py (path:/tmp/pip-_ZaJF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:59 INFO - Running setup.py (path:/tmp/pip-Se6L4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:59 INFO - Running setup.py (path:/tmp/pip-_ZBJbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:59 INFO - Running setup.py (path:/tmp/pip-VpX3YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:59 INFO - Running setup.py (path:/tmp/pip-38ibGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:00 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:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:00 INFO - Running setup.py (path:/tmp/pip-xYyn7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:00 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:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:00 INFO - Running setup.py (path:/tmp/pip-534zx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:00 INFO - Running setup.py (path:/tmp/pip-X1a5T_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:00 INFO - Running setup.py (path:/tmp/pip-xSO5lG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:00 INFO - Running setup.py (path:/tmp/pip-LxrOVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:00 INFO - Running setup.py (path:/tmp/pip-JeCclL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:00 INFO - Running setup.py (path:/tmp/pip-1gW24y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:00 INFO - Running setup.py (path:/tmp/pip-LEQJbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:02:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:02 INFO - Downloading blessings-1.6.tar.gz 04:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:02:02 INFO - Installing collected packages: blessings 04:02:02 INFO - Running setup.py install for blessings 04:02:02 INFO - Successfully installed blessings 04:02:02 INFO - Cleaning up... 04:02:02 INFO - Return code: 0 04:02:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:02:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:03 INFO - Reading from file tmpfile_stdout 04:02:03 INFO - Current package versions: 04:02:03 INFO - argparse == 1.2.1 04:02:03 INFO - blessings == 1.6 04:02:03 INFO - blobuploader == 1.2.4 04:02:03 INFO - docopt == 0.6.1 04:02:03 INFO - manifestparser == 1.1 04:02:03 INFO - mozInstall == 1.12 04:02:03 INFO - mozcrash == 0.17 04:02:03 INFO - mozdebug == 0.1 04:02:03 INFO - mozdevice == 0.48 04:02:03 INFO - mozfile == 1.2 04:02:03 INFO - mozhttpd == 0.7 04:02:03 INFO - mozinfo == 0.9 04:02:03 INFO - mozleak == 0.1 04:02:03 INFO - mozlog == 3.1 04:02:03 INFO - moznetwork == 0.27 04:02:03 INFO - mozprocess == 0.22 04:02:03 INFO - mozprofile == 0.28 04:02:03 INFO - mozrunner == 6.11 04:02:03 INFO - mozscreenshot == 0.1 04:02:03 INFO - mozsystemmonitor == 0.0 04:02:03 INFO - moztest == 0.7 04:02:03 INFO - mozversion == 1.4 04:02:03 INFO - psutil == 3.1.1 04:02:03 INFO - requests == 1.2.3 04:02:03 INFO - wsgiref == 0.1.2 04:02:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:03 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 0x7fb5a7010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1510640>, '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 0x1511540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15119d0>, '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': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', '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:03 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:03 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:03 INFO - Using env: {'DISPLAY': ':0', 04:02:03 INFO - 'HOME': '/home/cltbld', 04:02:03 INFO - 'LANG': 'en_US.UTF-8', 04:02:03 INFO - 'LANGUAGE': 'en_US:en', 04:02:03 INFO - 'LOGNAME': 'cltbld', 04:02:03 INFO - 'MAIL': '/var/mail/cltbld', 04:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:03 INFO - 'MOZ_NO_REMOTE': '1', 04:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:03 INFO - 'NO_EM_RESTART': '1', 04:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:03 INFO - 'PWD': '/builds/slave/test', 04:02:03 INFO - 'SHELL': '/bin/bash', 04:02:03 INFO - 'SHLVL': '1', 04:02:03 INFO - 'TERM': 'linux', 04:02:03 INFO - 'TMOUT': '86400', 04:02:03 INFO - 'USER': 'cltbld', 04:02:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', 04:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:03 INFO - '_': '/tools/buildbot/bin/python'} 04:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:02:03 INFO - Cleaning up... 04:02:03 INFO - Return code: 0 04:02:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5a7010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1510640>, '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 0x1511540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15119d0>, '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': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', '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:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:02:03 INFO - Using env: {'DISPLAY': ':0', 04:02:03 INFO - 'HOME': '/home/cltbld', 04:02:03 INFO - 'LANG': 'en_US.UTF-8', 04:02:03 INFO - 'LANGUAGE': 'en_US:en', 04:02:03 INFO - 'LOGNAME': 'cltbld', 04:02:03 INFO - 'MAIL': '/var/mail/cltbld', 04:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:03 INFO - 'MOZ_NO_REMOTE': '1', 04:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:03 INFO - 'NO_EM_RESTART': '1', 04:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:03 INFO - 'PWD': '/builds/slave/test', 04:02:03 INFO - 'SHELL': '/bin/bash', 04:02:03 INFO - 'SHLVL': '1', 04:02:03 INFO - 'TERM': 'linux', 04:02:03 INFO - 'TMOUT': '86400', 04:02:03 INFO - 'USER': 'cltbld', 04:02:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', 04:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:03 INFO - '_': '/tools/buildbot/bin/python'} 04:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:03 INFO - Downloading/unpacking 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:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:02:05 INFO - Downloading/unpacking functools32 (from jsonschema) 04:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:05 INFO - Downloading functools32-3.2.3-2.tar.gz 04:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:05 INFO - warning: no files found matching '*.txt' 04:02:05 INFO - no previously-included directories found matching 'build' 04:02:05 INFO - no previously-included directories found matching 'dist' 04:02:05 INFO - no previously-included directories found matching '.git*' 04:02:05 INFO - Installing collected packages: jsonschema, functools32 04:02:05 INFO - Running setup.py install for functools32 04:02:05 INFO - warning: no files found matching '*.txt' 04:02:05 INFO - no previously-included directories found matching 'build' 04:02:05 INFO - no previously-included directories found matching 'dist' 04:02:05 INFO - no previously-included directories found matching '.git*' 04:02:05 INFO - Successfully installed jsonschema functools32 04:02:05 INFO - Cleaning up... 04:02:05 INFO - Return code: 0 04:02:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5a7010f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14817d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1510640>, '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 0x1511540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15119d0>, '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': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', '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:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:02:05 INFO - Using env: {'DISPLAY': ':0', 04:02:05 INFO - 'HOME': '/home/cltbld', 04:02:05 INFO - 'LANG': 'en_US.UTF-8', 04:02:05 INFO - 'LANGUAGE': 'en_US:en', 04:02:05 INFO - 'LOGNAME': 'cltbld', 04:02:05 INFO - 'MAIL': '/var/mail/cltbld', 04:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:05 INFO - 'MOZ_NO_REMOTE': '1', 04:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:05 INFO - 'NO_EM_RESTART': '1', 04:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:05 INFO - 'PWD': '/builds/slave/test', 04:02:05 INFO - 'SHELL': '/bin/bash', 04:02:05 INFO - 'SHLVL': '1', 04:02:05 INFO - 'TERM': 'linux', 04:02:05 INFO - 'TMOUT': '86400', 04:02:05 INFO - 'USER': 'cltbld', 04:02:05 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', 04:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:05 INFO - '_': '/tools/buildbot/bin/python'} 04:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:06 INFO - Downloading/unpacking 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 - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:02:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:02:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:08 INFO - no previously-included directories found matching 'docs/_build' 04:02:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:02:08 INFO - Running setup.py install for pep8 04:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:08 INFO - no previously-included directories found matching 'docs/_build' 04:02:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:02:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:02:08 INFO - Cleaning up... 04:02:08 INFO - Return code: 0 04:02:08 INFO - Running post-action listener: _resource_record_post_action 04:02:08 INFO - Running post-action listener: _start_resource_monitoring 04:02:08 INFO - Starting resource monitoring. 04:02:08 INFO - ##### 04:02:08 INFO - ##### Running install step. 04:02:08 INFO - ##### 04:02:08 INFO - Running pre-action listener: _resource_record_pre_action 04:02:08 INFO - Running main action method: install 04:02:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:09 INFO - Reading from file tmpfile_stdout 04:02:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:09 INFO - Reading from file tmpfile_stdout 04:02:09 INFO - Output received: 04:02:09 INFO - Usage: mozinstall [options] installer 04:02:09 INFO - Options: 04:02:09 INFO - -h, --help show this help message and exit 04:02:09 INFO - -d DEST, --destination=DEST 04:02:09 INFO - Directory to install application into. [default: 04:02:09 INFO - "/builds/slave/test"] 04:02:09 INFO - --app=APP Application being installed. [default: firefox] 04:02:09 INFO - mkdir: /builds/slave/test/build/application 04:02:09 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:09 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:22 INFO - Reading from file tmpfile_stdout 04:02:22 INFO - Output received: 04:02:22 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:22 INFO - Running post-action listener: _resource_record_post_action 04:02:22 INFO - ##### 04:02:22 INFO - ##### Running run-tests step. 04:02:22 INFO - ##### 04:02:22 INFO - Running pre-action listener: _resource_record_pre_action 04:02:22 INFO - Running main action method: run_tests 04:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:22 INFO - Python 2.7.3 04:02:22 INFO - Return code: 0 04:02:22 INFO - grabbing minidump binary from tooltool 04:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:22 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 0x1510640>, '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 0x1511540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15119d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:22 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:22 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:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:22 INFO - Return code: 0 04:02:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:02:23 INFO - Return code: 0 04:02:23 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-028', '--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:23 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-028 --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:23 INFO - Using env: {'DISPLAY': ':0', 04:02:23 INFO - 'HOME': '/home/cltbld', 04:02:23 INFO - 'LANG': 'en_US.UTF-8', 04:02:23 INFO - 'LANGUAGE': 'en_US:en', 04:02:23 INFO - 'LOGNAME': 'cltbld', 04:02:23 INFO - 'MAIL': '/var/mail/cltbld', 04:02:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:23 INFO - 'MOZ_NO_REMOTE': '1', 04:02:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:23 INFO - 'NO_EM_RESTART': '1', 04:02:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:23 INFO - 'PWD': '/builds/slave/test', 04:02:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:23 INFO - 'SHELL': '/bin/bash', 04:02:23 INFO - 'SHLVL': '1', 04:02:23 INFO - 'TERM': 'linux', 04:02:23 INFO - 'TMOUT': '86400', 04:02:23 INFO - 'USER': 'cltbld', 04:02:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588', 04:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:23 INFO - '_': '/tools/buildbot/bin/python'} 04:02:23 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-028', '--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:23 INFO - mozversion application_buildid: 20160726073802 04:02:23 INFO - mozversion application_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:02:23 INFO - mozversion application_display_name: Firefox 04:02:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:23 INFO - mozversion application_name: Firefox 04:02:23 INFO - mozversion application_remotingname: firefox 04:02:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:02:23 INFO - mozversion application_vendor: Mozilla 04:02:23 INFO - mozversion application_version: 48.0 04:02:23 INFO - mozversion platform_buildid: 20160726073802 04:02:23 INFO - mozversion platform_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:02:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:02:23 INFO - mozversion platform_version: 48.0 04:02:23 INFO - using testdate: 1469617343 04:02:23 INFO - actual date: 1469617343 04:02:23 INFO - starting webserver on 'localhost:48896' 04:02:23 INFO - SUITE-START | Running 2 tests 04:02:23 INFO - TEST-START | dromaeo_css 04:02:23 INFO - operating with platform_type : linux_ 04:02:23 INFO - Initialising browser for dromaeo_css test... 04:02:23 INFO - TEST-INFO | started process 15417 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuY7AXF/profile http://localhost:48896/getInfo.html) 04:02:27 INFO - PROCESS | 15417 | 04:02:27 INFO - PROCESS | 15417 | (process:15494): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:02:28 INFO - PROCESS | 15417 | __metrics Screen width/height:1600/1200 04:02:28 INFO - PROCESS | 15417 | colorDepth:24 04:02:28 INFO - PROCESS | 15417 | Browser inner width/height: 1024/697 04:02:28 INFO - PROCESS | 15417 | __metrics 04:02:28 ERROR - PROCESS | 15417 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:02:29 INFO - TEST-INFO | 15417: 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 15544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuY7AXF/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 | 15544 | 04:02:31 INFO - PROCESS | 15544 | (process:15611): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:02:41 INFO - PROCESS | 15544 | RSS: Main: 150720512 04:02:41 INFO - PROCESS | 15544 | 04:03:31 INFO - PROCESS | 15544 | 1469617410997 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:38 INFO - PROCESS | 15544 | Cycle 1(1): loaded http://localhost:48896/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48896/tests/dromaeo/cssquery-ext.html) 04:05:39 INFO - PROCESS | 15544 | RSS: Main: 155066368 04:05:39 INFO - PROCESS | 15544 | 04:08:41 INFO - PROCESS | 15544 | Cycle 1(1): loaded http://localhost:48896/tests/dromaeo/cssquery-ext.html (next: http://localhost:48896/tests/dromaeo/cssquery-jquery.html) 04:08:41 INFO - PROCESS | 15544 | RSS: Main: 152735744 04:08:41 INFO - PROCESS | 15544 | 04:11:43 INFO - PROCESS | 15544 | Cycle 1(1): loaded http://localhost:48896/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48896/tests/dromaeo/cssquery-mootools.html) 04:11:44 INFO - PROCESS | 15544 | RSS: Main: 152055808 04:11:44 INFO - PROCESS | 15544 | 04:14:45 INFO - PROCESS | 15544 | Cycle 1(1): loaded http://localhost:48896/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48896/tests/dromaeo/cssquery-prototype.html) 04:14:46 INFO - PROCESS | 15544 | RSS: Main: 153956352 04:14:46 INFO - PROCESS | 15544 | 04:17:48 INFO - PROCESS | 15544 | Cycle 1(1): loaded http://localhost:48896/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48896/tests/dromaeo/cssquery-yui.html) 04:17:49 INFO - PROCESS | 15544 | RSS: Main: 152145920 04:17:49 INFO - PROCESS | 15544 | 04:20:51 INFO - PROCESS | 15544 | Cycle 1(1): loaded http://localhost:48896/tests/dromaeo/cssquery-yui.html (next: http://localhost:48896/tests/dromaeo/cssquery-dojo.html) 04:20:51 INFO - PROCESS | 15544 | RSS: Main: 156213248 04:20:51 INFO - PROCESS | 15544 | 04:20:51 INFO - PROCESS | 15544 | __start_tp_report 04:20:51 INFO - PROCESS | 15544 | _x_x_mozilla_page_load 04:20:51 INFO - PROCESS | 15544 | _x_x_mozilla_page_load_details 04:20:51 INFO - PROCESS | 15544 | |i|pagename|runs| 04:20:51 INFO - PROCESS | 15544 | |0;dojo.html;3305.4050270951234;3318.2865683877963;3344.063662174592;3357.966420335796;3368.1242876852025;5388.676679399239;5401.837944861655;5416.052190866598;5427.755750991205;5435.076037073697;5482;5497.835064948048;5507.586930980173;5507.807226747064;5553.861153471165;4977.203647416414;5008.148614735485;5047.369078865142;5060.746962651871;5066.088104141253;5017.222330538772;5108.795648174068;5109.978004399117;5144.6655967362;5149.897002059956;5029.446760856303;5057.772400241998;5110.718910459923;5120.308758317636;5144.4598317176715;5142.922856157161;5156.561692256181;5201.895962080737;5202.14164662834;5210.843674689765;4917.7786999585105;5023.32185155003;5032.924506132411;5035.84892453227;5068.594512438996;5250.317458730341;5319.760610772524;5355.0896347621;5389.461053894618;5438.864028399282;5877.294724633029;5917.644941303535;5925.970370148165;5932.644041357489;5940.673262970535;6001.48987336077;6001.579889407743;6006.939930600682;6010.75956961721;6014;5502;5561.833145005657;5600.915986260209;5634.943650563524;5654;6016.368281330485;6018.8194354169445;6020.458158765645;6026.548008899263;6037.879242415127;5764.827055188351;5807.157962095473;5811.3316968548315;5820.301563812285;5831.533477321804;5842.678652674143;5887.381824908409;5962.821115366546;5977.043673012297;5985.670788106696;5915.733791979371;5916.290045194518;5921.348651648402;5926.525877929756;5932.822015339547;5774.797882074107;5789.102689083199;5884.558658100659;5929.614575052694;5934.7922822701;4562.954370456319;4569.9314510282375;4571.565701258442;4579.633629309714;4599.931001034987;4102.405151253051;4115.753054816721;4120.423140760296;4133.379993001014;4151.584841515824;5762.683052432073;5800.767969281266;5840.065589505659;5857.326407463111;5876.882462350814;5886.499647530008;5907.586468947133;5911.349751527328;5925.466707996301;5985.132155837379;5739.942600573941;5769.07694768835;5773.24947756789;5778.595498315078;5787.102999035156;5046.470120637354;5120.206368012964;5191.351081114861;5197.922031169535;5232.319798426181;6126.448619624166;6149.446549810538;6158.815235542941;6177.567570270128;6181.443670069715;5776.9133462998925;5948.2862056553495;5948.958932186936;5949.137375080589;5954.702264886651;5992.221011268507;6125.540694081788;6145.9692701536205;6149.385061493815;6150.815475535741;5738.9096071746235;5774;5786.247787787561;5794.884102318014;5796.768129274782;5759.942400576108;5853.882922341614;5864.530837532901;5864.912026319694;5881.647101173943;5719.685417301922;5765.192872997867;5772.422757724194;5774.538036956949;5805.361410244954;5709.600327977002;5741.8564535886935;5752.395998420273;5762.30852297727;5763.567732420001;5561.860953476195;5676.148577713376;5682.204491371294;5691.971540142438;5737.8565535861935;5806.954748145375;5818.418158184148;5848.970755146367;5865.882682346244;5867.354590994902;5696.829095127153;5716.5426765859465;5756.510696590669;5757.193992840922;5768.769249229984 04:20:51 INFO - PROCESS | 15544 | |1;ext.html;613.2548953022077;648.1347401219372;659.6009414304345;665.9843738299094;672.9394354508094;38543;39599.80200099003;39602.40596391049;39849.40225896614;39993.200135997264;44447.11105777883;44888.3266750999;44972.3254151188;44979.77510112453;45150.322745158766;8721.476711397321;8949.910500894974;8960.327975401839;8960.775980600472;8968.148025937558;8764.123587641217;8861.069587693297;8885.422447540921;8890;8901.421407608517;9133.315001374891;9152.4966126863;9164.908350916505;9173.08269173084;9190.586423610921;8994.190522852941;9040.954795225982;9043.321750868645;9047.638094476213;9093.727188184332;9051.864222036675;9150.40522366044;9160.816783664355;9179.586918588613;9197.034311397274;43576.56423435789;43784.56215437836;43862.56137438617;43969;44116.55883441157;3535.487354333607;3539.221371298336;3592.0840185752727;3600.5859326177565;3753.9624603753887;31678.524822127685;31874.362512749845;31882.202944926332;32053.51919721206;32869.34261314784;3961.3067713150085;3973.920521589552;3976.781277029791;3981.980090099531;3985.5217373915316;328847;330678;333551;335331;336359;41032.58967410288;61486.69256653688;61804.69097654483;61871;61977.38022619806;40366.59633403687;40574.39138412926;40695.59304406918;40777.38833917493;40925;17228.569285767706;17487.300507979537;17561.56096097608;17562.82437175612;17588.560285992695;14733.263336833115;14848.10911345301;14893.404263829325;14911.478098266509;14912.403503859941;9553.904460955302;9577.521123943914;9600.75998100053;9816.509174541245;9818.410895346302;3793.203427280247;3804.904877378088;3850.114473671071;3910.0420397002918;3925;1089.3681664634494;1138.2146319039837;1212.563477148226;1249.6938250128776;1255.6107606641788;33166.502502462485;33447.83276083604;33449.331013380084;33749.32501349959;35945.64054359475;1144.7767685301453;1221.9511219551296;1291.1930043722673;1304.8499422566335;1331.42083193811;16515.83484165167;16687;16900.154992250584;16965.915170424316;17068.829311706722;471533;477104;888340;932140;938871;63311.36688633055;63416.68291658512;63801.36198638047;64117.679411603574;64302.35697642963;1558.9142597157038;1594.0993338763562;1601.2394112796328;1603.1903888536215;1603.6552141289678;32710.34579308353;33294.33411331808;33519;34129.65870341364;34216.486752698234;55483;56039.71980140073;56190;56214;56289.43710562842;447069;447803;449576;451127;452484;31005;31448.37103257876;32180.35639287248;32245.51631725479;32317.35365292728;51240;51536.74231628968;51867.740661296455;52083.73958130185;52693.20960185677;43066.354004689325;43224.35163472613;43440.56559434365;43739.34390984074;44413;41769;42096;42536;42592.57407425886;43053.78473107614;42661.57338426576;43092.78453607712;43727;43770.56229437665;43829.12341753211;36671.63328366682;36855.8157209223;36896.26207475782;36943.728854097375;37631.05922351963;29063.56404653974;29107.563386548794;29108.8356465739;29314.41371172522;29639.555406669348 04:20:51 INFO - PROCESS | 15544 | |2;jquery.html;416.3629646640639;417.7744018230152;421.4415898933913;430.40174157920484;431.5404094639209;18745.812541874577;19263.807361926378;19320.4203873884;19338.51653708658;20192.39422817318;19231.519212019706;19287.61424771504;19937.900310498426;20377;20413.081411336487;5668.348139963895;5736.164357610406;5808.925348810483;5837.1536127261525;5925.940740592603;5769.971150144264;5791.7972870949525;5792.623479473821;5809.506191973687;5861.032929566616;5609.411011843759;5646.830595082133;5799.884002319972;5800.216970708963;5833.82498525045;5747.59766816323;5770.134479828017;5774.595778295521;5779.479846813786;5811.564132690023;5202.03762303975;5206.739663016872;5219.869503262411;6981.0924579804805;7346.59593722345;24114.87942560276;24631.753682463306;25023.749762502324;25818.87090564535;25896;2595.7014943281574;2769.7922655800894;2863.642044744407;3186.745060395186;3270.5421241026274;15577.922110389489;15650.843491565167;16006.599835004217;16141;16382.180890955404;2119.8834064126468;2138.1981756841183;2205.3604454708116;2218.279059305732;2226.2096955580696;86808.13191868064;88227.55886220591;88634.55682721609;90103;90269.54865225697;17339.739903901453;18593.90703046476;18786.624267514573;18821.435356939313;19007.524811879815;33914.83042584821;34170.31659366799;34185;34528.65471345305;34539.82730086333;10490.947545262377;10497.212709046851;10515.316504427188;10533.104686101615;10826.458677066115;8789.252913502423;8878.334124940655;8946.910530894738;9029.548522573845;9051;9201.815963680823;9357.532123393803;9446.763830904145;9566.9043309566;9675.612975481043;3531.134871956387;3603.6396360363756;3701.5373078365205;3853.7880416576795;3896.376579747227;990.7572644702094;1032.9225308101923;1067.0206766448282;1070.8755806403246;1117.8323251512174;18659.440216793246;18718.625627487374;18783.436496905113;18989.050547472572;19516.902415488115;1061.840723891407;1076.214363514623;1077.0844781935448;1077.9137668986618;1138.8918052784973;10666.679999600025;10895.67312980596;10945;10953.671389858317;11010.229283950206;497746;498729;500959;505027;507194;53372.73313633407;73672.89490657645;73959;83520.74718879221;85218.14781852227;1118.6588090632272;1155.0759392485977;1166.8249762535688;1171.912106592009;1172.0974849366112;16389.180540972666;17060;17218.913905430392;17683.823161768218;17833.554161146076;36450.27099458049;36599.08502287357;36982.8150859244;39896.401553977295;40191.598084018784;49925;51019.744901275255;52088.21867672064;52169.217461737346;53198.4680153209;8796.516191609522;8882.200601945857;8921;9000.459972401415;9134.451932884049;9839;12755.48978040868;13101.148425352321;13277.269750163834;13559;10835.458227088457;10956.12351011933;10959.945200273947;11318.207725459139;11480.655580332603;10967.287126336763;11166.44167791591;11324.6036388726;11410.600628977945;11818.409079545816;11270.718232044264;11565.595204167814;11644.825327619923;11700.35648039366;11868.940655296668;8882.422642528474;8947.463152210888;8971.730848074569;9039.548022598976;9082.500462474363;8412.621432035696;10663.360198388122;11481.885181148416;11838.526458941546;11875.287482751062 04:20:51 INFO - PROCESS | 15544 | |3;mootools.html;1537.2467490929444;1567.921603919804;1765.2762367429357;1891.271860333771;1892;7277.818054548639;7858.1356050834365;7995.999999999993;8029.959850200748;8058;7754.10827754807;7776.883346749803;7837.255460731236;7858.96070519648;7860.68557257709;2282.6804247405375;2309.08791027544;2313.9768602314016;2321.0483701682315;2323.9883800581056;2312.6184179610345;2319.46652269978;2373.2405630198346;2377.2868139558063;2378.2151889876386;2344.566255242777;2347.096367898363;2365.5387199496104;2373.667686523888;2390.3785015895905;2358.41039740065;2360.221127028077;2383.344580240439;2391.0316321889577;2392.629142482918;2328.8253380996325;2329.9301020969397;2342.0631747301045;2342.976570234293;2353.5645905507536;7731.072271327421;7750.031246094239;7789.221077892222;7799.6100194990595;7823.569703666296;5002.449730529639;5082.034413461431;5121.155009423441;5124.103281925648;5144.588432925394;3221.9850747014616;3295.40682677118;3361.2773253750315;3394.8302584870657;3402.3705614461405;1134.3137401871832;1134.7067517035453;1134.8467956825805;1145.1411441418936;1151.3782557418983;11637.534498620045;11660.06719462441;11694.473748681245;11698.941505292503;11753.118516111326;4263.339182426729;4275.935860962088;4359.80380882861;4360.127974405132;4433.534478879736;9405.106514881076;9414.105659962293;9426.340156189139;9429.198518126037;9441.669541566012;4964.925526117111;4988.176950803077;4992.8002879885125;5002.924956125661;5017.623678224075;4484.461864576272;4591.885202869955;4593.977030114895;4597.540245975442;4631.9536804631525;3740.541188936317;3829.5213098362706;3839.3281175794123;3866.8646597368956;3904.375299951994;1103.5585765693786;1184.7571247894161;1192.7614477104614;1193.9462724177433;1203.9699007524707;1045.0490054050777;1056.5773690523852;1058.4548957287004;1061.5382308695741;1084.360227465799;5880.26496687914;5983;6031.788887388921;6099.350762418881;6106.084087386927;467.64692657043713;467.78715684363533;470.2264774446017;476.26892719675135;480.3491269330077;4235.851745188904;4268.0183557781265;4286.978565107154;4291.206126866539;4311.245532031882;10092.444915529717;10379.688609341732;10491.895081049244;10505.789884202426;10509.159267258601;10355;10360.481975901175;10374.948125259325;10378.532966016548;10380.06579407857;7727.150013498511;7940.0868900076075;8023.638936247883;8025.9598702006115;8047.597620118971;5659.236003139524;5800.622959507618;5941.910871336847;5942.31663358702;5978.983572792548;8855.60149793248;9130.680426185052;9150.40522366044;9183.908160918305;9228.95385523068;8935;9113.407628504126;9115.589798458952;9154.725358239264;9264.861027084464;7106.395956343768;7326.487145899736;7331.303526165006;7333.889991650023;7434.553926764412;8144.30773384269;8150.83698326042;8164.714235001747;8170.142135075732;8221.506709597443;7107.395871350786;7351.154617219088;7376.557406555624;7456.179820219663;7504.249575042452;7033.577985320897;7199.496035277481;7239.058922340062;7257.745978890714;7395.112586489656;6624.933750662624;6692;6695.933040669531;6721.630310332978;6733.528652994243;5078.136716758234;5095.923561146512;5159.974200128975;5239.659422137549;5250.65870718402;5170.689758614495;5244.685318880879;5272.44639312882;5272.736363181903;5417.268668729671 04:20:51 INFO - PROCESS | 15544 | |4;prototype.html;348.8900996186201;358.30131244074045;359.06821797435646;362.1110174521549;365.57410616631626;6352.237731472218;6429.132067170931;6515.381038801313;6606;6613.801585952417;6531.118299029641;6533.640649764261;6567.671616419184;6570.474362051036;6591.209054913417;4949.950500495003;4953.10844048073;4956.900861982758;4962.826301079463;4966.925496117561;4985.45160032398;4986.4265609455015;4986.700797952134;4988.625853061017;4992.350994370727;4904.5831104356175;4947.851564453054;4953.851384458472;4958.206686930092;4960.131976904046;4734.83428080019;4866.221404575286;4932.96407754372;4941.555260026596;4954.058728841526;4240.279152544075;4244.511881133678;4259.936100958457;4265.936010959838;4266.210751011073;6247.562670613013;6253.437190652818;6257.499400047986;6260.718267677966;6268.247810262797;5644.435556444364;5650.378458369576;5651.7456714447535;5701.657900525982;5704.686242256675;6787.490938179656;6794.3545363190415;6797.150356205474;6816.9318306816795;6829.248782633907;4555.886102847422;4702.506236845116;4704.106219818258;4715.7877895494785;4731.929021064652;7102.609356485391;7122.715091396338;7135.536190147675;7148.428125749928;7164.355208031302;4796.8081276748535;4804.039192161582;4804.327394164819;4809.254565542346;4820.831270905572;4870.391201099863;4878.121938051185;4878.390201224847;4886.071646387175;4907.460179380265;5652;5674.546036317085;5680.204771332017;5683.431656834284;5694.829155125353;6715.731370745116;6818.659067046628;6857.451403887777;6922.688479018456;6930.13373328334;1681.8065922418834;1683.7474378843026;1685.5112017514784;1686.9372295453786;1691.7631531585587;1093.7429704019548;1106.2643342177523;1108.3793075877534;1132.7281452451516;1135.3641960502146;6682.131322928086;6695.196576410862;6757.358050985148;6764.526483146231;6767.830804229934;7054.294570542905;7055;7063.89404158938;7067.787966360915;7081.185663648746;6750.459963202932;6750.662466876636;6752.898706519406;6754.223264324567;6758.817206988757;3812.0279328770985;3828.789416582115;3829.157585331223;3842.9231415372096;3843.7309388343106;7389;7608.733694320672;7635.198304178092;7636.961815191;7641.885371719429;7288.70845166198;7290;7291.234420385889;7310.96344518274;7341.889871651822;7612.505187162817;7614.2766437188375;7623.199564045806;7623.809404764815;7630.923690763021;6962.338577835098;7170.103737032871;7198.172210195685;7202.135743710788;7214.96392518034;7088.326608972139;7114.253003434772;7120.145582529923;7126.35862772353;7144.4641651877355;7557.924420755722;7598.620068996639;7603.885941710768;7612.885806713015;7643;4774.188387974123;4814.5907597854575;4818.98801251741;4824.831130910401;4829.9034019318715;7066.152061752623;7207.279272072751;7213;7213.278672132745;7224.760324299484;6961.8955715665315;6962.651867406711;6971.128608923885;6978.267281935527;6990.965045174741;6926.376626103674;6948.791536253921;6952.5480843745;6961.965190174017;6970.442364610921;6824.658767061726;6827.385535301847;6832.350926661959;6833.58998460094;6841.213260475109;6793.218779840382;7012.368886800213;7031.613261270679;7037.401820845285;7046.260142684944;6701.832454188684;6791.558548694319;6821.3519715626935;6835.043093966749;6895.4138898194215 04:20:51 INFO - PROCESS | 15544 | |5;yui.html;880.423322723616;881.4490943160524;925.893522244942;929.4887811703566;932.6036434515329;14962.925185374072;15158.696826063471;15254.923725381384;15258.313375898097;15278.618034549141;12615.306158161298;12842.871571284284;12953.740925181492;12977.15648482848;13048.28234447105;729.821193807518;866.315610667575;903.8599017152352;905.0813424374265;906.7189171356868;886.8359353519587;890.6481939633841;895.9507227102507;899.7570655922897;901.733988473402;959.5681943125586;964.3924327673556;966.9468179250139;967.337373898878;970.0299700299701;934.1592566689966;950.6292545907137;951.2437612098364;955.0163331768255;956.4357029352645;685.372883811312;687.6733551563018;688.9965550172267;697.0137255783061;699.832040310327;14749.483768068174;14779.261036948217;14841.70316593662;14895.851041489555;14968.47610333644;13888.791668124986;14057.437702491889;14123.71752564943;14147.858521414757;14152.36314365856;9934.80130397388;10034.749131271703;10039.096481316716;10050.899491005142;10057.647982320657;4046.4129756706175;4075.5924407559305;4097.1191193893455;4140.503139623234;4148.668106551469;53594.19608705873;53873;54325;54572.45427545714;54977;10366.740831479274;10722.142228621691;10887.23789334739;10912.61805836792;11107.444627768578;20567;20991.370258892257;21095;21190.576188476145;21209.15163393478;8351.58242087893;8398.832023359499;8406.915930840736;8535;8553.144685531397;4770.880727981828;4938.530839570235;4996.525330093708;5034.093863104603;5065.316182315414;3544.80503572306;3587.6053634100226;3602.369585322558;3604.7837129772297;3606.404943184398;696.885013972699;701.0780823217555;710.6340234779093;712.262807993724;724.6521669598623;643.8551325951717;661.1306132435927;812;842.5113434208145;861.4443683824023;10115.848262276071;10136.239782016379;10207;10219.591216351262;10292.330998485075;684.910961574992;830.9459885107449;839.4501601451059;843.2747836860295;884.2395539835736;4487.910241795146;4714.622830173578;4727.550882666142;4866.172750632401;4903.338049363361;54317;54812;54972;55036.174457383175;55261.72369138209;50042.74978625084;50603.49396506062;51076;53004.46995529995;53712;46967.76516117466;47103.5289647106;47428.52571474241;48499.272510912364;48651.756741216064;9090.272778177863;9173.220276276592;9379.718608441757;9441.386309889835;9577.185939195246;34071.65928340685;35161.47257791084;35402.822985885934;35921.46117808183;35998.820005899805;41986.37020444635;42465;43086.35370469383;45709;46199.53800462087;11021.228514003942;11151.665450036511;11527.596534121265;12819.230846149261;12978.610641680387;13776.862231377558;14273.714525709634;14575.854241457873;14902.32939517746;14916.477923272634;13374.732505350034;13421;13690.65773355674;13834.861651383357;14216.431342746588;12050.819237711617;12400.441980110736;13277;13561.864381356454;13773.517926872511;12971.935140324238;13162.539311124065;13318;13570.321483925962;13868.861311386758;10214.438205898747;10297.330673506198;10459.372437653765;10557.683269501927;10680.359178449318;10884.510197040994;11347.829782553434;11602.6519204424;11678.474468649101;11693.473793679135 04:20:51 INFO - PROCESS | 15544 | __end_tp_report 04:20:51 INFO - PROCESS | 15544 | __start_cc_report 04:20:51 INFO - PROCESS | 15544 | _x_x_mozilla_cycle_collect,343 04:20:51 INFO - PROCESS | 15544 | __end_cc_report 04:20:51 INFO - PROCESS | 15544 | __startTimestamp1469618451716__endTimestamp 04:20:51 INFO - PROCESS | 15544 | 04:20:51 INFO - PROCESS | 15544 | ------- Summary: start ------- 04:20:51 INFO - PROCESS | 15544 | Number of tests: 6 04:20:51 INFO - PROCESS | 15544 | 04:20:51 INFO - PROCESS | 15544 | [#0] dojo.html Cycles:165 Average:5516.97 Median:5762.68 stddev:596.14 (10.3%) stddev-sans-first:572.16 04:20:51 INFO - PROCESS | 15544 | Values: 3305.4 3318.3 3344.1 3358.0 3368.1 5388.7 5401.8 5416.1 5427.8 5435.1 5482.0 5497.8 5507.6 5507.8 5553.9 4977.2 5008.1 5047.4 5060.7 5066.1 5017.2 5108.8 5110.0 5144.7 5149.9 5029.4 5057.8 5110.7 5120.3 5144.5 5142.9 5156.6 5201.9 5202.1 5210.8 4917.8 5023.3 5032.9 5035.8 5068.6 5250.3 5319.8 5355.1 5389.5 5438.9 5877.3 5917.6 5926.0 5932.6 5940.7 6001.5 6001.6 6006.9 6010.8 6014.0 5502.0 5561.8 5600.9 5634.9 5654.0 6016.4 6018.8 6020.5 6026.5 6037.9 5764.8 5807.2 5811.3 5820.3 5831.5 5842.7 5887.4 5962.8 5977.0 5985.7 5915.7 5916.3 5921.3 5926.5 5932.8 5774.8 5789.1 5884.6 5929.6 5934.8 4563.0 4569.9 4571.6 4579.6 4599.9 4102.4 4115.8 4120.4 4133.4 4151.6 5762.7 5800.8 5840.1 5857.3 5876.9 5886.5 5907.6 5911.3 5925.5 5985.1 5739.9 5769.1 5773.2 5778.6 5787.1 5046.5 5120.2 5191.4 5197.9 5232.3 6126.4 6149.4 6158.8 6177.6 6181.4 5776.9 5948.3 5949.0 5949.1 5954.7 5992.2 6125.5 6146.0 6149.4 6150.8 5738.9 5774.0 5786.2 5794.9 5796.8 5759.9 5853.9 5864.5 5864.9 5881.6 5719.7 5765.2 5772.4 5774.5 5805.4 5709.6 5741.9 5752.4 5762.3 5763.6 5561.9 5676.1 5682.2 5692.0 5737.9 5807.0 5818.4 5849.0 5865.9 5867.4 5696.8 5716.5 5756.5 5757.2 5768.8 04:20:51 INFO - PROCESS | 15544 | 04:20:51 INFO - PROCESS | 15544 | [#1] ext.html Cycles:180 Average:65823.26 Median:41400.79 stddev:148444.43 (358.6%) stddev-sans-first:148780.11 04:20:51 INFO - PROCESS | 15544 | Values: 613.3 648.1 659.6 666.0 672.9 38543.0 39599.8 39602.4 39849.4 39993.2 44447.1 44888.3 44972.3 44979.8 45150.3 8721.5 8949.9 8960.3 8960.8 8968.1 8764.1 8861.1 8885.4 8890.0 8901.4 9133.3 9152.5 9164.9 9173.1 9190.6 8994.2 9041.0 9043.3 9047.6 9093.7 9051.9 9150.4 9160.8 9179.6 9197.0 43576.6 43784.6 43862.6 43969.0 44116.6 3535.5 3539.2 3592.1 3600.6 3754.0 31678.5 31874.4 31882.2 32053.5 32869.3 3961.3 3973.9 3976.8 3982.0 3985.5 328847.0 330678.0 333551.0 335331.0 336359.0 41032.6 61486.7 61804.7 61871.0 61977.4 40366.6 40574.4 40695.6 40777.4 40925.0 17228.6 17487.3 17561.6 17562.8 17588.6 14733.3 14848.1 14893.4 14911.5 14912.4 9553.9 9577.5 9600.8 9816.5 9818.4 3793.2 3804.9 3850.1 3910.0 3925.0 1089.4 1138.2 1212.6 1249.7 1255.6 33166.5 33447.8 33449.3 33749.3 35945.6 1144.8 1222.0 1291.2 1304.8 1331.4 16515.8 16687.0 16900.2 16965.9 17068.8 471533.0 477104.0 888340.0 932140.0 938871.0 63311.4 63416.7 63801.4 64117.7 64302.4 1558.9 1594.1 1601.2 1603.2 1603.7 32710.3 33294.3 33519.0 34129.7 34216.5 55483.0 56039.7 56190.0 56214.0 56289.4 447069.0 447803.0 449576.0 451127.0 452484.0 31005.0 31448.4 32180.4 32245.5 32317.4 51240.0 51536.7 51867.7 52083.7 52693.2 43066.4 43224.4 43440.6 43739.3 44413.0 41769.0 42096.0 42536.0 42592.6 43053.8 42661.6 43092.8 43727.0 43770.6 43829.1 36671.6 36855.8 36896.3 36943.7 37631.1 29063.6 29107.6 29108.8 29314.4 29639.6 04:20:51 INFO - PROCESS | 15544 | 04:20:51 INFO - PROCESS | 15544 | [#2] jquery.html Cycles:180 Average:30013.38 Median:3228.64 stddev:82282.35 (2548.5%) stddev-sans-first:82483.16 04:20:51 INFO - PROCESS | 15544 | Values: 416.4 417.8 421.4 430.4 431.5 18745.8 19263.8 19320.4 19338.5 20192.4 19231.5 19287.6 19937.9 20377.0 20413.1 5668.3 5736.2 5808.9 5837.2 5925.9 5770.0 5791.8 5792.6 5809.5 5861.0 5609.4 5646.8 5799.9 5800.2 5833.8 5747.6 5770.1 5774.6 5779.5 5811.6 5202.0 5206.7 5219.9 6981.1 7346.6 24114.9 24631.8 25023.7 25818.9 25896.0 2595.7 2769.8 2863.6 3186.7 3270.5 15577.9 15650.8 16006.6 16141.0 16382.2 2119.9 2138.2 2205.4 2218.3 2226.2 86808.1 88227.6 88634.6 90103.0 90269.5 17339.7 18593.9 18786.6 18821.4 19007.5 33914.8 34170.3 34185.0 34528.7 34539.8 10490.9 10497.2 10515.3 10533.1 10826.5 8789.3 8878.3 8946.9 9029.5 9051.0 9201.8 9357.5 9446.8 9566.9 9675.6 3531.1 3603.6 3701.5 3853.8 3896.4 990.8 1032.9 1067.0 1070.9 1117.8 18659.4 18718.6 18783.4 18989.1 19516.9 1061.8 1076.2 1077.1 1077.9 1138.9 10666.7 10895.7 10945.0 10953.7 11010.2 497746.0 498729.0 500959.0 505027.0 507194.0 53372.7 73672.9 73959.0 83520.7 85218.1 1118.7 1155.1 1166.8 1171.9 1172.1 16389.2 17060.0 17218.9 17683.8 17833.6 36450.3 36599.1 36982.8 39896.4 40191.6 49925.0 51019.7 52088.2 52169.2 53198.5 8796.5 8882.2 8921.0 9000.5 9134.5 9839.0 12755.5 13101.1 13277.3 13559.0 10835.5 10956.1 10959.9 11318.2 11480.7 10967.3 11166.4 11324.6 11410.6 11818.4 11270.7 11565.6 11644.8 11700.4 11868.9 8882.4 8947.5 8971.7 9039.5 9082.5 8412.6 10663.4 11481.9 11838.5 11875.3 04:20:51 INFO - PROCESS | 15544 | 04:20:51 INFO - PROCESS | 15544 | [#3] mootools.html Cycles:180 Average:5509.92 Median:4976.55 stddev:3021.22 (60.7%) stddev-sans-first:3014.94 04:20:51 INFO - PROCESS | 15544 | Values: 1537.2 1567.9 1765.3 1891.3 1892.0 7277.8 7858.1 7996.0 8030.0 8058.0 7754.1 7776.9 7837.3 7859.0 7860.7 2282.7 2309.1 2314.0 2321.0 2324.0 2312.6 2319.5 2373.2 2377.3 2378.2 2344.6 2347.1 2365.5 2373.7 2390.4 2358.4 2360.2 2383.3 2391.0 2392.6 2328.8 2329.9 2342.1 2343.0 2353.6 7731.1 7750.0 7789.2 7799.6 7823.6 5002.4 5082.0 5121.2 5124.1 5144.6 3222.0 3295.4 3361.3 3394.8 3402.4 1134.3 1134.7 1134.8 1145.1 1151.4 11637.5 11660.1 11694.5 11698.9 11753.1 4263.3 4275.9 4359.8 4360.1 4433.5 9405.1 9414.1 9426.3 9429.2 9441.7 4964.9 4988.2 4992.8 5002.9 5017.6 4484.5 4591.9 4594.0 4597.5 4632.0 3740.5 3829.5 3839.3 3866.9 3904.4 1103.6 1184.8 1192.8 1193.9 1204.0 1045.0 1056.6 1058.5 1061.5 1084.4 5880.3 5983.0 6031.8 6099.4 6106.1 467.6 467.8 470.2 476.3 480.3 4235.9 4268.0 4287.0 4291.2 4311.2 10092.4 10379.7 10491.9 10505.8 10509.2 10355.0 10360.5 10374.9 10378.5 10380.1 7727.2 7940.1 8023.6 8026.0 8047.6 5659.2 5800.6 5941.9 5942.3 5979.0 8855.6 9130.7 9150.4 9183.9 9229.0 8935.0 9113.4 9115.6 9154.7 9264.9 7106.4 7326.5 7331.3 7333.9 7434.6 8144.3 8150.8 8164.7 8170.1 8221.5 7107.4 7351.2 7376.6 7456.2 7504.2 7033.6 7199.5 7239.1 7257.7 7395.1 6624.9 6692.0 6695.9 6721.6 6733.5 5078.1 5095.9 5160.0 5239.7 5250.7 5170.7 5244.7 5272.4 5272.7 5417.3 04:20:51 INFO - PROCESS | 15544 | 04:20:51 INFO - PROCESS | 15544 | [#4] prototype.html Cycles:180 Average:5786.96 Median:6688.66 stddev:1784.83 (26.7%) stddev-sans-first:1742.55 04:20:51 INFO - PROCESS | 15544 | Values: 348.9 358.3 359.1 362.1 365.6 6352.2 6429.1 6515.4 6606.0 6613.8 6531.1 6533.6 6567.7 6570.5 6591.2 4950.0 4953.1 4956.9 4962.8 4966.9 4985.5 4986.4 4986.7 4988.6 4992.4 4904.6 4947.9 4953.9 4958.2 4960.1 4734.8 4866.2 4933.0 4941.6 4954.1 4240.3 4244.5 4259.9 4265.9 4266.2 6247.6 6253.4 6257.5 6260.7 6268.2 5644.4 5650.4 5651.7 5701.7 5704.7 6787.5 6794.4 6797.2 6816.9 6829.2 4555.9 4702.5 4704.1 4715.8 4731.9 7102.6 7122.7 7135.5 7148.4 7164.4 4796.8 4804.0 4804.3 4809.3 4820.8 4870.4 4878.1 4878.4 4886.1 4907.5 5652.0 5674.5 5680.2 5683.4 5694.8 6715.7 6818.7 6857.5 6922.7 6930.1 1681.8 1683.7 1685.5 1686.9 1691.8 1093.7 1106.3 1108.4 1132.7 1135.4 6682.1 6695.2 6757.4 6764.5 6767.8 7054.3 7055.0 7063.9 7067.8 7081.2 6750.5 6750.7 6752.9 6754.2 6758.8 3812.0 3828.8 3829.2 3842.9 3843.7 7389.0 7608.7 7635.2 7637.0 7641.9 7288.7 7290.0 7291.2 7311.0 7341.9 7612.5 7614.3 7623.2 7623.8 7630.9 6962.3 7170.1 7198.2 7202.1 7215.0 7088.3 7114.3 7120.1 7126.4 7144.5 7557.9 7598.6 7603.9 7612.9 7643.0 4774.2 4814.6 4819.0 4824.8 4829.9 7066.2 7207.3 7213.0 7213.3 7224.8 6961.9 6962.7 6971.1 6978.3 6991.0 6926.4 6948.8 6952.5 6962.0 6970.4 6824.7 6827.4 6832.4 6833.6 6841.2 6793.2 7012.4 7031.6 7037.4 7046.3 6701.8 6791.6 6821.4 6835.0 6895.4 04:20:51 INFO - PROCESS | 15544 | 04:20:51 INFO - PROCESS | 15544 | [#5] yui.html Cycles:180 Average:14663.70 Median:42775.68 stddev:16112.49 (37.7%) stddev-sans-first:16124.44 04:20:51 INFO - PROCESS | 15544 | Values: 880.4 881.4 925.9 929.5 932.6 14962.9 15158.7 15254.9 15258.3 15278.6 12615.3 12842.9 12953.7 12977.2 13048.3 729.8 866.3 903.9 905.1 906.7 886.8 890.6 896.0 899.8 901.7 959.6 964.4 966.9 967.3 970.0 934.2 950.6 951.2 955.0 956.4 685.4 687.7 689.0 697.0 699.8 14749.5 14779.3 14841.7 14895.9 14968.5 13888.8 14057.4 14123.7 14147.9 14152.4 9934.8 10034.7 10039.1 10050.9 10057.6 4046.4 4075.6 4097.1 4140.5 4148.7 53594.2 53873.0 54325.0 54572.5 54977.0 10366.7 10722.1 10887.2 10912.6 11107.4 20567.0 20991.4 21095.0 21190.6 21209.2 8351.6 8398.8 8406.9 8535.0 8553.1 4770.9 4938.5 4996.5 5034.1 5065.3 3544.8 3587.6 3602.4 3604.8 3606.4 696.9 701.1 710.6 712.3 724.7 643.9 661.1 812.0 842.5 861.4 10115.8 10136.2 10207.0 10219.6 10292.3 684.9 830.9 839.5 843.3 884.2 4487.9 4714.6 4727.6 4866.2 4903.3 54317.0 54812.0 54972.0 55036.2 55261.7 50042.7 50603.5 51076.0 53004.5 53712.0 46967.8 47103.5 47428.5 48499.3 48651.8 9090.3 9173.2 9379.7 9441.4 9577.2 34071.7 35161.5 35402.8 35921.5 35998.8 41986.4 42465.0 43086.4 45709.0 46199.5 11021.2 11151.7 11527.6 12819.2 12978.6 13776.9 14273.7 14575.9 14902.3 14916.5 13374.7 13421.0 13690.7 13834.9 14216.4 12050.8 12400.4 13277.0 13561.9 13773.5 12971.9 13162.5 13318.0 13570.3 13868.9 10214.4 10297.3 10459.4 10557.7 10680.4 10884.5 11347.8 11602.7 11678.5 11693.5 04:20:51 INFO - PROCESS | 15544 | -------- Summary: end -------- 04:20:51 INFO - PROCESS | 15544 | 04:20:52 INFO - TEST-INFO | 15544: exit 0 04:20:52 INFO - TEST-OK | dromaeo_css | took 1108669ms 04:20:52 INFO - TEST-START | kraken 04:20:52 INFO - operating with platform_type : linux_ 04:20:52 INFO - Initialising browser for kraken test... 04:20:52 INFO - TEST-INFO | started process 15785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVm8Az_/profile http://localhost:48896/getInfo.html) 04:20:56 INFO - PROCESS | 15785 | 04:20:56 INFO - PROCESS | 15785 | (process:15863): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:20:56 INFO - PROCESS | 15785 | __metrics Screen width/height:1600/1200 04:20:56 INFO - PROCESS | 15785 | colorDepth:24 04:20:56 INFO - PROCESS | 15785 | Browser inner width/height: 1024/697 04:20:56 INFO - PROCESS | 15785 | __metrics 04:20:57 ERROR - PROCESS | 15785 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:20:58 INFO - TEST-INFO | 15785: 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 15914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVm8Az_/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 | 15914 | 04:21:00 INFO - PROCESS | 15914 | (process:15981): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:21:10 INFO - PROCESS | 15914 | RSS: Main: 150360064 04:21:10 INFO - PROCESS | 15914 | 04:21:12 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48896/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:13 INFO - PROCESS | 15914 | RSS: Main: 156078080 04:21:13 INFO - PROCESS | 15914 | 04:21:16 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48896/tests/kraken/driver.html?testName=audio-dft) 04:21:16 INFO - PROCESS | 15914 | RSS: Main: 155811840 04:21:16 INFO - PROCESS | 15914 | 04:21:19 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48896/tests/kraken/driver.html?testName=audio-fft) 04:21:20 INFO - PROCESS | 15914 | RSS: Main: 156299264 04:21:20 INFO - PROCESS | 15914 | 04:21:22 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48896/tests/kraken/driver.html?testName=audio-oscillator) 04:21:22 INFO - PROCESS | 15914 | RSS: Main: 155922432 04:21:22 INFO - PROCESS | 15914 | 04:21:25 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48896/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:25 INFO - PROCESS | 15914 | RSS: Main: 156110848 04:21:25 INFO - PROCESS | 15914 | 04:21:28 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48896/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:29 INFO - PROCESS | 15914 | RSS: Main: 156278784 04:21:29 INFO - PROCESS | 15914 | 04:21:32 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48896/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:33 INFO - PROCESS | 15914 | RSS: Main: 156446720 04:21:33 INFO - PROCESS | 15914 | 04:21:36 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48896/tests/kraken/driver.html?testName=json-parse-financial) 04:21:36 INFO - PROCESS | 15914 | RSS: Main: 156188672 04:21:36 INFO - PROCESS | 15914 | 04:21:38 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48896/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:38 INFO - PROCESS | 15914 | RSS: Main: 155869184 04:21:38 INFO - PROCESS | 15914 | 04:21:40 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48896/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:41 INFO - PROCESS | 15914 | RSS: Main: 155799552 04:21:41 INFO - PROCESS | 15914 | 04:21:43 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48896/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:43 INFO - PROCESS | 15914 | RSS: Main: 156192768 04:21:43 INFO - PROCESS | 15914 | 04:21:46 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:46 INFO - PROCESS | 15914 | RSS: Main: 156803072 04:21:46 INFO - PROCESS | 15914 | 04:21:49 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:50 INFO - PROCESS | 15914 | RSS: Main: 156516352 04:21:50 INFO - PROCESS | 15914 | 04:21:51 INFO - PROCESS | 15914 | Cycle 1(1): loaded http://localhost:48896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48896/tests/kraken/driver.html?testName=ai-astar) 04:21:52 INFO - PROCESS | 15914 | RSS: Main: 157470720 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | __start_tp_report 04:21:52 INFO - PROCESS | 15914 | _x_x_mozilla_page_load 04:21:52 INFO - PROCESS | 15914 | _x_x_mozilla_page_load_details 04:21:52 INFO - PROCESS | 15914 | |i|pagename|runs| 04:21:52 INFO - PROCESS | 15914 | |0;ai-astar;110;111;104;110;112;112;102;112;113;112 04:21:52 INFO - PROCESS | 15914 | |1;audio-beat-detection;159;127;160;170;129;156;156;129;179;128 04:21:52 INFO - PROCESS | 15914 | |2;audio-dft;164;162;162;163;162;162;167;166;161;161 04:21:52 INFO - PROCESS | 15914 | |3;audio-fft;77;75;77;174;73;79;77;76;163;76 04:21:52 INFO - PROCESS | 15914 | |4;audio-oscillator;93;92;163;91;91;92;151;94;92;148 04:21:52 INFO - PROCESS | 15914 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 04:21:52 INFO - PROCESS | 15914 | |6;imaging-darkroom;146;146;147;146;145;149;149;146;147;146 04:21:52 INFO - PROCESS | 15914 | |7;imaging-desaturate;95;95;95;99;98;95;95;95;96;96 04:21:52 INFO - PROCESS | 15914 | |8;json-parse-financial;55;58;57;57;60;58;57;83;62;59 04:21:52 INFO - PROCESS | 15914 | |9;json-stringify-tinderbox;57;58;58;58;58;59;58;58;59;58 04:21:52 INFO - PROCESS | 15914 | |10;stanford-crypto-aes;74;74;73;74;75;75;82;74;75;76 04:21:52 INFO - PROCESS | 15914 | |11;stanford-crypto-ccm;115;125;124;116;115;125;117;112;127;130 04:21:52 INFO - PROCESS | 15914 | |12;stanford-crypto-pbkdf2;167;165;160;165;168;162;162;163;162;160 04:21:52 INFO - PROCESS | 15914 | |13;stanford-crypto-sha256-iterative;70;68;67;66;67;66;65;67;66;66 04:21:52 INFO - PROCESS | 15914 | __end_tp_report 04:21:52 INFO - PROCESS | 15914 | __start_cc_report 04:21:52 INFO - PROCESS | 15914 | _x_x_mozilla_cycle_collect,827 04:21:52 INFO - PROCESS | 15914 | __end_cc_report 04:21:52 INFO - PROCESS | 15914 | __startTimestamp1469618512218__endTimestamp 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | ------- Summary: start ------- 04:21:52 INFO - PROCESS | 15914 | Number of tests: 14 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#0] ai-astar Cycles:10 Average:109.80 Median:112.00 stddev:3.74 (3.3%) stddev-sans-first:3.96 04:21:52 INFO - PROCESS | 15914 | Values: 110.0 111.0 104.0 110.0 112.0 112.0 102.0 112.0 113.0 112.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:157.50 stddev:19.39 (12.3%) stddev-sans-first:20.25 04:21:52 INFO - PROCESS | 15914 | Values: 159.0 127.0 160.0 170.0 129.0 156.0 156.0 129.0 179.0 128.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.05 (1.3%) stddev-sans-first:2.15 04:21:52 INFO - PROCESS | 15914 | Values: 164.0 162.0 162.0 163.0 162.0 162.0 167.0 166.0 161.0 161.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.50 stddev:39.01 (51.0%) stddev-sans-first:40.85 04:21:52 INFO - PROCESS | 15914 | Values: 77.0 75.0 77.0 174.0 73.0 79.0 77.0 76.0 163.0 76.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:92.00 stddev:30.13 (32.7%) stddev-sans-first:31.26 04:21:52 INFO - PROCESS | 15914 | Values: 93.0 92.0 163.0 91.0 91.0 92.0 151.0 94.0 92.0 148.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:21:52 INFO - PROCESS | 15914 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:1.34 (0.9%) stddev-sans-first:1.39 04:21:52 INFO - PROCESS | 15914 | Values: 146.0 146.0 147.0 146.0 145.0 149.0 149.0 146.0 147.0 146.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.50 stddev:1.45 (1.5%) stddev-sans-first:1.50 04:21:52 INFO - PROCESS | 15914 | Values: 95.0 95.0 95.0 99.0 98.0 95.0 95.0 95.0 96.0 96.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:58.50 stddev:8.10 (13.8%) stddev-sans-first:8.33 04:21:52 INFO - PROCESS | 15914 | Values: 55.0 58.0 57.0 57.0 60.0 58.0 57.0 83.0 62.0 59.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 04:21:52 INFO - PROCESS | 15914 | Values: 57.0 58.0 58.0 58.0 58.0 59.0 58.0 58.0 59.0 58.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:2.53 (3.4%) stddev-sans-first:2.65 04:21:52 INFO - PROCESS | 15914 | Values: 74.0 74.0 73.0 74.0 75.0 75.0 82.0 74.0 75.0 76.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:124.50 stddev:6.24 (5.0%) stddev-sans-first:6.28 04:21:52 INFO - PROCESS | 15914 | Values: 115.0 125.0 124.0 116.0 115.0 125.0 117.0 112.0 127.0 130.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:164.00 stddev:2.76 (1.7%) stddev-sans-first:2.60 04:21:52 INFO - PROCESS | 15914 | Values: 167.0 165.0 160.0 165.0 168.0 162.0 162.0 163.0 162.0 160.0 04:21:52 INFO - PROCESS | 15914 | 04:21:52 INFO - PROCESS | 15914 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.40 (2.1%) stddev-sans-first:0.88 04:21:52 INFO - PROCESS | 15914 | Values: 70.0 68.0 67.0 66.0 67.0 66.0 65.0 67.0 66.0 66.0 04:21:52 INFO - PROCESS | 15914 | -------- Summary: end -------- 04:21:52 INFO - PROCESS | 15914 | 04:21:53 INFO - TEST-INFO | 15914: exit 0 04:21:53 INFO - TEST-OK | kraken | took 60838ms 04:21:53 INFO - SUITE-END | took 1169s 04:21:53 INFO - Completed test suite (00:19:29) 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": [3305.4050270951234, 3318.2865683877963, 3344.063662174592, 3357.966420335796, 3368.1242876852025, 5388.676679399239, 5401.837944861655, 5416.052190866598, 5427.755750991205, 5435.076037073697, 5482.0, 5497.835064948048, 5507.586930980173, 5507.807226747064, 5553.861153471165, 4977.203647416414, 5008.148614735485, 5047.369078865142, 5060.746962651871, 5066.088104141253, 5017.222330538772, 5108.795648174068, 5109.978004399117, 5144.6655967362, 5149.897002059956, 5029.446760856303, 5057.772400241998, 5110.718910459923, 5120.308758317636, 5144.4598317176715, 5142.922856157161, 5156.561692256181, 5201.895962080737, 5202.14164662834, 5210.843674689765, 4917.7786999585105, 5023.32185155003, 5032.924506132411, 5035.84892453227, 5068.594512438996, 5250.317458730341, 5319.760610772524, 5355.0896347621, 5389.461053894618, 5438.864028399282, 5877.294724633029, 5917.644941303535, 5925.970370148165, 5932.644041357489, 5940.673262970535, 6001.48987336077, 6001.579889407743, 6006.939930600682, 6010.75956961721, 6014.0, 5502.0, 5561.833145005657, 5600.915986260209, 5634.943650563524, 5654.0, 6016.368281330485, 6018.8194354169445, 6020.458158765645, 6026.548008899263, 6037.879242415127, 5764.827055188351, 5807.157962095473, 5811.3316968548315, 5820.301563812285, 5831.533477321804, 5842.678652674143, 5887.381824908409, 5962.821115366546, 5977.043673012297, 5985.670788106696, 5915.733791979371, 5916.290045194518, 5921.348651648402, 5926.525877929756, 5932.822015339547, 5774.797882074107, 5789.102689083199, 5884.558658100659, 5929.614575052694, 5934.7922822701, 4562.954370456319, 4569.9314510282375, 4571.565701258442, 4579.633629309714, 4599.931001034987, 4102.405151253051, 4115.753054816721, 4120.423140760296, 4133.379993001014, 4151.584841515824, 5762.683052432073, 5800.767969281266, 5840.065589505659, 5857.326407463111, 5876.882462350814, 5886.499647530008, 5907.586468947133, 5911.349751527328, 5925.466707996301, 5985.132155837379, 5739.942600573941, 5769.07694768835, 5773.24947756789, 5778.595498315078, 5787.102999035156, 5046.470120637354, 5120.206368012964, 5191.351081114861, 5197.922031169535, 5232.319798426181, 6126.448619624166, 6149.446549810538, 6158.815235542941, 6177.567570270128, 6181.443670069715, 5776.9133462998925, 5948.2862056553495, 5948.958932186936, 5949.137375080589, 5954.702264886651, 5992.221011268507, 6125.540694081788, 6145.9692701536205, 6149.385061493815, 6150.815475535741, 5738.9096071746235, 5774.0, 5786.247787787561, 5794.884102318014, 5796.768129274782, 5759.942400576108, 5853.882922341614, 5864.530837532901, 5864.912026319694, 5881.647101173943, 5719.685417301922, 5765.192872997867, 5772.422757724194, 5774.538036956949, 5805.361410244954, 5709.600327977002, 5741.8564535886935, 5752.395998420273, 5762.30852297727, 5763.567732420001, 5561.860953476195, 5676.148577713376, 5682.204491371294, 5691.971540142438, 5737.8565535861935, 5806.954748145375, 5818.418158184148, 5848.970755146367, 5865.882682346244, 5867.354590994902, 5696.829095127153, 5716.5426765859465, 5756.510696590669, 5757.193992840922, 5768.769249229984], "value": 5479.121039264215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.2548953022077, 648.1347401219372, 659.6009414304345, 665.9843738299094, 672.9394354508094, 38543.0, 39599.80200099003, 39602.40596391049, 39849.40225896614, 39993.200135997264, 44447.11105777883, 44888.3266750999, 44972.3254151188, 44979.77510112453, 45150.322745158766, 8721.476711397321, 8949.910500894974, 8960.327975401839, 8960.775980600472, 8968.148025937558, 8764.123587641217, 8861.069587693297, 8885.422447540921, 8890.0, 8901.421407608517, 9133.315001374891, 9152.4966126863, 9164.908350916505, 9173.08269173084, 9190.586423610921, 8994.190522852941, 9040.954795225982, 9043.321750868645, 9047.638094476213, 9093.727188184332, 9051.864222036675, 9150.40522366044, 9160.816783664355, 9179.586918588613, 9197.034311397274, 43576.56423435789, 43784.56215437836, 43862.56137438617, 43969.0, 44116.55883441157, 3535.487354333607, 3539.221371298336, 3592.0840185752727, 3600.5859326177565, 3753.9624603753887, 31678.524822127685, 31874.362512749845, 31882.202944926332, 32053.51919721206, 32869.34261314784, 3961.3067713150085, 3973.920521589552, 3976.781277029791, 3981.980090099531, 3985.5217373915316, 328847.0, 330678.0, 333551.0, 335331.0, 336359.0, 41032.58967410288, 61486.69256653688, 61804.69097654483, 61871.0, 61977.38022619806, 40366.59633403687, 40574.39138412926, 40695.59304406918, 40777.38833917493, 40925.0, 17228.569285767706, 17487.300507979537, 17561.56096097608, 17562.82437175612, 17588.560285992695, 14733.263336833115, 14848.10911345301, 14893.404263829325, 14911.478098266509, 14912.403503859941, 9553.904460955302, 9577.521123943914, 9600.75998100053, 9816.509174541245, 9818.410895346302, 3793.203427280247, 3804.904877378088, 3850.114473671071, 3910.0420397002918, 3925.0, 1089.3681664634494, 1138.2146319039837, 1212.563477148226, 1249.6938250128776, 1255.6107606641788, 33166.502502462485, 33447.83276083604, 33449.331013380084, 33749.32501349959, 35945.64054359475, 1144.7767685301453, 1221.9511219551296, 1291.1930043722673, 1304.8499422566335, 1331.42083193811, 16515.83484165167, 16687.0, 16900.154992250584, 16965.915170424316, 17068.829311706722, 471533.0, 477104.0, 888340.0, 932140.0, 938871.0, 63311.36688633055, 63416.68291658512, 63801.36198638047, 64117.679411603574, 64302.35697642963, 1558.9142597157038, 1594.0993338763562, 1601.2394112796328, 1603.1903888536215, 1603.6552141289678, 32710.34579308353, 33294.33411331808, 33519.0, 34129.65870341364, 34216.486752698234, 55483.0, 56039.71980140073, 56190.0, 56214.0, 56289.43710562842, 447069.0, 447803.0, 449576.0, 451127.0, 452484.0, 31005.0, 31448.37103257876, 32180.35639287248, 32245.51631725479, 32317.35365292728, 51240.0, 51536.74231628968, 51867.740661296455, 52083.73958130185, 52693.20960185677, 43066.354004689325, 43224.35163472613, 43440.56559434365, 43739.34390984074, 44413.0, 41769.0, 42096.0, 42536.0, 42592.57407425886, 43053.78473107614, 42661.57338426576, 43092.78453607712, 43727.0, 43770.56229437665, 43829.12341753211, 36671.63328366682, 36855.8157209223, 36896.26207475782, 36943.728854097375, 37631.05922351963, 29063.56404653974, 29107.563386548794, 29108.8356465739, 29314.41371172522, 29639.555406669348], "value": 20104.201999900088, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.3629646640639, 417.7744018230152, 421.4415898933913, 430.40174157920484, 431.5404094639209, 18745.812541874577, 19263.807361926378, 19320.4203873884, 19338.51653708658, 20192.39422817318, 19231.519212019706, 19287.61424771504, 19937.900310498426, 20377.0, 20413.081411336487, 5668.348139963895, 5736.164357610406, 5808.925348810483, 5837.1536127261525, 5925.940740592603, 5769.971150144264, 5791.7972870949525, 5792.623479473821, 5809.506191973687, 5861.032929566616, 5609.411011843759, 5646.830595082133, 5799.884002319972, 5800.216970708963, 5833.82498525045, 5747.59766816323, 5770.134479828017, 5774.595778295521, 5779.479846813786, 5811.564132690023, 5202.03762303975, 5206.739663016872, 5219.869503262411, 6981.0924579804805, 7346.59593722345, 24114.87942560276, 24631.753682463306, 25023.749762502324, 25818.87090564535, 25896.0, 2595.7014943281574, 2769.7922655800894, 2863.642044744407, 3186.745060395186, 3270.5421241026274, 15577.922110389489, 15650.843491565167, 16006.599835004217, 16141.0, 16382.180890955404, 2119.8834064126468, 2138.1981756841183, 2205.3604454708116, 2218.279059305732, 2226.2096955580696, 86808.13191868064, 88227.55886220591, 88634.55682721609, 90103.0, 90269.54865225697, 17339.739903901453, 18593.90703046476, 18786.624267514573, 18821.435356939313, 19007.524811879815, 33914.83042584821, 34170.31659366799, 34185.0, 34528.65471345305, 34539.82730086333, 10490.947545262377, 10497.212709046851, 10515.316504427188, 10533.104686101615, 10826.458677066115, 8789.252913502423, 8878.334124940655, 8946.910530894738, 9029.548522573845, 9051.0, 9201.815963680823, 9357.532123393803, 9446.763830904145, 9566.9043309566, 9675.612975481043, 3531.134871956387, 3603.6396360363756, 3701.5373078365205, 3853.7880416576795, 3896.376579747227, 990.7572644702094, 1032.9225308101923, 1067.0206766448282, 1070.8755806403246, 1117.8323251512174, 18659.440216793246, 18718.625627487374, 18783.436496905113, 18989.050547472572, 19516.902415488115, 1061.840723891407, 1076.214363514623, 1077.0844781935448, 1077.9137668986618, 1138.8918052784973, 10666.679999600025, 10895.67312980596, 10945.0, 10953.671389858317, 11010.229283950206, 497746.0, 498729.0, 500959.0, 505027.0, 507194.0, 53372.73313633407, 73672.89490657645, 73959.0, 83520.74718879221, 85218.14781852227, 1118.6588090632272, 1155.0759392485977, 1166.8249762535688, 1171.912106592009, 1172.0974849366112, 16389.180540972666, 17060.0, 17218.913905430392, 17683.823161768218, 17833.554161146076, 36450.27099458049, 36599.08502287357, 36982.8150859244, 39896.401553977295, 40191.598084018784, 49925.0, 51019.744901275255, 52088.21867672064, 52169.217461737346, 53198.4680153209, 8796.516191609522, 8882.200601945857, 8921.0, 9000.459972401415, 9134.451932884049, 9839.0, 12755.48978040868, 13101.148425352321, 13277.269750163834, 13559.0, 10835.458227088457, 10956.12351011933, 10959.945200273947, 11318.207725459139, 11480.655580332603, 10967.287126336763, 11166.44167791591, 11324.6036388726, 11410.600628977945, 11818.409079545816, 11270.718232044264, 11565.595204167814, 11644.825327619923, 11700.35648039366, 11868.940655296668, 8882.422642528474, 8947.463152210888, 8971.730848074569, 9039.548022598976, 9082.500462474363, 8412.621432035696, 10663.360198388122, 11481.885181148416, 11838.526458941546, 11875.287482751062], "value": 10298.299511835157, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.2467490929444, 1567.921603919804, 1765.2762367429357, 1891.271860333771, 1892.0, 7277.818054548639, 7858.1356050834365, 7995.999999999993, 8029.959850200748, 8058.0, 7754.10827754807, 7776.883346749803, 7837.255460731236, 7858.96070519648, 7860.68557257709, 2282.6804247405375, 2309.08791027544, 2313.9768602314016, 2321.0483701682315, 2323.9883800581056, 2312.6184179610345, 2319.46652269978, 2373.2405630198346, 2377.2868139558063, 2378.2151889876386, 2344.566255242777, 2347.096367898363, 2365.5387199496104, 2373.667686523888, 2390.3785015895905, 2358.41039740065, 2360.221127028077, 2383.344580240439, 2391.0316321889577, 2392.629142482918, 2328.8253380996325, 2329.9301020969397, 2342.0631747301045, 2342.976570234293, 2353.5645905507536, 7731.072271327421, 7750.031246094239, 7789.221077892222, 7799.6100194990595, 7823.569703666296, 5002.449730529639, 5082.034413461431, 5121.155009423441, 5124.103281925648, 5144.588432925394, 3221.9850747014616, 3295.40682677118, 3361.2773253750315, 3394.8302584870657, 3402.3705614461405, 1134.3137401871832, 1134.7067517035453, 1134.8467956825805, 1145.1411441418936, 1151.3782557418983, 11637.534498620045, 11660.06719462441, 11694.473748681245, 11698.941505292503, 11753.118516111326, 4263.339182426729, 4275.935860962088, 4359.80380882861, 4360.127974405132, 4433.534478879736, 9405.106514881076, 9414.105659962293, 9426.340156189139, 9429.198518126037, 9441.669541566012, 4964.925526117111, 4988.176950803077, 4992.8002879885125, 5002.924956125661, 5017.623678224075, 4484.461864576272, 4591.885202869955, 4593.977030114895, 4597.540245975442, 4631.9536804631525, 3740.541188936317, 3829.5213098362706, 3839.3281175794123, 3866.8646597368956, 3904.375299951994, 1103.5585765693786, 1184.7571247894161, 1192.7614477104614, 1193.9462724177433, 1203.9699007524707, 1045.0490054050777, 1056.5773690523852, 1058.4548957287004, 1061.5382308695741, 1084.360227465799, 5880.26496687914, 5983.0, 6031.788887388921, 6099.350762418881, 6106.084087386927, 467.64692657043713, 467.78715684363533, 470.2264774446017, 476.26892719675135, 480.3491269330077, 4235.851745188904, 4268.0183557781265, 4286.978565107154, 4291.206126866539, 4311.245532031882, 10092.444915529717, 10379.688609341732, 10491.895081049244, 10505.789884202426, 10509.159267258601, 10355.0, 10360.481975901175, 10374.948125259325, 10378.532966016548, 10380.06579407857, 7727.150013498511, 7940.0868900076075, 8023.638936247883, 8025.9598702006115, 8047.597620118971, 5659.236003139524, 5800.622959507618, 5941.910871336847, 5942.31663358702, 5978.983572792548, 8855.60149793248, 9130.680426185052, 9150.40522366044, 9183.908160918305, 9228.95385523068, 8935.0, 9113.407628504126, 9115.589798458952, 9154.725358239264, 9264.861027084464, 7106.395956343768, 7326.487145899736, 7331.303526165006, 7333.889991650023, 7434.553926764412, 8144.30773384269, 8150.83698326042, 8164.714235001747, 8170.142135075732, 8221.506709597443, 7107.395871350786, 7351.154617219088, 7376.557406555624, 7456.179820219663, 7504.249575042452, 7033.577985320897, 7199.496035277481, 7239.058922340062, 7257.745978890714, 7395.112586489656, 6624.933750662624, 6692.0, 6695.933040669531, 6721.630310332978, 6733.528652994243, 5078.136716758234, 5095.923561146512, 5159.974200128975, 5239.659422137549, 5250.65870718402, 5170.689758614495, 5244.685318880879, 5272.44639312882, 5272.736363181903, 5417.268668729671], "value": 4423.23373888172, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.8900996186201, 358.30131244074045, 359.06821797435646, 362.1110174521549, 365.57410616631626, 6352.237731472218, 6429.132067170931, 6515.381038801313, 6606.0, 6613.801585952417, 6531.118299029641, 6533.640649764261, 6567.671616419184, 6570.474362051036, 6591.209054913417, 4949.950500495003, 4953.10844048073, 4956.900861982758, 4962.826301079463, 4966.925496117561, 4985.45160032398, 4986.4265609455015, 4986.700797952134, 4988.625853061017, 4992.350994370727, 4904.5831104356175, 4947.851564453054, 4953.851384458472, 4958.206686930092, 4960.131976904046, 4734.83428080019, 4866.221404575286, 4932.96407754372, 4941.555260026596, 4954.058728841526, 4240.279152544075, 4244.511881133678, 4259.936100958457, 4265.936010959838, 4266.210751011073, 6247.562670613013, 6253.437190652818, 6257.499400047986, 6260.718267677966, 6268.247810262797, 5644.435556444364, 5650.378458369576, 5651.7456714447535, 5701.657900525982, 5704.686242256675, 6787.490938179656, 6794.3545363190415, 6797.150356205474, 6816.9318306816795, 6829.248782633907, 4555.886102847422, 4702.506236845116, 4704.106219818258, 4715.7877895494785, 4731.929021064652, 7102.609356485391, 7122.715091396338, 7135.536190147675, 7148.428125749928, 7164.355208031302, 4796.8081276748535, 4804.039192161582, 4804.327394164819, 4809.254565542346, 4820.831270905572, 4870.391201099863, 4878.121938051185, 4878.390201224847, 4886.071646387175, 4907.460179380265, 5652.0, 5674.546036317085, 5680.204771332017, 5683.431656834284, 5694.829155125353, 6715.731370745116, 6818.659067046628, 6857.451403887777, 6922.688479018456, 6930.13373328334, 1681.8065922418834, 1683.7474378843026, 1685.5112017514784, 1686.9372295453786, 1691.7631531585587, 1093.7429704019548, 1106.2643342177523, 1108.3793075877534, 1132.7281452451516, 1135.3641960502146, 6682.131322928086, 6695.196576410862, 6757.358050985148, 6764.526483146231, 6767.830804229934, 7054.294570542905, 7055.0, 7063.89404158938, 7067.787966360915, 7081.185663648746, 6750.459963202932, 6750.662466876636, 6752.898706519406, 6754.223264324567, 6758.817206988757, 3812.0279328770985, 3828.789416582115, 3829.157585331223, 3842.9231415372096, 3843.7309388343106, 7389.0, 7608.733694320672, 7635.198304178092, 7636.961815191, 7641.885371719429, 7288.70845166198, 7290.0, 7291.234420385889, 7310.96344518274, 7341.889871651822, 7612.505187162817, 7614.2766437188375, 7623.199564045806, 7623.809404764815, 7630.923690763021, 6962.338577835098, 7170.103737032871, 7198.172210195685, 7202.135743710788, 7214.96392518034, 7088.326608972139, 7114.253003434772, 7120.145582529923, 7126.35862772353, 7144.4641651877355, 7557.924420755722, 7598.620068996639, 7603.885941710768, 7612.885806713015, 7643.0, 4774.188387974123, 4814.5907597854575, 4818.98801251741, 4824.831130910401, 4829.9034019318715, 7066.152061752623, 7207.279272072751, 7213.0, 7213.278672132745, 7224.760324299484, 6961.8955715665315, 6962.651867406711, 6971.128608923885, 6978.267281935527, 6990.965045174741, 6926.376626103674, 6948.791536253921, 6952.5480843745, 6961.965190174017, 6970.442364610921, 6824.658767061726, 6827.385535301847, 6832.350926661959, 6833.58998460094, 6841.213260475109, 6793.218779840382, 7012.368886800213, 7031.613261270679, 7037.401820845285, 7046.260142684944, 6701.832454188684, 6791.558548694319, 6821.3519715626935, 6835.043093966749, 6895.4138898194215], "value": 5198.61112991762, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [880.423322723616, 881.4490943160524, 925.893522244942, 929.4887811703566, 932.6036434515329, 14962.925185374072, 15158.696826063471, 15254.923725381384, 15258.313375898097, 15278.618034549141, 12615.306158161298, 12842.871571284284, 12953.740925181492, 12977.15648482848, 13048.28234447105, 729.821193807518, 866.315610667575, 903.8599017152352, 905.0813424374265, 906.7189171356868, 886.8359353519587, 890.6481939633841, 895.9507227102507, 899.7570655922897, 901.733988473402, 959.5681943125586, 964.3924327673556, 966.9468179250139, 967.337373898878, 970.0299700299701, 934.1592566689966, 950.6292545907137, 951.2437612098364, 955.0163331768255, 956.4357029352645, 685.372883811312, 687.6733551563018, 688.9965550172267, 697.0137255783061, 699.832040310327, 14749.483768068174, 14779.261036948217, 14841.70316593662, 14895.851041489555, 14968.47610333644, 13888.791668124986, 14057.437702491889, 14123.71752564943, 14147.858521414757, 14152.36314365856, 9934.80130397388, 10034.749131271703, 10039.096481316716, 10050.899491005142, 10057.647982320657, 4046.4129756706175, 4075.5924407559305, 4097.1191193893455, 4140.503139623234, 4148.668106551469, 53594.19608705873, 53873.0, 54325.0, 54572.45427545714, 54977.0, 10366.740831479274, 10722.142228621691, 10887.23789334739, 10912.61805836792, 11107.444627768578, 20567.0, 20991.370258892257, 21095.0, 21190.576188476145, 21209.15163393478, 8351.58242087893, 8398.832023359499, 8406.915930840736, 8535.0, 8553.144685531397, 4770.880727981828, 4938.530839570235, 4996.525330093708, 5034.093863104603, 5065.316182315414, 3544.80503572306, 3587.6053634100226, 3602.369585322558, 3604.7837129772297, 3606.404943184398, 696.885013972699, 701.0780823217555, 710.6340234779093, 712.262807993724, 724.6521669598623, 643.8551325951717, 661.1306132435927, 812.0, 842.5113434208145, 861.4443683824023, 10115.848262276071, 10136.239782016379, 10207.0, 10219.591216351262, 10292.330998485075, 684.910961574992, 830.9459885107449, 839.4501601451059, 843.2747836860295, 884.2395539835736, 4487.910241795146, 4714.622830173578, 4727.550882666142, 4866.172750632401, 4903.338049363361, 54317.0, 54812.0, 54972.0, 55036.174457383175, 55261.72369138209, 50042.74978625084, 50603.49396506062, 51076.0, 53004.46995529995, 53712.0, 46967.76516117466, 47103.5289647106, 47428.52571474241, 48499.272510912364, 48651.756741216064, 9090.272778177863, 9173.220276276592, 9379.718608441757, 9441.386309889835, 9577.185939195246, 34071.65928340685, 35161.47257791084, 35402.822985885934, 35921.46117808183, 35998.820005899805, 41986.37020444635, 42465.0, 43086.35370469383, 45709.0, 46199.53800462087, 11021.228514003942, 11151.665450036511, 11527.596534121265, 12819.230846149261, 12978.610641680387, 13776.862231377558, 14273.714525709634, 14575.854241457873, 14902.32939517746, 14916.477923272634, 13374.732505350034, 13421.0, 13690.65773355674, 13834.861651383357, 14216.431342746588, 12050.819237711617, 12400.441980110736, 13277.0, 13561.864381356454, 13773.517926872511, 12971.935140324238, 13162.539311124065, 13318.0, 13570.321483925962, 13868.861311386758, 10214.438205898747, 10297.330673506198, 10459.372437653765, 10557.683269501927, 10680.359178449318, 10884.510197040994, 11347.829782553434, 11602.6519204424, 11678.474468649101, 11693.473793679135], "value": 7015.95199342753, "unit": "score"}], "name": "dromaeo_css", "value": 7535.05313955133, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 104.0, 110.0, 112.0, 112.0, 102.0, 112.0, 113.0, 112.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 160.0, 170.0, 129.0, 156.0, 156.0, 129.0, 179.0, 128.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 163.0, 162.0, 162.0, 167.0, 166.0, 161.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 174.0, 73.0, 79.0, 77.0, 76.0, 163.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 163.0, 91.0, 91.0, 92.0, 151.0, 94.0, 92.0, 148.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 145.0, 149.0, 149.0, 146.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 99.0, 98.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 57.0, 57.0, 60.0, 58.0, 57.0, 83.0, 62.0, 59.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0, 59.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 74.0, 75.0, 75.0, 82.0, 74.0, 75.0, 76.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 125.0, 124.0, 116.0, 115.0, 125.0, 117.0, 112.0, 127.0, 130.0], "value": 120.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 160.0, 165.0, 168.0, 162.0, 162.0, 163.0, 162.0, 160.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 67.0, 66.0, 67.0, 66.0, 65.0, 67.0, 66.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1531.7, "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:54 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 24576; Write bytes: 462716928; Read time: 12; Write time: 406080 04:21:54 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242413568; Read time: 0; Write time: 265900 04:21:54 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 220299264; Read time: 0; Write time: 140180 04:21:54 INFO - Running post-run listener: _upload_blobber_files 04:21:54 INFO - Blob upload gear active. 04:21:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:54 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:54 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:54 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:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:21:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:55 INFO - (blobuploader) - INFO - Done attempting. 04:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.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_raw.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 - Iteration through files over. 04:21:56 INFO - Return code: 0 04:21:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:56 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/64fb74718a3640c4df08d93af9f3d0997d302d0c1d53bea2700ef3d95084cc35c9317e3c181076d2e26abfb36f25e8d630629054610fd096aad9476cecf9f12e"} 04:21:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:56 INFO - Contents: 04:21:56 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/64fb74718a3640c4df08d93af9f3d0997d302d0c1d53bea2700ef3d95084cc35c9317e3c181076d2e26abfb36f25e8d630629054610fd096aad9476cecf9f12e"} 04:21:56 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:56 INFO - Copying logs to upload dir... 04:21:56 INFO - mkdir: /builds/slave/test/build/upload/logs 04:21:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.514213 ========= master_lag: 0.73 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-07-27 04:21:56.711558) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:56.714733) ========= 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=836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588 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/64fb74718a3640c4df08d93af9f3d0997d302d0c1d53bea2700ef3d95084cc35c9317e3c181076d2e26abfb36f25e8d630629054610fd096aad9476cecf9f12e"} 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.011216 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/64fb74718a3640c4df08d93af9f3d0997d302d0c1d53bea2700ef3d95084cc35c9317e3c181076d2e26abfb36f25e8d630629054610fd096aad9476cecf9f12e"}' ========= master_lag: 0.80 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:57.529577) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-07-27 04:21:57.529914) ========= 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=836cfdc75598d54cb747368e000001a9-1469617291.338146-44398588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 4.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-07-27 04:22:01.628128) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-07-27 04:22:01.628489) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-07-27 04:22:04.821625) ========= ========= Total master_lag: 5.68 =========