builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1467985661.82 results: success (0) buildid: 20160708040727 builduid: 75f4324d657349a998af2caa2550aa8a revision: 24e82cb41040b1f515135ae3ba8b6bddf234d509 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:41.823201) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:41.823675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:41.823954) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:41.838471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:41.838790) ========= 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=523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 06:47:42-- 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% 219M=0s 2016-07-08 06:47:42 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140611 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:41.993416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:41.993734) ========= 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=523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018334 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:42.043951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:42.044335) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 24e82cb41040b1f515135ae3ba8b6bddf234d509 --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 24e82cb41040b1f515135ae3ba8b6bddf234d509 --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=523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 06:47:42,377 truncating revision to first 12 chars 2016-07-08 06:47:42,377 Setting DEBUG logging. 2016-07-08 06:47:42,378 attempt 1/10 2016-07-08 06:47:42,378 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/24e82cb41040?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 06:47:42,674 unpacking tar archive at: mozilla-beta-24e82cb41040/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615498 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:42.673367) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:42.673746) ========= script_repo_revision: 24e82cb41040b1f515135ae3ba8b6bddf234d509 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:42.674188) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:42.674513) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 06:47:42.683718) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-07-08 06:47:42.684057) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:47:43 INFO - MultiFileLogger online at 20160708 06:47:43 in /builds/slave/test 06:47:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:47:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:47:43 INFO - {'append_to_log': False, 06:47:43 INFO - 'base_work_dir': '/builds/slave/test', 06:47:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:47:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:47:43 INFO - 'branch': 'Mozilla-Beta', 06:47:43 INFO - 'buildbot_json_path': 'buildprops.json', 06:47:43 INFO - 'config_files': ('talos/linux_config.py',), 06:47:43 INFO - 'default_actions': ('clobber', 06:47:43 INFO - 'read-buildbot-config', 06:47:43 INFO - 'download-and-extract', 06:47:43 INFO - 'populate-webroot', 06:47:43 INFO - 'create-virtualenv', 06:47:43 INFO - 'install', 06:47:43 INFO - 'run-tests'), 06:47:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:47:43 INFO - 'download_minidump_stackwalk': True, 06:47:43 INFO - 'download_symbols': 'ondemand', 06:47:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:47:43 INFO - 'tooltool.py': '/tools/tooltool.py', 06:47:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:47:43 INFO - '/tools/misc-python/virtualenv.py')}, 06:47:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:47:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:47:43 INFO - 'installer_path': 'installer.exe', 06:47:43 INFO - 'log_level': 'info', 06:47:43 INFO - 'log_name': 'talos', 06:47:43 INFO - 'log_to_console': True, 06:47:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:47:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:47:43 INFO - 'opt_config_files': (), 06:47:43 INFO - 'pip_index': False, 06:47:43 INFO - 'sps_profile': False, 06:47:43 INFO - 'sps_profile_interval': 0, 06:47:43 INFO - 'suite': 'dromaeojs', 06:47:43 INFO - 'system_bits': '32', 06:47:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:47:43 INFO - 'title': 'talos-linux64-ix-065', 06:47:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:47:43 INFO - 'use_talos_json': True, 06:47:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:47:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:47:43 INFO - 'work_dir': 'build'} 06:47:43 INFO - ##### 06:47:43 INFO - ##### Running clobber step. 06:47:43 INFO - ##### 06:47:43 INFO - Running pre-action listener: _resource_record_pre_action 06:47:43 INFO - Running main action method: clobber 06:47:43 INFO - rmtree: /builds/slave/test/build 06:47:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:47:43 INFO - Running post-action listener: _resource_record_post_action 06:47:43 INFO - ##### 06:47:43 INFO - ##### Running read-buildbot-config step. 06:47:43 INFO - ##### 06:47:43 INFO - Running pre-action listener: _resource_record_pre_action 06:47:43 INFO - Running main action method: read_buildbot_config 06:47:43 INFO - Using buildbot properties: 06:47:43 INFO - { 06:47:43 INFO - "project": "", 06:47:43 INFO - "product": "firefox", 06:47:43 INFO - "script_repo_revision": "production", 06:47:43 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:47:43 INFO - "repository": "", 06:47:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:47:43 INFO - "buildid": "20160708040727", 06:47:43 INFO - "pgo_build": "True", 06:47:43 INFO - "basedir": "/builds/slave/test", 06:47:43 INFO - "buildnumber": 161, 06:47:43 INFO - "slavename": "talos-linux64-ix-065", 06:47:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:47:43 INFO - "platform": "ubuntu64_hw", 06:47:43 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:47:43 INFO - "branch": "mozilla-beta", 06:47:43 INFO - "repo_path": "releases/mozilla-beta", 06:47:43 INFO - "revision": "24e82cb41040b1f515135ae3ba8b6bddf234d509", 06:47:43 INFO - "stage_platform": "linux64-pgo", 06:47:43 INFO - "builduid": "75f4324d657349a998af2caa2550aa8a", 06:47:43 INFO - "slavebuilddir": "test" 06:47:43 INFO - } 06:47:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 06:47:43 INFO - Running post-action listener: _resource_record_post_action 06:47:43 INFO - ##### 06:47:43 INFO - ##### Running download-and-extract step. 06:47:43 INFO - ##### 06:47:43 INFO - Running pre-action listener: _resource_record_pre_action 06:47:43 INFO - Running main action method: download_and_extract 06:47:43 INFO - mkdir: /builds/slave/test/build/tests 06:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:43 INFO - https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:47:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:47:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:47:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/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 06:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/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 06:47:45 INFO - Downloaded 1327 bytes. 06:47:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:47:45 INFO - Using the following test package requirements: 06:47:45 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:47:45 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:47:45 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 06:47:45 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'jsshell-linux-x86_64.zip'], 06:47:45 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:47:45 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:47:45 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 06:47:45 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 06:47:45 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:47:45 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:47:45 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:45 INFO - https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/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 06:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/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 06:47:46 INFO - Downloaded 24237140 bytes. 06:47:46 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'] 06:47:46 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 06:47:47 INFO - Return code: 0 06:47:47 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 06:47: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')]} 06:47:47 INFO - https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:47:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:47:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:47:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/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 06:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/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 06:47:48 INFO - Downloaded 24237140 bytes. 06:47:48 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'] 06:47:48 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 06:47:50 INFO - Return code: 0 06:47: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')]} 06:47:50 INFO - https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:47:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:47:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:47:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/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 06:47:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/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 06:47:51 INFO - Downloaded 10840145 bytes. 06:47:51 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'] 06:47:51 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 06:47:51 INFO - Return code: 0 06:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:51 INFO - https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:47:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:47:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:47:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/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 06:47:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GG9ETDHxRcS67K7yd2rshg/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 06:47:52 INFO - Downloaded 56023701 bytes. 06:47:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:47:52 INFO - mkdir: /builds/slave/test/properties 06:47:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:47:52 INFO - Writing to file /builds/slave/test/properties/build_url 06:47:52 INFO - Contents: 06:47:52 INFO - build_url:https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:47:53 INFO - Running post-action listener: _resource_record_post_action 06:47:53 INFO - Running post-action listener: set_extra_try_arguments 06:47:53 INFO - ##### 06:47:53 INFO - ##### Running populate-webroot step. 06:47:53 INFO - ##### 06:47:53 INFO - Running pre-action listener: _resource_record_pre_action 06:47:53 INFO - Running main action method: populate_webroot 06:47:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:47:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:47:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:47:53 INFO - '--tppagecycles', 06:47:53 INFO - '7'], 06:47:53 INFO - 'tests': ['tsvgm']}}, 06:47:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:47:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:47:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:47:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:47:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:47:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:47:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:53 INFO - 'talos_options': ['--disable-e10s'], 06:47:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:53 INFO - 'talos_options': ['--disable-e10s'], 06:47:53 INFO - 'tests': ['damp', 'tps']}, 06:47:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:53 INFO - 'tests': ['damp', 'tps']}, 06:47:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:47:53 INFO - 'tests': ['dromaeo_dom']}, 06:47:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:47:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:47:53 INFO - 'tests': ['a11yr', 06:47:53 INFO - 'ts_paint', 06:47:53 INFO - 'tpaint', 06:47:53 INFO - 'sessionrestore', 06:47:53 INFO - 'sessionrestore_no_auto_restore', 06:47:53 INFO - 'tabpaint']}, 06:47:53 INFO - 'other-e10s': {'tests': ['a11yr', 06:47:53 INFO - 'ts_paint', 06:47:53 INFO - 'tpaint', 06:47:53 INFO - 'sessionrestore', 06:47:53 INFO - 'sessionrestore_no_auto_restore', 06:47:53 INFO - 'tabpaint']}, 06:47:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:47:53 INFO - 'ts_paint', 06:47:53 INFO - 'tpaint', 06:47:53 INFO - 'sessionrestore', 06:47:53 INFO - 'sessionrestore_no_auto_restore', 06:47:53 INFO - 'tabpaint']}, 06:47:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:47:53 INFO - 'ts_paint', 06:47:53 INFO - 'tpaint', 06:47:53 INFO - 'sessionrestore', 06:47:53 INFO - 'sessionrestore_no_auto_restore', 06:47:53 INFO - 'tabpaint']}, 06:47:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:47:53 INFO - 'tests': ['a11yr', 06:47:53 INFO - 'ts_paint', 06:47:53 INFO - 'tpaint', 06:47:53 INFO - 'sessionrestore', 06:47:53 INFO - 'sessionrestore_no_auto_restore', 06:47:53 INFO - 'tabpaint']}, 06:47:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:47:53 INFO - 'tests': ['a11yr', 06:47:53 INFO - 'ts_paint', 06:47:53 INFO - 'tpaint', 06:47:53 INFO - 'sessionrestore', 06:47:53 INFO - 'sessionrestore_no_auto_restore', 06:47:53 INFO - 'tabpaint']}, 06:47:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:47:53 INFO - 'tests': ['tsvgx', 06:47:53 INFO - 'tsvgr_opacity', 06:47:53 INFO - 'tart', 06:47:53 INFO - 'tscrollx', 06:47:53 INFO - 'cart']}, 06:47:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:47:53 INFO - 'tsvgr_opacity', 06:47:53 INFO - 'tart', 06:47:53 INFO - 'tscrollx', 06:47:53 INFO - 'cart']}, 06:47:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:53 INFO - 'talos_options': ['--disable-e10s'], 06:47:53 INFO - 'tests': ['tp5o']}, 06:47:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:53 INFO - 'tests': ['tp5o']}, 06:47:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:53 INFO - 'talos_options': ['--disable-e10s', 06:47:53 INFO - '--xperf_path', 06:47:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:53 INFO - 'tests': ['tp5n']}, 06:47:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:53 INFO - 'talos_options': ['--xperf_path', 06:47:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:53 INFO - 'tests': ['tp5n']}}, 06:47:53 INFO - 'talos.zip': {'path': '', 06:47:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:47:53 INFO - Running post-action listener: _resource_record_post_action 06:47:53 INFO - ##### 06:47:53 INFO - ##### Running create-virtualenv step. 06:47:53 INFO - ##### 06:47:53 INFO - Running pre-action listener: _resource_record_pre_action 06:47:53 INFO - Running main action method: create_virtualenv 06:47:53 INFO - Creating virtualenv /builds/slave/test/build/venv 06:47:53 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 06:47:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:47:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:47:53 INFO - Using real prefix '/usr' 06:47:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:47:54 INFO - Installing distribute.............................................................................................................................................................................................done. 06:47:56 INFO - Installing pip.................done. 06:47:56 INFO - Return code: 0 06:47:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:47:56 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')]} 06:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:56 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')]} 06:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:56 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 0x7f103afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de410>, '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 0x29df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', '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 06:47:56 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 06:47:56 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 06:47:56 INFO - Using env: {'DISPLAY': ':0', 06:47:56 INFO - 'HOME': '/home/cltbld', 06:47:56 INFO - 'LANG': 'en_US.UTF-8', 06:47:56 INFO - 'LANGUAGE': 'en_US:en', 06:47:56 INFO - 'LOGNAME': 'cltbld', 06:47:56 INFO - 'MAIL': '/var/mail/cltbld', 06:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:56 INFO - 'MOZ_NO_REMOTE': '1', 06:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:56 INFO - 'NO_EM_RESTART': '1', 06:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:56 INFO - 'PWD': '/builds/slave/test', 06:47:56 INFO - 'SHELL': '/bin/bash', 06:47:56 INFO - 'SHLVL': '1', 06:47:56 INFO - 'TERM': 'linux', 06:47:56 INFO - 'TMOUT': '86400', 06:47:56 INFO - 'USER': 'cltbld', 06:47:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', 06:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:56 INFO - '_': '/tools/buildbot/bin/python'} 06:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:56 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 06:47:56 INFO - Cleaning up... 06:47:56 INFO - Return code: 0 06:47:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:47:56 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')]} 06:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:56 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')]} 06:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:56 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 0x7f103afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de410>, '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 0x29df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', '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 06:47:56 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 06:47:56 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 06:47:56 INFO - Using env: {'DISPLAY': ':0', 06:47:56 INFO - 'HOME': '/home/cltbld', 06:47:56 INFO - 'LANG': 'en_US.UTF-8', 06:47:56 INFO - 'LANGUAGE': 'en_US:en', 06:47:56 INFO - 'LOGNAME': 'cltbld', 06:47:56 INFO - 'MAIL': '/var/mail/cltbld', 06:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:56 INFO - 'MOZ_NO_REMOTE': '1', 06:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:56 INFO - 'NO_EM_RESTART': '1', 06:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:56 INFO - 'PWD': '/builds/slave/test', 06:47:56 INFO - 'SHELL': '/bin/bash', 06:47:56 INFO - 'SHLVL': '1', 06:47:56 INFO - 'TERM': 'linux', 06:47:56 INFO - 'TMOUT': '86400', 06:47:56 INFO - 'USER': 'cltbld', 06:47:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', 06:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:56 INFO - '_': '/tools/buildbot/bin/python'} 06:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:56 INFO - Downloading/unpacking psutil>=0.7.1 06:47:56 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 06:47:56 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 06:47:56 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 06:47:56 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 06:47:56 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 06:47:56 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 06:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:47:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:58 INFO - Installing collected packages: psutil 06:47:58 INFO - Running setup.py install for psutil 06:47:58 INFO - building 'psutil._psutil_linux' extension 06:47:58 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 06:47:58 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 06:47:58 INFO - building 'psutil._psutil_posix' extension 06:47:58 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 06:47:58 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 06:47:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:59 INFO - Successfully installed psutil 06:47:59 INFO - Cleaning up... 06:47:59 INFO - Return code: 0 06:47:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:47: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')]} 06:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47: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')]} 06:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:59 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 0x7f103afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de410>, '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 0x29df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', '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 06:47:59 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 06:47:59 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 06:47:59 INFO - Using env: {'DISPLAY': ':0', 06:47:59 INFO - 'HOME': '/home/cltbld', 06:47:59 INFO - 'LANG': 'en_US.UTF-8', 06:47:59 INFO - 'LANGUAGE': 'en_US:en', 06:47:59 INFO - 'LOGNAME': 'cltbld', 06:47:59 INFO - 'MAIL': '/var/mail/cltbld', 06:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:59 INFO - 'MOZ_NO_REMOTE': '1', 06:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:59 INFO - 'NO_EM_RESTART': '1', 06:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:59 INFO - 'PWD': '/builds/slave/test', 06:47:59 INFO - 'SHELL': '/bin/bash', 06:47:59 INFO - 'SHLVL': '1', 06:47:59 INFO - 'TERM': 'linux', 06:47:59 INFO - 'TMOUT': '86400', 06:47:59 INFO - 'USER': 'cltbld', 06:47:59 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', 06:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:59 INFO - '_': '/tools/buildbot/bin/python'} 06:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:48:01 INFO - Installing collected packages: mozsystemmonitor 06:48:01 INFO - Running setup.py install for mozsystemmonitor 06:48:01 INFO - Successfully installed mozsystemmonitor 06:48:01 INFO - Cleaning up... 06:48:01 INFO - Return code: 0 06:48:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f103afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de410>, '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 0x29df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', '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 06:48:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:48:01 INFO - Using env: {'DISPLAY': ':0', 06:48:01 INFO - 'HOME': '/home/cltbld', 06:48:01 INFO - 'LANG': 'en_US.UTF-8', 06:48:01 INFO - 'LANGUAGE': 'en_US:en', 06:48:01 INFO - 'LOGNAME': 'cltbld', 06:48:01 INFO - 'MAIL': '/var/mail/cltbld', 06:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:01 INFO - 'MOZ_NO_REMOTE': '1', 06:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:01 INFO - 'NO_EM_RESTART': '1', 06:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:01 INFO - 'PWD': '/builds/slave/test', 06:48:01 INFO - 'SHELL': '/bin/bash', 06:48:01 INFO - 'SHLVL': '1', 06:48:01 INFO - 'TERM': 'linux', 06:48:01 INFO - 'TMOUT': '86400', 06:48:01 INFO - 'USER': 'cltbld', 06:48:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', 06:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:01 INFO - '_': '/tools/buildbot/bin/python'} 06:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:01 INFO - Downloading/unpacking blobuploader==1.2.4 06:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:03 INFO - Downloading blobuploader-1.2.4.tar.gz 06:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:48:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:48: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 06:48: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 06:48: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 06:48: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 06:48: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 06:48: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 06:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:48:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:48: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 06:48: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 06:48: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 06:48: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 06:48: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 06:48: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 06:48:04 INFO - Downloading docopt-0.6.1.tar.gz 06:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:48:04 INFO - Installing collected packages: blobuploader, requests, docopt 06:48:04 INFO - Running setup.py install for blobuploader 06:48:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:48:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:48:04 INFO - Running setup.py install for requests 06:48:04 INFO - Running setup.py install for docopt 06:48:04 INFO - Successfully installed blobuploader requests docopt 06:48:04 INFO - Cleaning up... 06:48:04 INFO - Return code: 0 06:48:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:04 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 0x7f103afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de410>, '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 0x29df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', '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 06:48:04 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 06:48:04 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 06:48:04 INFO - Using env: {'DISPLAY': ':0', 06:48:04 INFO - 'HOME': '/home/cltbld', 06:48:04 INFO - 'LANG': 'en_US.UTF-8', 06:48:04 INFO - 'LANGUAGE': 'en_US:en', 06:48:04 INFO - 'LOGNAME': 'cltbld', 06:48:04 INFO - 'MAIL': '/var/mail/cltbld', 06:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:04 INFO - 'MOZ_NO_REMOTE': '1', 06:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:04 INFO - 'NO_EM_RESTART': '1', 06:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:04 INFO - 'PWD': '/builds/slave/test', 06:48:04 INFO - 'SHELL': '/bin/bash', 06:48:04 INFO - 'SHLVL': '1', 06:48:04 INFO - 'TERM': 'linux', 06:48:04 INFO - 'TMOUT': '86400', 06:48:04 INFO - 'USER': 'cltbld', 06:48:04 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', 06:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:04 INFO - '_': '/tools/buildbot/bin/python'} 06:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:05 INFO - Running setup.py (path:/tmp/pip-WqNddV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:05 INFO - Running setup.py (path:/tmp/pip-9Hya3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:05 INFO - Running setup.py (path:/tmp/pip-v0Ja9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:05 INFO - Running setup.py (path:/tmp/pip-UuLRLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:05 INFO - Running setup.py (path:/tmp/pip-883nn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:05 INFO - Running setup.py (path:/tmp/pip-YPDZwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:05 INFO - Running setup.py (path:/tmp/pip-CAXx1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:05 INFO - Running setup.py (path:/tmp/pip-SZzvC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:05 INFO - Running setup.py (path:/tmp/pip-L_yVnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:05 INFO - Running setup.py (path:/tmp/pip-5_YsUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:05 INFO - Running setup.py (path:/tmp/pip-geuOXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:05 INFO - Running setup.py (path:/tmp/pip-G7U7sC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:05 INFO - Running setup.py (path:/tmp/pip-kPXWPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:05 INFO - Running setup.py (path:/tmp/pip-tiOwvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:06 INFO - Running setup.py (path:/tmp/pip-YAzJQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:06 INFO - Running setup.py (path:/tmp/pip-IGESe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:06 INFO - Running setup.py (path:/tmp/pip-kKnbP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:48:06 INFO - Running setup.py install for manifestparser 06:48:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:48:06 INFO - Running setup.py install for mozcrash 06:48:06 INFO - Running setup.py install for mozdebug 06:48:06 INFO - Running setup.py install for mozdevice 06:48:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:48:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:48:06 INFO - Running setup.py install for mozfile 06:48:06 INFO - Running setup.py install for mozhttpd 06:48:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:48:06 INFO - Running setup.py install for mozinfo 06:48:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:48:06 INFO - Running setup.py install for mozInstall 06:48:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Running setup.py install for mozleak 06:48:07 INFO - Running setup.py install for mozlog 06:48:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Running setup.py install for moznetwork 06:48:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Running setup.py install for mozprocess 06:48:07 INFO - Running setup.py install for mozprofile 06:48:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Running setup.py install for mozrunner 06:48:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Running setup.py install for mozscreenshot 06:48:07 INFO - Running setup.py install for moztest 06:48:07 INFO - Running setup.py install for mozversion 06:48:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:48:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:48:08 INFO - Cleaning up... 06:48:08 INFO - Return code: 0 06:48:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:08 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 0x7f103afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de410>, '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 0x29df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', '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 06:48:08 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 06:48:08 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 06:48:08 INFO - Using env: {'DISPLAY': ':0', 06:48:08 INFO - 'HOME': '/home/cltbld', 06:48:08 INFO - 'LANG': 'en_US.UTF-8', 06:48:08 INFO - 'LANGUAGE': 'en_US:en', 06:48:08 INFO - 'LOGNAME': 'cltbld', 06:48:08 INFO - 'MAIL': '/var/mail/cltbld', 06:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:08 INFO - 'MOZ_NO_REMOTE': '1', 06:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:08 INFO - 'NO_EM_RESTART': '1', 06:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:08 INFO - 'PWD': '/builds/slave/test', 06:48:08 INFO - 'SHELL': '/bin/bash', 06:48:08 INFO - 'SHLVL': '1', 06:48:08 INFO - 'TERM': 'linux', 06:48:08 INFO - 'TMOUT': '86400', 06:48:08 INFO - 'USER': 'cltbld', 06:48:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', 06:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:08 INFO - '_': '/tools/buildbot/bin/python'} 06:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:08 INFO - Running setup.py (path:/tmp/pip-beFg7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:08 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)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:08 INFO - Running setup.py (path:/tmp/pip-UNnkMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:08 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)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:08 INFO - Running setup.py (path:/tmp/pip-pJ3nCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:08 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)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:08 INFO - Running setup.py (path:/tmp/pip-ywumcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:08 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)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:08 INFO - Running setup.py (path:/tmp/pip-FFwbNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:08 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)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:08 INFO - Running setup.py (path:/tmp/pip-vg7Kt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:08 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)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:08 INFO - Running setup.py (path:/tmp/pip-sD1nRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:08 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)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:08 INFO - Running setup.py (path:/tmp/pip-CX3BGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:08 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)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:08 INFO - Running setup.py (path:/tmp/pip-Jf423X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:08 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)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:08 INFO - Running setup.py (path:/tmp/pip-6Mxdfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:08 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)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:08 INFO - Running setup.py (path:/tmp/pip-5Dso_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:09 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)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:09 INFO - Running setup.py (path:/tmp/pip-OLfKEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:09 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)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:09 INFO - Running setup.py (path:/tmp/pip-FNgQFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:09 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)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:09 INFO - Running setup.py (path:/tmp/pip-MJ2kmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:09 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)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:09 INFO - Running setup.py (path:/tmp/pip-OWizhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:09 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)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:09 INFO - Running setup.py (path:/tmp/pip-xAr2iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:09 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)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:09 INFO - Running setup.py (path:/tmp/pip-hiIcsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:09 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)) 06:48:09 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)) 06:48:09 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)) 06:48:09 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)) 06:48:09 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)) 06:48:09 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)) 06:48:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:48:09 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 06:48:09 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 06:48:09 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 06:48:09 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 06:48:09 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 06:48:09 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 06:48:11 INFO - Downloading blessings-1.6.tar.gz 06:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:48:11 INFO - Installing collected packages: blessings 06:48:11 INFO - Running setup.py install for blessings 06:48:11 INFO - Successfully installed blessings 06:48:11 INFO - Cleaning up... 06:48:11 INFO - Return code: 0 06:48:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:48:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:11 INFO - Reading from file tmpfile_stdout 06:48:11 INFO - Current package versions: 06:48:11 INFO - argparse == 1.2.1 06:48:11 INFO - blessings == 1.6 06:48:11 INFO - blobuploader == 1.2.4 06:48:11 INFO - docopt == 0.6.1 06:48:11 INFO - manifestparser == 1.1 06:48:11 INFO - mozInstall == 1.12 06:48:11 INFO - mozcrash == 0.17 06:48:11 INFO - mozdebug == 0.1 06:48:11 INFO - mozdevice == 0.48 06:48:11 INFO - mozfile == 1.2 06:48:11 INFO - mozhttpd == 0.7 06:48:11 INFO - mozinfo == 0.9 06:48:11 INFO - mozleak == 0.1 06:48:11 INFO - mozlog == 3.1 06:48:11 INFO - moznetwork == 0.27 06:48:11 INFO - mozprocess == 0.22 06:48:11 INFO - mozprofile == 0.28 06:48:11 INFO - mozrunner == 6.11 06:48:11 INFO - mozscreenshot == 0.1 06:48:11 INFO - mozsystemmonitor == 0.0 06:48:11 INFO - moztest == 0.7 06:48:11 INFO - mozversion == 1.4 06:48:11 INFO - psutil == 3.1.1 06:48:11 INFO - requests == 1.2.3 06:48:11 INFO - wsgiref == 0.1.2 06:48:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:11 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')]} 06:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:11 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')]} 06:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:11 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 0x7f103afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de410>, '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 0x29df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', '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 06:48:11 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 06:48:11 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 06:48:11 INFO - Using env: {'DISPLAY': ':0', 06:48:11 INFO - 'HOME': '/home/cltbld', 06:48:11 INFO - 'LANG': 'en_US.UTF-8', 06:48:11 INFO - 'LANGUAGE': 'en_US:en', 06:48:11 INFO - 'LOGNAME': 'cltbld', 06:48:11 INFO - 'MAIL': '/var/mail/cltbld', 06:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:12 INFO - 'MOZ_NO_REMOTE': '1', 06:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:12 INFO - 'NO_EM_RESTART': '1', 06:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:12 INFO - 'PWD': '/builds/slave/test', 06:48:12 INFO - 'SHELL': '/bin/bash', 06:48:12 INFO - 'SHLVL': '1', 06:48:12 INFO - 'TERM': 'linux', 06:48:12 INFO - 'TMOUT': '86400', 06:48:12 INFO - 'USER': 'cltbld', 06:48:12 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', 06:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:12 INFO - '_': '/tools/buildbot/bin/python'} 06:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:12 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)) 06:48:12 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)) 06:48:12 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)) 06:48:12 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)) 06:48:12 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)) 06:48:12 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)) 06:48:12 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)) 06:48:12 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)) 06:48:12 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)) 06:48:12 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)) 06:48:12 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)) 06:48:12 INFO - Cleaning up... 06:48:12 INFO - Return code: 0 06:48:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:12 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 0x7f103afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de410>, '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 0x29df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', '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 06:48:12 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 06:48:12 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 06:48:12 INFO - Using env: {'DISPLAY': ':0', 06:48:12 INFO - 'HOME': '/home/cltbld', 06:48:12 INFO - 'LANG': 'en_US.UTF-8', 06:48:12 INFO - 'LANGUAGE': 'en_US:en', 06:48:12 INFO - 'LOGNAME': 'cltbld', 06:48:12 INFO - 'MAIL': '/var/mail/cltbld', 06:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:12 INFO - 'MOZ_NO_REMOTE': '1', 06:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:12 INFO - 'NO_EM_RESTART': '1', 06:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:12 INFO - 'PWD': '/builds/slave/test', 06:48:12 INFO - 'SHELL': '/bin/bash', 06:48:12 INFO - 'SHLVL': '1', 06:48:12 INFO - 'TERM': 'linux', 06:48:12 INFO - 'TMOUT': '86400', 06:48:12 INFO - 'USER': 'cltbld', 06:48:12 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', 06:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:12 INFO - '_': '/tools/buildbot/bin/python'} 06:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:12 INFO - Downloading/unpacking jsonschema 06:48:12 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 06:48:12 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 06:48:12 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 06:48:12 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 06:48:12 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 06:48:12 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 06:48:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:48:14 INFO - Downloading/unpacking functools32 (from jsonschema) 06:48:14 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 06:48:14 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 06:48:14 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 06:48:14 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 06:48:14 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 06:48:14 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 06:48:14 INFO - Downloading functools32-3.2.3-2.tar.gz 06:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:48:14 INFO - warning: no files found matching '*.txt' 06:48:14 INFO - no previously-included directories found matching 'build' 06:48:14 INFO - no previously-included directories found matching 'dist' 06:48:14 INFO - no previously-included directories found matching '.git*' 06:48:14 INFO - Installing collected packages: jsonschema, functools32 06:48:14 INFO - Running setup.py install for functools32 06:48:14 INFO - warning: no files found matching '*.txt' 06:48:14 INFO - no previously-included directories found matching 'build' 06:48:14 INFO - no previously-included directories found matching 'dist' 06:48:14 INFO - no previously-included directories found matching '.git*' 06:48:14 INFO - Successfully installed jsonschema functools32 06:48:14 INFO - Cleaning up... 06:48:14 INFO - Return code: 0 06:48:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:14 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 0x7f103afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29de410>, '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 0x29df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', '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 06:48:14 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 06:48:14 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 06:48:14 INFO - Using env: {'DISPLAY': ':0', 06:48:14 INFO - 'HOME': '/home/cltbld', 06:48:14 INFO - 'LANG': 'en_US.UTF-8', 06:48:14 INFO - 'LANGUAGE': 'en_US:en', 06:48:14 INFO - 'LOGNAME': 'cltbld', 06:48:14 INFO - 'MAIL': '/var/mail/cltbld', 06:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:14 INFO - 'MOZ_NO_REMOTE': '1', 06:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:14 INFO - 'NO_EM_RESTART': '1', 06:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:14 INFO - 'PWD': '/builds/slave/test', 06:48:14 INFO - 'SHELL': '/bin/bash', 06:48:14 INFO - 'SHLVL': '1', 06:48:14 INFO - 'TERM': 'linux', 06:48:14 INFO - 'TMOUT': '86400', 06:48:14 INFO - 'USER': 'cltbld', 06:48:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', 06:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:14 INFO - '_': '/tools/buildbot/bin/python'} 06:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:15 INFO - Downloading/unpacking flake8 06:48:15 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 06:48:15 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 06:48:15 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 06:48:15 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 06:48:15 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 06:48:15 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 06:48:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:48:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:48:16 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 06:48:16 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 06:48:16 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 06:48:16 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 06:48:16 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 06:48:16 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 06:48:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:48:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:48:17 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 06:48:17 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 06:48:17 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 06:48:17 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 06:48:17 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 06:48:17 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 06:48:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:48:17 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 06:48:17 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 06:48:17 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 06:48:17 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 06:48:17 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 06:48:17 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 06:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:48:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:48:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:48:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:48:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:48:17 INFO - no previously-included directories found matching 'docs/_build' 06:48:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:48:17 INFO - Running setup.py install for pep8 06:48:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:48:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:48:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:48:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:48:17 INFO - no previously-included directories found matching 'docs/_build' 06:48:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:48:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:48:17 INFO - Cleaning up... 06:48:17 INFO - Return code: 0 06:48:17 INFO - Running post-action listener: _resource_record_post_action 06:48:17 INFO - Running post-action listener: _start_resource_monitoring 06:48:17 INFO - Starting resource monitoring. 06:48:17 INFO - ##### 06:48:17 INFO - ##### Running install step. 06:48:17 INFO - ##### 06:48:17 INFO - Running pre-action listener: _resource_record_pre_action 06:48:17 INFO - Running main action method: install 06:48:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:18 INFO - Reading from file tmpfile_stdout 06:48:18 INFO - Detecting whether we're running mozinstall >=1.0... 06:48:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:48:18 INFO - Reading from file tmpfile_stdout 06:48:18 INFO - Output received: 06:48:18 INFO - Usage: mozinstall [options] installer 06:48:18 INFO - Options: 06:48:18 INFO - -h, --help show this help message and exit 06:48:18 INFO - -d DEST, --destination=DEST 06:48:18 INFO - Directory to install application into. [default: 06:48:18 INFO - "/builds/slave/test"] 06:48:18 INFO - --app=APP Application being installed. [default: firefox] 06:48:18 INFO - mkdir: /builds/slave/test/build/application 06:48:18 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'] 06:48:18 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 06:48:31 INFO - Reading from file tmpfile_stdout 06:48:31 INFO - Output received: 06:48:31 INFO - /builds/slave/test/build/application/firefox/firefox 06:48:31 INFO - Running post-action listener: _resource_record_post_action 06:48:31 INFO - ##### 06:48:31 INFO - ##### Running run-tests step. 06:48:31 INFO - ##### 06:48:31 INFO - Running pre-action listener: _resource_record_pre_action 06:48:31 INFO - Running main action method: run_tests 06:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:48:31 INFO - Python 2.7.3 06:48:31 INFO - Return code: 0 06:48:31 INFO - grabbing minidump binary from tooltool 06:48:31 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')]} 06:48:31 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 0x29de410>, '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 0x29df310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:48:31 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 06:48:31 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 06:48:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:48:31 INFO - Return code: 0 06:48:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:48:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:48:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:48:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:48:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:48:32 INFO - Return code: 0 06:48:32 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:48:32 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:48:32 INFO - Using env: {'DISPLAY': ':0', 06:48:32 INFO - 'HOME': '/home/cltbld', 06:48:32 INFO - 'LANG': 'en_US.UTF-8', 06:48:32 INFO - 'LANGUAGE': 'en_US:en', 06:48:32 INFO - 'LOGNAME': 'cltbld', 06:48:32 INFO - 'MAIL': '/var/mail/cltbld', 06:48:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:48:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:32 INFO - 'MOZ_NO_REMOTE': '1', 06:48:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:32 INFO - 'NO_EM_RESTART': '1', 06:48:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:32 INFO - 'PWD': '/builds/slave/test', 06:48:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:48:32 INFO - 'SHELL': '/bin/bash', 06:48:32 INFO - 'SHLVL': '1', 06:48:32 INFO - 'TERM': 'linux', 06:48:32 INFO - 'TMOUT': '86400', 06:48:32 INFO - 'USER': 'cltbld', 06:48:32 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280', 06:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:32 INFO - '_': '/tools/buildbot/bin/python'} 06:48:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:48:32 INFO - mozversion application_buildid: 20160708040727 06:48:32 INFO - mozversion application_changeset: 24e82cb41040b1f515135ae3ba8b6bddf234d509 06:48:32 INFO - mozversion application_display_name: Firefox 06:48:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:48:32 INFO - mozversion application_name: Firefox 06:48:32 INFO - mozversion application_remotingname: firefox 06:48:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:48:32 INFO - mozversion application_vendor: Mozilla 06:48:32 INFO - mozversion application_version: 48.0 06:48:32 INFO - mozversion platform_buildid: 20160708040727 06:48:32 INFO - mozversion platform_changeset: 24e82cb41040b1f515135ae3ba8b6bddf234d509 06:48:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:48:32 INFO - mozversion platform_version: 48.0 06:48:32 INFO - using testdate: 1467985712 06:48:32 INFO - actual date: 1467985712 06:48:32 INFO - starting webserver on 'localhost:35311' 06:48:32 INFO - SUITE-START | Running 2 tests 06:48:32 INFO - TEST-START | dromaeo_css 06:48:32 INFO - operating with platform_type : linux_ 06:48:32 INFO - Initialising browser for dromaeo_css test... 06:48:32 INFO - TEST-INFO | started process 31896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdeSERR/profile http://localhost:35311/getInfo.html) 06:48:36 INFO - PROCESS | 31896 | __metrics Screen width/height:1600/1200 06:48:36 INFO - PROCESS | 31896 | colorDepth:24 06:48:36 INFO - PROCESS | 31896 | Browser inner width/height: 1024/697 06:48:36 INFO - PROCESS | 31896 | __metrics 06:48:37 ERROR - PROCESS | 31896 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:48:37 INFO - TEST-INFO | 31896: exit 0 06:48:37 INFO - Browser initialized. 06:48:37 INFO - Running cycle 1/1 for dromaeo_css test... 06:48:37 INFO - TEST-INFO | started process 31986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdeSERR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:48:49 INFO - PROCESS | 31986 | RSS: Main: 139837440 06:48:49 INFO - PROCESS | 31986 | 06:49:41 INFO - PROCESS | 31986 | 1467985781332 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] 06:51:48 INFO - PROCESS | 31986 | Cycle 1(1): loaded http://localhost:35311/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35311/tests/dromaeo/cssquery-ext.html) 06:51:49 INFO - PROCESS | 31986 | RSS: Main: 251490304 06:51:49 INFO - PROCESS | 31986 | 06:54:51 INFO - PROCESS | 31986 | Cycle 1(1): loaded http://localhost:35311/tests/dromaeo/cssquery-ext.html (next: http://localhost:35311/tests/dromaeo/cssquery-jquery.html) 06:54:51 INFO - PROCESS | 31986 | RSS: Main: 223195136 06:54:51 INFO - PROCESS | 31986 | 06:57:53 INFO - PROCESS | 31986 | Cycle 1(1): loaded http://localhost:35311/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35311/tests/dromaeo/cssquery-mootools.html) 06:57:54 INFO - PROCESS | 31986 | RSS: Main: 214614016 06:57:54 INFO - PROCESS | 31986 | 07:00:56 INFO - PROCESS | 31986 | Cycle 1(1): loaded http://localhost:35311/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35311/tests/dromaeo/cssquery-prototype.html) 07:00:56 INFO - PROCESS | 31986 | RSS: Main: 216334336 07:00:56 INFO - PROCESS | 31986 | 07:03:59 INFO - PROCESS | 31986 | Cycle 1(1): loaded http://localhost:35311/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35311/tests/dromaeo/cssquery-yui.html) 07:04:00 INFO - PROCESS | 31986 | RSS: Main: 183328768 07:04:00 INFO - PROCESS | 31986 | 07:07:02 INFO - PROCESS | 31986 | Cycle 1(1): loaded http://localhost:35311/tests/dromaeo/cssquery-yui.html (next: http://localhost:35311/tests/dromaeo/cssquery-dojo.html) 07:07:02 INFO - PROCESS | 31986 | RSS: Main: 258355200 07:07:02 INFO - PROCESS | 31986 | 07:07:02 INFO - PROCESS | 31986 | __start_tp_report 07:07:02 INFO - PROCESS | 31986 | _x_x_mozilla_page_load 07:07:02 INFO - PROCESS | 31986 | _x_x_mozilla_page_load_details 07:07:02 INFO - PROCESS | 31986 | |i|pagename|runs| 07:07:02 INFO - PROCESS | 31986 | |0;dojo.html;3305.190228394043;3352.4468462703653;3377.729781617469;3414.214730611961;3428.8628454861805;5519.061759500884;5524.14375771755;5530.225768392424;5551.139573366135;5570.136628822534;5537.363203231619;5567.693776842272;5576.581756368279;5580.553555715544;5628.493435590796;5034.697918124906;5053.065182941158;5060.84817455477;5145.511176438233;5188.195829646411;4945.826896058638;5064.265681476184;5092.592592592584;5127.897442051157;5170.172772356424;5125.051865404894;5165.276861239411;5166.225066240076;5174;5182.222666600002;5091.79632814687;5103.877147027648;5158.329417175762;5171.405288391846;5186.844394668147;4986.40163180417;4995.150824359867;5044.243363495505;5045.697258164485;5062.696238225718;5433.673979561239;5455.5908306877145;5459.754311056012;5478.698671573062;5485.451454854522;5673.26247587815;5919.348871624118;5919.378465261172;5925.762969481216;5930.080837470199;5936.940630593682;5984.371640977678;5986.28164620244;6008.03871380577;6041.607295525777;5514.724263786795;5518.475744804197;5519.227308176858;5526.364468086182;5545.528630066449;5929.436703513159;5950.821475355746;5990.850228744316;6019.036954087413;6076.240469941257;5805.680687562224;5808.680522571299;5812.505936995318;5827.35899051104;5839.386864379179;5929.169916211734;5929.911051334234;5930.644161350333;5933.495652869468;5938.61399009063;5745.798897038583;5877.794277200277;5878.941210587925;5881.147233651097;5949.762009519657;5859.589828712034;5866.6186697864505;5867.911981320283;5870.5010074144175;5872.031114866085;4495.640348772155;4545.499995000548;4546.408966834357;4547.454305483297;4571.9314210286875;3990.06233535119;4023.1752490739914;4069.5116586009867;4073.490813648294;4099.8975025624595;5674.914876276859;5681.801136960186;5700.087985922232;5718.056520674042;5720.170575266647;5982.880342393128;5984.491318237911;5984.850378740566;5987.43119403656;5989.730462129215;5516.862078447991;5618.4662457066515;5633.267675202197;5697.6296540724725;5700.800471983461;5062.797488100508;5077.086124497626;5078.644494885397;5084.110280700863;5100.51545103222;6078.939210607926;6190.288116866528;6197.045269585496;6223.906641400383;6259.342769009279;5940.108983652487;5977.731002104829;5979.4917432018765;5990.670513121646;6019.969900150471;6138.508919286535;6142.293636231891;6143;6146.446819786241;6149.323574406902;5696.344920334214;5771.220885180447;5774.0761478163295;5792.957267691688;5800.100984347433;5918.970405147947;5942.376050514634;5950.31571369298;5954.553408494467;5991.3409524953095;5715;5743.942560574341;5744.597878148489;5745.6552606843725;5765.250517432707;5671.602987790815;5729;5739.397363276963;5747.195392645117;5776.682282474504;5658.971705141448;5659.405762394889;5660.971695141498;5669.5180909621495;5680.346760122638;5757.136429535603;5765.5675824314185;5765.827025189251;5800.578858179773;5804.854878628068;5530.5022547970875;5682.602217844711;5706.771729130955;5734.197212390352;5755.510781583613 07:07:02 INFO - PROCESS | 31986 | |1;ext.html;661.9106420633213;675.6587923098834;678.8845896197643;740.049036987471;757.2503221810409;32176;40848.38727419087;41554;41584.16831663369;41697.16605667885;43352.3497147543;43899;43912.780436097855;43928.34107488382;44004.339934901;7968.32269257111;8700.956495217515;8879.467231966071;8884.244839188677;10221.233407494468;10349.948250258738;10484.37093774372;10485.895141048606;10487.790244195112;10488.265821392468;10519.737006574858;10587.84118238227;10592.78814423711;10595.735106622318;10603.575856965712;10436.425996570224;10486.108680762145;10495.580176792995;10498;10499.107575856062;10458.9477052615;10813.405262710548;10820.567177312898;10843.83734243987;10851.131909447304;44480;44954.550454495366;45040;45046.32430513545;45047.099058018655;3821.121142137324;3901.08324543732;3974.7615143091507;4142.109446469024;4462.776861156962;33928.83035584806;34268.31463370719;34393.656063439295;34402.82798585991;35878.82060589706;4345.717528360678;4347.3696314034605;4348.130373925228;4371.737695738266;4400.73743161117;328924;330096;330896;330949;331171;39720.404193937116;58757.41242587519;59898.70050649719;59986.70006649939;60016.69991650014;39863.60136398657;40239;40358.39462408066;40425.39361909574;40472.79763601163;18100.185491652643;18350.541236469195;18367;18369.173387197607;18372.540686482946;14154.079984800956;14705.852941470663;15229.086254824746;15280.847191528164;15336.923315383352;9310.255179585616;9311.348205625676;9378.577963991636;9394.342396032349;9428.585712143233;3576.946345804815;3590.174259920233;3597.892063238107;3626.8005259710967;3637.836297366625;1118.1613789657756;1124.3501405437742;1150.1546363422879;1204.187173657795;1253.486070711004;33142;33860.32279354399;33987.66012339894;34086.48870266948;34455.310893781985;1176.6940595445246;1272.3193091696082;1272.7899896517156;1298.4416700818738;1307.607717684691;17931.758530183728;17973.765001395386;18036.4828858374;18120.818791812177;18141.665547547815;494473;499458;499778;501541;501939;63168.05247921285;63418.36581634217;63632;63877.68061159665;63888.68055659692;1463.1440607244667;1536.454558631692;1543.5060780550116;1554.8289688134296;1582.3591445464606;30145.24636884008;31611;31995.840020799747;33370.66629333773;33408.83295583507;48658.270125948846;50424.49575504198;50450.24324635207;50459;50509;281917;286556;287163;288025;289097;27526.449471010867;30475.84762076264;30792.53811192789;30824;31509.684903151592;46058;53109.734451327495;53559.46440535545;53787.462125378246;54184;41288;41664;41871.37192942047;43159.78420107879;43239.56760432355;41124;42110.78944605257;42335.576644233166;42371.576284238;42728.57271427246;42352.78823605862;42501;43177.78411107924;43509;43697.56302437062;35566.64433355737;36862;37474.437883432314;37477.4378384319;38639;22075.55848882981;22216.55566888621;22278;22278.220262290743;22428 07:07:02 INFO - PROCESS | 31986 | |2;jquery.html;428.35104816203454;429.13957515182057;432.43567144875936;432.66468486922633;446.59359982415987;18678.53303667409;19200.623825328912;19441.222351105956;20313;20974.370768876957;19644.31244906425;20052.39842804718;20189.798102018976;20240.190392384287;20249.088791004404;5430.8913821723545;5649.209110724501;5674.886502269952;5678.43215678433;5681.517071048966;4110.794460276974;5197.830488140157;5666.773329066853;5673.489385955263;6333.240011198663;6296.212973378328;6323.272823625273;6327.27236367819;6330.208723909512;6339.1442155308905;5814.215080964058;5832.766689332421;5980.013297805878;6248.593841400295;6304.180456540644;5653.9151912721345;5656.3777984422095;5658.377578466407;5679.2333035040565;5697.373288938214;14766.630834229123;19552.511187220432;21236.256731014495;23985;24045.75954240453;2452.2765784093735;2493.551160791057;2504.186139504668;2513.912013079552;2928.253295409657;10865.185111116618;10899.83650245247;10966.835497467544;11023.889761102366;12562.874371256354;1986.7119267706246;2045.8670186437982;2069.6688529835155;2073.6060148571723;2150.774168712294;62057.68971155115;69107.65446172787;72783.27216727818;72867.63566182135;81295.59352203201;10858.72853178661;11352.48913798881;11360.772784544428;11405.600803971987;11569.6529104127;16318.34726610946;16487.917560412123;16490.422835200712;16492;16508.092054937093;8966.730998070068;8989.640414383482;8989.955050224838;9073.274138069071;9258.490783006999;8920.687775927812;9038.412503187272;9043.728688139367;9053.321000924958;9254;4891.730954797449;5022.874428139326;5117.309163262912;5133.768980395891;5238.423773384925;2022.8887411192525;2089.2687559354104;2095.630610177766;2132.3283165802723;2171.2183613898983;985.8028394321165;1048.2033654422694;1054.520193312041;1112.8998390144764;1137.4938152522047;18678.81321186798;19115.71326430105;19547;19580.118894649775;19730.210791568465;1057.2282233969092;1062.7555662197738;1079.071998081649;1100.9064229540418;1117.5246828275408;10658.786824263627;11046.392448415254;11222.831657525143;11264.887351126548;11386.259893107088;520604;527619;534859;542841;544859;88822.55588722015;90364;93287;93443.42058227731;93467.53266233625;1009.2279406254221;1053.6274460986813;1116.2298014369896;1130.598637483698;1146.9942650286696;16754.58113547171;17306.82693173052;17468.47594572165;17731.11344432799;18174.27302907869;37935.62064379321;38672.613273866904;39026.21947560976;39635.405468918565;39904.800475997436;53976.30118493981;54639.72680136574;54715.45284547263;54838;54890.45109548853;8771.824563508822;9112.179903808688;9132.726018219464;9185.632574696938;9385.765355865884;9592.9040709592;9702.417854928726;9838.75403114928;9877.40735555869;10045.547950342107;8901.910980890108;9022.684206052756;9025.368224224241;9047.276217902421;9067.637294508146;8920;9047.411918225294;9048.909510904807;9111.635534578807;9186.356955013352;6009.399060093956;8986.236169925629;9304.16262536375;9388.57751401175;9512.571934263113;13114.344282786013;13305.46778128864;13431.19412835233;13480;13718.794218086936;11815.881841181477;12094.39528023613;12161.825270988551;12203.3288169148;12229.388530573613 07:07:02 INFO - PROCESS | 31986 | |3;mootools.html;1480.052766229614;1603.0461875184264;1621.9675606487867;1863.0870873272102;1963.087164468522;8179.672813087477;8275.875861862069;8284.13016633254;8288.171182881717;8289.212524810133;8134.6339414726335;8334.249917507423;8334.791630209233;8347.0818209997;8353.331733461324;2435.4885474050425;2476.8761561921924;2477.6531285620026;2484.8757562121914;2485.2171565956664;2392.9521409571885;2445.74319696432;2453.521563295158;2477.9592571120083;2482.7765501104896;2247.921322753704;2279.464325883416;2285.3715228312262;2288.5422915416984;2323.546908352872;2389.1279682915783;2428.672129262545;2441.511697660475;2443.0838435586656;2460.1758410932357;2410.409449684821;2454.7667971542674;2466.8766561671846;2467.1734968785477;2468.5680005999056;7289.526180798284;7977.48146370484;8513.404061715682;8558.529280889548;8573.399862009663;5185.092608793484;5340.279062326575;5349.197620356938;5356;5358.303420555303;3581.659742324475;3618.6743193112484;3619.927601447983;3642.6357364263627;3703.055720791208;1161.756031233442;1175.794236008695;1182.6629410617932;1197.9700507487296;1200.9731679414062;11654.592089276835;11835.349055801928;11843.644690659294;12178.695532611668;12194.451249693786;4716.29255611661;4786.2581299898575;4795.664303498722;4826.203676393426;4826.903461930741;10344.27590068688;10366.740831479274;10368.066873981377;10371.429571373646;10371.740706482398;5450.91823622646;5480.068388373986;5488.204210389471;5496.835094947158;5504.119340905436;4941.505849415102;4993.051320249141;4994.675346102492;4995.125852975787;4996.025774973918;4055.7972101395403;4112.91774164515;4117.629413352813;4123.0516981094515;4125.463689720317;1272.1413046193782;1281.6734679606564;1299.155548893227;1305.7323248733987;1326.396489597231;872.9388942773945;984.5175863826673;998.9012086704712;1082.5182793656904;1095.802755504017;6001.489873360726;6004.6097003695495;6071.696415179312;6078.270607527125;6125.754969801158;984.8178087053918;1023.3399457350116;1036.1451802263011;1044.770150566874;1067.354250678344;4057.6753859691153;4064.7561146331313;4147.730397524151;4186.623203911662;4242.278812601803;10219.284650074424;10513.264071514921;10602;10629.362238265729;10668.093212076905;10291.639792607222;10369.066783989478;10397.376157430579;10405.115565177044;10487.37075775456;8168.224018718212;8233.34133269337;8252.133525979805;8261.339092872557;8276.0896301408;5846.94153058464;5943.7028148591535;5955;5970.164177015308;6110.969445152746;9418.481983490974;9458.574364153492;9531.285153613368;9553.522323883639;9558.28312876551;9059.094090591152;9158.771030724285;9350.859737103812;9529.285303602397;9692.515374231401;7231.240719724564;7420.740274090381;7518.8496230074;7566;7607.353374962969;7981.321587665114;8063.475874068166;8074.475159114639;8078.555679437687;8086.393520485869;7193;7193.712251509881;7225.783226503213;7283.308085731847;7386.48294619393;6920.446364290744;6975.302469753187;7010.26392228829;7018.75434359795;7098.112735908012;6696.995450682437;6715.4963377747845;6760.425363843931;6885.1049363582415;6894.793156205322;4696.506866779076;5277.788888444573;5279.868003299948;5337.439568845371;5427.810026649048;5229.450907654642;5235.528802407802;5345.278387417648;5429.077056900415;5483 07:07:02 INFO - PROCESS | 31986 | |4;prototype.html;362.87299445194185;368.8211217559481;369.11780843783356;370.2576334449428;371.72863809419124;5989.550783691218;6046.637201767891;6063.878722425548;6102.542309326796;6143.324234334231;6201.131841542187;6248.343923887995;6250.9062364064575;6254.906176407358;6262.718177682003;4604.917844306586;4709.764511774415;4794.2329227323635;4799.808007679689;4834.7824347904425;4786.305985632099;4789.353437285974;4795.616350691954;4798.83204087857;4798.83204087857;4759.595434388081;4765.571098601125;4765.857024289259;4768.761561921908;4779;4765.761711914391;4766.142094423002;4766.904661906777;4768.737719425413;4772.952270477285;4275.444192254987;4276.123394704109;4278.058827058042;4286.76422796746;4289.6997210195295;5732.369439361667;5944.970275148597;5947.078202878561;5950.851228719273;5953.8809223815715;5410.1073322901675;5410.215518749759;5436.293281873371;5472.042392581322;5473.917891231595;6510.316416776265;6514.3811337922825;6521.217453905561;6522.478201743849;6524.380183882524;4467.30756732707;4562.361269422284;4565.908681826378;4581.725096494221;4584.426946631671;6749.797506074826;6806.319368063154;6809.625470599115;6833.931660683379;6834.863302733917;4645.512221216791;4653.7207767534055;4653.95346046542;4656.930146047812;4658.650601204923;4711.387519622427;4718.575328220477;4720.645951553579;4722.268048452495;4722.787474563653;5163.122269214167;5419.701916394636;5433.565314774809;5439.592030597721;5445.319335083114;6334.683265836782;6372.55392122547;6388;6390.360963903572;6509.414152726183;1640.8769342299374;1659.1372486307052;1663.3180396037808;1664.2427695398565;1668.4243935842114;1073.9033486986052;1084.4035780320792;1103.9944800275948;1111.9388433636066;1113.4098927568402;6425.614463132227;6426.518011149089;6428.967855160788;6430.7749228776765;6439.903401448982;6716.798496045127;6733.797986060426;6735.225449073419;6744.12326397575;6759.526833121634;6414.967925160345;6423.550351475352;6424.421802037746;6432.485401167895;6435.935640643627;3605.7836529808296;3642.1623026704005;3644.4351125575577;3645.4167333226555;3646.869470464165;6931.054301921663;7050.048243487064;7146.857062858714;7147.53541019832;7159.355657990702;6813.3527314905;6818.420434263143;6822.454203663695;6830.658467076726;6831.487638427137;7110.608916509538;7117.110361204849;7126.429885609139;7131.25121862197;7137.1435427749;6732.629705366252;6743.5953842769595;6746.6626668665385;6753.15585551806;6754.527183097136;6460.21298805682;6535.085088087577;6589.967050164719;6592.967035164794;6593.208814942238;7101.076860008166;7103.857922841617;7110.288971102848;7113.146422429341;7117.074780278531;4656.8137274508645;4665.066986602761;4671.135839869635;4674.509176536415;4687.460941991714;6430.903536446864;6590.604563726191;6713.832154196184;6722.731090756315;6730.394264516021;6599.835004124743;6614.735410583715;6626.6686665667485;6634.5024123191915;6650.534462587572;6568.310327415744;6577.572457790228;6579.736810527525;6585.604863708193;6586.176727909012;6462.289148193789;6469.094326794158;6470.6441145737435;6479.352064793483;6487.44856687168;6492.64290464029;6580.638064906476;6627.701753421011;6628.105205797348;6631.801045968628;6408.423241908251;6444.4844412445955;6446.613203207822;6449.4840412765925;6452.483801295979 07:07:02 INFO - PROCESS | 31986 | |5;yui.html;868.9695860644879;870.991290087099;924.8843894513187;930.3254142543423;972.5831309196645;14371.13773173609;14585.854141458582;14695.044822086556;14704.26478676066;14706.41174353026;13971.371288292026;13987.510437134702;14023.859761402384;14040.578782636512;14066;735.8675438421095;756.5120497279252;756.6103456719794;758.2190343945745;915.0757734687979;908.0238743350891;911.7036962987023;912.2063804490103;913.2374467319796;914.0356923445762;959.6017652674132;980.6077568972432;980.9754756131118;980.9901900980971;982.4203719805314;785.458033956571;967.8741763570761;970.4468452981803;979.3536266064399;986.7138529826342;705.2453874354443;715.3669002932443;721.4661150748408;722.5917356693451;722.916864560577;14370.640733981629;14410.351534180987;14414;14417.351219195056;14425.855741442556;13973.650658733512;14334.139951602938;14487.855121448756;14493.275336233146;14579.125252484884;11900.702482438008;12099.758004839854;12106.697332566668;12216.511339546496;12325.260484370876;4058.6753059755147;4133.751974881517;4150.315197992328;4150.543440221573;4229.70392072555;52568.75973015045;53361;53446.198307025814;54753;54863.45136548623;11596.826047609124;11627.244229125079;11678.416079196006;11768.70578235551;11846.585369512026;17350.47948561545;17373.305067797148;17429.825701743073;17437.04096274717;17464;8829.470231786114;8858.424202426822;8928.196462318423;8966.23786978101;9045.954770226239;4624.213883639722;4640.628749700016;4891.486393928586;4997.9750101249265;5168.793248270103;3585.8386372613295;3624.8187590620364;3626.637336266352;3633.16437219441;3640.7087433005295;672.6300534705892;677.3023785500942;678.8438659108433;679.6635665345586;697.3549466743242;660.1385192323967;768.4851149729694;817.0460566386225;817.2440492544373;844.1727107434748;9562.856557151648;9867.605295788231;10174.186065114773;10247.897521024694;10301.793964120825;719.3993015831735;833.0628043451118;843.1568431568431;847.1993965702352;858.2919091749332;4562.58936695699;4583.679142460062;4723.291506274087;4846.224604063333;4899.314096026559;58561.12158317629;58926;68704.3129568708;69296.30703692899;69313;50881;51296;51928.48071519312;51963;59438;47475;47910.28134577984;52842.47157528452;52929.2060619091;54675.72662136744;10351.482425878525;10579.576816927545;10703.625373111903;10729;10832.67501974942;39029.609703903734;39202.6079739199;39592.40611390774;39867.40198896961;40248.396274055325;44731.32903006393;45018.77490612526;47983.3205837794;50306.7484662589;50663;13731.313434328444;13743;13849.692793340151;13863.722725545635;13863.792043119563;14095.224762638154;14150.858491414954;14223.573292801233;14303.284835757962;14408.639784005483;10882.29265097766;13554.390052447861;13616.727665446833;13722.862771372558;13950.651233719238;13107.279099649611;13163.802542961672;13604.387802548712;13607;13607.455701772215;13241.867581324064;13785.310734463437;13828.861711382757;13891.305434728021;14026.78959815624;11076.944615276872;11114.833277501006;11177.497012634614;11305.886941130813;11332.263402878787;11488.885111148782;11569.19015668895;11833.112516561465;11851.70370740704;11902.345371004332 07:07:02 INFO - PROCESS | 31986 | __end_tp_report 07:07:02 INFO - PROCESS | 31986 | __start_cc_report 07:07:02 INFO - PROCESS | 31986 | _x_x_mozilla_cycle_collect,875 07:07:02 INFO - PROCESS | 31986 | __end_cc_report 07:07:02 INFO - PROCESS | 31986 | __startTimestamp1467986822608__endTimestamp 07:07:02 INFO - PROCESS | 31986 | 07:07:02 INFO - PROCESS | 31986 | ------- Summary: start ------- 07:07:02 INFO - PROCESS | 31986 | Number of tests: 6 07:07:02 INFO - PROCESS | 31986 | 07:07:02 INFO - PROCESS | 31986 | [#0] dojo.html Cycles:165 Average:5513.93 Median:5700.80 stddev:597.13 (10.5%) stddev-sans-first:573.27 07:07:02 INFO - PROCESS | 31986 | Values: 3305.2 3352.4 3377.7 3414.2 3428.9 5519.1 5524.1 5530.2 5551.1 5570.1 5537.4 5567.7 5576.6 5580.6 5628.5 5034.7 5053.1 5060.8 5145.5 5188.2 4945.8 5064.3 5092.6 5127.9 5170.2 5125.1 5165.3 5166.2 5174.0 5182.2 5091.8 5103.9 5158.3 5171.4 5186.8 4986.4 4995.2 5044.2 5045.7 5062.7 5433.7 5455.6 5459.8 5478.7 5485.5 5673.3 5919.3 5919.4 5925.8 5930.1 5936.9 5984.4 5986.3 6008.0 6041.6 5514.7 5518.5 5519.2 5526.4 5545.5 5929.4 5950.8 5990.9 6019.0 6076.2 5805.7 5808.7 5812.5 5827.4 5839.4 5929.2 5929.9 5930.6 5933.5 5938.6 5745.8 5877.8 5878.9 5881.1 5949.8 5859.6 5866.6 5867.9 5870.5 5872.0 4495.6 4545.5 4546.4 4547.5 4571.9 3990.1 4023.2 4069.5 4073.5 4099.9 5674.9 5681.8 5700.1 5718.1 5720.2 5982.9 5984.5 5984.9 5987.4 5989.7 5516.9 5618.5 5633.3 5697.6 5700.8 5062.8 5077.1 5078.6 5084.1 5100.5 6078.9 6190.3 6197.0 6223.9 6259.3 5940.1 5977.7 5979.5 5990.7 6020.0 6138.5 6142.3 6143.0 6146.4 6149.3 5696.3 5771.2 5774.1 5793.0 5800.1 5919.0 5942.4 5950.3 5954.6 5991.3 5715.0 5743.9 5744.6 5745.7 5765.3 5671.6 5729.0 5739.4 5747.2 5776.7 5659.0 5659.4 5661.0 5669.5 5680.3 5757.1 5765.6 5765.8 5800.6 5804.9 5530.5 5682.6 5706.8 5734.2 5755.5 07:07:02 INFO - PROCESS | 31986 | 07:07:02 INFO - PROCESS | 31986 | [#1] ext.html Cycles:180 Average:54243.26 Median:3612.35 stddev:101323.15 (2804.9%) stddev-sans-first:101527.52 07:07:02 INFO - PROCESS | 31986 | Values: 661.9 675.7 678.9 740.0 757.3 32176.0 40848.4 41554.0 41584.2 41697.2 43352.3 43899.0 43912.8 43928.3 44004.3 7968.3 8701.0 8879.5 8884.2 10221.2 10349.9 10484.4 10485.9 10487.8 10488.3 10519.7 10587.8 10592.8 10595.7 10603.6 10436.4 10486.1 10495.6 10498.0 10499.1 10458.9 10813.4 10820.6 10843.8 10851.1 44480.0 44954.6 45040.0 45046.3 45047.1 3821.1 3901.1 3974.8 4142.1 4462.8 33928.8 34268.3 34393.7 34402.8 35878.8 4345.7 4347.4 4348.1 4371.7 4400.7 328924.0 330096.0 330896.0 330949.0 331171.0 39720.4 58757.4 59898.7 59986.7 60016.7 39863.6 40239.0 40358.4 40425.4 40472.8 18100.2 18350.5 18367.0 18369.2 18372.5 14154.1 14705.9 15229.1 15280.8 15336.9 9310.3 9311.3 9378.6 9394.3 9428.6 3576.9 3590.2 3597.9 3626.8 3637.8 1118.2 1124.4 1150.2 1204.2 1253.5 33142.0 33860.3 33987.7 34086.5 34455.3 1176.7 1272.3 1272.8 1298.4 1307.6 17931.8 17973.8 18036.5 18120.8 18141.7 494473.0 499458.0 499778.0 501541.0 501939.0 63168.1 63418.4 63632.0 63877.7 63888.7 1463.1 1536.5 1543.5 1554.8 1582.4 30145.2 31611.0 31995.8 33370.7 33408.8 48658.3 50424.5 50450.2 50459.0 50509.0 281917.0 286556.0 287163.0 288025.0 289097.0 27526.4 30475.8 30792.5 30824.0 31509.7 46058.0 53109.7 53559.5 53787.5 54184.0 41288.0 41664.0 41871.4 43159.8 43239.6 41124.0 42110.8 42335.6 42371.6 42728.6 42352.8 42501.0 43177.8 43509.0 43697.6 35566.6 36862.0 37474.4 37477.4 38639.0 22075.6 22216.6 22278.0 22278.2 22428.0 07:07:02 INFO - PROCESS | 31986 | 07:07:02 INFO - PROCESS | 31986 | [#2] jquery.html Cycles:180 Average:29794.64 Median:2269.57 stddev:87685.44 (3863.5%) stddev-sans-first:87903.70 07:07:02 INFO - PROCESS | 31986 | Values: 428.4 429.1 432.4 432.7 446.6 18678.5 19200.6 19441.2 20313.0 20974.4 19644.3 20052.4 20189.8 20240.2 20249.1 5430.9 5649.2 5674.9 5678.4 5681.5 4110.8 5197.8 5666.8 5673.5 6333.2 6296.2 6323.3 6327.3 6330.2 6339.1 5814.2 5832.8 5980.0 6248.6 6304.2 5653.9 5656.4 5658.4 5679.2 5697.4 14766.6 19552.5 21236.3 23985.0 24045.8 2452.3 2493.6 2504.2 2513.9 2928.3 10865.2 10899.8 10966.8 11023.9 12562.9 1986.7 2045.9 2069.7 2073.6 2150.8 62057.7 69107.7 72783.3 72867.6 81295.6 10858.7 11352.5 11360.8 11405.6 11569.7 16318.3 16487.9 16490.4 16492.0 16508.1 8966.7 8989.6 8990.0 9073.3 9258.5 8920.7 9038.4 9043.7 9053.3 9254.0 4891.7 5022.9 5117.3 5133.8 5238.4 2022.9 2089.3 2095.6 2132.3 2171.2 985.8 1048.2 1054.5 1112.9 1137.5 18678.8 19115.7 19547.0 19580.1 19730.2 1057.2 1062.8 1079.1 1100.9 1117.5 10658.8 11046.4 11222.8 11264.9 11386.3 520604.0 527619.0 534859.0 542841.0 544859.0 88822.6 90364.0 93287.0 93443.4 93467.5 1009.2 1053.6 1116.2 1130.6 1147.0 16754.6 17306.8 17468.5 17731.1 18174.3 37935.6 38672.6 39026.2 39635.4 39904.8 53976.3 54639.7 54715.5 54838.0 54890.5 8771.8 9112.2 9132.7 9185.6 9385.8 9592.9 9702.4 9838.8 9877.4 10045.5 8901.9 9022.7 9025.4 9047.3 9067.6 8920.0 9047.4 9048.9 9111.6 9186.4 6009.4 8986.2 9304.2 9388.6 9512.6 13114.3 13305.5 13431.2 13480.0 13718.8 11815.9 12094.4 12161.8 12203.3 12229.4 07:07:02 INFO - PROCESS | 31986 | 07:07:02 INFO - PROCESS | 31986 | [#3] mootools.html Cycles:180 Average:5694.22 Median:4995.58 stddev:3077.76 (61.6%) stddev-sans-first:3070.09 07:07:02 INFO - PROCESS | 31986 | Values: 1480.1 1603.0 1622.0 1863.1 1963.1 8179.7 8275.9 8284.1 8288.2 8289.2 8134.6 8334.2 8334.8 8347.1 8353.3 2435.5 2476.9 2477.7 2484.9 2485.2 2393.0 2445.7 2453.5 2478.0 2482.8 2247.9 2279.5 2285.4 2288.5 2323.5 2389.1 2428.7 2441.5 2443.1 2460.2 2410.4 2454.8 2466.9 2467.2 2468.6 7289.5 7977.5 8513.4 8558.5 8573.4 5185.1 5340.3 5349.2 5356.0 5358.3 3581.7 3618.7 3619.9 3642.6 3703.1 1161.8 1175.8 1182.7 1198.0 1201.0 11654.6 11835.3 11843.6 12178.7 12194.5 4716.3 4786.3 4795.7 4826.2 4826.9 10344.3 10366.7 10368.1 10371.4 10371.7 5450.9 5480.1 5488.2 5496.8 5504.1 4941.5 4993.1 4994.7 4995.1 4996.0 4055.8 4112.9 4117.6 4123.1 4125.5 1272.1 1281.7 1299.2 1305.7 1326.4 872.9 984.5 998.9 1082.5 1095.8 6001.5 6004.6 6071.7 6078.3 6125.8 984.8 1023.3 1036.1 1044.8 1067.4 4057.7 4064.8 4147.7 4186.6 4242.3 10219.3 10513.3 10602.0 10629.4 10668.1 10291.6 10369.1 10397.4 10405.1 10487.4 8168.2 8233.3 8252.1 8261.3 8276.1 5846.9 5943.7 5955.0 5970.2 6111.0 9418.5 9458.6 9531.3 9553.5 9558.3 9059.1 9158.8 9350.9 9529.3 9692.5 7231.2 7420.7 7518.8 7566.0 7607.4 7981.3 8063.5 8074.5 8078.6 8086.4 7193.0 7193.7 7225.8 7283.3 7386.5 6920.4 6975.3 7010.3 7018.8 7098.1 6697.0 6715.5 6760.4 6885.1 6894.8 4696.5 5277.8 5279.9 5337.4 5427.8 5229.5 5235.5 5345.3 5429.1 5483.0 07:07:02 INFO - PROCESS | 31986 | 07:07:02 INFO - PROCESS | 31986 | [#4] prototype.html Cycles:180 Average:5496.37 Median:6353.62 stddev:1648.72 (25.9%) stddev-sans-first:1607.69 07:07:02 INFO - PROCESS | 31986 | Values: 362.9 368.8 369.1 370.3 371.7 5989.6 6046.6 6063.9 6102.5 6143.3 6201.1 6248.3 6250.9 6254.9 6262.7 4604.9 4709.8 4794.2 4799.8 4834.8 4786.3 4789.4 4795.6 4798.8 4798.8 4759.6 4765.6 4765.9 4768.8 4779.0 4765.8 4766.1 4766.9 4768.7 4773.0 4275.4 4276.1 4278.1 4286.8 4289.7 5732.4 5945.0 5947.1 5950.9 5953.9 5410.1 5410.2 5436.3 5472.0 5473.9 6510.3 6514.4 6521.2 6522.5 6524.4 4467.3 4562.4 4565.9 4581.7 4584.4 6749.8 6806.3 6809.6 6833.9 6834.9 4645.5 4653.7 4654.0 4656.9 4658.7 4711.4 4718.6 4720.6 4722.3 4722.8 5163.1 5419.7 5433.6 5439.6 5445.3 6334.7 6372.6 6388.0 6390.4 6509.4 1640.9 1659.1 1663.3 1664.2 1668.4 1073.9 1084.4 1104.0 1111.9 1113.4 6425.6 6426.5 6429.0 6430.8 6439.9 6716.8 6733.8 6735.2 6744.1 6759.5 6415.0 6423.6 6424.4 6432.5 6435.9 3605.8 3642.2 3644.4 3645.4 3646.9 6931.1 7050.0 7146.9 7147.5 7159.4 6813.4 6818.4 6822.5 6830.7 6831.5 7110.6 7117.1 7126.4 7131.3 7137.1 6732.6 6743.6 6746.7 6753.2 6754.5 6460.2 6535.1 6590.0 6593.0 6593.2 7101.1 7103.9 7110.3 7113.1 7117.1 4656.8 4665.1 4671.1 4674.5 4687.5 6430.9 6590.6 6713.8 6722.7 6730.4 6599.8 6614.7 6626.7 6634.5 6650.5 6568.3 6577.6 6579.7 6585.6 6586.2 6462.3 6469.1 6470.6 6479.4 6487.4 6492.6 6580.6 6627.7 6628.1 6631.8 6408.4 6444.5 6446.6 6449.5 6452.5 07:07:02 INFO - PROCESS | 31986 | 07:07:02 INFO - PROCESS | 31986 | [#5] yui.html Cycles:180 Average:15410.61 Median:4150.43 stddev:17439.74 (420.2%) stddev-sans-first:17454.47 07:07:02 INFO - PROCESS | 31986 | Values: 869.0 871.0 924.9 930.3 972.6 14371.1 14585.9 14695.0 14704.3 14706.4 13971.4 13987.5 14023.9 14040.6 14066.0 735.9 756.5 756.6 758.2 915.1 908.0 911.7 912.2 913.2 914.0 959.6 980.6 981.0 981.0 982.4 785.5 967.9 970.4 979.4 986.7 705.2 715.4 721.5 722.6 722.9 14370.6 14410.4 14414.0 14417.4 14425.9 13973.7 14334.1 14487.9 14493.3 14579.1 11900.7 12099.8 12106.7 12216.5 12325.3 4058.7 4133.8 4150.3 4150.5 4229.7 52568.8 53361.0 53446.2 54753.0 54863.5 11596.8 11627.2 11678.4 11768.7 11846.6 17350.5 17373.3 17429.8 17437.0 17464.0 8829.5 8858.4 8928.2 8966.2 9046.0 4624.2 4640.6 4891.5 4998.0 5168.8 3585.8 3624.8 3626.6 3633.2 3640.7 672.6 677.3 678.8 679.7 697.4 660.1 768.5 817.0 817.2 844.2 9562.9 9867.6 10174.2 10247.9 10301.8 719.4 833.1 843.2 847.2 858.3 4562.6 4583.7 4723.3 4846.2 4899.3 58561.1 58926.0 68704.3 69296.3 69313.0 50881.0 51296.0 51928.5 51963.0 59438.0 47475.0 47910.3 52842.5 52929.2 54675.7 10351.5 10579.6 10703.6 10729.0 10832.7 39029.6 39202.6 39592.4 39867.4 40248.4 44731.3 45018.8 47983.3 50306.7 50663.0 13731.3 13743.0 13849.7 13863.7 13863.8 14095.2 14150.9 14223.6 14303.3 14408.6 10882.3 13554.4 13616.7 13722.9 13950.7 13107.3 13163.8 13604.4 13607.0 13607.5 13241.9 13785.3 13828.9 13891.3 14026.8 11076.9 11114.8 11177.5 11305.9 11332.3 11488.9 11569.2 11833.1 11851.7 11902.3 07:07:02 INFO - PROCESS | 31986 | -------- Summary: end -------- 07:07:02 INFO - PROCESS | 31986 | 07:07:03 INFO - TEST-INFO | 31986: exit 0 07:07:03 INFO - TEST-OK | dromaeo_css | took 1110649ms 07:07:03 INFO - TEST-START | kraken 07:07:03 INFO - operating with platform_type : linux_ 07:07:03 INFO - Initialising browser for kraken test... 07:07:03 INFO - TEST-INFO | started process 32187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw2wDiI/profile http://localhost:35311/getInfo.html) 07:07:06 INFO - PROCESS | 32187 | __metrics Screen width/height:1600/1200 07:07:06 INFO - PROCESS | 32187 | colorDepth:24 07:07:06 INFO - PROCESS | 32187 | Browser inner width/height: 1024/697 07:07:06 INFO - PROCESS | 32187 | __metrics 07:07:07 ERROR - PROCESS | 32187 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:07:08 INFO - TEST-INFO | 32187: exit 0 07:07:08 INFO - Browser initialized. 07:07:08 INFO - Running cycle 1/1 for kraken test... 07:07:08 INFO - TEST-INFO | started process 32277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw2wDiI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:20 INFO - PROCESS | 32277 | RSS: Main: 139583488 07:07:20 INFO - PROCESS | 32277 | 07:07:22 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35311/tests/kraken/driver.html?testName=audio-beat-detection) 07:07:23 INFO - PROCESS | 32277 | RSS: Main: 197488640 07:07:23 INFO - PROCESS | 32277 | 07:07:26 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35311/tests/kraken/driver.html?testName=audio-dft) 07:07:26 INFO - PROCESS | 32277 | RSS: Main: 185126912 07:07:26 INFO - PROCESS | 32277 | 07:07:29 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35311/tests/kraken/driver.html?testName=audio-fft) 07:07:30 INFO - PROCESS | 32277 | RSS: Main: 273752064 07:07:30 INFO - PROCESS | 32277 | 07:07:32 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35311/tests/kraken/driver.html?testName=audio-oscillator) 07:07:32 INFO - PROCESS | 32277 | RSS: Main: 180621312 07:07:32 INFO - PROCESS | 32277 | 07:07:35 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35311/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:07:35 INFO - PROCESS | 32277 | RSS: Main: 177709056 07:07:35 INFO - PROCESS | 32277 | 07:07:38 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35311/tests/kraken/driver.html?testName=imaging-darkroom) 07:07:39 INFO - PROCESS | 32277 | RSS: Main: 213016576 07:07:39 INFO - PROCESS | 32277 | 07:07:42 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35311/tests/kraken/driver.html?testName=imaging-desaturate) 07:07:43 INFO - PROCESS | 32277 | RSS: Main: 212799488 07:07:43 INFO - PROCESS | 32277 | 07:07:45 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35311/tests/kraken/driver.html?testName=json-parse-financial) 07:07:46 INFO - PROCESS | 32277 | RSS: Main: 212496384 07:07:46 INFO - PROCESS | 32277 | 07:07:48 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35311/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:07:48 INFO - PROCESS | 32277 | RSS: Main: 193347584 07:07:48 INFO - PROCESS | 32277 | 07:07:50 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35311/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:07:51 INFO - PROCESS | 32277 | RSS: Main: 197476352 07:07:51 INFO - PROCESS | 32277 | 07:07:52 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35311/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:07:53 INFO - PROCESS | 32277 | RSS: Main: 208211968 07:07:53 INFO - PROCESS | 32277 | 07:07:55 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:07:56 INFO - PROCESS | 32277 | RSS: Main: 217931776 07:07:56 INFO - PROCESS | 32277 | 07:07:59 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:07:59 INFO - PROCESS | 32277 | RSS: Main: 213671936 07:07:59 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:35311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35311/tests/kraken/driver.html?testName=ai-astar) 07:08:01 INFO - PROCESS | 32277 | RSS: Main: 274059264 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | __start_tp_report 07:08:01 INFO - PROCESS | 32277 | _x_x_mozilla_page_load 07:08:01 INFO - PROCESS | 32277 | _x_x_mozilla_page_load_details 07:08:01 INFO - PROCESS | 32277 | |i|pagename|runs| 07:08:01 INFO - PROCESS | 32277 | |0;ai-astar;111;110;110;113;111;110;105;109;112;111 07:08:01 INFO - PROCESS | 32277 | |1;audio-beat-detection;155;127;163;175;130;159;163;129;182;126 07:08:01 INFO - PROCESS | 32277 | |2;audio-dft;160;160;162;161;160;160;161;160;160;160 07:08:01 INFO - PROCESS | 32277 | |3;audio-fft;73;77;77;183;76;75;77;77;157;75 07:08:01 INFO - PROCESS | 32277 | |4;audio-oscillator;92;91;156;91;92;91;149;92;92;145 07:08:01 INFO - PROCESS | 32277 | |5;imaging-gaussian-blur;116;117;117;117;116;116;117;117;116;116 07:08:01 INFO - PROCESS | 32277 | |6;imaging-darkroom;145;146;147;145;145;145;146;146;145;146 07:08:01 INFO - PROCESS | 32277 | |7;imaging-desaturate;94;95;94;95;94;95;95;94;95;94 07:08:01 INFO - PROCESS | 32277 | |8;json-parse-financial;54;54;56;55;56;56;58;79;53;54 07:08:01 INFO - PROCESS | 32277 | |9;json-stringify-tinderbox;58;59;58;59;58;60;58;58;59;65 07:08:01 INFO - PROCESS | 32277 | |10;stanford-crypto-aes;73;78;72;72;74;73;74;74;73;74 07:08:01 INFO - PROCESS | 32277 | |11;stanford-crypto-ccm;115;123;113;112;112;110;109;113;128;125 07:08:01 INFO - PROCESS | 32277 | |12;stanford-crypto-pbkdf2;165;160;161;158;160;160;161;160;166;161 07:08:01 INFO - PROCESS | 32277 | |13;stanford-crypto-sha256-iterative;67;66;66;67;66;65;65;66;66;69 07:08:01 INFO - PROCESS | 32277 | __end_tp_report 07:08:01 INFO - PROCESS | 32277 | __start_cc_report 07:08:01 INFO - PROCESS | 32277 | _x_x_mozilla_cycle_collect,1558 07:08:01 INFO - PROCESS | 32277 | __end_cc_report 07:08:01 INFO - PROCESS | 32277 | __startTimestamp1467986881773__endTimestamp 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | ------- Summary: start ------- 07:08:01 INFO - PROCESS | 32277 | Number of tests: 14 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.15 (1.9%) stddev-sans-first:2.26 07:08:01 INFO - PROCESS | 32277 | Values: 111.0 110.0 110.0 113.0 111.0 110.0 105.0 109.0 112.0 111.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:161.00 stddev:21.16 (13.1%) stddev-sans-first:22.39 07:08:01 INFO - PROCESS | 32277 | Values: 155.0 127.0 163.0 175.0 130.0 159.0 163.0 129.0 182.0 126.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 07:08:01 INFO - PROCESS | 32277 | Values: 160.0 160.0 162.0 161.0 160.0 160.0 161.0 160.0 160.0 160.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.50 stddev:40.18 (52.5%) stddev-sans-first:41.84 07:08:01 INFO - PROCESS | 32277 | Values: 73.0 77.0 77.0 183.0 76.0 75.0 77.0 77.0 157.0 75.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:91.50 stddev:28.35 (31.0%) stddev-sans-first:29.39 07:08:01 INFO - PROCESS | 32277 | Values: 92.0 91.0 156.0 91.0 92.0 91.0 149.0 92.0 92.0 145.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:08:01 INFO - PROCESS | 32277 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 116.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 07:08:01 INFO - PROCESS | 32277 | Values: 145.0 146.0 147.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:08:01 INFO - PROCESS | 32277 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:56.00 stddev:7.69 (13.7%) stddev-sans-first:8.05 07:08:01 INFO - PROCESS | 32277 | Values: 54.0 54.0 56.0 55.0 56.0 56.0 58.0 79.0 53.0 54.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:2.15 (3.6%) stddev-sans-first:2.24 07:08:01 INFO - PROCESS | 32277 | Values: 58.0 59.0 58.0 59.0 58.0 60.0 58.0 58.0 59.0 65.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:74.00 stddev:1.70 (2.3%) stddev-sans-first:1.79 07:08:01 INFO - PROCESS | 32277 | Values: 73.0 78.0 72.0 72.0 74.0 73.0 74.0 74.0 73.0 74.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:114.00 stddev:6.75 (5.9%) stddev-sans-first:7.15 07:08:01 INFO - PROCESS | 32277 | Values: 115.0 123.0 113.0 112.0 112.0 110.0 109.0 113.0 128.0 125.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:161.00 stddev:2.44 (1.5%) stddev-sans-first:2.17 07:08:01 INFO - PROCESS | 32277 | Values: 165.0 160.0 161.0 158.0 160.0 160.0 161.0 160.0 166.0 161.0 07:08:01 INFO - PROCESS | 32277 | 07:08:01 INFO - PROCESS | 32277 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 07:08:01 INFO - PROCESS | 32277 | Values: 67.0 66.0 66.0 67.0 66.0 65.0 65.0 66.0 66.0 69.0 07:08:01 INFO - PROCESS | 32277 | -------- Summary: end -------- 07:08:01 INFO - PROCESS | 32277 | 07:08:02 INFO - TEST-INFO | 32277: exit 0 07:08:02 INFO - TEST-OK | kraken | took 59375ms 07:08:02 INFO - SUITE-END | took 1170s 07:08:02 INFO - Completed test suite (00:19:30) 07:08:02 INFO - javascript benchmark 07:08:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3305.190228394043, 3352.4468462703653, 3377.729781617469, 3414.214730611961, 3428.8628454861805, 5519.061759500884, 5524.14375771755, 5530.225768392424, 5551.139573366135, 5570.136628822534, 5537.363203231619, 5567.693776842272, 5576.581756368279, 5580.553555715544, 5628.493435590796, 5034.697918124906, 5053.065182941158, 5060.84817455477, 5145.511176438233, 5188.195829646411, 4945.826896058638, 5064.265681476184, 5092.592592592584, 5127.897442051157, 5170.172772356424, 5125.051865404894, 5165.276861239411, 5166.225066240076, 5174.0, 5182.222666600002, 5091.79632814687, 5103.877147027648, 5158.329417175762, 5171.405288391846, 5186.844394668147, 4986.40163180417, 4995.150824359867, 5044.243363495505, 5045.697258164485, 5062.696238225718, 5433.673979561239, 5455.5908306877145, 5459.754311056012, 5478.698671573062, 5485.451454854522, 5673.26247587815, 5919.348871624118, 5919.378465261172, 5925.762969481216, 5930.080837470199, 5936.940630593682, 5984.371640977678, 5986.28164620244, 6008.03871380577, 6041.607295525777, 5514.724263786795, 5518.475744804197, 5519.227308176858, 5526.364468086182, 5545.528630066449, 5929.436703513159, 5950.821475355746, 5990.850228744316, 6019.036954087413, 6076.240469941257, 5805.680687562224, 5808.680522571299, 5812.505936995318, 5827.35899051104, 5839.386864379179, 5929.169916211734, 5929.911051334234, 5930.644161350333, 5933.495652869468, 5938.61399009063, 5745.798897038583, 5877.794277200277, 5878.941210587925, 5881.147233651097, 5949.762009519657, 5859.589828712034, 5866.6186697864505, 5867.911981320283, 5870.5010074144175, 5872.031114866085, 4495.640348772155, 4545.499995000548, 4546.408966834357, 4547.454305483297, 4571.9314210286875, 3990.06233535119, 4023.1752490739914, 4069.5116586009867, 4073.490813648294, 4099.8975025624595, 5674.914876276859, 5681.801136960186, 5700.087985922232, 5718.056520674042, 5720.170575266647, 5982.880342393128, 5984.491318237911, 5984.850378740566, 5987.43119403656, 5989.730462129215, 5516.862078447991, 5618.4662457066515, 5633.267675202197, 5697.6296540724725, 5700.800471983461, 5062.797488100508, 5077.086124497626, 5078.644494885397, 5084.110280700863, 5100.51545103222, 6078.939210607926, 6190.288116866528, 6197.045269585496, 6223.906641400383, 6259.342769009279, 5940.108983652487, 5977.731002104829, 5979.4917432018765, 5990.670513121646, 6019.969900150471, 6138.508919286535, 6142.293636231891, 6143.0, 6146.446819786241, 6149.323574406902, 5696.344920334214, 5771.220885180447, 5774.0761478163295, 5792.957267691688, 5800.100984347433, 5918.970405147947, 5942.376050514634, 5950.31571369298, 5954.553408494467, 5991.3409524953095, 5715.0, 5743.942560574341, 5744.597878148489, 5745.6552606843725, 5765.250517432707, 5671.602987790815, 5729.0, 5739.397363276963, 5747.195392645117, 5776.682282474504, 5658.971705141448, 5659.405762394889, 5660.971695141498, 5669.5180909621495, 5680.346760122638, 5757.136429535603, 5765.5675824314185, 5765.827025189251, 5800.578858179773, 5804.854878628068, 5530.5022547970875, 5682.602217844711, 5706.771729130955, 5734.197212390352, 5755.510781583613], "value": 5476.074263960142, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.9106420633213, 675.6587923098834, 678.8845896197643, 740.049036987471, 757.2503221810409, 32176.0, 40848.38727419087, 41554.0, 41584.16831663369, 41697.16605667885, 43352.3497147543, 43899.0, 43912.780436097855, 43928.34107488382, 44004.339934901, 7968.32269257111, 8700.956495217515, 8879.467231966071, 8884.244839188677, 10221.233407494468, 10349.948250258738, 10484.37093774372, 10485.895141048606, 10487.790244195112, 10488.265821392468, 10519.737006574858, 10587.84118238227, 10592.78814423711, 10595.735106622318, 10603.575856965712, 10436.425996570224, 10486.108680762145, 10495.580176792995, 10498.0, 10499.107575856062, 10458.9477052615, 10813.405262710548, 10820.567177312898, 10843.83734243987, 10851.131909447304, 44480.0, 44954.550454495366, 45040.0, 45046.32430513545, 45047.099058018655, 3821.121142137324, 3901.08324543732, 3974.7615143091507, 4142.109446469024, 4462.776861156962, 33928.83035584806, 34268.31463370719, 34393.656063439295, 34402.82798585991, 35878.82060589706, 4345.717528360678, 4347.3696314034605, 4348.130373925228, 4371.737695738266, 4400.73743161117, 328924.0, 330096.0, 330896.0, 330949.0, 331171.0, 39720.404193937116, 58757.41242587519, 59898.70050649719, 59986.70006649939, 60016.69991650014, 39863.60136398657, 40239.0, 40358.39462408066, 40425.39361909574, 40472.79763601163, 18100.185491652643, 18350.541236469195, 18367.0, 18369.173387197607, 18372.540686482946, 14154.079984800956, 14705.852941470663, 15229.086254824746, 15280.847191528164, 15336.923315383352, 9310.255179585616, 9311.348205625676, 9378.577963991636, 9394.342396032349, 9428.585712143233, 3576.946345804815, 3590.174259920233, 3597.892063238107, 3626.8005259710967, 3637.836297366625, 1118.1613789657756, 1124.3501405437742, 1150.1546363422879, 1204.187173657795, 1253.486070711004, 33142.0, 33860.32279354399, 33987.66012339894, 34086.48870266948, 34455.310893781985, 1176.6940595445246, 1272.3193091696082, 1272.7899896517156, 1298.4416700818738, 1307.607717684691, 17931.758530183728, 17973.765001395386, 18036.4828858374, 18120.818791812177, 18141.665547547815, 494473.0, 499458.0, 499778.0, 501541.0, 501939.0, 63168.05247921285, 63418.36581634217, 63632.0, 63877.68061159665, 63888.68055659692, 1463.1440607244667, 1536.454558631692, 1543.5060780550116, 1554.8289688134296, 1582.3591445464606, 30145.24636884008, 31611.0, 31995.840020799747, 33370.66629333773, 33408.83295583507, 48658.270125948846, 50424.49575504198, 50450.24324635207, 50459.0, 50509.0, 281917.0, 286556.0, 287163.0, 288025.0, 289097.0, 27526.449471010867, 30475.84762076264, 30792.53811192789, 30824.0, 31509.684903151592, 46058.0, 53109.734451327495, 53559.46440535545, 53787.462125378246, 54184.0, 41288.0, 41664.0, 41871.37192942047, 43159.78420107879, 43239.56760432355, 41124.0, 42110.78944605257, 42335.576644233166, 42371.576284238, 42728.57271427246, 42352.78823605862, 42501.0, 43177.78411107924, 43509.0, 43697.56302437062, 35566.64433355737, 36862.0, 37474.437883432314, 37477.4378384319, 38639.0, 22075.55848882981, 22216.55566888621, 22278.0, 22278.220262290743, 22428.0], "value": 19848.67857759181, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.35104816203454, 429.13957515182057, 432.43567144875936, 432.66468486922633, 446.59359982415987, 18678.53303667409, 19200.623825328912, 19441.222351105956, 20313.0, 20974.370768876957, 19644.31244906425, 20052.39842804718, 20189.798102018976, 20240.190392384287, 20249.088791004404, 5430.8913821723545, 5649.209110724501, 5674.886502269952, 5678.43215678433, 5681.517071048966, 4110.794460276974, 5197.830488140157, 5666.773329066853, 5673.489385955263, 6333.240011198663, 6296.212973378328, 6323.272823625273, 6327.27236367819, 6330.208723909512, 6339.1442155308905, 5814.215080964058, 5832.766689332421, 5980.013297805878, 6248.593841400295, 6304.180456540644, 5653.9151912721345, 5656.3777984422095, 5658.377578466407, 5679.2333035040565, 5697.373288938214, 14766.630834229123, 19552.511187220432, 21236.256731014495, 23985.0, 24045.75954240453, 2452.2765784093735, 2493.551160791057, 2504.186139504668, 2513.912013079552, 2928.253295409657, 10865.185111116618, 10899.83650245247, 10966.835497467544, 11023.889761102366, 12562.874371256354, 1986.7119267706246, 2045.8670186437982, 2069.6688529835155, 2073.6060148571723, 2150.774168712294, 62057.68971155115, 69107.65446172787, 72783.27216727818, 72867.63566182135, 81295.59352203201, 10858.72853178661, 11352.48913798881, 11360.772784544428, 11405.600803971987, 11569.6529104127, 16318.34726610946, 16487.917560412123, 16490.422835200712, 16492.0, 16508.092054937093, 8966.730998070068, 8989.640414383482, 8989.955050224838, 9073.274138069071, 9258.490783006999, 8920.687775927812, 9038.412503187272, 9043.728688139367, 9053.321000924958, 9254.0, 4891.730954797449, 5022.874428139326, 5117.309163262912, 5133.768980395891, 5238.423773384925, 2022.8887411192525, 2089.2687559354104, 2095.630610177766, 2132.3283165802723, 2171.2183613898983, 985.8028394321165, 1048.2033654422694, 1054.520193312041, 1112.8998390144764, 1137.4938152522047, 18678.81321186798, 19115.71326430105, 19547.0, 19580.118894649775, 19730.210791568465, 1057.2282233969092, 1062.7555662197738, 1079.071998081649, 1100.9064229540418, 1117.5246828275408, 10658.786824263627, 11046.392448415254, 11222.831657525143, 11264.887351126548, 11386.259893107088, 520604.0, 527619.0, 534859.0, 542841.0, 544859.0, 88822.55588722015, 90364.0, 93287.0, 93443.42058227731, 93467.53266233625, 1009.2279406254221, 1053.6274460986813, 1116.2298014369896, 1130.598637483698, 1146.9942650286696, 16754.58113547171, 17306.82693173052, 17468.47594572165, 17731.11344432799, 18174.27302907869, 37935.62064379321, 38672.613273866904, 39026.21947560976, 39635.405468918565, 39904.800475997436, 53976.30118493981, 54639.72680136574, 54715.45284547263, 54838.0, 54890.45109548853, 8771.824563508822, 9112.179903808688, 9132.726018219464, 9185.632574696938, 9385.765355865884, 9592.9040709592, 9702.417854928726, 9838.75403114928, 9877.40735555869, 10045.547950342107, 8901.910980890108, 9022.684206052756, 9025.368224224241, 9047.276217902421, 9067.637294508146, 8920.0, 9047.411918225294, 9048.909510904807, 9111.635534578807, 9186.356955013352, 6009.399060093956, 8986.236169925629, 9304.16262536375, 9388.57751401175, 9512.571934263113, 13114.344282786013, 13305.46778128864, 13431.19412835233, 13480.0, 13718.794218086936, 11815.881841181477, 12094.39528023613, 12161.825270988551, 12203.3288169148, 12229.388530573613], "value": 9334.20655089168, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.052766229614, 1603.0461875184264, 1621.9675606487867, 1863.0870873272102, 1963.087164468522, 8179.672813087477, 8275.875861862069, 8284.13016633254, 8288.171182881717, 8289.212524810133, 8134.6339414726335, 8334.249917507423, 8334.791630209233, 8347.0818209997, 8353.331733461324, 2435.4885474050425, 2476.8761561921924, 2477.6531285620026, 2484.8757562121914, 2485.2171565956664, 2392.9521409571885, 2445.74319696432, 2453.521563295158, 2477.9592571120083, 2482.7765501104896, 2247.921322753704, 2279.464325883416, 2285.3715228312262, 2288.5422915416984, 2323.546908352872, 2389.1279682915783, 2428.672129262545, 2441.511697660475, 2443.0838435586656, 2460.1758410932357, 2410.409449684821, 2454.7667971542674, 2466.8766561671846, 2467.1734968785477, 2468.5680005999056, 7289.526180798284, 7977.48146370484, 8513.404061715682, 8558.529280889548, 8573.399862009663, 5185.092608793484, 5340.279062326575, 5349.197620356938, 5356.0, 5358.303420555303, 3581.659742324475, 3618.6743193112484, 3619.927601447983, 3642.6357364263627, 3703.055720791208, 1161.756031233442, 1175.794236008695, 1182.6629410617932, 1197.9700507487296, 1200.9731679414062, 11654.592089276835, 11835.349055801928, 11843.644690659294, 12178.695532611668, 12194.451249693786, 4716.29255611661, 4786.2581299898575, 4795.664303498722, 4826.203676393426, 4826.903461930741, 10344.27590068688, 10366.740831479274, 10368.066873981377, 10371.429571373646, 10371.740706482398, 5450.91823622646, 5480.068388373986, 5488.204210389471, 5496.835094947158, 5504.119340905436, 4941.505849415102, 4993.051320249141, 4994.675346102492, 4995.125852975787, 4996.025774973918, 4055.7972101395403, 4112.91774164515, 4117.629413352813, 4123.0516981094515, 4125.463689720317, 1272.1413046193782, 1281.6734679606564, 1299.155548893227, 1305.7323248733987, 1326.396489597231, 872.9388942773945, 984.5175863826673, 998.9012086704712, 1082.5182793656904, 1095.802755504017, 6001.489873360726, 6004.6097003695495, 6071.696415179312, 6078.270607527125, 6125.754969801158, 984.8178087053918, 1023.3399457350116, 1036.1451802263011, 1044.770150566874, 1067.354250678344, 4057.6753859691153, 4064.7561146331313, 4147.730397524151, 4186.623203911662, 4242.278812601803, 10219.284650074424, 10513.264071514921, 10602.0, 10629.362238265729, 10668.093212076905, 10291.639792607222, 10369.066783989478, 10397.376157430579, 10405.115565177044, 10487.37075775456, 8168.224018718212, 8233.34133269337, 8252.133525979805, 8261.339092872557, 8276.0896301408, 5846.94153058464, 5943.7028148591535, 5955.0, 5970.164177015308, 6110.969445152746, 9418.481983490974, 9458.574364153492, 9531.285153613368, 9553.522323883639, 9558.28312876551, 9059.094090591152, 9158.771030724285, 9350.859737103812, 9529.285303602397, 9692.515374231401, 7231.240719724564, 7420.740274090381, 7518.8496230074, 7566.0, 7607.353374962969, 7981.321587665114, 8063.475874068166, 8074.475159114639, 8078.555679437687, 8086.393520485869, 7193.0, 7193.712251509881, 7225.783226503213, 7283.308085731847, 7386.48294619393, 6920.446364290744, 6975.302469753187, 7010.26392228829, 7018.75434359795, 7098.112735908012, 6696.995450682437, 6715.4963377747845, 6760.425363843931, 6885.1049363582415, 6894.793156205322, 4696.506866779076, 5277.788888444573, 5279.868003299948, 5337.439568845371, 5427.810026649048, 5229.450907654642, 5235.528802407802, 5345.278387417648, 5429.077056900415, 5483.0], "value": 4656.895147965027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.87299445194185, 368.8211217559481, 369.11780843783356, 370.2576334449428, 371.72863809419124, 5989.550783691218, 6046.637201767891, 6063.878722425548, 6102.542309326796, 6143.324234334231, 6201.131841542187, 6248.343923887995, 6250.9062364064575, 6254.906176407358, 6262.718177682003, 4604.917844306586, 4709.764511774415, 4794.2329227323635, 4799.808007679689, 4834.7824347904425, 4786.305985632099, 4789.353437285974, 4795.616350691954, 4798.83204087857, 4798.83204087857, 4759.595434388081, 4765.571098601125, 4765.857024289259, 4768.761561921908, 4779.0, 4765.761711914391, 4766.142094423002, 4766.904661906777, 4768.737719425413, 4772.952270477285, 4275.444192254987, 4276.123394704109, 4278.058827058042, 4286.76422796746, 4289.6997210195295, 5732.369439361667, 5944.970275148597, 5947.078202878561, 5950.851228719273, 5953.8809223815715, 5410.1073322901675, 5410.215518749759, 5436.293281873371, 5472.042392581322, 5473.917891231595, 6510.316416776265, 6514.3811337922825, 6521.217453905561, 6522.478201743849, 6524.380183882524, 4467.30756732707, 4562.361269422284, 4565.908681826378, 4581.725096494221, 4584.426946631671, 6749.797506074826, 6806.319368063154, 6809.625470599115, 6833.931660683379, 6834.863302733917, 4645.512221216791, 4653.7207767534055, 4653.95346046542, 4656.930146047812, 4658.650601204923, 4711.387519622427, 4718.575328220477, 4720.645951553579, 4722.268048452495, 4722.787474563653, 5163.122269214167, 5419.701916394636, 5433.565314774809, 5439.592030597721, 5445.319335083114, 6334.683265836782, 6372.55392122547, 6388.0, 6390.360963903572, 6509.414152726183, 1640.8769342299374, 1659.1372486307052, 1663.3180396037808, 1664.2427695398565, 1668.4243935842114, 1073.9033486986052, 1084.4035780320792, 1103.9944800275948, 1111.9388433636066, 1113.4098927568402, 6425.614463132227, 6426.518011149089, 6428.967855160788, 6430.7749228776765, 6439.903401448982, 6716.798496045127, 6733.797986060426, 6735.225449073419, 6744.12326397575, 6759.526833121634, 6414.967925160345, 6423.550351475352, 6424.421802037746, 6432.485401167895, 6435.935640643627, 3605.7836529808296, 3642.1623026704005, 3644.4351125575577, 3645.4167333226555, 3646.869470464165, 6931.054301921663, 7050.048243487064, 7146.857062858714, 7147.53541019832, 7159.355657990702, 6813.3527314905, 6818.420434263143, 6822.454203663695, 6830.658467076726, 6831.487638427137, 7110.608916509538, 7117.110361204849, 7126.429885609139, 7131.25121862197, 7137.1435427749, 6732.629705366252, 6743.5953842769595, 6746.6626668665385, 6753.15585551806, 6754.527183097136, 6460.21298805682, 6535.085088087577, 6589.967050164719, 6592.967035164794, 6593.208814942238, 7101.076860008166, 7103.857922841617, 7110.288971102848, 7113.146422429341, 7117.074780278531, 4656.8137274508645, 4665.066986602761, 4671.135839869635, 4674.509176536415, 4687.460941991714, 6430.903536446864, 6590.604563726191, 6713.832154196184, 6722.731090756315, 6730.394264516021, 6599.835004124743, 6614.735410583715, 6626.6686665667485, 6634.5024123191915, 6650.534462587572, 6568.310327415744, 6577.572457790228, 6579.736810527525, 6585.604863708193, 6586.176727909012, 6462.289148193789, 6469.094326794158, 6470.6441145737435, 6479.352064793483, 6487.44856687168, 6492.64290464029, 6580.638064906476, 6627.701753421011, 6628.105205797348, 6631.801045968628, 6408.423241908251, 6444.4844412445955, 6446.613203207822, 6449.4840412765925, 6452.483801295979], "value": 4964.928349517718, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [868.9695860644879, 870.991290087099, 924.8843894513187, 930.3254142543423, 972.5831309196645, 14371.13773173609, 14585.854141458582, 14695.044822086556, 14704.26478676066, 14706.41174353026, 13971.371288292026, 13987.510437134702, 14023.859761402384, 14040.578782636512, 14066.0, 735.8675438421095, 756.5120497279252, 756.6103456719794, 758.2190343945745, 915.0757734687979, 908.0238743350891, 911.7036962987023, 912.2063804490103, 913.2374467319796, 914.0356923445762, 959.6017652674132, 980.6077568972432, 980.9754756131118, 980.9901900980971, 982.4203719805314, 785.458033956571, 967.8741763570761, 970.4468452981803, 979.3536266064399, 986.7138529826342, 705.2453874354443, 715.3669002932443, 721.4661150748408, 722.5917356693451, 722.916864560577, 14370.640733981629, 14410.351534180987, 14414.0, 14417.351219195056, 14425.855741442556, 13973.650658733512, 14334.139951602938, 14487.855121448756, 14493.275336233146, 14579.125252484884, 11900.702482438008, 12099.758004839854, 12106.697332566668, 12216.511339546496, 12325.260484370876, 4058.6753059755147, 4133.751974881517, 4150.315197992328, 4150.543440221573, 4229.70392072555, 52568.75973015045, 53361.0, 53446.198307025814, 54753.0, 54863.45136548623, 11596.826047609124, 11627.244229125079, 11678.416079196006, 11768.70578235551, 11846.585369512026, 17350.47948561545, 17373.305067797148, 17429.825701743073, 17437.04096274717, 17464.0, 8829.470231786114, 8858.424202426822, 8928.196462318423, 8966.23786978101, 9045.954770226239, 4624.213883639722, 4640.628749700016, 4891.486393928586, 4997.9750101249265, 5168.793248270103, 3585.8386372613295, 3624.8187590620364, 3626.637336266352, 3633.16437219441, 3640.7087433005295, 672.6300534705892, 677.3023785500942, 678.8438659108433, 679.6635665345586, 697.3549466743242, 660.1385192323967, 768.4851149729694, 817.0460566386225, 817.2440492544373, 844.1727107434748, 9562.856557151648, 9867.605295788231, 10174.186065114773, 10247.897521024694, 10301.793964120825, 719.3993015831735, 833.0628043451118, 843.1568431568431, 847.1993965702352, 858.2919091749332, 4562.58936695699, 4583.679142460062, 4723.291506274087, 4846.224604063333, 4899.314096026559, 58561.12158317629, 58926.0, 68704.3129568708, 69296.30703692899, 69313.0, 50881.0, 51296.0, 51928.48071519312, 51963.0, 59438.0, 47475.0, 47910.28134577984, 52842.47157528452, 52929.2060619091, 54675.72662136744, 10351.482425878525, 10579.576816927545, 10703.625373111903, 10729.0, 10832.67501974942, 39029.609703903734, 39202.6079739199, 39592.40611390774, 39867.40198896961, 40248.396274055325, 44731.32903006393, 45018.77490612526, 47983.3205837794, 50306.7484662589, 50663.0, 13731.313434328444, 13743.0, 13849.692793340151, 13863.722725545635, 13863.792043119563, 14095.224762638154, 14150.858491414954, 14223.573292801233, 14303.284835757962, 14408.639784005483, 10882.29265097766, 13554.390052447861, 13616.727665446833, 13722.862771372558, 13950.651233719238, 13107.279099649611, 13163.802542961672, 13604.387802548712, 13607.0, 13607.455701772215, 13241.867581324064, 13785.310734463437, 13828.861711382757, 13891.305434728021, 14026.78959815624, 11076.944615276872, 11114.833277501006, 11177.497012634614, 11305.886941130813, 11332.263402878787, 11488.885111148782, 11569.19015668895, 11833.112516561465, 11851.70370740704, 11902.345371004332], "value": 7200.459440736324, "unit": "score"}], "name": "dromaeo_css", "value": 7435.001225639984, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 110.0, 113.0, 111.0, 110.0, 105.0, 109.0, 112.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 163.0, 175.0, 130.0, 159.0, 163.0, 129.0, 182.0, 126.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 77.0, 183.0, 76.0, 75.0, 77.0, 77.0, 157.0, 75.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 156.0, 91.0, 92.0, 91.0, 149.0, 92.0, 92.0, 145.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 55.0, 56.0, 56.0, 58.0, 79.0, 53.0, 54.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 58.0, 60.0, 58.0, 58.0, 59.0, 65.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 72.0, 72.0, 74.0, 73.0, 74.0, 74.0, 73.0, 74.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 123.0, 113.0, 112.0, 112.0, 110.0, 109.0, 113.0, 128.0, 125.0], "value": 116.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 160.0, 161.0, 158.0, 160.0, 160.0, 161.0, 160.0, 166.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 66.0, 65.0, 65.0, 66.0, 66.0, 69.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1515.8000000000002, "alertThreshold": 2.0}]} 07:08:03 INFO - Return code: 0 07:08:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:08:03 ERROR - # TBPL SUCCESS # 07:08:03 INFO - Running post-action listener: _resource_record_post_action 07:08:03 INFO - Running post-run listener: _resource_record_post_run 07:08:04 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 24576; Write bytes: 466333696; Read time: 16; Write time: 359916 07:08:04 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 249389056; Read time: 0; Write time: 249804 07:08:04 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 216944640; Read time: 0; Write time: 110112 07:08:04 INFO - Running post-run listener: _upload_blobber_files 07:08:04 INFO - Blob upload gear active. 07:08:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:08:04 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 07:08:04 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'] 07:08:04 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 07:08:04 INFO - (blobuploader) - INFO - Open directory for files ... 07:08:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:08:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:08:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:05 INFO - (blobuploader) - INFO - Done attempting. 07:08:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:08:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:08:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:06 INFO - (blobuploader) - INFO - Done attempting. 07:08:06 INFO - (blobuploader) - INFO - Iteration through files over. 07:08:06 INFO - Return code: 0 07:08:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:08:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:08:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/324a69bbe5445f051a012ab6f22292f967a4a9fa77cb113ad17432f38aca055b9963d17340d5d2e72f7a0322c4602c9e6cb61c8890e6b53de659faf15d14e600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/670e7d0a04557325e4ad2da19ace17d64534ebcaec8e7fa327c113a62e67657fc81c614b62e90945fcf8d3720a6d2b982da961d8c7d25ea60d53747bea66d6a6"} 07:08:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:08:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:08:06 INFO - Contents: 07:08:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/324a69bbe5445f051a012ab6f22292f967a4a9fa77cb113ad17432f38aca055b9963d17340d5d2e72f7a0322c4602c9e6cb61c8890e6b53de659faf15d14e600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/670e7d0a04557325e4ad2da19ace17d64534ebcaec8e7fa327c113a62e67657fc81c614b62e90945fcf8d3720a6d2b982da961d8c7d25ea60d53747bea66d6a6"} 07:08:06 INFO - Running post-run listener: copy_logs_to_upload_dir 07:08:06 INFO - Copying logs to upload dir... 07:08:06 INFO - mkdir: /builds/slave/test/build/upload/logs 07:08:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.371622 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-07-08 07:08:06.066027) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 07:08:06.070044) ========= 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=523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/324a69bbe5445f051a012ab6f22292f967a4a9fa77cb113ad17432f38aca055b9963d17340d5d2e72f7a0322c4602c9e6cb61c8890e6b53de659faf15d14e600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/670e7d0a04557325e4ad2da19ace17d64534ebcaec8e7fa327c113a62e67657fc81c614b62e90945fcf8d3720a6d2b982da961d8c7d25ea60d53747bea66d6a6"} build_url:https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/GG9ETDHxRcS67K7yd2rshg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/324a69bbe5445f051a012ab6f22292f967a4a9fa77cb113ad17432f38aca055b9963d17340d5d2e72f7a0322c4602c9e6cb61c8890e6b53de659faf15d14e600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/670e7d0a04557325e4ad2da19ace17d64534ebcaec8e7fa327c113a62e67657fc81c614b62e90945fcf8d3720a6d2b982da961d8c7d25ea60d53747bea66d6a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 07:08:06.098131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:08:06.098646) ========= 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=523ca41ca1e0623de333ad52000001bf-1467985661.380503-1070345280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:08:06.179361) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 07:08:06.179683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 07:08:06.179977) ========= ========= Total master_lag: 0.16 =========