builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1468933257.44 results: success (0) buildid: 20160719052920 builduid: 09943e17049c4d5b91b74cba7d1254eb revision: efa58477381d54e2d0bd1d89c2d9210a3714e143 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 06:00:57.439451) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 06:00:57.440140) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 06:00:57.440451) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 06:00:57.456294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 06:00:57.456733) ========= 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=7de08804244eb36560b44971000001c3-1468932543.403668-1284255090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 06:00:57-- 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% 46.3M=0s 2016-07-19 06:00:57 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099381 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 06:00:57.570418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 06:00:57.570825) ========= 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=7de08804244eb36560b44971000001c3-1468932543.403668-1284255090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019745 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 06:00:57.621555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 06:00:57.621931) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev efa58477381d54e2d0bd1d89c2d9210a3714e143 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev efa58477381d54e2d0bd1d89c2d9210a3714e143 --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=7de08804244eb36560b44971000001c3-1468932543.403668-1284255090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 06:00:57,775 truncating revision to first 12 chars 2016-07-19 06:00:57,776 Setting DEBUG logging. 2016-07-19 06:00:57,776 attempt 1/10 2016-07-19 06:00:57,776 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/efa58477381d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 06:00:59,255 unpacking tar archive at: fx-team-efa58477381d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.828193 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 06:00:59.463994) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 06:00:59.464306) ========= script_repo_revision: efa58477381d54e2d0bd1d89c2d9210a3714e143 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 06:00:59.464774) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 06:00:59.465051) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 06:00:59.473823) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-19 06:00:59.474189) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=7de08804244eb36560b44971000001c3-1468932543.403668-1284255090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:00:59 INFO - MultiFileLogger online at 20160719 06:00:59 in /builds/slave/test 06:00:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:00:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:00:59 INFO - {'append_to_log': False, 06:00:59 INFO - 'base_work_dir': '/builds/slave/test', 06:00:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:00:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:00:59 INFO - 'branch': 'Fx-Team-Non-PGO', 06:00:59 INFO - 'buildbot_json_path': 'buildprops.json', 06:00:59 INFO - 'config_files': ('talos/linux_config.py',), 06:00:59 INFO - 'default_actions': ('clobber', 06:00:59 INFO - 'read-buildbot-config', 06:00:59 INFO - 'download-and-extract', 06:00:59 INFO - 'populate-webroot', 06:00:59 INFO - 'create-virtualenv', 06:00:59 INFO - 'install', 06:00:59 INFO - 'run-tests'), 06:00:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:00:59 INFO - 'download_minidump_stackwalk': True, 06:00:59 INFO - 'download_symbols': 'ondemand', 06:00:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:00:59 INFO - 'tooltool.py': '/tools/tooltool.py', 06:00:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:00:59 INFO - '/tools/misc-python/virtualenv.py')}, 06:00:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:00:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:00:59 INFO - 'installer_path': 'installer.exe', 06:00:59 INFO - 'log_level': 'info', 06:00:59 INFO - 'log_name': 'talos', 06:00:59 INFO - 'log_to_console': True, 06:00:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:00:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:00:59 INFO - 'opt_config_files': (), 06:00:59 INFO - 'pip_index': False, 06:00:59 INFO - 'sps_profile': False, 06:00:59 INFO - 'sps_profile_interval': 0, 06:00:59 INFO - 'suite': 'dromaeojs', 06:00:59 INFO - 'system_bits': '32', 06:00:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:00:59 INFO - 'title': 'talos-linux64-ix-003', 06:00:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:00:59 INFO - 'use_talos_json': True, 06:00:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:00:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:00:59 INFO - 'work_dir': 'build'} 06:00:59 INFO - ##### 06:00:59 INFO - ##### Running clobber step. 06:00:59 INFO - ##### 06:00:59 INFO - Running pre-action listener: _resource_record_pre_action 06:00:59 INFO - Running main action method: clobber 06:00:59 INFO - rmtree: /builds/slave/test/build 06:00:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:01:00 INFO - Running post-action listener: _resource_record_post_action 06:01:00 INFO - ##### 06:01:00 INFO - ##### Finished clobber step (success) 06:01:00 INFO - ##### 06:01:00 INFO - ##### 06:01:00 INFO - ##### Running read-buildbot-config step. 06:01:00 INFO - ##### 06:01:00 INFO - Running pre-action listener: _resource_record_pre_action 06:01:00 INFO - Running main action method: read_buildbot_config 06:01:00 INFO - Using buildbot properties: 06:01:00 INFO - { 06:01:00 INFO - "project": "", 06:01:00 INFO - "product": "firefox", 06:01:00 INFO - "script_repo_revision": "production", 06:01:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:01:00 INFO - "repository": "", 06:01:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:01:00 INFO - "buildid": "20160719052920", 06:01:00 INFO - "pgo_build": "False", 06:01:00 INFO - "basedir": "/builds/slave/test", 06:01:00 INFO - "buildnumber": 3178, 06:01:00 INFO - "slavename": "talos-linux64-ix-003", 06:01:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:01:00 INFO - "platform": "ubuntu64_hw", 06:01:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:01:00 INFO - "branch": "fx-team", 06:01:00 INFO - "repo_path": "integration/fx-team", 06:01:00 INFO - "revision": "efa58477381d54e2d0bd1d89c2d9210a3714e143", 06:01:00 INFO - "stage_platform": "linux64", 06:01:00 INFO - "builduid": "09943e17049c4d5b91b74cba7d1254eb", 06:01:00 INFO - "slavebuilddir": "test" 06:01:00 INFO - } 06:01:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:01:00 INFO - Running post-action listener: _resource_record_post_action 06:01:00 INFO - ##### 06:01:00 INFO - ##### Finished read-buildbot-config step (success) 06:01:00 INFO - ##### 06:01:00 INFO - ##### 06:01:00 INFO - ##### Running download-and-extract step. 06:01:00 INFO - ##### 06:01:00 INFO - Running pre-action listener: _resource_record_pre_action 06:01:00 INFO - Running main action method: download_and_extract 06:01:00 INFO - mkdir: /builds/slave/test/build/tests 06:01:00 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:01:00 INFO - https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:01:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:01:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:01:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:01:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:01:00 INFO - Downloaded 1361 bytes. 06:01:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:01:00 INFO - Using the following test package requirements: 06:01:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:01:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:01:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:00 INFO - u'jsshell-linux-x86_64.zip'], 06:01:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:01:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:01:00 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:01:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:01:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:01:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:01:00 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:01:00 INFO - https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:01:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:01:05 INFO - Downloaded 22763363 bytes. 06:01:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:01:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:01:06 INFO - Return code: 0 06:01:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:01:06 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:01:06 INFO - https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:01:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:01:07 INFO - Downloaded 22763363 bytes. 06:01:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:01:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:01:09 INFO - Return code: 0 06:01:09 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:01:09 INFO - https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:01:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:01:12 INFO - Downloaded 14403317 bytes. 06:01:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:01:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:01:12 INFO - Return code: 0 06:01: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:01:12 INFO - https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:01:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:01:15 INFO - Downloaded 57120660 bytes. 06:01:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:15 INFO - mkdir: /builds/slave/test/properties 06:01:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:01:15 INFO - Writing to file /builds/slave/test/properties/build_url 06:01:15 INFO - Contents: 06:01:15 INFO - build_url:https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:16 INFO - Running post-action listener: _resource_record_post_action 06:01:16 INFO - Running post-action listener: set_extra_try_arguments 06:01:16 INFO - ##### 06:01:16 INFO - ##### Finished download-and-extract step (success) 06:01:16 INFO - ##### 06:01:16 INFO - ##### 06:01:16 INFO - ##### Running populate-webroot step. 06:01:16 INFO - ##### 06:01:16 INFO - Running pre-action listener: _resource_record_pre_action 06:01:16 INFO - Running main action method: populate_webroot 06:01:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:01:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:01:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:01:16 INFO - '--tppagecycles', 06:01:16 INFO - '7'], 06:01:16 INFO - 'tests': ['tsvgm']}}, 06:01:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:01:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:01:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:01:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:01:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:01:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:01:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:16 INFO - 'talos_options': ['--disable-e10s'], 06:01:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:01:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:01:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:16 INFO - 'talos_options': ['--disable-e10s'], 06:01:16 INFO - 'tests': ['damp', 'tps']}, 06:01:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:16 INFO - 'tests': ['damp', 'tps']}, 06:01:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:01:16 INFO - 'tests': ['dromaeo_dom']}, 06:01:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:01:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:01:16 INFO - 'tests': ['basic_compositor_video']}, 06:01:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:01:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:01:16 INFO - 'tests': ['a11yr', 06:01:16 INFO - 'ts_paint', 06:01:16 INFO - 'tpaint', 06:01:16 INFO - 'sessionrestore', 06:01:16 INFO - 'sessionrestore_no_auto_restore', 06:01:16 INFO - 'tabpaint']}, 06:01:16 INFO - 'other-e10s': {'tests': ['a11yr', 06:01:16 INFO - 'ts_paint', 06:01:16 INFO - 'tpaint', 06:01:16 INFO - 'sessionrestore', 06:01:16 INFO - 'sessionrestore_no_auto_restore', 06:01:16 INFO - 'tabpaint']}, 06:01:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:01:16 INFO - 'ts_paint', 06:01:16 INFO - 'tpaint', 06:01:16 INFO - 'sessionrestore', 06:01:16 INFO - 'sessionrestore_no_auto_restore', 06:01:16 INFO - 'tabpaint']}, 06:01:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:01:16 INFO - 'ts_paint', 06:01:16 INFO - 'tpaint', 06:01:16 INFO - 'sessionrestore', 06:01:16 INFO - 'sessionrestore_no_auto_restore', 06:01:16 INFO - 'tabpaint']}, 06:01:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:01:16 INFO - 'tests': ['a11yr', 06:01:16 INFO - 'ts_paint', 06:01:16 INFO - 'tpaint', 06:01:16 INFO - 'sessionrestore', 06:01:16 INFO - 'sessionrestore_no_auto_restore', 06:01:16 INFO - 'tabpaint']}, 06:01:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:01:16 INFO - 'tests': ['a11yr', 06:01:16 INFO - 'ts_paint', 06:01:16 INFO - 'tpaint', 06:01:16 INFO - 'sessionrestore', 06:01:16 INFO - 'sessionrestore_no_auto_restore', 06:01:16 INFO - 'tabpaint']}, 06:01:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:01:16 INFO - 'tests': ['tsvgx', 06:01:16 INFO - 'tsvgr_opacity', 06:01:16 INFO - 'tart', 06:01:16 INFO - 'tscrollx', 06:01:16 INFO - 'cart']}, 06:01:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:01:16 INFO - 'tsvgr_opacity', 06:01:16 INFO - 'tart', 06:01:16 INFO - 'tscrollx', 06:01:16 INFO - 'cart']}, 06:01:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:16 INFO - 'talos_options': ['--disable-e10s'], 06:01:16 INFO - 'tests': ['tp5o']}, 06:01:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:16 INFO - 'tests': ['tp5o']}, 06:01:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:16 INFO - 'talos_options': ['--disable-e10s', 06:01:16 INFO - '--xperf_path', 06:01:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:01:16 INFO - 'tests': ['tp5n']}, 06:01:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:16 INFO - 'talos_options': ['--xperf_path', 06:01:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:01:16 INFO - 'tests': ['tp5n']}}, 06:01:16 INFO - 'talos.zip': {'path': '', 06:01:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:01:16 INFO - Running post-action listener: _resource_record_post_action 06:01:16 INFO - ##### 06:01:16 INFO - ##### Finished populate-webroot step (success) 06:01:16 INFO - ##### 06:01:16 INFO - ##### 06:01:16 INFO - ##### Running create-virtualenv step. 06:01:16 INFO - ##### 06:01:16 INFO - Running pre-action listener: _resource_record_pre_action 06:01:16 INFO - Running main action method: create_virtualenv 06:01:16 INFO - Creating virtualenv /builds/slave/test/build/venv 06:01:16 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:01:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:01:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:01:16 INFO - Using real prefix '/usr' 06:01:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:01:17 INFO - Installing distribute.............................................................................................................................................................................................done. 06:01:19 INFO - Installing pip.................done. 06:01:19 INFO - Return code: 0 06:01:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:19 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 0x108e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d3b0>, '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 0x134e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e740>, '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': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', '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:01:19 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:01:19 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:01:19 INFO - Using env: {'DISPLAY': ':0', 06:01:19 INFO - 'HOME': '/home/cltbld', 06:01:19 INFO - 'LANG': 'en_US.UTF-8', 06:01:19 INFO - 'LANGUAGE': 'en_US:en', 06:01:19 INFO - 'LOGNAME': 'cltbld', 06:01:19 INFO - 'MAIL': '/var/mail/cltbld', 06:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:19 INFO - 'MOZ_NO_REMOTE': '1', 06:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:19 INFO - 'NO_EM_RESTART': '1', 06:01:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:19 INFO - 'PWD': '/builds/slave/test', 06:01:19 INFO - 'SHELL': '/bin/bash', 06:01:19 INFO - 'SHLVL': '1', 06:01:19 INFO - 'TERM': 'linux', 06:01:19 INFO - 'TMOUT': '86400', 06:01:19 INFO - 'USER': 'cltbld', 06:01:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', 06:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:19 INFO - '_': '/tools/buildbot/bin/python'} 06:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:19 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:01:19 INFO - Cleaning up... 06:01:19 INFO - Return code: 0 06:01:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:19 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d3b0>, '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 0x134e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e740>, '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': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', '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:01:19 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>=3.1.1'] in /builds/slave/test/build 06:01:19 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>=3.1.1 06:01:19 INFO - Using env: {'DISPLAY': ':0', 06:01:19 INFO - 'HOME': '/home/cltbld', 06:01:19 INFO - 'LANG': 'en_US.UTF-8', 06:01:19 INFO - 'LANGUAGE': 'en_US:en', 06:01:19 INFO - 'LOGNAME': 'cltbld', 06:01:19 INFO - 'MAIL': '/var/mail/cltbld', 06:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:19 INFO - 'MOZ_NO_REMOTE': '1', 06:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:19 INFO - 'NO_EM_RESTART': '1', 06:01:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:19 INFO - 'PWD': '/builds/slave/test', 06:01:19 INFO - 'SHELL': '/bin/bash', 06:01:19 INFO - 'SHLVL': '1', 06:01:19 INFO - 'TERM': 'linux', 06:01:19 INFO - 'TMOUT': '86400', 06:01:19 INFO - 'USER': 'cltbld', 06:01:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', 06:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:19 INFO - '_': '/tools/buildbot/bin/python'} 06:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:19 INFO - Downloading/unpacking psutil>=3.1.1 06:01:19 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:01:19 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:01:19 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:01:19 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:01:19 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:01:19 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:01:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:01:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:21 INFO - Installing collected packages: psutil 06:01:21 INFO - Running setup.py install for psutil 06:01:21 INFO - building 'psutil._psutil_linux' extension 06:01:21 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:01:21 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:01:21 INFO - building 'psutil._psutil_posix' extension 06:01:21 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:01:22 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:01:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:22 INFO - Successfully installed psutil 06:01:22 INFO - Cleaning up... 06:01:22 INFO - Return code: 0 06:01:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:22 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d3b0>, '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 0x134e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e740>, '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': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', '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:01:22 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.3'] in /builds/slave/test/build 06:01:22 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.3 06:01:22 INFO - Using env: {'DISPLAY': ':0', 06:01:22 INFO - 'HOME': '/home/cltbld', 06:01:22 INFO - 'LANG': 'en_US.UTF-8', 06:01:22 INFO - 'LANGUAGE': 'en_US:en', 06:01:22 INFO - 'LOGNAME': 'cltbld', 06:01:22 INFO - 'MAIL': '/var/mail/cltbld', 06:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:22 INFO - 'MOZ_NO_REMOTE': '1', 06:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:22 INFO - 'NO_EM_RESTART': '1', 06:01:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:22 INFO - 'PWD': '/builds/slave/test', 06:01:22 INFO - 'SHELL': '/bin/bash', 06:01:22 INFO - 'SHLVL': '1', 06:01:22 INFO - 'TERM': 'linux', 06:01:22 INFO - 'TMOUT': '86400', 06:01:22 INFO - 'USER': 'cltbld', 06:01:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', 06:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:22 INFO - '_': '/tools/buildbot/bin/python'} 06:01:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:01:22 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:01:22 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:01:22 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:01:22 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:01:22 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:01:22 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:01:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:01:24 INFO - Installing collected packages: mozsystemmonitor 06:01:24 INFO - Running setup.py install for mozsystemmonitor 06:01:24 INFO - Successfully installed mozsystemmonitor 06:01:24 INFO - Cleaning up... 06:01:24 INFO - Return code: 0 06:01:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:01:24 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:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:24 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:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:24 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d3b0>, '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 0x134e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e740>, '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': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', '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:01:24 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==2.5.1'] in /builds/slave/test/build 06:01:24 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==2.5.1 06:01:24 INFO - Using env: {'DISPLAY': ':0', 06:01:24 INFO - 'HOME': '/home/cltbld', 06:01:24 INFO - 'LANG': 'en_US.UTF-8', 06:01:24 INFO - 'LANGUAGE': 'en_US:en', 06:01:24 INFO - 'LOGNAME': 'cltbld', 06:01:24 INFO - 'MAIL': '/var/mail/cltbld', 06:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:24 INFO - 'MOZ_NO_REMOTE': '1', 06:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:24 INFO - 'NO_EM_RESTART': '1', 06:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:24 INFO - 'PWD': '/builds/slave/test', 06:01:24 INFO - 'SHELL': '/bin/bash', 06:01:24 INFO - 'SHLVL': '1', 06:01:24 INFO - 'TERM': 'linux', 06:01:24 INFO - 'TMOUT': '86400', 06:01:24 INFO - 'USER': 'cltbld', 06:01:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', 06:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:24 INFO - '_': '/tools/buildbot/bin/python'} 06:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:24 INFO - Downloading/unpacking jsonschema==2.5.1 06:01:24 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:01:24 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:01:24 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:01:24 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:01:24 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:01:24 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:01:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:01:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:01:26 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:01:26 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:01:26 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:01:26 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:01:26 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:01:26 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:01:26 INFO - Downloading functools32-3.2.3-2.tar.gz 06:01:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:01:26 INFO - warning: no files found matching '*.txt' 06:01:26 INFO - no previously-included directories found matching 'build' 06:01:26 INFO - no previously-included directories found matching 'dist' 06:01:26 INFO - no previously-included directories found matching '.git*' 06:01:26 INFO - Installing collected packages: jsonschema, functools32 06:01:26 INFO - Running setup.py install for functools32 06:01:26 INFO - warning: no files found matching '*.txt' 06:01:26 INFO - no previously-included directories found matching 'build' 06:01:26 INFO - no previously-included directories found matching 'dist' 06:01:26 INFO - no previously-included directories found matching '.git*' 06:01:26 INFO - Successfully installed jsonschema functools32 06:01:26 INFO - Cleaning up... 06:01:27 INFO - Return code: 0 06:01:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d3b0>, '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 0x134e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e740>, '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': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', '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:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:01:27 INFO - Using env: {'DISPLAY': ':0', 06:01:27 INFO - 'HOME': '/home/cltbld', 06:01:27 INFO - 'LANG': 'en_US.UTF-8', 06:01:27 INFO - 'LANGUAGE': 'en_US:en', 06:01:27 INFO - 'LOGNAME': 'cltbld', 06:01:27 INFO - 'MAIL': '/var/mail/cltbld', 06:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:27 INFO - 'MOZ_NO_REMOTE': '1', 06:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:27 INFO - 'NO_EM_RESTART': '1', 06:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:27 INFO - 'PWD': '/builds/slave/test', 06:01:27 INFO - 'SHELL': '/bin/bash', 06:01:27 INFO - 'SHLVL': '1', 06:01:27 INFO - 'TERM': 'linux', 06:01:27 INFO - 'TMOUT': '86400', 06:01:27 INFO - 'USER': 'cltbld', 06:01:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', 06:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:27 INFO - '_': '/tools/buildbot/bin/python'} 06:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:27 INFO - Downloading/unpacking blobuploader==1.2.4 06:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:29 INFO - Downloading blobuploader-1.2.4.tar.gz 06:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:01:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:01:29 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:01:29 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:01:29 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:01:29 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:01:29 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:01:29 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:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:01:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:01:29 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:01:29 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:01:29 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:01:29 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:01:29 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:01:29 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:01:29 INFO - Downloading docopt-0.6.1.tar.gz 06:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:01:29 INFO - Installing collected packages: blobuploader, requests, docopt 06:01:29 INFO - Running setup.py install for blobuploader 06:01:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:01:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:01:30 INFO - Running setup.py install for requests 06:01:30 INFO - Running setup.py install for docopt 06:01:30 INFO - Successfully installed blobuploader requests docopt 06:01:30 INFO - Cleaning up... 06:01:30 INFO - Return code: 0 06:01:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:30 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 0x108e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d3b0>, '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 0x134e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e740>, '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': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', '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:01:30 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:01:30 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:01:30 INFO - Using env: {'DISPLAY': ':0', 06:01:30 INFO - 'HOME': '/home/cltbld', 06:01:30 INFO - 'LANG': 'en_US.UTF-8', 06:01:30 INFO - 'LANGUAGE': 'en_US:en', 06:01:30 INFO - 'LOGNAME': 'cltbld', 06:01:30 INFO - 'MAIL': '/var/mail/cltbld', 06:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:30 INFO - 'MOZ_NO_REMOTE': '1', 06:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:30 INFO - 'NO_EM_RESTART': '1', 06:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:30 INFO - 'PWD': '/builds/slave/test', 06:01:30 INFO - 'SHELL': '/bin/bash', 06:01:30 INFO - 'SHLVL': '1', 06:01:30 INFO - 'TERM': 'linux', 06:01:30 INFO - 'TMOUT': '86400', 06:01:30 INFO - 'USER': 'cltbld', 06:01:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', 06:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:30 INFO - '_': '/tools/buildbot/bin/python'} 06:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:30 INFO - Running setup.py (path:/tmp/pip-v2ytyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:30 INFO - Running setup.py (path:/tmp/pip-m9xYzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:30 INFO - Running setup.py (path:/tmp/pip-LC0Rhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:31 INFO - Running setup.py (path:/tmp/pip-52iYfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:31 INFO - Running setup.py (path:/tmp/pip-Y3CEDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:31 INFO - Running setup.py (path:/tmp/pip-_Bg1J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:31 INFO - Running setup.py (path:/tmp/pip-UFRt11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:31 INFO - Running setup.py (path:/tmp/pip-I63IsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:31 INFO - Running setup.py (path:/tmp/pip-eIzQgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:31 INFO - Running setup.py (path:/tmp/pip-nfVgrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:31 INFO - Running setup.py (path:/tmp/pip-Dng6mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:31 INFO - Running setup.py (path:/tmp/pip-_qFfTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:31 INFO - Running setup.py (path:/tmp/pip-drPDU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:31 INFO - Running setup.py (path:/tmp/pip-vcRjEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:31 INFO - Running setup.py (path:/tmp/pip-VxrC1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:31 INFO - Running setup.py (path:/tmp/pip-bM4NE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:31 INFO - Running setup.py (path:/tmp/pip-37FMOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:01:32 INFO - Running setup.py install for manifestparser 06:01:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:01:32 INFO - Running setup.py install for mozcrash 06:01:32 INFO - Running setup.py install for mozdebug 06:01:32 INFO - Running setup.py install for mozdevice 06:01:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:01:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:01:32 INFO - Running setup.py install for mozfile 06:01:32 INFO - Running setup.py install for mozhttpd 06:01:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:01:32 INFO - Running setup.py install for mozinfo 06:01:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:01:32 INFO - Running setup.py install for mozInstall 06:01:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:01:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:01:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:01:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:01:32 INFO - Running setup.py install for mozleak 06:01:32 INFO - Running setup.py install for mozlog 06:01:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:01:33 INFO - Running setup.py install for moznetwork 06:01:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:01:33 INFO - Running setup.py install for mozprocess 06:01:33 INFO - Running setup.py install for mozprofile 06:01:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:01:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:01:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:01:33 INFO - Running setup.py install for mozrunner 06:01:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:01:33 INFO - Running setup.py install for mozscreenshot 06:01:33 INFO - Running setup.py install for moztest 06:01:33 INFO - Running setup.py install for mozversion 06:01:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:01:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:01:33 INFO - Cleaning up... 06:01:33 INFO - Return code: 0 06:01:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:33 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 0x108e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d3b0>, '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 0x134e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e740>, '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': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', '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:01:33 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:01:33 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:01:33 INFO - Using env: {'DISPLAY': ':0', 06:01:33 INFO - 'HOME': '/home/cltbld', 06:01:33 INFO - 'LANG': 'en_US.UTF-8', 06:01:33 INFO - 'LANGUAGE': 'en_US:en', 06:01:33 INFO - 'LOGNAME': 'cltbld', 06:01:33 INFO - 'MAIL': '/var/mail/cltbld', 06:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:33 INFO - 'MOZ_NO_REMOTE': '1', 06:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:33 INFO - 'NO_EM_RESTART': '1', 06:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:33 INFO - 'PWD': '/builds/slave/test', 06:01:33 INFO - 'SHELL': '/bin/bash', 06:01:33 INFO - 'SHLVL': '1', 06:01:33 INFO - 'TERM': 'linux', 06:01:33 INFO - 'TMOUT': '86400', 06:01:33 INFO - 'USER': 'cltbld', 06:01:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', 06:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:33 INFO - '_': '/tools/buildbot/bin/python'} 06:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:34 INFO - Running setup.py (path:/tmp/pip-tjY1PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:34 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:34 INFO - Running setup.py (path:/tmp/pip-na9_Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:34 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:34 INFO - Running setup.py (path:/tmp/pip-Y9bBgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:34 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:34 INFO - Running setup.py (path:/tmp/pip-ppoWvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:34 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:34 INFO - Running setup.py (path:/tmp/pip-2JrsWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:34 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:34 INFO - Running setup.py (path:/tmp/pip-ePAMQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:34 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:34 INFO - Running setup.py (path:/tmp/pip-ZhsNri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:34 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:34 INFO - Running setup.py (path:/tmp/pip-ip7z6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:34 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:34 INFO - Running setup.py (path:/tmp/pip-d0Cy94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:34 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:34 INFO - Running setup.py (path:/tmp/pip-kI7WRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:34 INFO - Running setup.py (path:/tmp/pip-7G31ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:34 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:34 INFO - Running setup.py (path:/tmp/pip-Yc2BiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:34 INFO - Running setup.py (path:/tmp/pip-lN50o_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:34 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:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:34 INFO - Running setup.py (path:/tmp/pip-pNIo69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:35 INFO - Running setup.py (path:/tmp/pip-IzGKZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:35 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:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:35 INFO - Running setup.py (path:/tmp/pip-b9mP9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:35 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:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:35 INFO - Running setup.py (path:/tmp/pip-ZJZb1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:35 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:01:35 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:01:35 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:01:35 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:01:35 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:01:35 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:01:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:37 INFO - Downloading blessings-1.6.tar.gz 06:01:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:01:37 INFO - Installing collected packages: blessings 06:01:37 INFO - Running setup.py install for blessings 06:01:37 INFO - Successfully installed blessings 06:01:37 INFO - Cleaning up... 06:01:37 INFO - Return code: 0 06:01:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:01:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:37 INFO - Reading from file tmpfile_stdout 06:01:37 INFO - Current package versions: 06:01:37 INFO - argparse == 1.2.1 06:01:37 INFO - blessings == 1.6 06:01:37 INFO - blobuploader == 1.2.4 06:01:37 INFO - docopt == 0.6.1 06:01:37 INFO - functools32 == 3.2.3-2 06:01:37 INFO - jsonschema == 2.5.1 06:01:37 INFO - manifestparser == 1.1 06:01:37 INFO - mozInstall == 1.12 06:01:37 INFO - mozcrash == 0.17 06:01:37 INFO - mozdebug == 0.1 06:01:37 INFO - mozdevice == 0.48 06:01:37 INFO - mozfile == 1.2 06:01:37 INFO - mozhttpd == 0.7 06:01:37 INFO - mozinfo == 0.9 06:01:37 INFO - mozleak == 0.1 06:01:37 INFO - mozlog == 3.2 06:01:37 INFO - moznetwork == 0.27 06:01:37 INFO - mozprocess == 0.23 06:01:37 INFO - mozprofile == 0.28 06:01:37 INFO - mozrunner == 6.12 06:01:37 INFO - mozscreenshot == 0.1 06:01:37 INFO - mozsystemmonitor == 0.3 06:01:37 INFO - moztest == 0.7 06:01:37 INFO - mozversion == 1.4 06:01:37 INFO - psutil == 3.1.1 06:01:37 INFO - requests == 1.2.3 06:01:37 INFO - wsgiref == 0.1.2 06:01:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:37 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:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:37 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:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:37 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 0x108e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d3b0>, '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 0x134e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e740>, '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': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', '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:01:37 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:01:37 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:01:37 INFO - Using env: {'DISPLAY': ':0', 06:01:37 INFO - 'HOME': '/home/cltbld', 06:01:37 INFO - 'LANG': 'en_US.UTF-8', 06:01:37 INFO - 'LANGUAGE': 'en_US:en', 06:01:37 INFO - 'LOGNAME': 'cltbld', 06:01:37 INFO - 'MAIL': '/var/mail/cltbld', 06:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:37 INFO - 'MOZ_NO_REMOTE': '1', 06:01:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:37 INFO - 'NO_EM_RESTART': '1', 06:01:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:37 INFO - 'PWD': '/builds/slave/test', 06:01:37 INFO - 'SHELL': '/bin/bash', 06:01:37 INFO - 'SHLVL': '1', 06:01:37 INFO - 'TERM': 'linux', 06:01:37 INFO - 'TMOUT': '86400', 06:01:37 INFO - 'USER': 'cltbld', 06:01:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', 06:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:37 INFO - '_': '/tools/buildbot/bin/python'} 06:01:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:37 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:01:37 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:01:37 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:01:37 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:01:37 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:01:37 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:01:37 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:01:37 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:01:37 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:01:37 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:01:37 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:01:37 INFO - Cleaning up... 06:01:37 INFO - Return code: 0 06:01:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:01:37 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:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:37 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:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:37 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 0x108e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d3b0>, '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 0x134e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e740>, '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': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', '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:01:37 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:01:37 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:01:37 INFO - Using env: {'DISPLAY': ':0', 06:01:37 INFO - 'HOME': '/home/cltbld', 06:01:37 INFO - 'LANG': 'en_US.UTF-8', 06:01:37 INFO - 'LANGUAGE': 'en_US:en', 06:01:37 INFO - 'LOGNAME': 'cltbld', 06:01:37 INFO - 'MAIL': '/var/mail/cltbld', 06:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:37 INFO - 'MOZ_NO_REMOTE': '1', 06:01:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:37 INFO - 'NO_EM_RESTART': '1', 06:01:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:37 INFO - 'PWD': '/builds/slave/test', 06:01:37 INFO - 'SHELL': '/bin/bash', 06:01:37 INFO - 'SHLVL': '1', 06:01:37 INFO - 'TERM': 'linux', 06:01:37 INFO - 'TMOUT': '86400', 06:01:37 INFO - 'USER': 'cltbld', 06:01:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', 06:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:37 INFO - '_': '/tools/buildbot/bin/python'} 06:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:01:38 INFO - Cleaning up... 06:01:38 INFO - Return code: 0 06:01:38 INFO - Running post-action listener: _resource_record_post_action 06:01:38 INFO - Running post-action listener: _start_resource_monitoring 06:01:38 INFO - Starting resource monitoring. 06:01:38 INFO - ##### 06:01:38 INFO - ##### Finished create-virtualenv step (success) 06:01:38 INFO - ##### 06:01:38 INFO - ##### 06:01:38 INFO - ##### Running install step. 06:01:38 INFO - ##### 06:01:38 INFO - Running pre-action listener: _resource_record_pre_action 06:01:38 INFO - Running main action method: install 06:01:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:38 INFO - Reading from file tmpfile_stdout 06:01:38 INFO - Detecting whether we're running mozinstall >=1.0... 06:01:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:01:38 INFO - Reading from file tmpfile_stdout 06:01:38 INFO - Output received: 06:01:38 INFO - Usage: mozinstall [options] installer 06:01:38 INFO - Options: 06:01:38 INFO - -h, --help show this help message and exit 06:01:38 INFO - -d DEST, --destination=DEST 06:01:38 INFO - Directory to install application into. [default: 06:01:38 INFO - "/builds/slave/test"] 06:01:38 INFO - --app=APP Application being installed. [default: firefox] 06:01:38 INFO - mkdir: /builds/slave/test/build/application 06:01:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:01:54 INFO - Reading from file tmpfile_stdout 06:01:54 INFO - Output received: 06:01:54 INFO - /builds/slave/test/build/application/firefox/firefox 06:01:54 INFO - Running post-action listener: _resource_record_post_action 06:01:54 INFO - ##### 06:01:54 INFO - ##### Finished install step (success) 06:01:54 INFO - ##### 06:01:54 INFO - ##### 06:01:54 INFO - ##### Running run-tests step. 06:01:54 INFO - ##### 06:01:54 INFO - Running pre-action listener: _resource_record_pre_action 06:01:54 INFO - Running main action method: run_tests 06:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:01:54 INFO - Python 2.7.3 06:01:54 INFO - Return code: 0 06:01:54 INFO - grabbing minidump binary from tooltool 06:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:54 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d3b0>, '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 0x134e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:01:54 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:01:54 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:01:54 INFO - Calling ['/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'] with output_timeout 600 06:01:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:54 INFO - Return code: 0 06:01:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:01:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:01:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:01:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:01:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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:01:54 INFO - Using env: {'DISPLAY': ':0', 06:01:54 INFO - 'HOME': '/home/cltbld', 06:01:54 INFO - 'LANG': 'en_US.UTF-8', 06:01:54 INFO - 'LANGUAGE': 'en_US:en', 06:01:54 INFO - 'LOGNAME': 'cltbld', 06:01:54 INFO - 'MAIL': '/var/mail/cltbld', 06:01:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:01:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:54 INFO - 'MOZ_NO_REMOTE': '1', 06:01:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:54 INFO - 'NO_EM_RESTART': '1', 06:01:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:54 INFO - 'PWD': '/builds/slave/test', 06:01:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:01:54 INFO - 'SHELL': '/bin/bash', 06:01:54 INFO - 'SHLVL': '1', 06:01:54 INFO - 'TERM': 'linux', 06:01:54 INFO - 'TMOUT': '86400', 06:01:54 INFO - 'USER': 'cltbld', 06:01:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468932543.403668-1284255090', 06:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:54 INFO - '_': '/tools/buildbot/bin/python'} 06:01:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:01:55 INFO - mozversion application_buildid: 20160719052920 06:01:55 INFO - mozversion application_changeset: efa58477381d54e2d0bd1d89c2d9210a3714e143 06:01:55 INFO - mozversion application_display_name: Nightly 06:01:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:55 INFO - mozversion application_name: Firefox 06:01:55 INFO - mozversion application_remotingname: firefox 06:01:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:01:55 INFO - mozversion application_vendor: Mozilla 06:01:55 INFO - mozversion application_version: 50.0a1 06:01:55 INFO - mozversion platform_buildid: 20160719052920 06:01:55 INFO - mozversion platform_changeset: efa58477381d54e2d0bd1d89c2d9210a3714e143 06:01:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:01:55 INFO - mozversion platform_version: 50.0a1 06:01:55 INFO - using testdate: 1468933315 06:01:55 INFO - actual date: 1468933315 06:01:55 INFO - starting webserver on 'localhost:46946' 06:01:55 INFO - SUITE-START | Running 2 tests 06:01:55 INFO - TEST-START | dromaeo_css 06:01:55 INFO - operating with platform_type : linux_ 06:01:55 INFO - Initialising browser for dromaeo_css test... 06:01:55 INFO - TEST-INFO | started process 6251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKLkNvf/profile http://localhost:46946/getInfo.html) 06:01:59 INFO - PROCESS | 6251 | __metrics Screen width/height:1600/1200 06:01:59 INFO - PROCESS | 6251 | colorDepth:24 06:01:59 INFO - PROCESS | 6251 | Browser inner width/height: 1024/697 06:01:59 INFO - PROCESS | 6251 | __metrics 06:02:00 INFO - PROCESS | 6251 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:02:00 INFO - PROCESS | 6251 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:02:00 INFO - PROCESS | 6251 | console.error: PushService: 06:02:00 INFO - PROCESS | 6251 | stateChangeProcessEnqueue: Error transitioning state 06:02:00 INFO - PROCESS | 6251 | UnknownError 06:02:01 INFO - TEST-INFO | 6251: exit 0 06:02:01 INFO - Browser initialized. 06:02:01 INFO - Running cycle 1/1 for dromaeo_css test... 06:02:01 INFO - TEST-INFO | started process 6333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKLkNvf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:13 INFO - PROCESS | 6333 | RSS: Main: 159043584 06:02:13 INFO - PROCESS | 6333 | 06:03:04 INFO - PROCESS | 6333 | 1468933384566 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:05:17 INFO - PROCESS | 6333 | Cycle 1(1): loaded http://localhost:46946/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46946/tests/dromaeo/cssquery-ext.html) 06:05:18 INFO - PROCESS | 6333 | RSS: Main: 239157248 06:05:18 INFO - PROCESS | 6333 | 06:08:20 INFO - PROCESS | 6333 | Cycle 1(1): loaded http://localhost:46946/tests/dromaeo/cssquery-ext.html (next: http://localhost:46946/tests/dromaeo/cssquery-jquery.html) 06:08:21 INFO - PROCESS | 6333 | RSS: Main: 242847744 06:08:21 INFO - PROCESS | 6333 | 06:11:23 INFO - PROCESS | 6333 | Cycle 1(1): loaded http://localhost:46946/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46946/tests/dromaeo/cssquery-mootools.html) 06:11:24 INFO - PROCESS | 6333 | RSS: Main: 245407744 06:11:24 INFO - PROCESS | 6333 | 06:14:26 INFO - PROCESS | 6333 | Cycle 1(1): loaded http://localhost:46946/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46946/tests/dromaeo/cssquery-prototype.html) 06:14:27 INFO - PROCESS | 6333 | RSS: Main: 239083520 06:14:27 INFO - PROCESS | 6333 | 06:17:30 INFO - PROCESS | 6333 | Cycle 1(1): loaded http://localhost:46946/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46946/tests/dromaeo/cssquery-yui.html) 06:17:30 INFO - PROCESS | 6333 | RSS: Main: 214679552 06:17:30 INFO - PROCESS | 6333 | 06:20:33 INFO - PROCESS | 6333 | Cycle 1(1): loaded http://localhost:46946/tests/dromaeo/cssquery-yui.html (next: http://localhost:46946/tests/dromaeo/cssquery-dojo.html) 06:20:34 INFO - PROCESS | 6333 | RSS: Main: 281481216 06:20:34 INFO - PROCESS | 6333 | 06:20:34 INFO - PROCESS | 6333 | __start_tp_report 06:20:34 INFO - PROCESS | 6333 | _x_x_mozilla_page_load 06:20:34 INFO - PROCESS | 6333 | _x_x_mozilla_page_load_details 06:20:34 INFO - PROCESS | 6333 | |i|pagename|runs| 06:20:34 INFO - PROCESS | 6333 | |0;dojo.html;2638.8680565971695;2651.973480265197;2682.731726827317;2690.8116431849767;2692.90574829881;4563.087382523492;4645.488996210414;4700.764961751912;4781.641376896733;4850.223964165734;4656.254999200129;4695.859124226278;4704.6706730528795;4710.152172608929;4717.575418212369;4084.5915408459214;4265.338872474764;4364.912701745963;4392.187445322609;4399.890002749941;4307.440032795732;4342.848000319989;4360;4369.868903932887;4399.406080179167;4290.442242508454;4337.9132417351475;4341.066670665822;4374.19077470669;4374.737515749065;4316.136772645484;4329.480462344539;4330.480342358906;4369.213541562517;4382.211201983641;4366.934495982531;4379.408779814716;4390.582894625006;4425.247707889666;4435.822567097344;4540.568645978659;4666.626669866402;4669.836555720533;4747.240441529373;4753;5124.0776660201145;5130.846074617767;5166.328377310963;5176.352955880515;5196.090684130262;5184.274201611777;5189.6886186828915;5227.111391063529;5228.843134705965;5231.450697676765;4602.654800889946;4717.481077081518;4767.61859051275;4770.76146192689;4799.184138696361;5200.97399513;5233.581313494911;5234.319538459976;5288.153895376799;5294.92057619136;4845.95154048455;5015.82444614444;5020.824271150492;5076.340075790124;5076.670016448919;4937.876553086202;4978.427480839678;4981;4997.950020499821;5014.774335154927;4971.975140124277;4975;4975.179095449211;4990.226514890198;5023.6985780853265;4946.109700253917;4964.230544265644;4985.102681517362;4988.326575912278;5033.446320904697;4374.387585737999;4407.669424793154;4413.668974826901;4420.535843736426;4472.217361961643;3831.5210598675167;3837.4819399380726;3845.8461661533224;3871.864484743077;3880.262750077476;4337.1976184405985;4455.064436468378;4455.77721113943;4467.195904737178;4512.75179865104;5023.346964894614;5051.570616497639;5058.924116138261;5066.341375621146;5087.31321271631;4378.124375124924;4389.561043895585;4391.407160033418;4396.428464299621;4435.578620031092;4519.774011299488;4566.292224705176;4611.054733779567;4612.262038073892;4643.628509719214;4796.112719146969;4799.1601469743355;4816.494268101939;4820.734859582757;4882.048000639841;5110.795568177231;5111.846644600668;5114.74426278692;5123.692578445156;5170;4672.976635116938;4679.46186188579;4696.131215725101;4801.879953001063;4860.854174374775;4910.975445122752;4929.112759703145;4933.383327084114;4934.9753251233515;4975.626827987843;4984.700917944935;5015.84952451427;5015.97172579613;5016.473270306711;5055.797768089235;4794;4924.507549245047;4932.654714169974;4964.304997300453;4992.151334273255;5017.172166592617;5029.119904016856;5035.597152227886;5038.521340472649;5084.720340381315;4949.57928576075;4967.081089998362;4975.601951843916;5012.649114561946;5028.044671512547;4878.463369029333;4940.555350018516;4991;5027.622928280467;5067.695938243717;4920.45874953762;4959.677620954626;4960.8759781005765;4963.354763880672;5010.348654674869 06:20:34 INFO - PROCESS | 6333 | |1;ext.html;564.7091063013512;581.1428143488355;584.9268841394826;593.5904226083999;605.2494906316167;38977.22045559087;40632.39051414231;40646.390304145425;40770.796146019304;44184;41500.58499415005;42037.78981105098;42077.36883946743;42077.57922420775;42086.57913420865;7553.660085296175;7753.573553454557;7755.418343624223;7915.2084791520965;8053;7709.575973321465;10155.136813370873;10428.843567346496;10430.843537346946;10779.245452818306;10487.10859576933;10546;10551.73620659482;10554.155667546616;10554.366737995706;7606.315431611126;10184.134348580379;10316.535755891004;10377.066064054272;10389.376637401741;9897.703068907944;10258.487075646188;10307.84538231927;10323.070923616911;10331.48342582868;35949.1012724684;36279.18604069786;36334.27331453383;36334.454983175274;36411.4538281926;3151.842407879597;3152.8265945372996;3368.3936891359544;3510.0226245464073;3686.041629176407;28278;28752.856235718897;29293.414131717458;29414.411711765857;29632.555511667128;3496.842642081087;3519.436890097598;3559;3565.8038807865555;3646.58064322601;248196;248277;249000;249067;249767;51797.48202518002;52050.47949520456;52085.47914520806;52176.739116304176;52210.73894630503;32702.672973270437;33528.832355838065;33633.49549756756;35749.64250357463;35821.1044723884;15331.156786376634;15383.769243461356;15493.535193944199;15497.84502154964;15573.844261557466;10627.415492147851;11575.363355015555;11742.70643233909;11802.5869094583;11903.940480297542;18285.90857045733;18308.816911830712;18318.725219121723;18377;18417.355392561196;6583.9012414813815;6653.73385064592;6666.933330666631;6668.66626674667;6983.162020557464;820.4707963363597;877.241186373782;951.7049714588361;957.4877440569262;973.3673112476947;27816.304592384946;27953;28020.299492512444;28111.71888281091;28138;901.715959472764;922.9123233292827;942.4298299528823;948.4783369146942;953.9713808585753;15058.247087645574;15070.171140587154;15213.467528636445;15251.161186134868;15351.385944562317;395781;400257;401015;401261;401527;49426.75286623616;49805;49885.50114498881;49889.25166122511;49908.500914990385;1147.17976646698;1192.3025030357337;1211.4003568233782;1215.1311812054423;1232.186756740547;27237.591436128077;28643.856780715963;28688;29026.27434314159;29217.41565168642;41476.58523414727;42158.578414215466;42201.36697949595;42209.15581688288;42243.3663495054;319666;321228;322039;322154;322512;24313.39216519601;25519.617205741557;25552;25553.361165971;25580.488390232462;40104.39843402409;40549.594504054585;41194.38208426936;42032.78983605062;42064.369034463896;34794.82602586971;35209;35640.10899727424;35894;36091.27817443689;34967.30065398729;35603.287934241685;35643.28713425769;35696.821515892254;36128.27743445169;34690.47964280588;35024.29951401009;35158.12104697403;35249.82375088108;35335.469967951016;29316.560251595816;31979.84010079935;32299.677003229666;32381.676183238807;32636.673633263363;24156.87921560381;24451.14420995328;24710.629340560266;25130.497390052464;25216.117435889657 06:20:34 INFO - PROCESS | 6333 | |2;jquery.html;350.63183657159976;374.4009584664537;379.8328735356444;380.40466669661976;390.7655406755947;13037.28294943779;13530.120542164765;16196.433124840632;17334.133293335315;17426.215820288086;15864;16869.40957066503;16949.152542372893;17202.483925482225;17220.311187552485;4934.925976110352;5090.974545127269;5127.384713834345;5132.8973420531565;5134.512221338967;3797.14564223049;5733.827985160452;6031.185789918371;6033.125196846455;6152.107944348067;5209.7134657593815;6065.090236464522;6082.118092876531;6120.234970628671;6126.081087836816;5460.989716902366;5557.3331200255825;5568.109102543614;5577.442255774431;5587.608867379285;5235.764390602432;5409.134538473825;5410.810621628224;5419.024575576394;5430.91853622196;11806.350650714206;12318.384080795924;12397.62807115788;12422.875771242352;12544.686382840411;1937.1476550317957;1960.8235258826774;1973.58554703511;1980.1683293016968;1992.262862740795;8960;9207.58565864531;9374.625014999392;9386.155246027822;9418.764530886714;1715;1759.1468137953082;1801.3335066025654;1811.5108920591367;1827.269092363052;45204;58255.41744582542;60786.19090458648;66897;69144.6542767288;9504.239660827117;9521.857172142423;9872.654457093968;10218.335808172445;10294.176465882862;13908.652283692989;14032.85967140336;14100;14127.78808317876;14133.85866141346;7240.239774823673;7267.527610705287;7404.481686282016;7476.813079673052;7496.700131994659;6941.47938904574;7035.577865328097;7064.293570642894;7169.519050593379;7259.201487836333;4375.234333991539;4464.129494748493;4489.573490518461;4504.391907092566;4559.338895860148;1813.384935339564;1814.510082277804;1838.2279442634126;1868.2060124447055;1882.4823173627362;768.8692922203239;817.1746535998566;836.2640876029177;870.3515880668942;911.1253196930888;16579.17104144788;16999.660006799793;17463.738043929352;17720.20259088344;17795.46613601594;802.9847921056396;840.5755093677653;856.8629019356997;864.5763575847915;873.4977388001925;6103.6948152592195;9624.181944534794;9817.754556136153;9823.115919567274;9947.602095916081;394636;401581;402652;403986;407058;77234.2276577227;77599;77776.61111694406;78244.60877695575;80819;891.0421297105637;925.5927391947522;939.9624015039321;961.5336561767538;962.0860182826343;15588.766168507254;15654.060756354655;15687.764683529527;15700.76448853291;16099.195040248174;35618.46572301469;38033.42949855699;38676.226475470896;39598.40602390909;40416;52475.47524524706;53368.733156335526;54786.45213547973;54861.725691371284;55013;7484;7746.767596972099;7752.18602046777;7792.18182090895;8113.269805717514;11241.66275011751;11946.223495472766;12256.080793940311;12381.62855114348;12493.93753031229;10558.947205263925;10617.469126543487;10673.199510036624;10683.94658026705;10830.837537437103;10327.690169294932;10960.232783705063;11010.339379637247;11140.387278699749;11184.720381990515;10505;10779.353238805697;10790;10890.128789696964;10984.670459886216;7783.338416234684;7825.843483130192;7826.804329891798;7888.921110789048;8109.3917956152345;8946.910530894607;11048.171387145836;11063.391513466837;11099.056580190774;11134.944325278646 06:20:34 INFO - PROCESS | 6333 | |3;mootools.html;1248.3259040118337;1346.3672074125159;1416.3767942105474;1486.8587484189004;1720.1657196259812;6671.699773510191;7327.633618319082;7511.6995320187125;7542.924570754298;7720.227977202277;7595.848083038336;7705.306522412981;7721.073471183466;7725.18885517021;7743.0708315002275;2178.172294528077;2201.3506015725397;2203.1297637433204;2207.0289072807996;2207.3267653365715;2143.603433364825;2155.5473350596394;2215.3686199433164;2216.1024784962115;2216.9113235470563;2174.8912554372296;2186.967195492061;2193.649016157415;2194.7914948079906;2222.022310183522;2150.215171462413;2151.655735082395;2152.5910077085305;2155.170259450107;2159.082389984258;2100.516881117336;2146.431195733132;2147.066026278558;2156.827453803692;2162.275637661385;7528.435367347416;7705.730299439493;7736.187700291444;7746.302832745024;7840.647170877267;4495;4569.109023740372;4574.0394517151435;4585.243434833248;4585.862424127282;2781.4437112577566;2862.1127450490417;2898.7536059434974;2908.1566345759707;2912.7815413844046;913.4291068082448;915.0620613870769;930.2929773372218;944.4569372610777;948.4925564822787;10697.732556686067;10851.457427128691;10854.511546980404;10878.184136189817;10891.237613367068;3984.880453586397;4106.40457133714;4199.076203235283;4199.454070970754;4241.766702831374;8524.914750852537;8577.356698247531;8582.055973842873;8589.355798315151;8594.183552562497;4681;4687.460941991646;4695.9530404695515;4697.271922851964;4700.623950084054;3813.237352529505;3954.307996100671;4284.67864910133;4284.828606855691;4292.034292284274;3505.1237190702323;3567.6253993330847;3617.81910904459;3641.253543023674;3647.76289541179;1058.3015209961388;1094.7700982793542;1096.4791723931228;1102.1127991966384;1110.9833352499718;719.9028131202325;803.3211935914143;889.675268526983;892.8928528576482;907.609727817045;5163.199704045879;5424.511793938565;5470.206820011076;5498;5646.2377579027125;832.433944917462;836.1387770596295;851.6040041380787;886.5035580075179;920.2821798996794;3822.7897465639103;3873.3996230584303;3885.0441754253297;3890.727649064595;3942.211557688474;9432.103950124727;9577.042295770367;9592.520373981273;9696.95151524238;9704.02959704038;9594.664186753569;9607.903920960702;9619.326647134774;9627.711168664951;9632.9036709632;6989.126359204997;7350.5957172354965;7467.253274672598;7472.775816725507;7484.326410622961;5537.833864984057;5647.802326918538;5655.88688226225;5683.5737319700365;5789.884202316014;8954;8957.776055598662;8958.92492900856;9029.23251523628;9069.274458043472;7725.652345644572;8776.824463510566;9238.769030774016;9249;9270.351075424656;6528.738850446119;6768.052472653931;6795.830104247236;6965.756198533027;6978.860422791414;7591.3926885847895;7630.7710768677025;7651.923480765121;7661.923380766121;7684.077910650534;6794.966025169842;6870.072540207008;6902.896456553055;6991.510594258353;7003.894941575983;6776.898346524905;6802.727890884309;6856.897146542906;6933.064036355229;7077.327653872874;6554.705038273194;6602.042703807825;6643.970184621391;6656.900146497903;6662.333766623493;4633.096546173599;4705.247160454311;4714.66997310185;4741.596964258077;4759.42886853566;4870.975645121894;4919;4925.507449255046;4963.057019166346;5018.4730603286125 06:20:34 INFO - PROCESS | 6333 | |4;prototype.html;297.64728796376295;298.1383800815642;306.1336417937237;306.91252992897;308.8502076492902;4891.804327826887;4898.951010489894;4903.901921961563;4952.554270115698;4954.8018079276835;4843.951560484403;4864.7324397158145;4894.804207831691;4901.828436004741;4906.19047857104;3628.546431696038;3733.7199710021723;3749.6812770914366;3775.509183806101;3829.885103446887;3778.3954567269243;3810.2760475509704;3821.8280177391944;3843.5195600549932;3844.4233364995334;3776;3779.622037796226;3801.714871384643;3832.156925476391;3833.6358045985726;3625.6011838697723;3710.1281198918095;3780.678642315379;3802.5056742623283;3827.311084004878;3374.797512149279;3381.374445727524;3400.472926696366;3402.6427225141497;3403.3873902697505;4729.9763501182615;4756.9762151189025;4764.2615394613895;4775.856724298276;4775.928361074587;4213.241616509027;4341.370501277329;4358.760268185249;4402.471703395613;4406.845760398371;4967.683563855581;4996.500349964975;5016.247562865563;5027.472115427864;5067.265246539268;3702.4446333049987;3710.77735335878;3728.422094575345;3735.122246272124;3742.9438558421643;5119.360079990001;5307.4161842196945;5311.920321195185;5318.946810531884;5377.333026761717;3627.6553727395853;3629.4555816627717;3640.690541303966;3653.1232504199334;3658.32321020612;3699.7595156314756;3719.237556300952;3728.8881333560034;3735.626437356297;3737.9626203738158;4069.369247766601;4234.449521562239;4255.5318914919335;4268.253055715238;4279.465066866642;5076.898462030738;5101.413337466165;5107.259447380109;5107.693538387709;5107.770150343244;1285.6400207941792;1299.636101891472;1305.4973835073565;1308.653206900172;1316.1642357103308;825.3273582030746;844.1263292492364;859.565919210807;870.5386145342978;890.5814267294361;4452.352629527096;4461.531539188403;4473.843415480443;4482.663800214932;4487.640988720895;5169.353830771153;5177.637565370388;5183.481651834786;5195.428502864682;5243.895122097613;4315;4381.978090109529;4456.910861782746;4461.219286624892;4473.2842745160615;2737.7399147080996;2765.4607351566656;2771.5011297966157;2772.6672799263815;2773.3898542320658;4820.276958456259;4880.267959805987;4882.218844984785;4886.853394398174;4908.730019848943;5152.330197074356;5273.156294992783;5281.762320695578;5292.973535132377;5403.621746477709;4944.579710724629;4972.303877457087;4994.9750251248515;4997.9750101249265;5005.273180752634;5232.869178270574;5288.2860813791185;5289.153735402318;5364.275822763877;5377.354717433933;4877.195262781602;5169.379674439091;5177.2492988515705;5177.896442071213;5188.22176673502;4919.704817710949;4928.137575924271;4934.125032487632;4934.851954441229;4961.3798275215595;3667.889963301105;3670.541182352206;3677.742558020913;3681.484592157047;3687.870924517629;5149.407818100966;5252.737363131751;5276.841694749163;5298.947010529845;5307.708076055854;5069.898602028013;5080.923786143285;5086.135356989246;5102;5104;5089.51649593288;5101.7194054327365;5124.154514505214;5135.024345374367;5158.819441319536;4919.532644398776;5045.672031317952;5046.1926091825135;5060.102461576908;5098.745062746922;4897.363342765418;4950.306957025947;5121.769520371667;5140.228965655182;5140.3831540215415;4998.950010499849;5011.7494125294315;5022.347094877642;5023.899522009612;5047.697138171575 06:20:34 INFO - PROCESS | 6333 | |5;yui.html;623.6632218601954;654.6235914349247;676.5669971218418;716.0762616225069;726.9241522546631;12499.625011249665;13001.284929328884;13710.725785484285;13719.245441500701;13731.382087806047;13039.543615973444;13075.934620326909;13190.142640728345;13198.406071726795;13206.867931320683;617.4597227426002;753.3370633842238;769.0847891009709;779.0612312163857;787.8818177273398;779.6998155710036;785.1049803224329;786.5320134519951;787.4763282417185;788.0897563314381;805.6616221187086;807.6527093349857;808.3412019204359;808.4583329169441;808.8180159464102;642.1651852591659;783.5768684910141;799.9000124984377;806.310604433207;812.1634716242221;593.0718425663822;593.6349145275667;593.7743657410157;594.0109717320656;594.4382558482235;12499.125061245717;12502.124851260416;12509.874901250962;12513.93743031288;12525.185862918972;12337;12559.183653062613;12859.614211573667;12860.228386296852;12915.67710807228;11747.94126029373;11853.170278080537;12000.69998250042;12082;12502.437390317458;3936.3898595717424;3944.9013774655577;4017.4978127734034;4095.1604920991126;4100.282450571138;59961;60162.69918650422;60467.395326046615;60760;60803.08795368117;9918.206543476505;9941.105300522842;9964.501774911225;9978.401295922267;10059.245556583286;18910.149043293084;18950.24199032023;18961.90519047396;18964.965605503054;18993.145308460877;6805.455563554904;6850.4862135340045;6864.862702745917;6883.965580172067;7005.929940700527;3529.8941031769086;3605.6394360563736;3642.453631955228;3660.9450858237146;3851.9614803852164;2745.6018877263086;2866;2872.4255148970287;2873.2960424696084;2878.294817769618;484.75277608419253;486.5256375034384;499.9325091112726;500.57201093065635;505.56016265848945;499.0119563264756;550.2653956967494;551.6386766667839;573.8192469372134;582.9183914252009;7475.252474752481;7660.80847978805;7763.534187948741;9421.481818500048;9457.90542094584;521.9582433405394;523.5524515590491;538.4385282680258;601.750273636436;615.2647586134526;3865.729398942103;4058.817353219112;4088.0173116038695;4176.707630465899;4341.088371442032;89049.55475222583;91702;92964;95876;96078;47894.28158577624;48028.63113586396;48787.51212487901;49047;81528;46892.999999999316;48163.759181203866;71124;73390;75075;9268.675596354095;9355.719328420158;9536.380135291183;9567.856482152634;9704.2721795867;43474;43781.56218437902;45132;46708.53291467178;47749;64940;65373;65375.34624653692;65565.34434655783;66281.66859165674;10811.837822432513;10917.181211409017;11145.440321638436;11444.599439019594;12006.75986480283;12372.381380930738;12861.549845755353;12918.935405322913;13186.340682965621;13439.328033598476;11312.9434352831;11430.314181149157;12129.75740485203;12829.807552886528;12916.547920823103;11557.942210288895;11795.820417958135;11875.406229688653;11904.523819047141;12000.819987700366;11800.881991180322;11805.76388472243;12501.624951251477;12561.37193140321;13187.274699891597;9846.310758246855;9925.950370248103;9978.700638980843;10114.696559103239;10118.8482172766;10344.844827327746;10423.530941107516;10428.923467576931;10469.895301046892;10510.159187264848 06:20:34 INFO - PROCESS | 6333 | __end_tp_report 06:20:34 INFO - PROCESS | 6333 | __start_cc_report 06:20:34 INFO - PROCESS | 6333 | _x_x_mozilla_cycle_collect,1088 06:20:34 INFO - PROCESS | 6333 | __end_cc_report 06:20:34 INFO - PROCESS | 6333 | __startTimestamp1468934434076__endTimestamp 06:20:34 INFO - PROCESS | 6333 | 06:20:34 INFO - PROCESS | 6333 | ------- Summary: start ------- 06:20:34 INFO - PROCESS | 6333 | Number of tests: 6 06:20:34 INFO - PROCESS | 6333 | 06:20:34 INFO - PROCESS | 6333 | [#0] dojo.html Cycles:165 Average:4700.39 Median:4820.73 stddev:486.71 (10.1%) stddev-sans-first:460.55 06:20:34 INFO - PROCESS | 6333 | Values: 2638.9 2652.0 2682.7 2690.8 2692.9 4563.1 4645.5 4700.8 4781.6 4850.2 4656.3 4695.9 4704.7 4710.2 4717.6 4084.6 4265.3 4364.9 4392.2 4399.9 4307.4 4342.8 4360.0 4369.9 4399.4 4290.4 4337.9 4341.1 4374.2 4374.7 4316.1 4329.5 4330.5 4369.2 4382.2 4366.9 4379.4 4390.6 4425.2 4435.8 4540.6 4666.6 4669.8 4747.2 4753.0 5124.1 5130.8 5166.3 5176.4 5196.1 5184.3 5189.7 5227.1 5228.8 5231.5 4602.7 4717.5 4767.6 4770.8 4799.2 5201.0 5233.6 5234.3 5288.2 5294.9 4846.0 5015.8 5020.8 5076.3 5076.7 4937.9 4978.4 4981.0 4998.0 5014.8 4972.0 4975.0 4975.2 4990.2 5023.7 4946.1 4964.2 4985.1 4988.3 5033.4 4374.4 4407.7 4413.7 4420.5 4472.2 3831.5 3837.5 3845.8 3871.9 3880.3 4337.2 4455.1 4455.8 4467.2 4512.8 5023.3 5051.6 5058.9 5066.3 5087.3 4378.1 4389.6 4391.4 4396.4 4435.6 4519.8 4566.3 4611.1 4612.3 4643.6 4796.1 4799.2 4816.5 4820.7 4882.0 5110.8 5111.8 5114.7 5123.7 5170.0 4673.0 4679.5 4696.1 4801.9 4860.9 4911.0 4929.1 4933.4 4935.0 4975.6 4984.7 5015.8 5016.0 5016.5 5055.8 4794.0 4924.5 4932.7 4964.3 4992.2 5017.2 5029.1 5035.6 5038.5 5084.7 4949.6 4967.1 4975.6 5012.6 5028.0 4878.5 4940.6 4991.0 5027.6 5067.7 4920.5 4959.7 4960.9 4963.4 5010.3 06:20:34 INFO - PROCESS | 6333 | 06:20:34 INFO - PROCESS | 6333 | [#1] ext.html Cycles:180 Average:47462.76 Median:19232.07 stddev:86640.86 (450.5%) stddev-sans-first:86812.35 06:20:34 INFO - PROCESS | 6333 | Values: 564.7 581.1 584.9 593.6 605.2 38977.2 40632.4 40646.4 40770.8 44184.0 41500.6 42037.8 42077.4 42077.6 42086.6 7553.7 7753.6 7755.4 7915.2 8053.0 7709.6 10155.1 10428.8 10430.8 10779.2 10487.1 10546.0 10551.7 10554.2 10554.4 7606.3 10184.1 10316.5 10377.1 10389.4 9897.7 10258.5 10307.8 10323.1 10331.5 35949.1 36279.2 36334.3 36334.5 36411.5 3151.8 3152.8 3368.4 3510.0 3686.0 28278.0 28752.9 29293.4 29414.4 29632.6 3496.8 3519.4 3559.0 3565.8 3646.6 248196.0 248277.0 249000.0 249067.0 249767.0 51797.5 52050.5 52085.5 52176.7 52210.7 32702.7 33528.8 33633.5 35749.6 35821.1 15331.2 15383.8 15493.5 15497.8 15573.8 10627.4 11575.4 11742.7 11802.6 11903.9 18285.9 18308.8 18318.7 18377.0 18417.4 6583.9 6653.7 6666.9 6668.7 6983.2 820.5 877.2 951.7 957.5 973.4 27816.3 27953.0 28020.3 28111.7 28138.0 901.7 922.9 942.4 948.5 954.0 15058.2 15070.2 15213.5 15251.2 15351.4 395781.0 400257.0 401015.0 401261.0 401527.0 49426.8 49805.0 49885.5 49889.3 49908.5 1147.2 1192.3 1211.4 1215.1 1232.2 27237.6 28643.9 28688.0 29026.3 29217.4 41476.6 42158.6 42201.4 42209.2 42243.4 319666.0 321228.0 322039.0 322154.0 322512.0 24313.4 25519.6 25552.0 25553.4 25580.5 40104.4 40549.6 41194.4 42032.8 42064.4 34794.8 35209.0 35640.1 35894.0 36091.3 34967.3 35603.3 35643.3 35696.8 36128.3 34690.5 35024.3 35158.1 35249.8 35335.5 29316.6 31979.8 32299.7 32381.7 32636.7 24156.9 24451.1 24710.6 25130.5 25216.1 06:20:34 INFO - PROCESS | 6333 | 06:20:34 INFO - PROCESS | 6333 | [#2] jquery.html Cycles:180 Average:24408.50 Median:24854.20 stddev:66243.98 (266.5%) stddev-sans-first:66405.18 06:20:34 INFO - PROCESS | 6333 | Values: 350.6 374.4 379.8 380.4 390.8 13037.3 13530.1 16196.4 17334.1 17426.2 15864.0 16869.4 16949.2 17202.5 17220.3 4934.9 5091.0 5127.4 5132.9 5134.5 3797.1 5733.8 6031.2 6033.1 6152.1 5209.7 6065.1 6082.1 6120.2 6126.1 5461.0 5557.3 5568.1 5577.4 5587.6 5235.8 5409.1 5410.8 5419.0 5430.9 11806.4 12318.4 12397.6 12422.9 12544.7 1937.1 1960.8 1973.6 1980.2 1992.3 8960.0 9207.6 9374.6 9386.2 9418.8 1715.0 1759.1 1801.3 1811.5 1827.3 45204.0 58255.4 60786.2 66897.0 69144.7 9504.2 9521.9 9872.7 10218.3 10294.2 13908.7 14032.9 14100.0 14127.8 14133.9 7240.2 7267.5 7404.5 7476.8 7496.7 6941.5 7035.6 7064.3 7169.5 7259.2 4375.2 4464.1 4489.6 4504.4 4559.3 1813.4 1814.5 1838.2 1868.2 1882.5 768.9 817.2 836.3 870.4 911.1 16579.2 16999.7 17463.7 17720.2 17795.5 803.0 840.6 856.9 864.6 873.5 6103.7 9624.2 9817.8 9823.1 9947.6 394636.0 401581.0 402652.0 403986.0 407058.0 77234.2 77599.0 77776.6 78244.6 80819.0 891.0 925.6 940.0 961.5 962.1 15588.8 15654.1 15687.8 15700.8 16099.2 35618.5 38033.4 38676.2 39598.4 40416.0 52475.5 53368.7 54786.5 54861.7 55013.0 7484.0 7746.8 7752.2 7792.2 8113.3 11241.7 11946.2 12256.1 12381.6 12493.9 10558.9 10617.5 10673.2 10683.9 10830.8 10327.7 10960.2 11010.3 11140.4 11184.7 10505.0 10779.4 10790.0 10890.1 10984.7 7783.3 7825.8 7826.8 7888.9 8109.4 8946.9 11048.2 11063.4 11099.1 11134.9 06:20:34 INFO - PROCESS | 6333 | 06:20:34 INFO - PROCESS | 6333 | [#3] mootools.html Cycles:180 Average:5170.88 Median:5647.02 stddev:2868.48 (50.8%) stddev-sans-first:2861.38 06:20:34 INFO - PROCESS | 6333 | Values: 1248.3 1346.4 1416.4 1486.9 1720.2 6671.7 7327.6 7511.7 7542.9 7720.2 7595.8 7705.3 7721.1 7725.2 7743.1 2178.2 2201.4 2203.1 2207.0 2207.3 2143.6 2155.5 2215.4 2216.1 2216.9 2174.9 2187.0 2193.6 2194.8 2222.0 2150.2 2151.7 2152.6 2155.2 2159.1 2100.5 2146.4 2147.1 2156.8 2162.3 7528.4 7705.7 7736.2 7746.3 7840.6 4495.0 4569.1 4574.0 4585.2 4585.9 2781.4 2862.1 2898.8 2908.2 2912.8 913.4 915.1 930.3 944.5 948.5 10697.7 10851.5 10854.5 10878.2 10891.2 3984.9 4106.4 4199.1 4199.5 4241.8 8524.9 8577.4 8582.1 8589.4 8594.2 4681.0 4687.5 4696.0 4697.3 4700.6 3813.2 3954.3 4284.7 4284.8 4292.0 3505.1 3567.6 3617.8 3641.3 3647.8 1058.3 1094.8 1096.5 1102.1 1111.0 719.9 803.3 889.7 892.9 907.6 5163.2 5424.5 5470.2 5498.0 5646.2 832.4 836.1 851.6 886.5 920.3 3822.8 3873.4 3885.0 3890.7 3942.2 9432.1 9577.0 9592.5 9697.0 9704.0 9594.7 9607.9 9619.3 9627.7 9632.9 6989.1 7350.6 7467.3 7472.8 7484.3 5537.8 5647.8 5655.9 5683.6 5789.9 8954.0 8957.8 8958.9 9029.2 9069.3 7725.7 8776.8 9238.8 9249.0 9270.4 6528.7 6768.1 6795.8 6965.8 6978.9 7591.4 7630.8 7651.9 7661.9 7684.1 6795.0 6870.1 6902.9 6991.5 7003.9 6776.9 6802.7 6856.9 6933.1 7077.3 6554.7 6602.0 6644.0 6656.9 6662.3 4633.1 4705.2 4714.7 4741.6 4759.4 4871.0 4919.0 4925.5 4963.1 5018.5 06:20:34 INFO - PROCESS | 6333 | 06:20:34 INFO - PROCESS | 6333 | [#4] prototype.html Cycles:180 Average:4227.68 Median:4884.54 stddev:1228.74 (25.2%) stddev-sans-first:1196.26 06:20:34 INFO - PROCESS | 6333 | Values: 297.6 298.1 306.1 306.9 308.9 4891.8 4899.0 4903.9 4952.6 4954.8 4844.0 4864.7 4894.8 4901.8 4906.2 3628.5 3733.7 3749.7 3775.5 3829.9 3778.4 3810.3 3821.8 3843.5 3844.4 3776.0 3779.6 3801.7 3832.2 3833.6 3625.6 3710.1 3780.7 3802.5 3827.3 3374.8 3381.4 3400.5 3402.6 3403.4 4730.0 4757.0 4764.3 4775.9 4775.9 4213.2 4341.4 4358.8 4402.5 4406.8 4967.7 4996.5 5016.2 5027.5 5067.3 3702.4 3710.8 3728.4 3735.1 3742.9 5119.4 5307.4 5311.9 5318.9 5377.3 3627.7 3629.5 3640.7 3653.1 3658.3 3699.8 3719.2 3728.9 3735.6 3738.0 4069.4 4234.4 4255.5 4268.3 4279.5 5076.9 5101.4 5107.3 5107.7 5107.8 1285.6 1299.6 1305.5 1308.7 1316.2 825.3 844.1 859.6 870.5 890.6 4452.4 4461.5 4473.8 4482.7 4487.6 5169.4 5177.6 5183.5 5195.4 5243.9 4315.0 4382.0 4456.9 4461.2 4473.3 2737.7 2765.5 2771.5 2772.7 2773.4 4820.3 4880.3 4882.2 4886.9 4908.7 5152.3 5273.2 5281.8 5293.0 5403.6 4944.6 4972.3 4995.0 4998.0 5005.3 5232.9 5288.3 5289.2 5364.3 5377.4 4877.2 5169.4 5177.2 5177.9 5188.2 4919.7 4928.1 4934.1 4934.9 4961.4 3667.9 3670.5 3677.7 3681.5 3687.9 5149.4 5252.7 5276.8 5298.9 5307.7 5069.9 5080.9 5086.1 5102.0 5104.0 5089.5 5101.7 5124.2 5135.0 5158.8 4919.5 5045.7 5046.2 5060.1 5098.7 4897.4 4950.3 5121.8 5140.2 5140.4 4999.0 5011.7 5022.3 5023.9 5047.7 06:20:34 INFO - PROCESS | 6333 | 06:20:34 INFO - PROCESS | 6333 | [#5] yui.html Cycles:180 Average:16705.49 Median:48096.20 stddev:22700.99 (47.2%) stddev-sans-first:22732.55 06:20:34 INFO - PROCESS | 6333 | Values: 623.7 654.6 676.6 716.1 726.9 12499.6 13001.3 13710.7 13719.2 13731.4 13039.5 13075.9 13190.1 13198.4 13206.9 617.5 753.3 769.1 779.1 787.9 779.7 785.1 786.5 787.5 788.1 805.7 807.7 808.3 808.5 808.8 642.2 783.6 799.9 806.3 812.2 593.1 593.6 593.8 594.0 594.4 12499.1 12502.1 12509.9 12513.9 12525.2 12337.0 12559.2 12859.6 12860.2 12915.7 11747.9 11853.2 12000.7 12082.0 12502.4 3936.4 3944.9 4017.5 4095.2 4100.3 59961.0 60162.7 60467.4 60760.0 60803.1 9918.2 9941.1 9964.5 9978.4 10059.2 18910.1 18950.2 18961.9 18965.0 18993.1 6805.5 6850.5 6864.9 6884.0 7005.9 3529.9 3605.6 3642.5 3660.9 3852.0 2745.6 2866.0 2872.4 2873.3 2878.3 484.8 486.5 499.9 500.6 505.6 499.0 550.3 551.6 573.8 582.9 7475.3 7660.8 7763.5 9421.5 9457.9 522.0 523.6 538.4 601.8 615.3 3865.7 4058.8 4088.0 4176.7 4341.1 89049.6 91702.0 92964.0 95876.0 96078.0 47894.3 48028.6 48787.5 49047.0 81528.0 46893.0 48163.8 71124.0 73390.0 75075.0 9268.7 9355.7 9536.4 9567.9 9704.3 43474.0 43781.6 45132.0 46708.5 47749.0 64940.0 65373.0 65375.3 65565.3 66281.7 10811.8 10917.2 11145.4 11444.6 12006.8 12372.4 12861.5 12918.9 13186.3 13439.3 11312.9 11430.3 12129.8 12829.8 12916.5 11557.9 11795.8 11875.4 11904.5 12000.8 11800.9 11805.8 12501.6 12561.4 13187.3 9846.3 9926.0 9978.7 10114.7 10118.8 10344.8 10423.5 10428.9 10469.9 10510.2 06:20:34 INFO - PROCESS | 6333 | -------- Summary: end -------- 06:20:34 INFO - PROCESS | 6333 | 06:20:34 INFO - TEST-INFO | 6333: exit 0 06:20:34 INFO - TEST-OK | dromaeo_css | took 1119779ms 06:20:34 INFO - TEST-START | kraken 06:20:34 INFO - operating with platform_type : linux_ 06:20:34 INFO - Initialising browser for kraken test... 06:20:34 INFO - TEST-INFO | started process 6521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUPAVCT/profile http://localhost:46946/getInfo.html) 06:20:39 INFO - PROCESS | 6521 | __metrics Screen width/height:1600/1200 06:20:39 INFO - PROCESS | 6521 | colorDepth:24 06:20:39 INFO - PROCESS | 6521 | Browser inner width/height: 1024/697 06:20:39 INFO - PROCESS | 6521 | __metrics 06:20:40 INFO - PROCESS | 6521 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:20:40 INFO - PROCESS | 6521 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:20:41 INFO - TEST-INFO | 6521: exit 0 06:20:41 INFO - Browser initialized. 06:20:41 INFO - Running cycle 1/1 for kraken test... 06:20:41 INFO - TEST-INFO | started process 6599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUPAVCT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:53 INFO - PROCESS | 6599 | RSS: Main: 158789632 06:20:53 INFO - PROCESS | 6599 | 06:20:55 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46946/tests/kraken/driver.html?testName=audio-beat-detection) 06:20:56 INFO - PROCESS | 6599 | RSS: Main: 217546752 06:20:56 INFO - PROCESS | 6599 | 06:20:59 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46946/tests/kraken/driver.html?testName=audio-dft) 06:21:00 INFO - PROCESS | 6599 | RSS: Main: 206479360 06:21:00 INFO - PROCESS | 6599 | 06:21:03 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46946/tests/kraken/driver.html?testName=audio-fft) 06:21:03 INFO - PROCESS | 6599 | RSS: Main: 271400960 06:21:03 INFO - PROCESS | 6599 | 06:21:06 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46946/tests/kraken/driver.html?testName=audio-oscillator) 06:21:06 INFO - PROCESS | 6599 | RSS: Main: 181780480 06:21:06 INFO - PROCESS | 6599 | 06:21:08 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46946/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:21:09 INFO - PROCESS | 6599 | RSS: Main: 185876480 06:21:09 INFO - PROCESS | 6599 | 06:21:12 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46946/tests/kraken/driver.html?testName=imaging-darkroom) 06:21:13 INFO - PROCESS | 6599 | RSS: Main: 222343168 06:21:13 INFO - PROCESS | 6599 | 06:21:16 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46946/tests/kraken/driver.html?testName=imaging-desaturate) 06:21:17 INFO - PROCESS | 6599 | RSS: Main: 223494144 06:21:17 INFO - PROCESS | 6599 | 06:21:20 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46946/tests/kraken/driver.html?testName=json-parse-financial) 06:21:20 INFO - PROCESS | 6599 | RSS: Main: 222846976 06:21:20 INFO - PROCESS | 6599 | 06:21:22 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46946/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:21:23 INFO - PROCESS | 6599 | RSS: Main: 212877312 06:21:23 INFO - PROCESS | 6599 | 06:21:25 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46946/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:21:25 INFO - PROCESS | 6599 | RSS: Main: 215965696 06:21:25 INFO - PROCESS | 6599 | 06:21:27 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46946/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:21:28 INFO - PROCESS | 6599 | RSS: Main: 213368832 06:21:28 INFO - PROCESS | 6599 | 06:21:31 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46946/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:21:31 INFO - PROCESS | 6599 | RSS: Main: 223653888 06:21:31 INFO - PROCESS | 6599 | 06:21:34 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46946/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:21:35 INFO - PROCESS | 6599 | RSS: Main: 225030144 06:21:35 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | Cycle 1(1): loaded http://localhost:46946/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46946/tests/kraken/driver.html?testName=ai-astar) 06:21:37 INFO - PROCESS | 6599 | RSS: Main: 267718656 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | __start_tp_report 06:21:37 INFO - PROCESS | 6599 | _x_x_mozilla_page_load 06:21:37 INFO - PROCESS | 6599 | _x_x_mozilla_page_load_details 06:21:37 INFO - PROCESS | 6599 | |i|pagename|runs| 06:21:37 INFO - PROCESS | 6599 | |0;ai-astar;104;115;114;115;115;113;113;113;114;112 06:21:37 INFO - PROCESS | 6599 | |1;audio-beat-detection;145;129;128;195;125;124;147;120;183;122 06:21:37 INFO - PROCESS | 6599 | |2;audio-dft;161;161;160;162;161;162;161;162;161;161 06:21:37 INFO - PROCESS | 6599 | |3;audio-fft;77;75;75;112;76;77;75;75;99;76 06:21:37 INFO - PROCESS | 6599 | |4;audio-oscillator;85;87;112;85;85;86;124;84;86;122 06:21:37 INFO - PROCESS | 6599 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;118;117;116 06:21:37 INFO - PROCESS | 6599 | |6;imaging-darkroom;147;146;146;146;146;146;146;147;145;146 06:21:37 INFO - PROCESS | 6599 | |7;imaging-desaturate;94;94;95;95;95;95;95;95;95;95 06:21:37 INFO - PROCESS | 6599 | |8;json-parse-financial;65;62;62;62;63;64;63;63;63;71 06:21:37 INFO - PROCESS | 6599 | |9;json-stringify-tinderbox;66;65;65;65;66;66;66;69;66;66 06:21:37 INFO - PROCESS | 6599 | |10;stanford-crypto-aes;78;78;81;79;79;87;78;84;78;85 06:21:37 INFO - PROCESS | 6599 | |11;stanford-crypto-ccm;128;127;128;135;126;127;128;133;169;133 06:21:37 INFO - PROCESS | 6599 | |12;stanford-crypto-pbkdf2;163;166;164;165;164;169;164;165;169;162 06:21:37 INFO - PROCESS | 6599 | |13;stanford-crypto-sha256-iterative;67;66;73;67;65;66;66;67;65;65 06:21:37 INFO - PROCESS | 6599 | __end_tp_report 06:21:37 INFO - PROCESS | 6599 | __start_cc_report 06:21:37 INFO - PROCESS | 6599 | _x_x_mozilla_cycle_collect,1946 06:21:37 INFO - PROCESS | 6599 | __end_cc_report 06:21:37 INFO - PROCESS | 6599 | __startTimestamp1468934497398__endTimestamp 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | ------- Summary: start ------- 06:21:37 INFO - PROCESS | 6599 | Number of tests: 14 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.26 (2.9%) stddev-sans-first:1.09 06:21:37 INFO - PROCESS | 6599 | Values: 104.0 115.0 114.0 115.0 115.0 113.0 113.0 113.0 114.0 112.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:137.00 stddev:26.64 (19.4%) stddev-sans-first:28.23 06:21:37 INFO - PROCESS | 6599 | Values: 145.0 129.0 128.0 195.0 125.0 124.0 147.0 120.0 183.0 122.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:21:37 INFO - PROCESS | 6599 | Values: 161.0 161.0 160.0 162.0 161.0 162.0 161.0 162.0 161.0 161.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.94 (17.0%) stddev-sans-first:13.61 06:21:37 INFO - PROCESS | 6599 | Values: 77.0 75.0 75.0 112.0 76.0 77.0 75.0 75.0 99.0 76.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:85.00 stddev:16.67 (19.6%) stddev-sans-first:17.24 06:21:37 INFO - PROCESS | 6599 | Values: 85.0 87.0 112.0 85.0 85.0 86.0 124.0 84.0 86.0 122.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 06:21:37 INFO - PROCESS | 6599 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 118.0 117.0 116.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 06:21:37 INFO - PROCESS | 6599 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:21:37 INFO - PROCESS | 6599 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:63.00 stddev:2.70 (4.3%) stddev-sans-first:2.83 06:21:37 INFO - PROCESS | 6599 | Values: 65.0 62.0 62.0 62.0 63.0 64.0 63.0 63.0 63.0 71.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:1.15 (1.7%) stddev-sans-first:1.22 06:21:37 INFO - PROCESS | 6599 | Values: 66.0 65.0 65.0 65.0 66.0 66.0 66.0 69.0 66.0 66.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:3.40 (4.3%) stddev-sans-first:3.46 06:21:37 INFO - PROCESS | 6599 | Values: 78.0 78.0 81.0 79.0 79.0 87.0 78.0 84.0 78.0 85.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:130.50 stddev:12.89 (9.9%) stddev-sans-first:13.52 06:21:37 INFO - PROCESS | 6599 | Values: 128.0 127.0 128.0 135.0 126.0 127.0 128.0 133.0 169.0 133.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.00 stddev:2.33 (1.4%) stddev-sans-first:2.35 06:21:37 INFO - PROCESS | 6599 | Values: 163.0 166.0 164.0 165.0 164.0 169.0 164.0 165.0 169.0 162.0 06:21:37 INFO - PROCESS | 6599 | 06:21:37 INFO - PROCESS | 6599 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:2.36 (3.5%) stddev-sans-first:2.50 06:21:37 INFO - PROCESS | 6599 | Values: 67.0 66.0 73.0 67.0 65.0 66.0 66.0 67.0 65.0 65.0 06:21:37 INFO - PROCESS | 6599 | -------- Summary: end -------- 06:21:37 INFO - PROCESS | 6599 | 06:21:38 INFO - TEST-INFO | 6599: exit 0 06:21:38 INFO - TEST-OK | kraken | took 63634ms 06:21:38 INFO - SUITE-END | took 1183s 06:21:38 INFO - Completed test suite (00:19:43) 06:21:38 INFO - javascript benchmark 06:21:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2638.8680565971695, 2651.973480265197, 2682.731726827317, 2690.8116431849767, 2692.90574829881, 4563.087382523492, 4645.488996210414, 4700.764961751912, 4781.641376896733, 4850.223964165734, 4656.254999200129, 4695.859124226278, 4704.6706730528795, 4710.152172608929, 4717.575418212369, 4084.5915408459214, 4265.338872474764, 4364.912701745963, 4392.187445322609, 4399.890002749941, 4307.440032795732, 4342.848000319989, 4360.0, 4369.868903932887, 4399.406080179167, 4290.442242508454, 4337.9132417351475, 4341.066670665822, 4374.19077470669, 4374.737515749065, 4316.136772645484, 4329.480462344539, 4330.480342358906, 4369.213541562517, 4382.211201983641, 4366.934495982531, 4379.408779814716, 4390.582894625006, 4425.247707889666, 4435.822567097344, 4540.568645978659, 4666.626669866402, 4669.836555720533, 4747.240441529373, 4753.0, 5124.0776660201145, 5130.846074617767, 5166.328377310963, 5176.352955880515, 5196.090684130262, 5184.274201611777, 5189.6886186828915, 5227.111391063529, 5228.843134705965, 5231.450697676765, 4602.654800889946, 4717.481077081518, 4767.61859051275, 4770.76146192689, 4799.184138696361, 5200.97399513, 5233.581313494911, 5234.319538459976, 5288.153895376799, 5294.92057619136, 4845.95154048455, 5015.82444614444, 5020.824271150492, 5076.340075790124, 5076.670016448919, 4937.876553086202, 4978.427480839678, 4981.0, 4997.950020499821, 5014.774335154927, 4971.975140124277, 4975.0, 4975.179095449211, 4990.226514890198, 5023.6985780853265, 4946.109700253917, 4964.230544265644, 4985.102681517362, 4988.326575912278, 5033.446320904697, 4374.387585737999, 4407.669424793154, 4413.668974826901, 4420.535843736426, 4472.217361961643, 3831.5210598675167, 3837.4819399380726, 3845.8461661533224, 3871.864484743077, 3880.262750077476, 4337.1976184405985, 4455.064436468378, 4455.77721113943, 4467.195904737178, 4512.75179865104, 5023.346964894614, 5051.570616497639, 5058.924116138261, 5066.341375621146, 5087.31321271631, 4378.124375124924, 4389.561043895585, 4391.407160033418, 4396.428464299621, 4435.578620031092, 4519.774011299488, 4566.292224705176, 4611.054733779567, 4612.262038073892, 4643.628509719214, 4796.112719146969, 4799.1601469743355, 4816.494268101939, 4820.734859582757, 4882.048000639841, 5110.795568177231, 5111.846644600668, 5114.74426278692, 5123.692578445156, 5170.0, 4672.976635116938, 4679.46186188579, 4696.131215725101, 4801.879953001063, 4860.854174374775, 4910.975445122752, 4929.112759703145, 4933.383327084114, 4934.9753251233515, 4975.626827987843, 4984.700917944935, 5015.84952451427, 5015.97172579613, 5016.473270306711, 5055.797768089235, 4794.0, 4924.507549245047, 4932.654714169974, 4964.304997300453, 4992.151334273255, 5017.172166592617, 5029.119904016856, 5035.597152227886, 5038.521340472649, 5084.720340381315, 4949.57928576075, 4967.081089998362, 4975.601951843916, 5012.649114561946, 5028.044671512547, 4878.463369029333, 4940.555350018516, 4991.0, 5027.622928280467, 5067.695938243717, 4920.45874953762, 4959.677620954626, 4960.8759781005765, 4963.354763880672, 5010.348654674869], "value": 4669.849296205813, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.7091063013512, 581.1428143488355, 584.9268841394826, 593.5904226083999, 605.2494906316167, 38977.22045559087, 40632.39051414231, 40646.390304145425, 40770.796146019304, 44184.0, 41500.58499415005, 42037.78981105098, 42077.36883946743, 42077.57922420775, 42086.57913420865, 7553.660085296175, 7753.573553454557, 7755.418343624223, 7915.2084791520965, 8053.0, 7709.575973321465, 10155.136813370873, 10428.843567346496, 10430.843537346946, 10779.245452818306, 10487.10859576933, 10546.0, 10551.73620659482, 10554.155667546616, 10554.366737995706, 7606.315431611126, 10184.134348580379, 10316.535755891004, 10377.066064054272, 10389.376637401741, 9897.703068907944, 10258.487075646188, 10307.84538231927, 10323.070923616911, 10331.48342582868, 35949.1012724684, 36279.18604069786, 36334.27331453383, 36334.454983175274, 36411.4538281926, 3151.842407879597, 3152.8265945372996, 3368.3936891359544, 3510.0226245464073, 3686.041629176407, 28278.0, 28752.856235718897, 29293.414131717458, 29414.411711765857, 29632.555511667128, 3496.842642081087, 3519.436890097598, 3559.0, 3565.8038807865555, 3646.58064322601, 248196.0, 248277.0, 249000.0, 249067.0, 249767.0, 51797.48202518002, 52050.47949520456, 52085.47914520806, 52176.739116304176, 52210.73894630503, 32702.672973270437, 33528.832355838065, 33633.49549756756, 35749.64250357463, 35821.1044723884, 15331.156786376634, 15383.769243461356, 15493.535193944199, 15497.84502154964, 15573.844261557466, 10627.415492147851, 11575.363355015555, 11742.70643233909, 11802.5869094583, 11903.940480297542, 18285.90857045733, 18308.816911830712, 18318.725219121723, 18377.0, 18417.355392561196, 6583.9012414813815, 6653.73385064592, 6666.933330666631, 6668.66626674667, 6983.162020557464, 820.4707963363597, 877.241186373782, 951.7049714588361, 957.4877440569262, 973.3673112476947, 27816.304592384946, 27953.0, 28020.299492512444, 28111.71888281091, 28138.0, 901.715959472764, 922.9123233292827, 942.4298299528823, 948.4783369146942, 953.9713808585753, 15058.247087645574, 15070.171140587154, 15213.467528636445, 15251.161186134868, 15351.385944562317, 395781.0, 400257.0, 401015.0, 401261.0, 401527.0, 49426.75286623616, 49805.0, 49885.50114498881, 49889.25166122511, 49908.500914990385, 1147.17976646698, 1192.3025030357337, 1211.4003568233782, 1215.1311812054423, 1232.186756740547, 27237.591436128077, 28643.856780715963, 28688.0, 29026.27434314159, 29217.41565168642, 41476.58523414727, 42158.578414215466, 42201.36697949595, 42209.15581688288, 42243.3663495054, 319666.0, 321228.0, 322039.0, 322154.0, 322512.0, 24313.39216519601, 25519.617205741557, 25552.0, 25553.361165971, 25580.488390232462, 40104.39843402409, 40549.594504054585, 41194.38208426936, 42032.78983605062, 42064.369034463896, 34794.82602586971, 35209.0, 35640.10899727424, 35894.0, 36091.27817443689, 34967.30065398729, 35603.287934241685, 35643.28713425769, 35696.821515892254, 36128.27743445169, 34690.47964280588, 35024.29951401009, 35158.12104697403, 35249.82375088108, 35335.469967951016, 29316.560251595816, 31979.84010079935, 32299.677003229666, 32381.676183238807, 32636.673633263363, 24156.87921560381, 24451.14420995328, 24710.629340560266, 25130.497390052464, 25216.117435889657], "value": 17889.464803670155, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.63183657159976, 374.4009584664537, 379.8328735356444, 380.40466669661976, 390.7655406755947, 13037.28294943779, 13530.120542164765, 16196.433124840632, 17334.133293335315, 17426.215820288086, 15864.0, 16869.40957066503, 16949.152542372893, 17202.483925482225, 17220.311187552485, 4934.925976110352, 5090.974545127269, 5127.384713834345, 5132.8973420531565, 5134.512221338967, 3797.14564223049, 5733.827985160452, 6031.185789918371, 6033.125196846455, 6152.107944348067, 5209.7134657593815, 6065.090236464522, 6082.118092876531, 6120.234970628671, 6126.081087836816, 5460.989716902366, 5557.3331200255825, 5568.109102543614, 5577.442255774431, 5587.608867379285, 5235.764390602432, 5409.134538473825, 5410.810621628224, 5419.024575576394, 5430.91853622196, 11806.350650714206, 12318.384080795924, 12397.62807115788, 12422.875771242352, 12544.686382840411, 1937.1476550317957, 1960.8235258826774, 1973.58554703511, 1980.1683293016968, 1992.262862740795, 8960.0, 9207.58565864531, 9374.625014999392, 9386.155246027822, 9418.764530886714, 1715.0, 1759.1468137953082, 1801.3335066025654, 1811.5108920591367, 1827.269092363052, 45204.0, 58255.41744582542, 60786.19090458648, 66897.0, 69144.6542767288, 9504.239660827117, 9521.857172142423, 9872.654457093968, 10218.335808172445, 10294.176465882862, 13908.652283692989, 14032.85967140336, 14100.0, 14127.78808317876, 14133.85866141346, 7240.239774823673, 7267.527610705287, 7404.481686282016, 7476.813079673052, 7496.700131994659, 6941.47938904574, 7035.577865328097, 7064.293570642894, 7169.519050593379, 7259.201487836333, 4375.234333991539, 4464.129494748493, 4489.573490518461, 4504.391907092566, 4559.338895860148, 1813.384935339564, 1814.510082277804, 1838.2279442634126, 1868.2060124447055, 1882.4823173627362, 768.8692922203239, 817.1746535998566, 836.2640876029177, 870.3515880668942, 911.1253196930888, 16579.17104144788, 16999.660006799793, 17463.738043929352, 17720.20259088344, 17795.46613601594, 802.9847921056396, 840.5755093677653, 856.8629019356997, 864.5763575847915, 873.4977388001925, 6103.6948152592195, 9624.181944534794, 9817.754556136153, 9823.115919567274, 9947.602095916081, 394636.0, 401581.0, 402652.0, 403986.0, 407058.0, 77234.2276577227, 77599.0, 77776.61111694406, 78244.60877695575, 80819.0, 891.0421297105637, 925.5927391947522, 939.9624015039321, 961.5336561767538, 962.0860182826343, 15588.766168507254, 15654.060756354655, 15687.764683529527, 15700.76448853291, 16099.195040248174, 35618.46572301469, 38033.42949855699, 38676.226475470896, 39598.40602390909, 40416.0, 52475.47524524706, 53368.733156335526, 54786.45213547973, 54861.725691371284, 55013.0, 7484.0, 7746.767596972099, 7752.18602046777, 7792.18182090895, 8113.269805717514, 11241.66275011751, 11946.223495472766, 12256.080793940311, 12381.62855114348, 12493.93753031229, 10558.947205263925, 10617.469126543487, 10673.199510036624, 10683.94658026705, 10830.837537437103, 10327.690169294932, 10960.232783705063, 11010.339379637247, 11140.387278699749, 11184.720381990515, 10505.0, 10779.353238805697, 10790.0, 10890.128789696964, 10984.670459886216, 7783.338416234684, 7825.843483130192, 7826.804329891798, 7888.921110789048, 8109.3917956152345, 8946.910530894607, 11048.171387145836, 11063.391513466837, 11099.056580190774, 11134.944325278646], "value": 8191.2486786077425, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.3259040118337, 1346.3672074125159, 1416.3767942105474, 1486.8587484189004, 1720.1657196259812, 6671.699773510191, 7327.633618319082, 7511.6995320187125, 7542.924570754298, 7720.227977202277, 7595.848083038336, 7705.306522412981, 7721.073471183466, 7725.18885517021, 7743.0708315002275, 2178.172294528077, 2201.3506015725397, 2203.1297637433204, 2207.0289072807996, 2207.3267653365715, 2143.603433364825, 2155.5473350596394, 2215.3686199433164, 2216.1024784962115, 2216.9113235470563, 2174.8912554372296, 2186.967195492061, 2193.649016157415, 2194.7914948079906, 2222.022310183522, 2150.215171462413, 2151.655735082395, 2152.5910077085305, 2155.170259450107, 2159.082389984258, 2100.516881117336, 2146.431195733132, 2147.066026278558, 2156.827453803692, 2162.275637661385, 7528.435367347416, 7705.730299439493, 7736.187700291444, 7746.302832745024, 7840.647170877267, 4495.0, 4569.109023740372, 4574.0394517151435, 4585.243434833248, 4585.862424127282, 2781.4437112577566, 2862.1127450490417, 2898.7536059434974, 2908.1566345759707, 2912.7815413844046, 913.4291068082448, 915.0620613870769, 930.2929773372218, 944.4569372610777, 948.4925564822787, 10697.732556686067, 10851.457427128691, 10854.511546980404, 10878.184136189817, 10891.237613367068, 3984.880453586397, 4106.40457133714, 4199.076203235283, 4199.454070970754, 4241.766702831374, 8524.914750852537, 8577.356698247531, 8582.055973842873, 8589.355798315151, 8594.183552562497, 4681.0, 4687.460941991646, 4695.9530404695515, 4697.271922851964, 4700.623950084054, 3813.237352529505, 3954.307996100671, 4284.67864910133, 4284.828606855691, 4292.034292284274, 3505.1237190702323, 3567.6253993330847, 3617.81910904459, 3641.253543023674, 3647.76289541179, 1058.3015209961388, 1094.7700982793542, 1096.4791723931228, 1102.1127991966384, 1110.9833352499718, 719.9028131202325, 803.3211935914143, 889.675268526983, 892.8928528576482, 907.609727817045, 5163.199704045879, 5424.511793938565, 5470.206820011076, 5498.0, 5646.2377579027125, 832.433944917462, 836.1387770596295, 851.6040041380787, 886.5035580075179, 920.2821798996794, 3822.7897465639103, 3873.3996230584303, 3885.0441754253297, 3890.727649064595, 3942.211557688474, 9432.103950124727, 9577.042295770367, 9592.520373981273, 9696.95151524238, 9704.02959704038, 9594.664186753569, 9607.903920960702, 9619.326647134774, 9627.711168664951, 9632.9036709632, 6989.126359204997, 7350.5957172354965, 7467.253274672598, 7472.775816725507, 7484.326410622961, 5537.833864984057, 5647.802326918538, 5655.88688226225, 5683.5737319700365, 5789.884202316014, 8954.0, 8957.776055598662, 8958.92492900856, 9029.23251523628, 9069.274458043472, 7725.652345644572, 8776.824463510566, 9238.769030774016, 9249.0, 9270.351075424656, 6528.738850446119, 6768.052472653931, 6795.830104247236, 6965.756198533027, 6978.860422791414, 7591.3926885847895, 7630.7710768677025, 7651.923480765121, 7661.923380766121, 7684.077910650534, 6794.966025169842, 6870.072540207008, 6902.896456553055, 6991.510594258353, 7003.894941575983, 6776.898346524905, 6802.727890884309, 6856.897146542906, 6933.064036355229, 7077.327653872874, 6554.705038273194, 6602.042703807825, 6643.970184621391, 6656.900146497903, 6662.333766623493, 4633.096546173599, 4705.247160454311, 4714.66997310185, 4741.596964258077, 4759.42886853566, 4870.975645121894, 4919.0, 4925.507449255046, 4963.057019166346, 5018.4730603286125], "value": 4162.664971417428, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.64728796376295, 298.1383800815642, 306.1336417937237, 306.91252992897, 308.8502076492902, 4891.804327826887, 4898.951010489894, 4903.901921961563, 4952.554270115698, 4954.8018079276835, 4843.951560484403, 4864.7324397158145, 4894.804207831691, 4901.828436004741, 4906.19047857104, 3628.546431696038, 3733.7199710021723, 3749.6812770914366, 3775.509183806101, 3829.885103446887, 3778.3954567269243, 3810.2760475509704, 3821.8280177391944, 3843.5195600549932, 3844.4233364995334, 3776.0, 3779.622037796226, 3801.714871384643, 3832.156925476391, 3833.6358045985726, 3625.6011838697723, 3710.1281198918095, 3780.678642315379, 3802.5056742623283, 3827.311084004878, 3374.797512149279, 3381.374445727524, 3400.472926696366, 3402.6427225141497, 3403.3873902697505, 4729.9763501182615, 4756.9762151189025, 4764.2615394613895, 4775.856724298276, 4775.928361074587, 4213.241616509027, 4341.370501277329, 4358.760268185249, 4402.471703395613, 4406.845760398371, 4967.683563855581, 4996.500349964975, 5016.247562865563, 5027.472115427864, 5067.265246539268, 3702.4446333049987, 3710.77735335878, 3728.422094575345, 3735.122246272124, 3742.9438558421643, 5119.360079990001, 5307.4161842196945, 5311.920321195185, 5318.946810531884, 5377.333026761717, 3627.6553727395853, 3629.4555816627717, 3640.690541303966, 3653.1232504199334, 3658.32321020612, 3699.7595156314756, 3719.237556300952, 3728.8881333560034, 3735.626437356297, 3737.9626203738158, 4069.369247766601, 4234.449521562239, 4255.5318914919335, 4268.253055715238, 4279.465066866642, 5076.898462030738, 5101.413337466165, 5107.259447380109, 5107.693538387709, 5107.770150343244, 1285.6400207941792, 1299.636101891472, 1305.4973835073565, 1308.653206900172, 1316.1642357103308, 825.3273582030746, 844.1263292492364, 859.565919210807, 870.5386145342978, 890.5814267294361, 4452.352629527096, 4461.531539188403, 4473.843415480443, 4482.663800214932, 4487.640988720895, 5169.353830771153, 5177.637565370388, 5183.481651834786, 5195.428502864682, 5243.895122097613, 4315.0, 4381.978090109529, 4456.910861782746, 4461.219286624892, 4473.2842745160615, 2737.7399147080996, 2765.4607351566656, 2771.5011297966157, 2772.6672799263815, 2773.3898542320658, 4820.276958456259, 4880.267959805987, 4882.218844984785, 4886.853394398174, 4908.730019848943, 5152.330197074356, 5273.156294992783, 5281.762320695578, 5292.973535132377, 5403.621746477709, 4944.579710724629, 4972.303877457087, 4994.9750251248515, 4997.9750101249265, 5005.273180752634, 5232.869178270574, 5288.2860813791185, 5289.153735402318, 5364.275822763877, 5377.354717433933, 4877.195262781602, 5169.379674439091, 5177.2492988515705, 5177.896442071213, 5188.22176673502, 4919.704817710949, 4928.137575924271, 4934.125032487632, 4934.851954441229, 4961.3798275215595, 3667.889963301105, 3670.541182352206, 3677.742558020913, 3681.484592157047, 3687.870924517629, 5149.407818100966, 5252.737363131751, 5276.841694749163, 5298.947010529845, 5307.708076055854, 5069.898602028013, 5080.923786143285, 5086.135356989246, 5102.0, 5104.0, 5089.51649593288, 5101.7194054327365, 5124.154514505214, 5135.024345374367, 5158.819441319536, 4919.532644398776, 5045.672031317952, 5046.1926091825135, 5060.102461576908, 5098.745062746922, 4897.363342765418, 4950.306957025947, 5121.769520371667, 5140.228965655182, 5140.3831540215415, 4998.950010499849, 5011.7494125294315, 5022.347094877642, 5023.899522009612, 5047.697138171575], "value": 3837.349229171892, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.6632218601954, 654.6235914349247, 676.5669971218418, 716.0762616225069, 726.9241522546631, 12499.625011249665, 13001.284929328884, 13710.725785484285, 13719.245441500701, 13731.382087806047, 13039.543615973444, 13075.934620326909, 13190.142640728345, 13198.406071726795, 13206.867931320683, 617.4597227426002, 753.3370633842238, 769.0847891009709, 779.0612312163857, 787.8818177273398, 779.6998155710036, 785.1049803224329, 786.5320134519951, 787.4763282417185, 788.0897563314381, 805.6616221187086, 807.6527093349857, 808.3412019204359, 808.4583329169441, 808.8180159464102, 642.1651852591659, 783.5768684910141, 799.9000124984377, 806.310604433207, 812.1634716242221, 593.0718425663822, 593.6349145275667, 593.7743657410157, 594.0109717320656, 594.4382558482235, 12499.125061245717, 12502.124851260416, 12509.874901250962, 12513.93743031288, 12525.185862918972, 12337.0, 12559.183653062613, 12859.614211573667, 12860.228386296852, 12915.67710807228, 11747.94126029373, 11853.170278080537, 12000.69998250042, 12082.0, 12502.437390317458, 3936.3898595717424, 3944.9013774655577, 4017.4978127734034, 4095.1604920991126, 4100.282450571138, 59961.0, 60162.69918650422, 60467.395326046615, 60760.0, 60803.08795368117, 9918.206543476505, 9941.105300522842, 9964.501774911225, 9978.401295922267, 10059.245556583286, 18910.149043293084, 18950.24199032023, 18961.90519047396, 18964.965605503054, 18993.145308460877, 6805.455563554904, 6850.4862135340045, 6864.862702745917, 6883.965580172067, 7005.929940700527, 3529.8941031769086, 3605.6394360563736, 3642.453631955228, 3660.9450858237146, 3851.9614803852164, 2745.6018877263086, 2866.0, 2872.4255148970287, 2873.2960424696084, 2878.294817769618, 484.75277608419253, 486.5256375034384, 499.9325091112726, 500.57201093065635, 505.56016265848945, 499.0119563264756, 550.2653956967494, 551.6386766667839, 573.8192469372134, 582.9183914252009, 7475.252474752481, 7660.80847978805, 7763.534187948741, 9421.481818500048, 9457.90542094584, 521.9582433405394, 523.5524515590491, 538.4385282680258, 601.750273636436, 615.2647586134526, 3865.729398942103, 4058.817353219112, 4088.0173116038695, 4176.707630465899, 4341.088371442032, 89049.55475222583, 91702.0, 92964.0, 95876.0, 96078.0, 47894.28158577624, 48028.63113586396, 48787.51212487901, 49047.0, 81528.0, 46892.999999999316, 48163.759181203866, 71124.0, 73390.0, 75075.0, 9268.675596354095, 9355.719328420158, 9536.380135291183, 9567.856482152634, 9704.2721795867, 43474.0, 43781.56218437902, 45132.0, 46708.53291467178, 47749.0, 64940.0, 65373.0, 65375.34624653692, 65565.34434655783, 66281.66859165674, 10811.837822432513, 10917.181211409017, 11145.440321638436, 11444.599439019594, 12006.75986480283, 12372.381380930738, 12861.549845755353, 12918.935405322913, 13186.340682965621, 13439.328033598476, 11312.9434352831, 11430.314181149157, 12129.75740485203, 12829.807552886528, 12916.547920823103, 11557.942210288895, 11795.820417958135, 11875.406229688653, 11904.523819047141, 12000.819987700366, 11800.881991180322, 11805.76388472243, 12501.624951251477, 12561.37193140321, 13187.274699891597, 9846.310758246855, 9925.950370248103, 9978.700638980843, 10114.696559103239, 10118.8482172766, 10344.844827327746, 10423.530941107516, 10428.923467576931, 10469.895301046892, 10510.159187264848], "value": 6523.95637888017, "unit": "score"}], "name": "dromaeo_css", "value": 6439.749576050461, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 115.0, 115.0, 113.0, 113.0, 113.0, 114.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 129.0, 128.0, 195.0, 125.0, 124.0, 147.0, 120.0, 183.0, 122.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 112.0, 76.0, 77.0, 75.0, 75.0, 99.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 112.0, 85.0, 85.0, 86.0, 124.0, 84.0, 86.0, 122.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 62.0, 63.0, 64.0, 63.0, 63.0, 63.0, 71.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 69.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 81.0, 79.0, 79.0, 87.0, 78.0, 84.0, 78.0, 85.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 128.0, 135.0, 126.0, 127.0, 128.0, 133.0, 169.0, 133.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 164.0, 165.0, 164.0, 169.0, 164.0, 165.0, 169.0, 162.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 73.0, 67.0, 65.0, 66.0, 66.0, 67.0, 65.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1526.4, "alertThreshold": 2.0}]} 06:21:38 INFO - Return code: 0 06:21:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:21:38 INFO - # TBPL SUCCESS # 06:21:38 INFO - Running post-action listener: _resource_record_post_action 06:21:38 INFO - ##### 06:21:38 INFO - ##### Finished run-tests step (success) 06:21:38 INFO - ##### 06:21:38 INFO - Running post-run listener: _resource_record_post_run 06:21:38 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535691264; Read time: 12; Write time: 395064 06:21:38 INFO - TinderboxPrint: CPU usage
12.9% 06:21:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:21:38 INFO - TinderboxPrint: I/O write bytes / time
535,691,264 / 395,064 06:21:38 INFO - TinderboxPrint: CPU idle
8,337.3 (87.0%) 06:21:38 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 06:21:38 INFO - TinderboxPrint: Swap in / out
0 / 0 06:21:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247242752; Read time: 0; Write time: 228548 06:21:38 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288448512; Read time: 0; Write time: 166516 06:21:39 INFO - Running post-run listener: _upload_blobber_files 06:21:39 INFO - Blob upload gear active. 06:21:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:21:39 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 06:21:39 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:21:39 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:21:39 INFO - (blobuploader) - INFO - Open directory for files ... 06:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:21:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:40 INFO - (blobuploader) - INFO - Done attempting. 06:21:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:21:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:41 INFO - (blobuploader) - INFO - Done attempting. 06:21:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:21:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:50 INFO - (blobuploader) - INFO - Done attempting. 06:21:50 INFO - (blobuploader) - INFO - Iteration through files over. 06:21:50 INFO - Return code: 0 06:21:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:21:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:21:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06e8a793806419048f83c48c3f46b04d135850cd3677758501cae0b189f525a1a7d9455b3f4150b8f4dd8b9e811bc7cf53a7bf026c1ed8ee0ed4860b84f7f682", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f15ac39c738d98f38d74a6854679df5e44f8f36d63d1d35315d1529022ca0a31e39444cfac3236963b3e2a41bbb6de11bba69606a0adee69ddfc0c88ac2faad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e320b9613a0f799e9c7bc04daaa907fda3064774d0de1adb1fc00ce0372a4426d9b1ef9bced2466ef1e840b62c0029d1d0ab552b190f6371041e839c9745fadc"} 06:21:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:21:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:21:50 INFO - Contents: 06:21:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06e8a793806419048f83c48c3f46b04d135850cd3677758501cae0b189f525a1a7d9455b3f4150b8f4dd8b9e811bc7cf53a7bf026c1ed8ee0ed4860b84f7f682", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f15ac39c738d98f38d74a6854679df5e44f8f36d63d1d35315d1529022ca0a31e39444cfac3236963b3e2a41bbb6de11bba69606a0adee69ddfc0c88ac2faad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e320b9613a0f799e9c7bc04daaa907fda3064774d0de1adb1fc00ce0372a4426d9b1ef9bced2466ef1e840b62c0029d1d0ab552b190f6371041e839c9745fadc"} 06:21:50 INFO - Running post-run listener: copy_logs_to_upload_dir 06:21:50 INFO - Copying logs to upload dir... 06:21:50 INFO - mkdir: /builds/slave/test/build/upload/logs 06:21:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.107923 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-19 06:21:50.596162) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 06:21:50.599845) ========= 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=7de08804244eb36560b44971000001c3-1468932543.403668-1284255090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06e8a793806419048f83c48c3f46b04d135850cd3677758501cae0b189f525a1a7d9455b3f4150b8f4dd8b9e811bc7cf53a7bf026c1ed8ee0ed4860b84f7f682", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f15ac39c738d98f38d74a6854679df5e44f8f36d63d1d35315d1529022ca0a31e39444cfac3236963b3e2a41bbb6de11bba69606a0adee69ddfc0c88ac2faad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e320b9613a0f799e9c7bc04daaa907fda3064774d0de1adb1fc00ce0372a4426d9b1ef9bced2466ef1e840b62c0029d1d0ab552b190f6371041e839c9745fadc"} build_url:https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011118 build_url: 'https://queue.taskcluster.net/v1/task/ZsEbkjmKRLaR99TvFiTz6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06e8a793806419048f83c48c3f46b04d135850cd3677758501cae0b189f525a1a7d9455b3f4150b8f4dd8b9e811bc7cf53a7bf026c1ed8ee0ed4860b84f7f682", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f15ac39c738d98f38d74a6854679df5e44f8f36d63d1d35315d1529022ca0a31e39444cfac3236963b3e2a41bbb6de11bba69606a0adee69ddfc0c88ac2faad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e320b9613a0f799e9c7bc04daaa907fda3064774d0de1adb1fc00ce0372a4426d9b1ef9bced2466ef1e840b62c0029d1d0ab552b190f6371041e839c9745fadc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 06:21:50.624590) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 06:21:50.624905) ========= 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=7de08804244eb36560b44971000001c3-1468932543.403668-1284255090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 06:21:50.708217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 06:21:50.708546) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 06:21:50.708849) ========= ========= Total master_lag: 0.17 =========