builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1468154580.67 results: success (0) buildid: 20160710030217 builduid: f5a6a71168b343fa97e5f99c1f3e624f revision: 679118259e91f40d4a8f968f03ec4cff066cdb5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:00.672444) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:00.673265) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:00.673609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:00.716858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:00.717159) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-10 05:43:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-07-10 05:43:01 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145080 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:00.884106) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:00.884386) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017666 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:00.942372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:00.942683) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 679118259e91f40d4a8f968f03ec4cff066cdb5b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 679118259e91f40d4a8f968f03ec4cff066cdb5b --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=a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-10 05:43:01,670 truncating revision to first 12 chars 2016-07-10 05:43:01,670 Setting DEBUG logging. 2016-07-10 05:43:01,670 attempt 1/10 2016-07-10 05:43:01,670 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/679118259e91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-10 05:43:02,215 unpacking tar archive at: mozilla-central-679118259e91/testing/mozharness/ program finished with exit code 0 elapsedTime=0.897213 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:01.853292) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:01.853630) ========= script_repo_revision: 679118259e91f40d4a8f968f03ec4cff066cdb5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:01.854111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:01.854416) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-10 05:43:01.865239) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-10 05:43:01.865528) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:43:02 INFO - MultiFileLogger online at 20160710 05:43:02 in /builds/slave/test 05:43:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:43:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:43:02 INFO - {'append_to_log': False, 05:43:02 INFO - 'base_work_dir': '/builds/slave/test', 05:43:02 INFO - 'blob_upload_branch': 'Firefox', 05:43:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:43:02 INFO - 'branch': 'Firefox', 05:43:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:43:02 INFO - 'config_files': ('talos/linux_config.py',), 05:43:02 INFO - 'default_actions': ('clobber', 05:43:02 INFO - 'read-buildbot-config', 05:43:02 INFO - 'download-and-extract', 05:43:02 INFO - 'populate-webroot', 05:43:02 INFO - 'create-virtualenv', 05:43:02 INFO - 'install', 05:43:02 INFO - 'run-tests'), 05:43:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:43:02 INFO - 'download_minidump_stackwalk': True, 05:43:02 INFO - 'download_symbols': 'ondemand', 05:43:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:43:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:43:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:43:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:43:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:43:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:43:02 INFO - 'installer_path': 'installer.exe', 05:43:02 INFO - 'log_level': 'info', 05:43:02 INFO - 'log_name': 'talos', 05:43:02 INFO - 'log_to_console': True, 05:43:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:43:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:43:02 INFO - 'opt_config_files': (), 05:43:02 INFO - 'pip_index': False, 05:43:02 INFO - 'sps_profile': False, 05:43:02 INFO - 'sps_profile_interval': 0, 05:43:02 INFO - 'suite': 'dromaeojs', 05:43:02 INFO - 'system_bits': '32', 05:43:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:43:02 INFO - 'title': 'talos-linux64-ix-002', 05:43:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:43:02 INFO - 'use_talos_json': True, 05:43:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:43:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:43:02 INFO - 'work_dir': 'build'} 05:43:02 INFO - ##### 05:43:02 INFO - ##### Running clobber step. 05:43:02 INFO - ##### 05:43:02 INFO - Running pre-action listener: _resource_record_pre_action 05:43:02 INFO - Running main action method: clobber 05:43:02 INFO - rmtree: /builds/slave/test/build 05:43:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:43:03 INFO - Running post-action listener: _resource_record_post_action 05:43:03 INFO - ##### 05:43:03 INFO - ##### Finished clobber step (success) 05:43:03 INFO - ##### 05:43:03 INFO - ##### 05:43:03 INFO - ##### Running read-buildbot-config step. 05:43:03 INFO - ##### 05:43:03 INFO - Running pre-action listener: _resource_record_pre_action 05:43:03 INFO - Running main action method: read_buildbot_config 05:43:03 INFO - Using buildbot properties: 05:43:03 INFO - { 05:43:03 INFO - "project": "", 05:43:03 INFO - "product": "firefox", 05:43:03 INFO - "script_repo_revision": "production", 05:43:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:43:03 INFO - "repository": "", 05:43:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:43:03 INFO - "buildid": "20160710030217", 05:43:03 INFO - "stage_platform": "linux64-pgo", 05:43:03 INFO - "basedir": "/builds/slave/test", 05:43:03 INFO - "nightly_build": "True", 05:43:03 INFO - "buildnumber": 380, 05:43:03 INFO - "slavename": "talos-linux64-ix-002", 05:43:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:43:03 INFO - "platform": "ubuntu64_hw", 05:43:03 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:43:03 INFO - "branch": "mozilla-central", 05:43:03 INFO - "repo_path": "mozilla-central", 05:43:03 INFO - "revision": "679118259e91f40d4a8f968f03ec4cff066cdb5b", 05:43:03 INFO - "pgo_build": "True", 05:43:03 INFO - "builduid": "f5a6a71168b343fa97e5f99c1f3e624f", 05:43:03 INFO - "slavebuilddir": "test" 05:43:03 INFO - } 05:43:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:43:03 INFO - Running post-action listener: _resource_record_post_action 05:43:03 INFO - ##### 05:43:03 INFO - ##### Finished read-buildbot-config step (success) 05:43:03 INFO - ##### 05:43:03 INFO - ##### 05:43:03 INFO - ##### Running download-and-extract step. 05:43:03 INFO - ##### 05:43:03 INFO - Running pre-action listener: _resource_record_pre_action 05:43:03 INFO - Running main action method: download_and_extract 05:43:03 INFO - mkdir: /builds/slave/test/build/tests 05:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:03 INFO - https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:43:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:43:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:43:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/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 05:43:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/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 05:43:14 INFO - Downloaded 1361 bytes. 05:43:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:43:14 INFO - Using the following test package requirements: 05:43:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:43:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:43:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:14 INFO - u'jsshell-linux-x86_64.zip'], 05:43:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:43:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:43:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:43:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:43:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:43:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:14 INFO - https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/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 05:43:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/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 05:43:25 INFO - Downloaded 24304158 bytes. 05:43:25 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'] 05:43:25 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 05:43:26 INFO - Return code: 0 05:43:26 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 05:43:26 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')]} 05:43:26 INFO - https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/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 05:43:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/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 05:43:28 INFO - Downloaded 24304158 bytes. 05:43:28 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'] 05:43:28 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 05:43:30 INFO - Return code: 0 05:43: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')]} 05:43:30 INFO - https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:43:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/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 05:43:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/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 05:43:31 INFO - Downloaded 14403333 bytes. 05:43:31 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'] 05:43:31 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 05:43:31 INFO - Return code: 0 05:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:31 INFO - https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:43:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/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 05:43:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCLeba1eSqiEvIrfai9whg/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 05:43:32 INFO - Downloaded 60485267 bytes. 05:43:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:32 INFO - mkdir: /builds/slave/test/properties 05:43:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:43:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:43:32 INFO - Contents: 05:43:32 INFO - build_url:https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:33 INFO - Running post-action listener: _resource_record_post_action 05:43:33 INFO - Running post-action listener: set_extra_try_arguments 05:43:33 INFO - ##### 05:43:33 INFO - ##### Finished download-and-extract step (success) 05:43:33 INFO - ##### 05:43:33 INFO - ##### 05:43:33 INFO - ##### Running populate-webroot step. 05:43:33 INFO - ##### 05:43:33 INFO - Running pre-action listener: _resource_record_pre_action 05:43:33 INFO - Running main action method: populate_webroot 05:43:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:43:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:43:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:43:33 INFO - '--tppagecycles', 05:43:33 INFO - '7'], 05:43:33 INFO - 'tests': ['tsvgm']}}, 05:43:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:43:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:43:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:43:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:43:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:43:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:43:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:33 INFO - 'talos_options': ['--disable-e10s'], 05:43:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:33 INFO - 'talos_options': ['--disable-e10s'], 05:43:33 INFO - 'tests': ['damp', 'tps']}, 05:43:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:33 INFO - 'tests': ['damp', 'tps']}, 05:43:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:43:33 INFO - 'tests': ['dromaeo_dom']}, 05:43:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:43:33 INFO - 'tests': ['basic_compositor_video']}, 05:43:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:43:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:43:33 INFO - 'tests': ['a11yr', 05:43:33 INFO - 'ts_paint', 05:43:33 INFO - 'tpaint', 05:43:33 INFO - 'sessionrestore', 05:43:33 INFO - 'sessionrestore_no_auto_restore', 05:43:33 INFO - 'tabpaint']}, 05:43:33 INFO - 'other-e10s': {'tests': ['a11yr', 05:43:33 INFO - 'ts_paint', 05:43:33 INFO - 'tpaint', 05:43:33 INFO - 'sessionrestore', 05:43:33 INFO - 'sessionrestore_no_auto_restore', 05:43:33 INFO - 'tabpaint']}, 05:43:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:43:33 INFO - 'ts_paint', 05:43:33 INFO - 'tpaint', 05:43:33 INFO - 'sessionrestore', 05:43:33 INFO - 'sessionrestore_no_auto_restore', 05:43:33 INFO - 'tabpaint']}, 05:43:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:43:33 INFO - 'ts_paint', 05:43:33 INFO - 'tpaint', 05:43:33 INFO - 'sessionrestore', 05:43:33 INFO - 'sessionrestore_no_auto_restore', 05:43:33 INFO - 'tabpaint']}, 05:43:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:43:33 INFO - 'tests': ['a11yr', 05:43:33 INFO - 'ts_paint', 05:43:33 INFO - 'tpaint', 05:43:33 INFO - 'sessionrestore', 05:43:33 INFO - 'sessionrestore_no_auto_restore', 05:43:33 INFO - 'tabpaint']}, 05:43:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:43:33 INFO - 'tests': ['a11yr', 05:43:33 INFO - 'ts_paint', 05:43:33 INFO - 'tpaint', 05:43:33 INFO - 'sessionrestore', 05:43:33 INFO - 'sessionrestore_no_auto_restore', 05:43:33 INFO - 'tabpaint']}, 05:43:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:43:33 INFO - 'tests': ['tsvgx', 05:43:33 INFO - 'tsvgr_opacity', 05:43:33 INFO - 'tart', 05:43:33 INFO - 'tscrollx', 05:43:33 INFO - 'cart']}, 05:43:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:43:33 INFO - 'tsvgr_opacity', 05:43:33 INFO - 'tart', 05:43:33 INFO - 'tscrollx', 05:43:33 INFO - 'cart']}, 05:43:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:33 INFO - 'talos_options': ['--disable-e10s'], 05:43:33 INFO - 'tests': ['tp5o']}, 05:43:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:33 INFO - 'tests': ['tp5o']}, 05:43:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:33 INFO - 'talos_options': ['--disable-e10s', 05:43:33 INFO - '--xperf_path', 05:43:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:33 INFO - 'tests': ['tp5n']}, 05:43:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:33 INFO - 'talos_options': ['--xperf_path', 05:43:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:33 INFO - 'tests': ['tp5n']}}, 05:43:33 INFO - 'talos.zip': {'path': '', 05:43:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:43:33 INFO - Running post-action listener: _resource_record_post_action 05:43:33 INFO - ##### 05:43:33 INFO - ##### Finished populate-webroot step (success) 05:43:33 INFO - ##### 05:43:33 INFO - ##### 05:43:33 INFO - ##### Running create-virtualenv step. 05:43:33 INFO - ##### 05:43:33 INFO - Running pre-action listener: _resource_record_pre_action 05:43:33 INFO - Running main action method: create_virtualenv 05:43:33 INFO - Creating virtualenv /builds/slave/test/build/venv 05:43:33 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 05:43:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:43:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:33 INFO - Using real prefix '/usr' 05:43:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:43:34 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:36 INFO - Installing pip.................done. 05:43:36 INFO - Return code: 0 05:43:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:36 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 0xb8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d3b0>, '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 0xe4e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4e740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', '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 05:43:36 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 05:43:36 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 05:43:36 INFO - Using env: {'DISPLAY': ':0', 05:43:36 INFO - 'HOME': '/home/cltbld', 05:43:36 INFO - 'LANG': 'en_US.UTF-8', 05:43:36 INFO - 'LANGUAGE': 'en_US:en', 05:43:36 INFO - 'LOGNAME': 'cltbld', 05:43:36 INFO - 'MAIL': '/var/mail/cltbld', 05:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:36 INFO - 'MOZ_NO_REMOTE': '1', 05:43:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:36 INFO - 'NO_EM_RESTART': '1', 05:43:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:36 INFO - 'PWD': '/builds/slave/test', 05:43:36 INFO - 'SHELL': '/bin/bash', 05:43:36 INFO - 'SHLVL': '1', 05:43:36 INFO - 'TERM': 'linux', 05:43:36 INFO - 'TMOUT': '86400', 05:43:36 INFO - 'USER': 'cltbld', 05:43:36 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', 05:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:36 INFO - '_': '/tools/buildbot/bin/python'} 05:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:36 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 05:43:36 INFO - Cleaning up... 05:43:36 INFO - Return code: 0 05:43:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:36 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 0xb8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d3b0>, '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 0xe4e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4e740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', '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 05:43:36 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 05:43:36 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 05:43:36 INFO - Using env: {'DISPLAY': ':0', 05:43:36 INFO - 'HOME': '/home/cltbld', 05:43:36 INFO - 'LANG': 'en_US.UTF-8', 05:43:36 INFO - 'LANGUAGE': 'en_US:en', 05:43:36 INFO - 'LOGNAME': 'cltbld', 05:43:36 INFO - 'MAIL': '/var/mail/cltbld', 05:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:36 INFO - 'MOZ_NO_REMOTE': '1', 05:43:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:36 INFO - 'NO_EM_RESTART': '1', 05:43:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:36 INFO - 'PWD': '/builds/slave/test', 05:43:36 INFO - 'SHELL': '/bin/bash', 05:43:36 INFO - 'SHLVL': '1', 05:43:36 INFO - 'TERM': 'linux', 05:43:36 INFO - 'TMOUT': '86400', 05:43:36 INFO - 'USER': 'cltbld', 05:43:36 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', 05:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:36 INFO - '_': '/tools/buildbot/bin/python'} 05:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:36 INFO - Downloading/unpacking psutil>=3.1.1 05:43:36 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 05:43:36 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 05:43:36 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 05:43:36 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 05:43:36 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 05:43:36 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 05:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:38 INFO - Installing collected packages: psutil 05:43:38 INFO - Running setup.py install for psutil 05:43:38 INFO - building 'psutil._psutil_linux' extension 05:43:38 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 05:43:38 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 05:43:38 INFO - building 'psutil._psutil_posix' extension 05:43:38 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 05:43:38 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 05:43:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:38 INFO - Successfully installed psutil 05:43:38 INFO - Cleaning up... 05:43:39 INFO - Return code: 0 05:43:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:39 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 0xb8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d3b0>, '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 0xe4e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4e740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', '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 05:43:39 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 05:43:39 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 05:43:39 INFO - Using env: {'DISPLAY': ':0', 05:43:39 INFO - 'HOME': '/home/cltbld', 05:43:39 INFO - 'LANG': 'en_US.UTF-8', 05:43:39 INFO - 'LANGUAGE': 'en_US:en', 05:43:39 INFO - 'LOGNAME': 'cltbld', 05:43:39 INFO - 'MAIL': '/var/mail/cltbld', 05:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:39 INFO - 'MOZ_NO_REMOTE': '1', 05:43:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:39 INFO - 'NO_EM_RESTART': '1', 05:43:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:39 INFO - 'PWD': '/builds/slave/test', 05:43:39 INFO - 'SHELL': '/bin/bash', 05:43:39 INFO - 'SHLVL': '1', 05:43:39 INFO - 'TERM': 'linux', 05:43:39 INFO - 'TMOUT': '86400', 05:43:39 INFO - 'USER': 'cltbld', 05:43:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', 05:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:39 INFO - '_': '/tools/buildbot/bin/python'} 05:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:43:39 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 05:43:39 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 05:43:39 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 05:43:39 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 05:43:39 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 05:43:39 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 05:43:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:43:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:43:41 INFO - Installing collected packages: mozsystemmonitor 05:43:41 INFO - Running setup.py install for mozsystemmonitor 05:43:41 INFO - Successfully installed mozsystemmonitor 05:43:41 INFO - Cleaning up... 05:43:41 INFO - Return code: 0 05:43:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:41 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 0xb8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d3b0>, '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 0xe4e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4e740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', '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 05:43:41 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 05:43:41 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 05:43:41 INFO - Using env: {'DISPLAY': ':0', 05:43:41 INFO - 'HOME': '/home/cltbld', 05:43:41 INFO - 'LANG': 'en_US.UTF-8', 05:43:41 INFO - 'LANGUAGE': 'en_US:en', 05:43:41 INFO - 'LOGNAME': 'cltbld', 05:43:41 INFO - 'MAIL': '/var/mail/cltbld', 05:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:41 INFO - 'MOZ_NO_REMOTE': '1', 05:43:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:41 INFO - 'NO_EM_RESTART': '1', 05:43:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:41 INFO - 'PWD': '/builds/slave/test', 05:43:41 INFO - 'SHELL': '/bin/bash', 05:43:41 INFO - 'SHLVL': '1', 05:43:41 INFO - 'TERM': 'linux', 05:43:41 INFO - 'TMOUT': '86400', 05:43:41 INFO - 'USER': 'cltbld', 05:43:41 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', 05:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:41 INFO - '_': '/tools/buildbot/bin/python'} 05:43:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:41 INFO - Downloading/unpacking jsonschema==2.5.1 05:43:41 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 05:43:41 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 05:43:41 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 05:43:41 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 05:43:41 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 05:43:41 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 05:43:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:43:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:43:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:43:43 INFO - warning: no files found matching '*.txt' 05:43:43 INFO - no previously-included directories found matching 'build' 05:43:43 INFO - no previously-included directories found matching 'dist' 05:43:43 INFO - no previously-included directories found matching '.git*' 05:43:43 INFO - Installing collected packages: jsonschema, functools32 05:43:43 INFO - Running setup.py install for functools32 05:43:43 INFO - warning: no files found matching '*.txt' 05:43:43 INFO - no previously-included directories found matching 'build' 05:43:43 INFO - no previously-included directories found matching 'dist' 05:43:43 INFO - no previously-included directories found matching '.git*' 05:43:43 INFO - Successfully installed jsonschema functools32 05:43:43 INFO - Cleaning up... 05:43:43 INFO - Return code: 0 05:43:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d3b0>, '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 0xe4e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4e740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', '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 05:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:43:43 INFO - Using env: {'DISPLAY': ':0', 05:43:43 INFO - 'HOME': '/home/cltbld', 05:43:43 INFO - 'LANG': 'en_US.UTF-8', 05:43:43 INFO - 'LANGUAGE': 'en_US:en', 05:43:43 INFO - 'LOGNAME': 'cltbld', 05:43:43 INFO - 'MAIL': '/var/mail/cltbld', 05:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:43 INFO - 'MOZ_NO_REMOTE': '1', 05:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:43 INFO - 'NO_EM_RESTART': '1', 05:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:43 INFO - 'PWD': '/builds/slave/test', 05:43:43 INFO - 'SHELL': '/bin/bash', 05:43:43 INFO - 'SHLVL': '1', 05:43:43 INFO - 'TERM': 'linux', 05:43:43 INFO - 'TMOUT': '86400', 05:43:43 INFO - 'USER': 'cltbld', 05:43:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', 05:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:43 INFO - '_': '/tools/buildbot/bin/python'} 05:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:43:44 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 05:43:44 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 05:43:44 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 05:43:44 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 05:43:44 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 05:43:44 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 05:43:45 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:43:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:46 INFO - Downloading docopt-0.6.1.tar.gz 05:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:46 INFO - Running setup.py install for blobuploader 05:43:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:43:46 INFO - Running setup.py install for requests 05:43:47 INFO - Running setup.py install for docopt 05:43:47 INFO - Successfully installed blobuploader requests docopt 05:43:47 INFO - Cleaning up... 05:43:47 INFO - Return code: 0 05:43:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:47 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 0xb8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d3b0>, '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 0xe4e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4e740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', '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 05:43:47 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 05:43:47 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 05:43:47 INFO - Using env: {'DISPLAY': ':0', 05:43:47 INFO - 'HOME': '/home/cltbld', 05:43:47 INFO - 'LANG': 'en_US.UTF-8', 05:43:47 INFO - 'LANGUAGE': 'en_US:en', 05:43:47 INFO - 'LOGNAME': 'cltbld', 05:43:47 INFO - 'MAIL': '/var/mail/cltbld', 05:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:47 INFO - 'MOZ_NO_REMOTE': '1', 05:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:47 INFO - 'NO_EM_RESTART': '1', 05:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:47 INFO - 'PWD': '/builds/slave/test', 05:43:47 INFO - 'SHELL': '/bin/bash', 05:43:47 INFO - 'SHLVL': '1', 05:43:47 INFO - 'TERM': 'linux', 05:43:47 INFO - 'TMOUT': '86400', 05:43:47 INFO - 'USER': 'cltbld', 05:43:47 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', 05:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:47 INFO - '_': '/tools/buildbot/bin/python'} 05:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:47 INFO - Running setup.py (path:/tmp/pip-WKmFyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:47 INFO - Running setup.py (path:/tmp/pip-BG5_gG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:47 INFO - Running setup.py (path:/tmp/pip-lpfx3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:47 INFO - Running setup.py (path:/tmp/pip-bNgyqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:47 INFO - Running setup.py (path:/tmp/pip-dXKOuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:47 INFO - Running setup.py (path:/tmp/pip-qKfOCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:47 INFO - Running setup.py (path:/tmp/pip-RRlbnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:48 INFO - Running setup.py (path:/tmp/pip-pbq_HY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:48 INFO - Running setup.py (path:/tmp/pip-G8bt7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:48 INFO - Running setup.py (path:/tmp/pip-LDEZAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:48 INFO - Running setup.py (path:/tmp/pip-nhNDly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:48 INFO - Running setup.py (path:/tmp/pip-Nfn732-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:48 INFO - Running setup.py (path:/tmp/pip-708RMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:48 INFO - Running setup.py (path:/tmp/pip-zklmM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:48 INFO - Running setup.py (path:/tmp/pip-C51l79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:48 INFO - Running setup.py (path:/tmp/pip-Va9YxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:48 INFO - Running setup.py (path:/tmp/pip-c1aqQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:48 INFO - Running setup.py install for manifestparser 05:43:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:43:48 INFO - Running setup.py install for mozcrash 05:43:48 INFO - Running setup.py install for mozdebug 05:43:49 INFO - Running setup.py install for mozdevice 05:43:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Running setup.py install for mozfile 05:43:49 INFO - Running setup.py install for mozhttpd 05:43:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Running setup.py install for mozinfo 05:43:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Running setup.py install for mozInstall 05:43:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Running setup.py install for mozleak 05:43:49 INFO - Running setup.py install for mozlog 05:43:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Running setup.py install for moznetwork 05:43:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:43:49 INFO - Running setup.py install for mozprocess 05:43:49 INFO - Running setup.py install for mozprofile 05:43:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:43:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:43:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:43:50 INFO - Running setup.py install for mozrunner 05:43:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:43:50 INFO - Running setup.py install for mozscreenshot 05:43:50 INFO - Running setup.py install for moztest 05:43:50 INFO - Running setup.py install for mozversion 05:43:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:43:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:50 INFO - Cleaning up... 05:43:50 INFO - Return code: 0 05:43:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:50 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 0xb8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d3b0>, '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 0xe4e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4e740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', '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 05:43:50 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 05:43:50 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 05:43:50 INFO - Using env: {'DISPLAY': ':0', 05:43:50 INFO - 'HOME': '/home/cltbld', 05:43:50 INFO - 'LANG': 'en_US.UTF-8', 05:43:50 INFO - 'LANGUAGE': 'en_US:en', 05:43:50 INFO - 'LOGNAME': 'cltbld', 05:43:50 INFO - 'MAIL': '/var/mail/cltbld', 05:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:50 INFO - 'MOZ_NO_REMOTE': '1', 05:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:50 INFO - 'NO_EM_RESTART': '1', 05:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:50 INFO - 'PWD': '/builds/slave/test', 05:43:50 INFO - 'SHELL': '/bin/bash', 05:43:50 INFO - 'SHLVL': '1', 05:43:50 INFO - 'TERM': 'linux', 05:43:50 INFO - 'TMOUT': '86400', 05:43:50 INFO - 'USER': 'cltbld', 05:43:50 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', 05:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:50 INFO - '_': '/tools/buildbot/bin/python'} 05:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:50 INFO - Running setup.py (path:/tmp/pip-UaG9vZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:50 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)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:50 INFO - Running setup.py (path:/tmp/pip-e32q_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:50 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)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:50 INFO - Running setup.py (path:/tmp/pip-QAbTe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:50 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)) 05:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:51 INFO - Running setup.py (path:/tmp/pip-fU4yYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:51 INFO - Running setup.py (path:/tmp/pip-8BxLEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:51 INFO - Running setup.py (path:/tmp/pip-DE2qe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:51 INFO - Running setup.py (path:/tmp/pip-r5tlDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:51 INFO - Running setup.py (path:/tmp/pip-QaC67u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:51 INFO - Running setup.py (path:/tmp/pip-Ziu0f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:51 INFO - Running setup.py (path:/tmp/pip-rSnEHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:51 INFO - Running setup.py (path:/tmp/pip-fkIne7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:51 INFO - Running setup.py (path:/tmp/pip-PxFR9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:51 INFO - Running setup.py (path:/tmp/pip-rOzell-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:51 INFO - Running setup.py (path:/tmp/pip-Tyg0os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:51 INFO - Running setup.py (path:/tmp/pip-scY8bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:51 INFO - Running setup.py (path:/tmp/pip-bIr5Z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:51 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)) 05:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:51 INFO - Running setup.py (path:/tmp/pip-GqhL_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:51 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)) 05:43:51 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)) 05:43:51 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)) 05:43:51 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)) 05:43:51 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)) 05:43:51 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)) 05:43:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:53 INFO - Downloading blessings-1.6.tar.gz 05:43:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:53 INFO - Installing collected packages: blessings 05:43:53 INFO - Running setup.py install for blessings 05:43:54 INFO - Successfully installed blessings 05:43:54 INFO - Cleaning up... 05:43:54 INFO - Return code: 0 05:43:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:43:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:54 INFO - Reading from file tmpfile_stdout 05:43:54 INFO - Current package versions: 05:43:54 INFO - argparse == 1.2.1 05:43:54 INFO - blessings == 1.6 05:43:54 INFO - blobuploader == 1.2.4 05:43:54 INFO - docopt == 0.6.1 05:43:54 INFO - functools32 == 3.2.3-2 05:43:54 INFO - jsonschema == 2.5.1 05:43:54 INFO - manifestparser == 1.1 05:43:54 INFO - mozInstall == 1.12 05:43:54 INFO - mozcrash == 0.17 05:43:54 INFO - mozdebug == 0.1 05:43:54 INFO - mozdevice == 0.48 05:43:54 INFO - mozfile == 1.2 05:43:54 INFO - mozhttpd == 0.7 05:43:54 INFO - mozinfo == 0.9 05:43:54 INFO - mozleak == 0.1 05:43:54 INFO - mozlog == 3.2 05:43:54 INFO - moznetwork == 0.27 05:43:54 INFO - mozprocess == 0.23 05:43:54 INFO - mozprofile == 0.28 05:43:54 INFO - mozrunner == 6.12 05:43:54 INFO - mozscreenshot == 0.1 05:43:54 INFO - mozsystemmonitor == 0.3 05:43:54 INFO - moztest == 0.7 05:43:54 INFO - mozversion == 1.4 05:43:54 INFO - psutil == 3.1.1 05:43:54 INFO - requests == 1.2.3 05:43:54 INFO - wsgiref == 0.1.2 05:43:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 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 0xb8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d3b0>, '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 0xe4e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4e740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', '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 05:43:54 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 05:43:54 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 05:43:54 INFO - Using env: {'DISPLAY': ':0', 05:43:54 INFO - 'HOME': '/home/cltbld', 05:43:54 INFO - 'LANG': 'en_US.UTF-8', 05:43:54 INFO - 'LANGUAGE': 'en_US:en', 05:43:54 INFO - 'LOGNAME': 'cltbld', 05:43:54 INFO - 'MAIL': '/var/mail/cltbld', 05:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:54 INFO - 'MOZ_NO_REMOTE': '1', 05:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:54 INFO - 'NO_EM_RESTART': '1', 05:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:54 INFO - 'PWD': '/builds/slave/test', 05:43:54 INFO - 'SHELL': '/bin/bash', 05:43:54 INFO - 'SHLVL': '1', 05:43:54 INFO - 'TERM': 'linux', 05:43:54 INFO - 'TMOUT': '86400', 05:43:54 INFO - 'USER': 'cltbld', 05:43:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', 05:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:54 INFO - '_': '/tools/buildbot/bin/python'} 05:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:54 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)) 05:43:54 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)) 05:43:54 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)) 05:43:54 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)) 05:43:54 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)) 05:43:54 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)) 05:43:54 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)) 05:43:54 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)) 05:43:54 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)) 05:43:54 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)) 05:43:54 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)) 05:43:54 INFO - Cleaning up... 05:43:54 INFO - Return code: 0 05:43:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 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 0xb8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d3b0>, '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 0xe4e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4e740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', '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 05:43:54 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 05:43:54 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 05:43:54 INFO - Using env: {'DISPLAY': ':0', 05:43:54 INFO - 'HOME': '/home/cltbld', 05:43:54 INFO - 'LANG': 'en_US.UTF-8', 05:43:54 INFO - 'LANGUAGE': 'en_US:en', 05:43:54 INFO - 'LOGNAME': 'cltbld', 05:43:54 INFO - 'MAIL': '/var/mail/cltbld', 05:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:54 INFO - 'MOZ_NO_REMOTE': '1', 05:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:54 INFO - 'NO_EM_RESTART': '1', 05:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:54 INFO - 'PWD': '/builds/slave/test', 05:43:54 INFO - 'SHELL': '/bin/bash', 05:43:54 INFO - 'SHLVL': '1', 05:43:54 INFO - 'TERM': 'linux', 05:43:54 INFO - 'TMOUT': '86400', 05:43:54 INFO - 'USER': 'cltbld', 05:43:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', 05:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:54 INFO - '_': '/tools/buildbot/bin/python'} 05:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:43:54 INFO - Cleaning up... 05:43:54 INFO - Return code: 0 05:43:54 INFO - Running post-action listener: _resource_record_post_action 05:43:54 INFO - Running post-action listener: _start_resource_monitoring 05:43:54 INFO - Starting resource monitoring. 05:43:54 INFO - ##### 05:43:54 INFO - ##### Finished create-virtualenv step (success) 05:43:54 INFO - ##### 05:43:54 INFO - ##### 05:43:54 INFO - ##### Running install step. 05:43:54 INFO - ##### 05:43:54 INFO - Running pre-action listener: _resource_record_pre_action 05:43:54 INFO - Running main action method: install 05:43:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:55 INFO - Reading from file tmpfile_stdout 05:43:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:43:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:43:55 INFO - Reading from file tmpfile_stdout 05:43:55 INFO - Output received: 05:43:55 INFO - Usage: mozinstall [options] installer 05:43:55 INFO - Options: 05:43:55 INFO - -h, --help show this help message and exit 05:43:55 INFO - -d DEST, --destination=DEST 05:43:55 INFO - Directory to install application into. [default: 05:43:55 INFO - "/builds/slave/test"] 05:43:55 INFO - --app=APP Application being installed. [default: firefox] 05:43:55 INFO - mkdir: /builds/slave/test/build/application 05:43:55 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'] 05:43:55 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 05:44:12 INFO - Reading from file tmpfile_stdout 05:44:12 INFO - Output received: 05:44:12 INFO - /builds/slave/test/build/application/firefox/firefox 05:44:12 INFO - Running post-action listener: _resource_record_post_action 05:44:12 INFO - ##### 05:44:12 INFO - ##### Finished install step (success) 05:44:12 INFO - ##### 05:44:12 INFO - ##### 05:44:12 INFO - ##### Running run-tests step. 05:44:12 INFO - ##### 05:44:12 INFO - Running pre-action listener: _resource_record_pre_action 05:44:12 INFO - Running main action method: run_tests 05:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:44:12 INFO - Python 2.7.3 05:44:12 INFO - Return code: 0 05:44:12 INFO - grabbing minidump binary from tooltool 05:44: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')]} 05:44:12 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 0xe4d3b0>, '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 0xe4e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:44:12 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 05:44:12 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 05:44:12 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 05:44:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:12 INFO - Return code: 0 05:44:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:44:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:44:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:44:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:44:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 05:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 05:44:12 INFO - Using env: {'DISPLAY': ':0', 05:44:12 INFO - 'HOME': '/home/cltbld', 05:44:12 INFO - 'LANG': 'en_US.UTF-8', 05:44:12 INFO - 'LANGUAGE': 'en_US:en', 05:44:12 INFO - 'LOGNAME': 'cltbld', 05:44:12 INFO - 'MAIL': '/var/mail/cltbld', 05:44:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:44:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:12 INFO - 'MOZ_NO_REMOTE': '1', 05:44:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:12 INFO - 'NO_EM_RESTART': '1', 05:44:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:12 INFO - 'PWD': '/builds/slave/test', 05:44:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:44:12 INFO - 'SHELL': '/bin/bash', 05:44:12 INFO - 'SHLVL': '1', 05:44:12 INFO - 'TERM': 'linux', 05:44:12 INFO - 'TMOUT': '86400', 05:44:12 INFO - 'USER': 'cltbld', 05:44:12 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976', 05:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:12 INFO - '_': '/tools/buildbot/bin/python'} 05:44:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 05:44:12 INFO - mozversion application_buildid: 20160710030217 05:44:12 INFO - mozversion application_changeset: 679118259e91f40d4a8f968f03ec4cff066cdb5b 05:44:12 INFO - mozversion application_display_name: Nightly 05:44:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:12 INFO - mozversion application_name: Firefox 05:44:12 INFO - mozversion application_remotingname: firefox 05:44:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:44:12 INFO - mozversion application_vendor: Mozilla 05:44:12 INFO - mozversion application_version: 50.0a1 05:44:12 INFO - mozversion platform_buildid: 20160710030217 05:44:12 INFO - mozversion platform_changeset: 679118259e91f40d4a8f968f03ec4cff066cdb5b 05:44:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:44:12 INFO - mozversion platform_version: 50.0a1 05:44:12 INFO - using testdate: 1468154652 05:44:12 INFO - actual date: 1468154652 05:44:12 INFO - starting webserver on 'localhost:37755' 05:44:12 INFO - SUITE-START | Running 2 tests 05:44:12 INFO - TEST-START | dromaeo_css 05:44:12 INFO - operating with platform_type : linux_ 05:44:12 INFO - Initialising browser for dromaeo_css test... 05:44:12 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmiyvMj/profile http://localhost:37755/getInfo.html) 05:44:16 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 05:44:16 INFO - PROCESS | 1964 | colorDepth:24 05:44:16 INFO - PROCESS | 1964 | Browser inner width/height: 1024/697 05:44:16 INFO - PROCESS | 1964 | __metrics 05:44:17 INFO - PROCESS | 1964 | 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" 05:44:17 INFO - PROCESS | 1964 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:44:18 INFO - TEST-INFO | 1964: exit 0 05:44:18 INFO - Browser initialized. 05:44:18 INFO - Running cycle 1/1 for dromaeo_css test... 05:44:18 INFO - TEST-INFO | started process 2048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmiyvMj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:29 INFO - PROCESS | 2048 | RSS: Main: 157487104 05:44:29 INFO - PROCESS | 2048 | 05:45:21 INFO - PROCESS | 2048 | 1468154721432 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] 05:47:28 INFO - PROCESS | 2048 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37755/tests/dromaeo/cssquery-ext.html) 05:47:29 INFO - PROCESS | 2048 | RSS: Main: 246198272 05:47:29 INFO - PROCESS | 2048 | 05:50:32 INFO - PROCESS | 2048 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-ext.html (next: http://localhost:37755/tests/dromaeo/cssquery-jquery.html) 05:50:32 INFO - PROCESS | 2048 | RSS: Main: 239960064 05:50:32 INFO - PROCESS | 2048 | 05:53:34 INFO - PROCESS | 2048 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37755/tests/dromaeo/cssquery-mootools.html) 05:53:35 INFO - PROCESS | 2048 | RSS: Main: 232833024 05:53:35 INFO - PROCESS | 2048 | 05:56:37 INFO - PROCESS | 2048 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37755/tests/dromaeo/cssquery-prototype.html) 05:56:38 INFO - PROCESS | 2048 | RSS: Main: 228368384 05:56:38 INFO - PROCESS | 2048 | 05:59:40 INFO - PROCESS | 2048 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37755/tests/dromaeo/cssquery-yui.html) 05:59:41 INFO - PROCESS | 2048 | RSS: Main: 225542144 05:59:41 INFO - PROCESS | 2048 | 06:02:43 INFO - PROCESS | 2048 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-yui.html (next: http://localhost:37755/tests/dromaeo/cssquery-dojo.html) 06:02:44 INFO - PROCESS | 2048 | RSS: Main: 317739008 06:02:44 INFO - PROCESS | 2048 | 06:02:44 INFO - PROCESS | 2048 | __start_tp_report 06:02:44 INFO - PROCESS | 2048 | _x_x_mozilla_page_load 06:02:44 INFO - PROCESS | 2048 | _x_x_mozilla_page_load_details 06:02:44 INFO - PROCESS | 2048 | |i|pagename|runs| 06:02:44 INFO - PROCESS | 2048 | |0;dojo.html;3015.336625942293;3030.0455356562693;3054.4501989641853;3062;3076.646185688645;5194.117000109981;5216;5248.737563121843;5306.151015837462;5356.464353564636;5283.128283833173;5299.205119232117;5306.336707911511;5318.9202161967505;5375.75809088591;4755.191617425029;4835.323054772335;4838.685485443452;4845.927311090337;5005.249212618118;4909.705417674951;4928.211486162215;4932.383452068491;4977.527134922177;4993.875153121183;4737.526247375269;4741.265103908882;4771.308160316752;4821.059893320804;4832.154372984749;4785.808567657289;4795.568398844121;4810.518948105197;4818.542238487373;4907.337509436252;4824.855254342376;4826.251930950673;4838.419389673227;4858.149823780825;4887.169181239198;5145.125328694131;5254.605904557136;5260.947390526084;5285.339332583427;5345.278387417688;5727.9427205727825;5736.713164341808;5739.82780516581;5741.052726300156;5765.1352297155345;5705.087186050212;5715.742791574389;5731.369549349568;5775.27809023872;5782.045962416196;5174.353205849231;5282.603804714662;5345.545628621572;5348.144296912515;5423.647462914898;5908.527317814564;5910.320313163955;5911.261092363455;5912.911306330322;5913.704314784243;5431.293931788921;5688.829335119953;5691.402402747734;5691.544676425876;5695.316562012585;5593.720313984284;5594.496495315441;5659.490645841812;5731.054376027909;5731.140328950607;5615;5632.267805185382;5634.859128521738;5648.604597678123;5689.743961521742;5456.890862182734;5577.05190117681;5673.404292549306;5685.260916080966;5692.203091567184;4318.438602981592;4330.480342358937;4350.695451318377;4389.780510974439;4390.582894625006;3856.132370216735;3874.748141370802;3887.61123887609;3892.2993861105274;3924.2151569686175;5244.606654500928;5248.160294352885;5270.183121616155;5379.112446446293;5420.186971954238;5658.462446067617;5708.743106560215;5728.513076388554;5735.311762588516;5787.363390027093;5349.679019258857;5355.250264962909;5362.51737343641;5364.678119312775;5367.597430192751;4794.328793968847;4872.196087645499;4894.021195760862;4950.77721502526;4987.027529631687;5866.530677545786;5869.589128761031;5869.618474799125;5875.9118613220835;5909.940900591025;5668.744906479136;5670.659760414388;5674.773009079756;5674.971625141848;5700.201971723879;5665.150227465913;5762.913556296575;5786.392428794916;5854.795082172103;5858.765649373977;5603.299587551556;5604.971975140098;5615.831525054255;5618.6628802272;5630.5777066720975;5631.155326701028;5677.914831277617;5705.7432415542235;5712.257406537124;5724.084146536534;5415.431379705232;5443.074677304789;5492.423295553909;5514.062609356339;5549.223108764695;5518.586106041983;5522.944770552243;5523.088690366205;5523.143912693539;5524.723763811874;5412.350517937873;5464.890702186013;5502.559795216293;5546.97226513881;5596.216529685766;5529.115341545334;5562.582806289463;5610.887782244414;5641.041023026013;5689.402612725604;5498.697571633598;5512.5314348280845;5512.944870551243;5514.751836167462;5519.834404967857 06:02:44 INFO - PROCESS | 2048 | |1;ext.html;595.348093837248;623.3236937922354;637.5760119520519;641.589382795011;644.2108417188947;32007.51988720171;34827;34865.651343486556;41532.58467415325;42563;44784;44908.775456122676;45159.322610160874;45286.77356613212;45310;8955.910440895588;9083.863742043875;9096.363254572183;9106.86339704905;9109.180173784358;9014.2788576914;9102.180803727662;9109.726708198765;9109.817803643924;9111.544422778868;9023.05257947916;9124.771880703001;9136.862947055799;9140.131687489678;9144.314176436794;9034.277257819358;9061.50161741104;9072.682456114004;9091.727248182498;9101.726948191565;8981.730548083568;9043.773905652346;9054.230390416822;9059.365844390895;9068.909310906873;42357.36463953043;42677.35983960243;42678.35982460265;42691.14617707628;42730;3464.168599536093;3527.5414196154334;3541.8937431877084;3567.0725611341236;3641.7268704847243;32954.83522582372;33042.6695733042;33408.16479588005;33546.832265838515;33600.49599256013;4115.36211887155;4115.691323150776;4146.979265103655;4163.458750362463;4266.786660666954;365509;369577;369996;370284;371087;34269.82865085708;35096.64903350985;35122.64877351245;55677.44322556723;56181.71909140428;36636.81681591628;36847.4472882907;36878.63121368806;36883.63116368856;36885.446718299245;15260.084394936339;15475.922620386826;15522.146281954601;15526.844731552766;15528.922355388151;12930.482780688668;12997.350132493337;13003.869961300456;13016.869831301756;13019;8292.419530632918;8304.750857474286;8320.37597180214;8333;8373.246407823324;3206.5190221466964;3266.4283750343593;3272.8199949002556;3285.572875526214;3330.717673695596;1046.1682962045193;1094.5129417409175;1129.5594718059963;1158.362900404774;1158.3802665573878;33507.66492335046;33531.66468335286;33933;34008.65991340055;34107.65892341094;1130.2032067392634;1135.3471753741633;1144.6508814811395;1145.7078444996473;1191.18999080626;17063.91468042652;17341.56646083858;17447.38934137299;17462.825371746374;17602.47192584199;589779;590233;595642;595721.0427895752;597428;58435;59120;59153;59183.704081479314;59190.11214831781;1231.4704676988802;1343.6237853401062;1348.2045593100117;1362.6729584899751;1381.84799672038;32805;34120.48819267663;34554.62585000201;34555.827220863735;34850.128746781535;49168.26247606217;49504.75247623739;49521.25718114303;49637.78078863337;49675;428609;429942;430881;431036;431819;21911.342659720234;26065.73934260709;27752.8612356945;27765;27803.524559430072;52921.7353913228;54056.18915716189;55079;59050.704746475996;59163;46469.53530464787;46838;47032;47364;47943;45447.318290226336;46620.53379466162;47064.29403559018;47162.76418617885;47573;45344.546554534034;45523;46085;46688.766556167;46813.53186468092;37947.24105517929;40267.597324026385;42971.3554296692;43205.351919720604;43734.343984839616;30274.54588181135;30926.381472369976;30966.380672386877;30983.225419364695;31304.686953130178 06:02:44 INFO - PROCESS | 2048 | |2;jquery.html;371.4150213413874;384.83067450321863;385.9035241189703;390.50991006287103;411.668606771549;18929.62140757184;19886;20185.697214541793;20220.595588088247;20237.797622023776;17163.91418042911;19585.90207048963;19630;19818.60362792747;19946;5571.4428557144365;5710.5717071219615;5855.151003104547;5879.147523609074;5920.4671579557835;3899.473571067912;5656;5870.589058765888;5874.060150375941;5879.235699359077;5768.192453056576;5921.940780592182;5938.554608404365;5946.048632218846;5959.255093113361;5931.555133364972;5959.910601340984;5961.135635332896;5984.3417224105315;5988.1317209004665;5565.666060036411;5613.214150019001;5626.971865140648;5777.075667893117;5798.7100644968;13546.254955977418;13611.591652250348;13640.386182621707;13747;21158.3652490424;2362.1732393662082;2490.941349926274;2493.7880280176205;2496.2885577610296;2736.2885649731215;10383.42891140987;10571.735706607396;11049.668509944715;12516.997280435178;14579.562613121623;1971.5662554238045;1995.6407846587608;2006.3679940818595;2008.98995505023;2051.1590247998397;74663.25336746672;81868.59065704692;82370;83122;86211.56894215489;11089.72275693098;11222.382768947786;11263.831042534368;11459;11570.537178512765;15426.691466170614;15478.458253961056;15494.922525387527;15533.301001454962;15543.300551475211;8098.797530061795;8152.225538573826;8201.507909525448;8201.917980820235;8242.134575869568;7830.2952734254195;7850.450468467267;7934.761957141295;8047.798805029804;8061.113277539466;4694.788734506956;4792.353032340589;4861.343718598015;4865.95134048662;4953.380827396575;1811.5652243461475;1857.5634725839418;1926.3546711851407;1940.2723978508059;1989.9403017909485;946.1484663802495;979.4710856137606;996.5366104761176;1012.3925644613173;1023.2734758321675;19668.50828729293;19677.8032219676;19715.309964151187;19730.90134549347;19863.30478433277;993.6919554937992;1047.5652604169184;1049.569676432659;1056.4136904018344;1081.8214994525972;10589.258751887293;10995.670129896116;11000.174986875856;11023.83464248037;11049.447527623586;469794;471417;474718;474824;478778;88350.55824720964;90694.54652726694;92477.53761231151;92508.53745731228;93497;978.3005151316701;983.4885859353096;998.7353351361895;999.7200783780553;1001.639409812467;17258.741118883478;17318.740218896473;17527.82472175262;17555.473335799947;17889.73165402494;40932.59067409288;41590;42115.1576968465;42694;44297.77851110724;55337;55729.72135139298;57928.77039395246;58207.4179258202;58975.410245896994;5999.430054144849;8637.352198585257;8690.348223883107;8756.868646970428;8897.688580899638;8965.327600430124;11223.60717374888;12697.084273608927;13196.802047969097;13621.931890340882;11813.763724725286;11865.881341186823;12048.277103373826;12182.939085304517;12303;11844.549649427685;11944.2833429991;11956.34240116802;12018.819717704067;12410.81383779226;12078.33569153705;12201.450934707782;12201.450934708137;12341.197822141532;12443.502259909503;7793.142754297136;7942.44402891792;7955.164707705608;8182.959085204536;9027.187553120251;11307.717307067389;12022.098342624513;12275.508979640714;12382.195157314745;12394.62816115518 06:02:44 INFO - PROCESS | 2048 | |3;mootools.html;1330.594168778522;1426.3296250762141;1464.1507925403266;1543.3286520363642;1692.179293042874;7726.8454630907345;8029.718959836407;8039.356851451885;8188.754337369874;8197.05733840607;7969.960150199241;8052.4765890217095;8081.3534917206625;8146.26683598476;8150.144234855344;1975.5357490989607;2166.8916554172306;2224.699665545155;2232.5646498932756;2254.7068881045443;2268.353519247015;2273.499830037389;2278.612635851909;2278.977210227893;2280.395695140789;2194.615942210115;2231.7210348706412;2234.1510226114056;2234.5642599693065;2240.1487434774763;1894.6779047561947;2116.629589821775;2170.913163473459;2173.71741673583;2183.585118827418;2149.7420309562954;2164.0802658869916;2170.1970270999673;2181.4655409424636;2182.1707751054655;8022.839543209161;8084.434089613729;8085.555294458803;8093.797655058612;8100.473469224482;4707.693999890031;4888.120138375091;4918.606511479109;4936.210206367;4937.037277730844;3029.4364183225593;3096.0866544369464;3134.09111357706;3149.9370012599848;3189.6012998375204;1081.6592773276393;1087.4127970895706;1093.9398333091676;1129.596416999436;1131.1685910855515;11256.493457794419;11256.887431125666;11260;11264.774704505864;11275.49260283281;4067.1255680028935;4126.112885729583;4210.32634778434;4234.576542345802;4305.763183024901;9460.290478214161;9471.952640236892;9487.525623718924;9488.240940724725;9489.952550237344;4788.377510923558;4789.95210047902;4790.449098353734;4796.424429068465;4803.903921921542;4018.8995275117773;4367.148406060851;4429.092036132585;4434.911301773946;4477.2164871147415;3741.8316175772156;3774.094217387862;3819.560750513671;3937.684985201177;3996.320625493673;1093.3767752381225;1192.2846292224597;1204.8554173499235;1233.1491271023144;1241.944112514939;847.7922908887239;944.6410364061612;956.6890760502864;975.6487664440796;981.4945303168873;5334.493223143795;5352.223927530486;5423.783048678088;5471.753771080311;5634;950.9286803489766;951.3911096897991;953.7091187187974;970.509892504295;979.5053497983473;3819.751716138442;3833.290841194388;3872.8644497442456;3874.0702231464247;4057.9391309130388;9950.253730970206;10030.398176109456;10159.085682288629;10160.898391016142;10423.114035306931;9956;9986.300958932805;9996.400215987063;10001.199904007663;10001.2999090063;7302.379297759644;7494;7506.211847755907;7620.428467864932;7621.69513219465;5170.870728231674;5218.608604354613;5352.812651557332;5437.782488700408;5469.288992431118;8999.820003600022;9137.5888085035;9237;9259.72220833376;9389.859152112587;9146.176844084064;9426.481543515172;9557.761055973657;9596.712098637052;9674.274429417681;7400.333969942731;7559.773206803805;7563.432742544222;7564;7575.734849280248;7731.574763388067;7867.763967080997;7881.408894333063;7983.441159118806;8063.637136328762;5944.524438045032;7258.237885021997;7305.305995930378;7321.9633901832285;7348.926510734825;7004.719811207495;7104.538205016657;7272.96363518179;7348.595827229554;7367.963160184165;6562.343765623399;6564.277929427663;6615.040819081302;6616.073749674953;6619.966900165468;4759.666823322473;4827.300041493893;4920.8769780755765;4939.48135445773;4945.035718035093;4654.557817007379;4798.568128868418;4906.190478571139;4908.730019848943;4927.778249978831 06:02:44 INFO - PROCESS | 2048 | |4;prototype.html;302.52503569396043;312.2568287475807;314.96062992125997;315.81524807987336;319.40271691936084;5265.9473405265935;5272.630915835893;5292.1267990781525;5310.6017048721305;5332.733363331838;5163.561097306733;5218.425973142951;5266.841994740154;5268.683878967265;5289.973550132244;3893.4743809585766;3941.7043721720843;4052.1895620875794;4069.1454794493043;4143.440635514212;4079.571644977279;4090.8159132839096;4091.590840915914;4107.377585853586;4113.547509773923;3919.451276821247;4030.9596904031023;4032.778197199153;4090.325096359112;4103.610157035077;3958.9802050989706;4092.4270602115726;4100.753954762708;4103.835846566134;4118.258713431581;3606.6114545899754;3613.530241068644;3627.020704409821;3630.5824830144343;3637.7271704621994;5118.539331460186;5120.769565369567;5122.948770512285;5122.948770512285;5148.253503242009;4423.203823311803;4637.628989680851;4670.229412146991;4696.7651617419;4696.976515117402;5488.121900495941;5497.5601951844155;5508.614396992212;5514.310711161105;5523.652447709747;3718.1819999600043;3867.1298957734566;3902.64876161144;3916.5104361954754;3925.077606762437;5596.649407248925;5625.437456254342;5633.380478077714;5655.175169575344;5658.773649054033;3967.6032396760093;3970.1265721541213;3972.503437070366;3980.3233450313514;4006.4791577094793;3899.1421887184774;4054.8986275343354;4055.8783236502363;4057.5333836609166;4060.634542891154;4589.54104589545;4602.309653551927;4636.559526844944;4648.604868586141;4657.81225787422;5520.613557050968;5534.1975413564805;5539.279893613885;5541.806036788693;5546.223528705985;1361.9455221791216;1374.2579007336126;1380.9102408343426;1389.0485017762865;1396.615930619088;870.3559366069189;887.1882227761525;895.4582477601087;897.1118592593416;906.3157316226338;4650.790794393482;4671.6262698984;4695.272232803921;4705;4780.780900870256;4913.361263035782;4977.253411988231;5002.374703162105;5095.133827249377;5096.210087436453;4341.630961368256;4639.698419602782;4650.256153942271;4726.503717109723;4745.335653008581;2649.5098406794805;2667.7328269072036;2684.9797077110575;2686.449277898026;2692.030868887199;5131.589472842164;5158.432572417031;5172.655109671513;5199.896002079937;5200.739963001911;4775.641826863;5013.724245166478;5031.874203144951;5036.194208926554;5053.67151135175;5092.932532130554;5134.512221338967;5135.974320128375;5181.611379146504;5250.711210883438;4806.711597304173;4985.6011519077665;5015.498450155102;5032.521910418504;5049.823256186016;4826.300186473012;4838.927416088691;4930.704157750546;4956.950430495649;4980.228064649985;5112.054269960069;5129.384473863011;5131.589472842238;5149;5229.189475631283;3691.3724666807243;3713.814309284579;3716.9442458363687;3719.126005388677;3719.85120595184;4768.356271903249;4913.533214344631;4928.433230178575;4933.679310844784;4958.776855041604;4853.223484242504;4867.318575399376;4914.189158788903;4917.28699338601;4960.131976903956;4829.73436460998;4870.09903167915;4871.87820304481;4925.251535704773;4930.6055515557955;4590.360542687901;4888.169011268022;4926.802927882844;4930.186519224288;4933.777979990838;4899.534544218293;4920.065187614342;4956.067133817742;4967.925481117858;5006.799728010838;4793.23308270675;4807.687500312469;4852.514748525119;4893.461719210955;4916.311716359641 06:02:44 INFO - PROCESS | 2048 | |5;yui.html;734.970601175953;739.4934469888127;743.1602289412964;802.9116797152312;847.3814115695538;15353.769693454607;16196.271167797448;16526.91736541317;16588.419405320816;16606.25271862766;14995.325210365532;15158.924205378986;15164.469243576477;15164.696706065899;15209.543713688607;639.6002498438476;751.7293774241268;757.1482082657025;781.5506084001722;785.3481610263468;760.8250102476434;765.8812884002989;767.3477544087509;768.1857231334803;768.6848392159216;819.3608984991716;819.7663665855232;819.8647223208163;820.831729495452;821.0229826506468;670.088679396021;803.9035315762117;825.22428916818;825.4593241426845;826.9545175015372;601.4737105033096;601.503759398498;601.7683191971079;602.0878369270558;602.6956387024568;14857.331420086122;14904.403823847033;14923;14927.477538286217;14928.10431374121;14216.289185540785;14518.20149891766;14522.782158267635;14570.854291457055;14648.267586620626;13020.674483137902;13390.687299456516;13471.66320841977;13586.320683965761;13783.931080344635;4512.684112112153;4514.210013247669;4553.612942899857;4566.223741963874;4680.789364478606;73930;75004;77491.22508774897;77523.61238193772;77915.61042194752;11481.196316257781;11572.59495917639;11645.475953582109;11754.588589399329;11843.170978031456;20678.379648610568;20740.06669699867;20853.37439876806;20863.37409877706;20876.37370878876;8648.308135349156;8678.088800675965;8773.122687731304;8788.736337909873;8821.735347939572;4826.155422800995;4858.8299409521205;4887.3890763654545;4996.800127994839;5018.473060328686;3320.8505617247283;3414.5219669246326;3420.3672320620763;3424.092615456906;3430.468277417004;561.3852831149884;574.4600075928614;585.2128886647453;587.3803137689692;600.9939900601025;615.7290792051483;681.3084719010209;692.536000879412;710.0627172132736;716.2085895085959;9510.38182518134;9717.56270967808;9777.168940640126;10033.097021267975;10064.144547713526;637.5664548107239;637.8628594852037;695.7564852301755;703.9753608623673;705.9399951004119;4435.866923992286;4663.370444989883;4687.882802929886;4758.976205118952;4822.95177048225;73137;128103;129169;129994;130443.34778326238;105259;109337.45331273452;109412;109548.4522577398;111347.44326278479;94696;95147;96638.51680741551;96943.51528242455;100449.49775251077;9222.308326875645;9475.099865512766;9488.003759605142;9505.762355941157;9602.66390676323;49393.259101112795;55762;56246.43753562576;57206;57522.42477575171;49728;73300;76219;79302.2069779318;79604.60197698974;11154.721131971766;11209.943950280196;11372;13598.728025439634;13895.444182232597;13613.591592252249;13778.862211377758;14109.435622574982;14248.430062797372;15734.9213253933;14079.225642589756;14276.357563909442;14788.852111478747;15287;15663.921680391524;14546.636334091732;14560.509111487341;15107.169105699291;15200.695986079996;15238.695226095195;14454.132752034911;14565.053271537316;15553.922230388776;15604.531864044096;15665.451709190123;11507.194496385173;11931.701707457383;12090.637280881587;12154.149209555246;12168.365826029873;11779.411029448665;12206.206596571194;12272.570460033856;12278.631641050782;12661.493540258654 06:02:44 INFO - PROCESS | 2048 | __end_tp_report 06:02:44 INFO - PROCESS | 2048 | __start_cc_report 06:02:44 INFO - PROCESS | 2048 | _x_x_mozilla_cycle_collect,788 06:02:44 INFO - PROCESS | 2048 | __end_cc_report 06:02:44 INFO - PROCESS | 2048 | __startTimestamp1468155764022__endTimestamp 06:02:44 INFO - PROCESS | 2048 | 06:02:44 INFO - PROCESS | 2048 | ------- Summary: start ------- 06:02:44 INFO - PROCESS | 2048 | Number of tests: 6 06:02:44 INFO - PROCESS | 2048 | 06:02:44 INFO - PROCESS | 2048 | [#0] dojo.html Cycles:165 Average:5279.67 Median:5498.70 stddev:601.22 (10.9%) stddev-sans-first:576.22 06:02:44 INFO - PROCESS | 2048 | Values: 3015.3 3030.0 3054.5 3062.0 3076.6 5194.1 5216.0 5248.7 5306.2 5356.5 5283.1 5299.2 5306.3 5318.9 5375.8 4755.2 4835.3 4838.7 4845.9 5005.2 4909.7 4928.2 4932.4 4977.5 4993.9 4737.5 4741.3 4771.3 4821.1 4832.2 4785.8 4795.6 4810.5 4818.5 4907.3 4824.9 4826.3 4838.4 4858.1 4887.2 5145.1 5254.6 5260.9 5285.3 5345.3 5727.9 5736.7 5739.8 5741.1 5765.1 5705.1 5715.7 5731.4 5775.3 5782.0 5174.4 5282.6 5345.5 5348.1 5423.6 5908.5 5910.3 5911.3 5912.9 5913.7 5431.3 5688.8 5691.4 5691.5 5695.3 5593.7 5594.5 5659.5 5731.1 5731.1 5615.0 5632.3 5634.9 5648.6 5689.7 5456.9 5577.1 5673.4 5685.3 5692.2 4318.4 4330.5 4350.7 4389.8 4390.6 3856.1 3874.7 3887.6 3892.3 3924.2 5244.6 5248.2 5270.2 5379.1 5420.2 5658.5 5708.7 5728.5 5735.3 5787.4 5349.7 5355.3 5362.5 5364.7 5367.6 4794.3 4872.2 4894.0 4950.8 4987.0 5866.5 5869.6 5869.6 5875.9 5909.9 5668.7 5670.7 5674.8 5675.0 5700.2 5665.2 5762.9 5786.4 5854.8 5858.8 5603.3 5605.0 5615.8 5618.7 5630.6 5631.2 5677.9 5705.7 5712.3 5724.1 5415.4 5443.1 5492.4 5514.1 5549.2 5518.6 5522.9 5523.1 5523.1 5524.7 5412.4 5464.9 5502.6 5547.0 5596.2 5529.1 5562.6 5610.9 5641.0 5689.4 5498.7 5512.5 5512.9 5514.8 5519.8 06:02:44 INFO - PROCESS | 2048 | 06:02:44 INFO - PROCESS | 2048 | [#1] ext.html Cycles:180 Average:61608.10 Median:23472.07 stddev:126163.98 (537.5%) stddev-sans-first:126434.74 06:02:44 INFO - PROCESS | 2048 | Values: 595.3 623.3 637.6 641.6 644.2 32007.5 34827.0 34865.7 41532.6 42563.0 44784.0 44908.8 45159.3 45286.8 45310.0 8955.9 9083.9 9096.4 9106.9 9109.2 9014.3 9102.2 9109.7 9109.8 9111.5 9023.1 9124.8 9136.9 9140.1 9144.3 9034.3 9061.5 9072.7 9091.7 9101.7 8981.7 9043.8 9054.2 9059.4 9068.9 42357.4 42677.4 42678.4 42691.1 42730.0 3464.2 3527.5 3541.9 3567.1 3641.7 32954.8 33042.7 33408.2 33546.8 33600.5 4115.4 4115.7 4147.0 4163.5 4266.8 365509.0 369577.0 369996.0 370284.0 371087.0 34269.8 35096.6 35122.6 55677.4 56181.7 36636.8 36847.4 36878.6 36883.6 36885.4 15260.1 15475.9 15522.1 15526.8 15528.9 12930.5 12997.4 13003.9 13016.9 13019.0 8292.4 8304.8 8320.4 8333.0 8373.2 3206.5 3266.4 3272.8 3285.6 3330.7 1046.2 1094.5 1129.6 1158.4 1158.4 33507.7 33531.7 33933.0 34008.7 34107.7 1130.2 1135.3 1144.7 1145.7 1191.2 17063.9 17341.6 17447.4 17462.8 17602.5 589779.0 590233.0 595642.0 595721.0 597428.0 58435.0 59120.0 59153.0 59183.7 59190.1 1231.5 1343.6 1348.2 1362.7 1381.8 32805.0 34120.5 34554.6 34555.8 34850.1 49168.3 49504.8 49521.3 49637.8 49675.0 428609.0 429942.0 430881.0 431036.0 431819.0 21911.3 26065.7 27752.9 27765.0 27803.5 52921.7 54056.2 55079.0 59050.7 59163.0 46469.5 46838.0 47032.0 47364.0 47943.0 45447.3 46620.5 47064.3 47162.8 47573.0 45344.5 45523.0 46085.0 46688.8 46813.5 37947.2 40267.6 42971.4 43205.4 43734.3 30274.5 30926.4 30966.4 30983.2 31304.7 06:02:44 INFO - PROCESS | 2048 | 06:02:44 INFO - PROCESS | 2048 | [#2] jquery.html Cycles:180 Average:28444.22 Median:1553.85 stddev:78237.09 (5035.0%) stddev-sans-first:78428.17 06:02:44 INFO - PROCESS | 2048 | Values: 371.4 384.8 385.9 390.5 411.7 18929.6 19886.0 20185.7 20220.6 20237.8 17163.9 19585.9 19630.0 19818.6 19946.0 5571.4 5710.6 5855.2 5879.1 5920.5 3899.5 5656.0 5870.6 5874.1 5879.2 5768.2 5921.9 5938.6 5946.0 5959.3 5931.6 5959.9 5961.1 5984.3 5988.1 5565.7 5613.2 5627.0 5777.1 5798.7 13546.3 13611.6 13640.4 13747.0 21158.4 2362.2 2490.9 2493.8 2496.3 2736.3 10383.4 10571.7 11049.7 12517.0 14579.6 1971.6 1995.6 2006.4 2009.0 2051.2 74663.3 81868.6 82370.0 83122.0 86211.6 11089.7 11222.4 11263.8 11459.0 11570.5 15426.7 15478.5 15494.9 15533.3 15543.3 8098.8 8152.2 8201.5 8201.9 8242.1 7830.3 7850.5 7934.8 8047.8 8061.1 4694.8 4792.4 4861.3 4866.0 4953.4 1811.6 1857.6 1926.4 1940.3 1989.9 946.1 979.5 996.5 1012.4 1023.3 19668.5 19677.8 19715.3 19730.9 19863.3 993.7 1047.6 1049.6 1056.4 1081.8 10589.3 10995.7 11000.2 11023.8 11049.4 469794.0 471417.0 474718.0 474824.0 478778.0 88350.6 90694.5 92477.5 92508.5 93497.0 978.3 983.5 998.7 999.7 1001.6 17258.7 17318.7 17527.8 17555.5 17889.7 40932.6 41590.0 42115.2 42694.0 44297.8 55337.0 55729.7 57928.8 58207.4 58975.4 5999.4 8637.4 8690.3 8756.9 8897.7 8965.3 11223.6 12697.1 13196.8 13621.9 11813.8 11865.9 12048.3 12182.9 12303.0 11844.5 11944.3 11956.3 12018.8 12410.8 12078.3 12201.5 12201.5 12341.2 12443.5 7793.1 7942.4 7955.2 8183.0 9027.2 11307.7 12022.1 12275.5 12382.2 12394.6 06:02:44 INFO - PROCESS | 2048 | 06:02:44 INFO - PROCESS | 2048 | [#3] mootools.html Cycles:180 Average:5382.14 Median:4924.33 stddev:3019.99 (61.3%) stddev-sans-first:3013.11 06:02:44 INFO - PROCESS | 2048 | Values: 1330.6 1426.3 1464.2 1543.3 1692.2 7726.8 8029.7 8039.4 8188.8 8197.1 7970.0 8052.5 8081.4 8146.3 8150.1 1975.5 2166.9 2224.7 2232.6 2254.7 2268.4 2273.5 2278.6 2279.0 2280.4 2194.6 2231.7 2234.2 2234.6 2240.1 1894.7 2116.6 2170.9 2173.7 2183.6 2149.7 2164.1 2170.2 2181.5 2182.2 8022.8 8084.4 8085.6 8093.8 8100.5 4707.7 4888.1 4918.6 4936.2 4937.0 3029.4 3096.1 3134.1 3149.9 3189.6 1081.7 1087.4 1093.9 1129.6 1131.2 11256.5 11256.9 11260.0 11264.8 11275.5 4067.1 4126.1 4210.3 4234.6 4305.8 9460.3 9472.0 9487.5 9488.2 9490.0 4788.4 4790.0 4790.4 4796.4 4803.9 4018.9 4367.1 4429.1 4434.9 4477.2 3741.8 3774.1 3819.6 3937.7 3996.3 1093.4 1192.3 1204.9 1233.1 1241.9 847.8 944.6 956.7 975.6 981.5 5334.5 5352.2 5423.8 5471.8 5634.0 950.9 951.4 953.7 970.5 979.5 3819.8 3833.3 3872.9 3874.1 4057.9 9950.3 10030.4 10159.1 10160.9 10423.1 9956.0 9986.3 9996.4 10001.2 10001.3 7302.4 7494.0 7506.2 7620.4 7621.7 5170.9 5218.6 5352.8 5437.8 5469.3 8999.8 9137.6 9237.0 9259.7 9389.9 9146.2 9426.5 9557.8 9596.7 9674.3 7400.3 7559.8 7563.4 7564.0 7575.7 7731.6 7867.8 7881.4 7983.4 8063.6 5944.5 7258.2 7305.3 7322.0 7348.9 7004.7 7104.5 7273.0 7348.6 7368.0 6562.3 6564.3 6615.0 6616.1 6620.0 4759.7 4827.3 4920.9 4939.5 4945.0 4654.6 4798.6 4906.2 4908.7 4927.8 06:02:44 INFO - PROCESS | 2048 | 06:02:44 INFO - PROCESS | 2048 | [#4] prototype.html Cycles:180 Average:4342.17 Median:4860.27 stddev:1229.05 (25.3%) stddev-sans-first:1194.51 06:02:44 INFO - PROCESS | 2048 | Values: 302.5 312.3 315.0 315.8 319.4 5265.9 5272.6 5292.1 5310.6 5332.7 5163.6 5218.4 5266.8 5268.7 5290.0 3893.5 3941.7 4052.2 4069.1 4143.4 4079.6 4090.8 4091.6 4107.4 4113.5 3919.5 4031.0 4032.8 4090.3 4103.6 3959.0 4092.4 4100.8 4103.8 4118.3 3606.6 3613.5 3627.0 3630.6 3637.7 5118.5 5120.8 5122.9 5122.9 5148.3 4423.2 4637.6 4670.2 4696.8 4697.0 5488.1 5497.6 5508.6 5514.3 5523.7 3718.2 3867.1 3902.6 3916.5 3925.1 5596.6 5625.4 5633.4 5655.2 5658.8 3967.6 3970.1 3972.5 3980.3 4006.5 3899.1 4054.9 4055.9 4057.5 4060.6 4589.5 4602.3 4636.6 4648.6 4657.8 5520.6 5534.2 5539.3 5541.8 5546.2 1361.9 1374.3 1380.9 1389.0 1396.6 870.4 887.2 895.5 897.1 906.3 4650.8 4671.6 4695.3 4705.0 4780.8 4913.4 4977.3 5002.4 5095.1 5096.2 4341.6 4639.7 4650.3 4726.5 4745.3 2649.5 2667.7 2685.0 2686.4 2692.0 5131.6 5158.4 5172.7 5199.9 5200.7 4775.6 5013.7 5031.9 5036.2 5053.7 5092.9 5134.5 5136.0 5181.6 5250.7 4806.7 4985.6 5015.5 5032.5 5049.8 4826.3 4838.9 4930.7 4957.0 4980.2 5112.1 5129.4 5131.6 5149.0 5229.2 3691.4 3713.8 3716.9 3719.1 3719.9 4768.4 4913.5 4928.4 4933.7 4958.8 4853.2 4867.3 4914.2 4917.3 4960.1 4829.7 4870.1 4871.9 4925.3 4930.6 4590.4 4888.2 4926.8 4930.2 4933.8 4899.5 4920.1 4956.1 4967.9 5006.8 4793.2 4807.7 4852.5 4893.5 4916.3 06:02:44 INFO - PROCESS | 2048 | 06:02:44 INFO - PROCESS | 2048 | [#5] yui.html Cycles:180 Average:21709.77 Median:4559.92 stddev:31820.58 (697.8%) stddev-sans-first:31870.87 06:02:44 INFO - PROCESS | 2048 | Values: 735.0 739.5 743.2 802.9 847.4 15353.8 16196.3 16526.9 16588.4 16606.3 14995.3 15158.9 15164.5 15164.7 15209.5 639.6 751.7 757.1 781.6 785.3 760.8 765.9 767.3 768.2 768.7 819.4 819.8 819.9 820.8 821.0 670.1 803.9 825.2 825.5 827.0 601.5 601.5 601.8 602.1 602.7 14857.3 14904.4 14923.0 14927.5 14928.1 14216.3 14518.2 14522.8 14570.9 14648.3 13020.7 13390.7 13471.7 13586.3 13783.9 4512.7 4514.2 4553.6 4566.2 4680.8 73930.0 75004.0 77491.2 77523.6 77915.6 11481.2 11572.6 11645.5 11754.6 11843.2 20678.4 20740.1 20853.4 20863.4 20876.4 8648.3 8678.1 8773.1 8788.7 8821.7 4826.2 4858.8 4887.4 4996.8 5018.5 3320.9 3414.5 3420.4 3424.1 3430.5 561.4 574.5 585.2 587.4 601.0 615.7 681.3 692.5 710.1 716.2 9510.4 9717.6 9777.2 10033.1 10064.1 637.6 637.9 695.8 704.0 705.9 4435.9 4663.4 4687.9 4759.0 4823.0 73137.0 128103.0 129169.0 129994.0 130443.3 105259.0 109337.5 109412.0 109548.5 111347.4 94696.0 95147.0 96638.5 96943.5 100449.5 9222.3 9475.1 9488.0 9505.8 9602.7 49393.3 55762.0 56246.4 57206.0 57522.4 49728.0 73300.0 76219.0 79302.2 79604.6 11154.7 11209.9 11372.0 13598.7 13895.4 13613.6 13778.9 14109.4 14248.4 15734.9 14079.2 14276.4 14788.9 15287.0 15663.9 14546.6 14560.5 15107.2 15200.7 15238.7 14454.1 14565.1 15553.9 15604.5 15665.5 11507.2 11931.7 12090.6 12154.1 12168.4 11779.4 12206.2 12272.6 12278.6 12661.5 06:02:44 INFO - PROCESS | 2048 | -------- Summary: end -------- 06:02:44 INFO - PROCESS | 2048 | 06:02:44 INFO - TEST-INFO | 2048: exit 0 06:02:44 INFO - TEST-OK | dromaeo_css | took 1112326ms 06:02:44 INFO - TEST-START | kraken 06:02:44 INFO - operating with platform_type : linux_ 06:02:44 INFO - Initialising browser for kraken test... 06:02:44 INFO - TEST-INFO | started process 2242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpng6KPD/profile http://localhost:37755/getInfo.html) 06:02:48 INFO - PROCESS | 2242 | __metrics Screen width/height:1600/1200 06:02:48 INFO - PROCESS | 2242 | colorDepth:24 06:02:48 INFO - PROCESS | 2242 | Browser inner width/height: 1024/697 06:02:48 INFO - PROCESS | 2242 | __metrics 06:02:49 INFO - PROCESS | 2242 | 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:49 INFO - PROCESS | 2242 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:02:50 INFO - TEST-INFO | 2242: exit 0 06:02:50 INFO - Browser initialized. 06:02:50 INFO - Running cycle 1/1 for kraken test... 06:02:50 INFO - TEST-INFO | started process 2323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpng6KPD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:02 INFO - PROCESS | 2323 | RSS: Main: 157184000 06:03:02 INFO - PROCESS | 2323 | 06:03:04 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37755/tests/kraken/driver.html?testName=audio-beat-detection) 06:03:05 INFO - PROCESS | 2323 | RSS: Main: 215875584 06:03:05 INFO - PROCESS | 2323 | 06:03:08 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37755/tests/kraken/driver.html?testName=audio-dft) 06:03:08 INFO - PROCESS | 2323 | RSS: Main: 203796480 06:03:08 INFO - PROCESS | 2323 | 06:03:12 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37755/tests/kraken/driver.html?testName=audio-fft) 06:03:12 INFO - PROCESS | 2323 | RSS: Main: 270016512 06:03:12 INFO - PROCESS | 2323 | 06:03:14 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37755/tests/kraken/driver.html?testName=audio-oscillator) 06:03:15 INFO - PROCESS | 2323 | RSS: Main: 180678656 06:03:15 INFO - PROCESS | 2323 | 06:03:17 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:03:18 INFO - PROCESS | 2323 | RSS: Main: 185659392 06:03:18 INFO - PROCESS | 2323 | 06:03:21 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37755/tests/kraken/driver.html?testName=imaging-darkroom) 06:03:21 INFO - PROCESS | 2323 | RSS: Main: 219594752 06:03:21 INFO - PROCESS | 2323 | 06:03:25 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37755/tests/kraken/driver.html?testName=imaging-desaturate) 06:03:25 INFO - PROCESS | 2323 | RSS: Main: 221536256 06:03:25 INFO - PROCESS | 2323 | 06:03:28 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37755/tests/kraken/driver.html?testName=json-parse-financial) 06:03:29 INFO - PROCESS | 2323 | RSS: Main: 221499392 06:03:29 INFO - PROCESS | 2323 | 06:03:30 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:31 INFO - PROCESS | 2323 | RSS: Main: 208998400 06:03:31 INFO - PROCESS | 2323 | 06:03:32 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:33 INFO - PROCESS | 2323 | RSS: Main: 213741568 06:03:33 INFO - PROCESS | 2323 | 06:03:35 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:36 INFO - PROCESS | 2323 | RSS: Main: 209694720 06:03:36 INFO - PROCESS | 2323 | 06:03:38 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:03:39 INFO - PROCESS | 2323 | RSS: Main: 229257216 06:03:39 INFO - PROCESS | 2323 | 06:03:42 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:42 INFO - PROCESS | 2323 | RSS: Main: 224231424 06:03:42 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37755/tests/kraken/driver.html?testName=ai-astar) 06:03:44 INFO - PROCESS | 2323 | RSS: Main: 266657792 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | __start_tp_report 06:03:44 INFO - PROCESS | 2323 | _x_x_mozilla_page_load 06:03:44 INFO - PROCESS | 2323 | _x_x_mozilla_page_load_details 06:03:44 INFO - PROCESS | 2323 | |i|pagename|runs| 06:03:44 INFO - PROCESS | 2323 | |0;ai-astar;102;113;112;113;113;111;111;111;111;111 06:03:44 INFO - PROCESS | 2323 | |1;audio-beat-detection;144;117;119;177;120;117;144;116;165;117 06:03:44 INFO - PROCESS | 2323 | |2;audio-dft;160;162;161;161;159;161;160;158;162;161 06:03:44 INFO - PROCESS | 2323 | |3;audio-fft;74;75;76;117;75;76;74;74;96;75 06:03:44 INFO - PROCESS | 2323 | |4;audio-oscillator;82;83;114;83;83;83;122;83;84;126 06:03:44 INFO - PROCESS | 2323 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 06:03:44 INFO - PROCESS | 2323 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;146;146 06:03:44 INFO - PROCESS | 2323 | |7;imaging-desaturate;96;95;95;95;95;95;96;95;95;95 06:03:44 INFO - PROCESS | 2323 | |8;json-parse-financial;55;55;56;55;54;54;55;54;54;55 06:03:44 INFO - PROCESS | 2323 | |9;json-stringify-tinderbox;61;61;60;60;63;61;61;60;61;60 06:03:44 INFO - PROCESS | 2323 | |10;stanford-crypto-aes;75;76;75;75;75;75;75;75;75;83 06:03:44 INFO - PROCESS | 2323 | |11;stanford-crypto-ccm;121;118;127;135;122;123;126;119;163;129 06:03:44 INFO - PROCESS | 2323 | |12;stanford-crypto-pbkdf2;161;161;160;158;158;156;156;162;156;161 06:03:44 INFO - PROCESS | 2323 | |13;stanford-crypto-sha256-iterative;62;64;64;63;63;62;62;62;62;62 06:03:44 INFO - PROCESS | 2323 | __end_tp_report 06:03:44 INFO - PROCESS | 2323 | __start_cc_report 06:03:44 INFO - PROCESS | 2323 | _x_x_mozilla_cycle_collect,1672 06:03:44 INFO - PROCESS | 2323 | __end_cc_report 06:03:44 INFO - PROCESS | 2323 | __startTimestamp1468155824627__endTimestamp 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | ------- Summary: start ------- 06:03:44 INFO - PROCESS | 2323 | Number of tests: 14 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:3.22 (2.9%) stddev-sans-first:0.97 06:03:44 INFO - PROCESS | 2323 | Values: 102.0 113.0 112.0 113.0 113.0 111.0 111.0 111.0 111.0 111.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:132.00 stddev:22.66 (17.2%) stddev-sans-first:23.72 06:03:44 INFO - PROCESS | 2323 | Values: 144.0 117.0 119.0 177.0 120.0 117.0 144.0 116.0 165.0 117.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 06:03:44 INFO - PROCESS | 2323 | Values: 160.0 162.0 161.0 161.0 159.0 161.0 160.0 158.0 162.0 161.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:14.24 (19.0%) stddev-sans-first:14.87 06:03:44 INFO - PROCESS | 2323 | Values: 74.0 75.0 76.0 117.0 75.0 76.0 74.0 74.0 96.0 75.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:83.00 stddev:18.43 (22.2%) stddev-sans-first:19.00 06:03:44 INFO - PROCESS | 2323 | Values: 82.0 83.0 114.0 83.0 83.0 83.0 122.0 83.0 84.0 126.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:03:44 INFO - PROCESS | 2323 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 06:03:44 INFO - PROCESS | 2323 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:03:44 INFO - PROCESS | 2323 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 06:03:44 INFO - PROCESS | 2323 | Values: 55.0 55.0 56.0 55.0 54.0 54.0 55.0 54.0 54.0 55.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 06:03:44 INFO - PROCESS | 2323 | Values: 61.0 61.0 60.0 60.0 63.0 61.0 61.0 60.0 61.0 60.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.00 stddev:2.51 (3.4%) stddev-sans-first:2.65 06:03:44 INFO - PROCESS | 2323 | Values: 75.0 76.0 75.0 75.0 75.0 75.0 75.0 75.0 75.0 83.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:126.50 stddev:13.21 (10.4%) stddev-sans-first:13.74 06:03:44 INFO - PROCESS | 2323 | Values: 121.0 118.0 127.0 135.0 122.0 123.0 126.0 119.0 163.0 129.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:160.50 stddev:2.38 (1.5%) stddev-sans-first:2.40 06:03:44 INFO - PROCESS | 2323 | Values: 161.0 161.0 160.0 158.0 158.0 156.0 156.0 162.0 156.0 161.0 06:03:44 INFO - PROCESS | 2323 | 06:03:44 INFO - PROCESS | 2323 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 06:03:44 INFO - PROCESS | 2323 | Values: 62.0 64.0 64.0 63.0 63.0 62.0 62.0 62.0 62.0 62.0 06:03:44 INFO - PROCESS | 2323 | -------- Summary: end -------- 06:03:44 INFO - PROCESS | 2323 | 06:03:45 INFO - TEST-INFO | 2323: exit 0 06:03:45 INFO - TEST-OK | kraken | took 60812ms 06:03:45 INFO - SUITE-END | took 1173s 06:03:45 INFO - Completed test suite (00:19:33) 06:03:45 INFO - javascript benchmark 06:03:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3015.336625942293, 3030.0455356562693, 3054.4501989641853, 3062.0, 3076.646185688645, 5194.117000109981, 5216.0, 5248.737563121843, 5306.151015837462, 5356.464353564636, 5283.128283833173, 5299.205119232117, 5306.336707911511, 5318.9202161967505, 5375.75809088591, 4755.191617425029, 4835.323054772335, 4838.685485443452, 4845.927311090337, 5005.249212618118, 4909.705417674951, 4928.211486162215, 4932.383452068491, 4977.527134922177, 4993.875153121183, 4737.526247375269, 4741.265103908882, 4771.308160316752, 4821.059893320804, 4832.154372984749, 4785.808567657289, 4795.568398844121, 4810.518948105197, 4818.542238487373, 4907.337509436252, 4824.855254342376, 4826.251930950673, 4838.419389673227, 4858.149823780825, 4887.169181239198, 5145.125328694131, 5254.605904557136, 5260.947390526084, 5285.339332583427, 5345.278387417688, 5727.9427205727825, 5736.713164341808, 5739.82780516581, 5741.052726300156, 5765.1352297155345, 5705.087186050212, 5715.742791574389, 5731.369549349568, 5775.27809023872, 5782.045962416196, 5174.353205849231, 5282.603804714662, 5345.545628621572, 5348.144296912515, 5423.647462914898, 5908.527317814564, 5910.320313163955, 5911.261092363455, 5912.911306330322, 5913.704314784243, 5431.293931788921, 5688.829335119953, 5691.402402747734, 5691.544676425876, 5695.316562012585, 5593.720313984284, 5594.496495315441, 5659.490645841812, 5731.054376027909, 5731.140328950607, 5615.0, 5632.267805185382, 5634.859128521738, 5648.604597678123, 5689.743961521742, 5456.890862182734, 5577.05190117681, 5673.404292549306, 5685.260916080966, 5692.203091567184, 4318.438602981592, 4330.480342358937, 4350.695451318377, 4389.780510974439, 4390.582894625006, 3856.132370216735, 3874.748141370802, 3887.61123887609, 3892.2993861105274, 3924.2151569686175, 5244.606654500928, 5248.160294352885, 5270.183121616155, 5379.112446446293, 5420.186971954238, 5658.462446067617, 5708.743106560215, 5728.513076388554, 5735.311762588516, 5787.363390027093, 5349.679019258857, 5355.250264962909, 5362.51737343641, 5364.678119312775, 5367.597430192751, 4794.328793968847, 4872.196087645499, 4894.021195760862, 4950.77721502526, 4987.027529631687, 5866.530677545786, 5869.589128761031, 5869.618474799125, 5875.9118613220835, 5909.940900591025, 5668.744906479136, 5670.659760414388, 5674.773009079756, 5674.971625141848, 5700.201971723879, 5665.150227465913, 5762.913556296575, 5786.392428794916, 5854.795082172103, 5858.765649373977, 5603.299587551556, 5604.971975140098, 5615.831525054255, 5618.6628802272, 5630.5777066720975, 5631.155326701028, 5677.914831277617, 5705.7432415542235, 5712.257406537124, 5724.084146536534, 5415.431379705232, 5443.074677304789, 5492.423295553909, 5514.062609356339, 5549.223108764695, 5518.586106041983, 5522.944770552243, 5523.088690366205, 5523.143912693539, 5524.723763811874, 5412.350517937873, 5464.890702186013, 5502.559795216293, 5546.97226513881, 5596.216529685766, 5529.115341545334, 5562.582806289463, 5610.887782244414, 5641.041023026013, 5689.402612725604, 5498.697571633598, 5512.5314348280845, 5512.944870551243, 5514.751836167462, 5519.834404967857], "value": 5238.786674601363, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.348093837248, 623.3236937922354, 637.5760119520519, 641.589382795011, 644.2108417188947, 32007.51988720171, 34827.0, 34865.651343486556, 41532.58467415325, 42563.0, 44784.0, 44908.775456122676, 45159.322610160874, 45286.77356613212, 45310.0, 8955.910440895588, 9083.863742043875, 9096.363254572183, 9106.86339704905, 9109.180173784358, 9014.2788576914, 9102.180803727662, 9109.726708198765, 9109.817803643924, 9111.544422778868, 9023.05257947916, 9124.771880703001, 9136.862947055799, 9140.131687489678, 9144.314176436794, 9034.277257819358, 9061.50161741104, 9072.682456114004, 9091.727248182498, 9101.726948191565, 8981.730548083568, 9043.773905652346, 9054.230390416822, 9059.365844390895, 9068.909310906873, 42357.36463953043, 42677.35983960243, 42678.35982460265, 42691.14617707628, 42730.0, 3464.168599536093, 3527.5414196154334, 3541.8937431877084, 3567.0725611341236, 3641.7268704847243, 32954.83522582372, 33042.6695733042, 33408.16479588005, 33546.832265838515, 33600.49599256013, 4115.36211887155, 4115.691323150776, 4146.979265103655, 4163.458750362463, 4266.786660666954, 365509.0, 369577.0, 369996.0, 370284.0, 371087.0, 34269.82865085708, 35096.64903350985, 35122.64877351245, 55677.44322556723, 56181.71909140428, 36636.81681591628, 36847.4472882907, 36878.63121368806, 36883.63116368856, 36885.446718299245, 15260.084394936339, 15475.922620386826, 15522.146281954601, 15526.844731552766, 15528.922355388151, 12930.482780688668, 12997.350132493337, 13003.869961300456, 13016.869831301756, 13019.0, 8292.419530632918, 8304.750857474286, 8320.37597180214, 8333.0, 8373.246407823324, 3206.5190221466964, 3266.4283750343593, 3272.8199949002556, 3285.572875526214, 3330.717673695596, 1046.1682962045193, 1094.5129417409175, 1129.5594718059963, 1158.362900404774, 1158.3802665573878, 33507.66492335046, 33531.66468335286, 33933.0, 34008.65991340055, 34107.65892341094, 1130.2032067392634, 1135.3471753741633, 1144.6508814811395, 1145.7078444996473, 1191.18999080626, 17063.91468042652, 17341.56646083858, 17447.38934137299, 17462.825371746374, 17602.47192584199, 589779.0, 590233.0, 595642.0, 595721.0427895752, 597428.0, 58435.0, 59120.0, 59153.0, 59183.704081479314, 59190.11214831781, 1231.4704676988802, 1343.6237853401062, 1348.2045593100117, 1362.6729584899751, 1381.84799672038, 32805.0, 34120.48819267663, 34554.62585000201, 34555.827220863735, 34850.128746781535, 49168.26247606217, 49504.75247623739, 49521.25718114303, 49637.78078863337, 49675.0, 428609.0, 429942.0, 430881.0, 431036.0, 431819.0, 21911.342659720234, 26065.73934260709, 27752.8612356945, 27765.0, 27803.524559430072, 52921.7353913228, 54056.18915716189, 55079.0, 59050.704746475996, 59163.0, 46469.53530464787, 46838.0, 47032.0, 47364.0, 47943.0, 45447.318290226336, 46620.53379466162, 47064.29403559018, 47162.76418617885, 47573.0, 45344.546554534034, 45523.0, 46085.0, 46688.766556167, 46813.53186468092, 37947.24105517929, 40267.597324026385, 42971.3554296692, 43205.351919720604, 43734.343984839616, 30274.54588181135, 30926.381472369976, 30966.380672386877, 30983.225419364695, 31304.686953130178], "value": 19371.04352866724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.4150213413874, 384.83067450321863, 385.9035241189703, 390.50991006287103, 411.668606771549, 18929.62140757184, 19886.0, 20185.697214541793, 20220.595588088247, 20237.797622023776, 17163.91418042911, 19585.90207048963, 19630.0, 19818.60362792747, 19946.0, 5571.4428557144365, 5710.5717071219615, 5855.151003104547, 5879.147523609074, 5920.4671579557835, 3899.473571067912, 5656.0, 5870.589058765888, 5874.060150375941, 5879.235699359077, 5768.192453056576, 5921.940780592182, 5938.554608404365, 5946.048632218846, 5959.255093113361, 5931.555133364972, 5959.910601340984, 5961.135635332896, 5984.3417224105315, 5988.1317209004665, 5565.666060036411, 5613.214150019001, 5626.971865140648, 5777.075667893117, 5798.7100644968, 13546.254955977418, 13611.591652250348, 13640.386182621707, 13747.0, 21158.3652490424, 2362.1732393662082, 2490.941349926274, 2493.7880280176205, 2496.2885577610296, 2736.2885649731215, 10383.42891140987, 10571.735706607396, 11049.668509944715, 12516.997280435178, 14579.562613121623, 1971.5662554238045, 1995.6407846587608, 2006.3679940818595, 2008.98995505023, 2051.1590247998397, 74663.25336746672, 81868.59065704692, 82370.0, 83122.0, 86211.56894215489, 11089.72275693098, 11222.382768947786, 11263.831042534368, 11459.0, 11570.537178512765, 15426.691466170614, 15478.458253961056, 15494.922525387527, 15533.301001454962, 15543.300551475211, 8098.797530061795, 8152.225538573826, 8201.507909525448, 8201.917980820235, 8242.134575869568, 7830.2952734254195, 7850.450468467267, 7934.761957141295, 8047.798805029804, 8061.113277539466, 4694.788734506956, 4792.353032340589, 4861.343718598015, 4865.95134048662, 4953.380827396575, 1811.5652243461475, 1857.5634725839418, 1926.3546711851407, 1940.2723978508059, 1989.9403017909485, 946.1484663802495, 979.4710856137606, 996.5366104761176, 1012.3925644613173, 1023.2734758321675, 19668.50828729293, 19677.8032219676, 19715.309964151187, 19730.90134549347, 19863.30478433277, 993.6919554937992, 1047.5652604169184, 1049.569676432659, 1056.4136904018344, 1081.8214994525972, 10589.258751887293, 10995.670129896116, 11000.174986875856, 11023.83464248037, 11049.447527623586, 469794.0, 471417.0, 474718.0, 474824.0, 478778.0, 88350.55824720964, 90694.54652726694, 92477.53761231151, 92508.53745731228, 93497.0, 978.3005151316701, 983.4885859353096, 998.7353351361895, 999.7200783780553, 1001.639409812467, 17258.741118883478, 17318.740218896473, 17527.82472175262, 17555.473335799947, 17889.73165402494, 40932.59067409288, 41590.0, 42115.1576968465, 42694.0, 44297.77851110724, 55337.0, 55729.72135139298, 57928.77039395246, 58207.4179258202, 58975.410245896994, 5999.430054144849, 8637.352198585257, 8690.348223883107, 8756.868646970428, 8897.688580899638, 8965.327600430124, 11223.60717374888, 12697.084273608927, 13196.802047969097, 13621.931890340882, 11813.763724725286, 11865.881341186823, 12048.277103373826, 12182.939085304517, 12303.0, 11844.549649427685, 11944.2833429991, 11956.34240116802, 12018.819717704067, 12410.81383779226, 12078.33569153705, 12201.450934707782, 12201.450934708137, 12341.197822141532, 12443.502259909503, 7793.142754297136, 7942.44402891792, 7955.164707705608, 8182.959085204536, 9027.187553120251, 11307.717307067389, 12022.098342624513, 12275.508979640714, 12382.195157314745, 12394.62816115518], "value": 9207.115733440094, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.594168778522, 1426.3296250762141, 1464.1507925403266, 1543.3286520363642, 1692.179293042874, 7726.8454630907345, 8029.718959836407, 8039.356851451885, 8188.754337369874, 8197.05733840607, 7969.960150199241, 8052.4765890217095, 8081.3534917206625, 8146.26683598476, 8150.144234855344, 1975.5357490989607, 2166.8916554172306, 2224.699665545155, 2232.5646498932756, 2254.7068881045443, 2268.353519247015, 2273.499830037389, 2278.612635851909, 2278.977210227893, 2280.395695140789, 2194.615942210115, 2231.7210348706412, 2234.1510226114056, 2234.5642599693065, 2240.1487434774763, 1894.6779047561947, 2116.629589821775, 2170.913163473459, 2173.71741673583, 2183.585118827418, 2149.7420309562954, 2164.0802658869916, 2170.1970270999673, 2181.4655409424636, 2182.1707751054655, 8022.839543209161, 8084.434089613729, 8085.555294458803, 8093.797655058612, 8100.473469224482, 4707.693999890031, 4888.120138375091, 4918.606511479109, 4936.210206367, 4937.037277730844, 3029.4364183225593, 3096.0866544369464, 3134.09111357706, 3149.9370012599848, 3189.6012998375204, 1081.6592773276393, 1087.4127970895706, 1093.9398333091676, 1129.596416999436, 1131.1685910855515, 11256.493457794419, 11256.887431125666, 11260.0, 11264.774704505864, 11275.49260283281, 4067.1255680028935, 4126.112885729583, 4210.32634778434, 4234.576542345802, 4305.763183024901, 9460.290478214161, 9471.952640236892, 9487.525623718924, 9488.240940724725, 9489.952550237344, 4788.377510923558, 4789.95210047902, 4790.449098353734, 4796.424429068465, 4803.903921921542, 4018.8995275117773, 4367.148406060851, 4429.092036132585, 4434.911301773946, 4477.2164871147415, 3741.8316175772156, 3774.094217387862, 3819.560750513671, 3937.684985201177, 3996.320625493673, 1093.3767752381225, 1192.2846292224597, 1204.8554173499235, 1233.1491271023144, 1241.944112514939, 847.7922908887239, 944.6410364061612, 956.6890760502864, 975.6487664440796, 981.4945303168873, 5334.493223143795, 5352.223927530486, 5423.783048678088, 5471.753771080311, 5634.0, 950.9286803489766, 951.3911096897991, 953.7091187187974, 970.509892504295, 979.5053497983473, 3819.751716138442, 3833.290841194388, 3872.8644497442456, 3874.0702231464247, 4057.9391309130388, 9950.253730970206, 10030.398176109456, 10159.085682288629, 10160.898391016142, 10423.114035306931, 9956.0, 9986.300958932805, 9996.400215987063, 10001.199904007663, 10001.2999090063, 7302.379297759644, 7494.0, 7506.211847755907, 7620.428467864932, 7621.69513219465, 5170.870728231674, 5218.608604354613, 5352.812651557332, 5437.782488700408, 5469.288992431118, 8999.820003600022, 9137.5888085035, 9237.0, 9259.72220833376, 9389.859152112587, 9146.176844084064, 9426.481543515172, 9557.761055973657, 9596.712098637052, 9674.274429417681, 7400.333969942731, 7559.773206803805, 7563.432742544222, 7564.0, 7575.734849280248, 7731.574763388067, 7867.763967080997, 7881.408894333063, 7983.441159118806, 8063.637136328762, 5944.524438045032, 7258.237885021997, 7305.305995930378, 7321.9633901832285, 7348.926510734825, 7004.719811207495, 7104.538205016657, 7272.96363518179, 7348.595827229554, 7367.963160184165, 6562.343765623399, 6564.277929427663, 6615.040819081302, 6616.073749674953, 6619.966900165468, 4759.666823322473, 4827.300041493893, 4920.8769780755765, 4939.48135445773, 4945.035718035093, 4654.557817007379, 4798.568128868418, 4906.190478571139, 4908.730019848943, 4927.778249978831], "value": 4342.350573476255, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.52503569396043, 312.2568287475807, 314.96062992125997, 315.81524807987336, 319.40271691936084, 5265.9473405265935, 5272.630915835893, 5292.1267990781525, 5310.6017048721305, 5332.733363331838, 5163.561097306733, 5218.425973142951, 5266.841994740154, 5268.683878967265, 5289.973550132244, 3893.4743809585766, 3941.7043721720843, 4052.1895620875794, 4069.1454794493043, 4143.440635514212, 4079.571644977279, 4090.8159132839096, 4091.590840915914, 4107.377585853586, 4113.547509773923, 3919.451276821247, 4030.9596904031023, 4032.778197199153, 4090.325096359112, 4103.610157035077, 3958.9802050989706, 4092.4270602115726, 4100.753954762708, 4103.835846566134, 4118.258713431581, 3606.6114545899754, 3613.530241068644, 3627.020704409821, 3630.5824830144343, 3637.7271704621994, 5118.539331460186, 5120.769565369567, 5122.948770512285, 5122.948770512285, 5148.253503242009, 4423.203823311803, 4637.628989680851, 4670.229412146991, 4696.7651617419, 4696.976515117402, 5488.121900495941, 5497.5601951844155, 5508.614396992212, 5514.310711161105, 5523.652447709747, 3718.1819999600043, 3867.1298957734566, 3902.64876161144, 3916.5104361954754, 3925.077606762437, 5596.649407248925, 5625.437456254342, 5633.380478077714, 5655.175169575344, 5658.773649054033, 3967.6032396760093, 3970.1265721541213, 3972.503437070366, 3980.3233450313514, 4006.4791577094793, 3899.1421887184774, 4054.8986275343354, 4055.8783236502363, 4057.5333836609166, 4060.634542891154, 4589.54104589545, 4602.309653551927, 4636.559526844944, 4648.604868586141, 4657.81225787422, 5520.613557050968, 5534.1975413564805, 5539.279893613885, 5541.806036788693, 5546.223528705985, 1361.9455221791216, 1374.2579007336126, 1380.9102408343426, 1389.0485017762865, 1396.615930619088, 870.3559366069189, 887.1882227761525, 895.4582477601087, 897.1118592593416, 906.3157316226338, 4650.790794393482, 4671.6262698984, 4695.272232803921, 4705.0, 4780.780900870256, 4913.361263035782, 4977.253411988231, 5002.374703162105, 5095.133827249377, 5096.210087436453, 4341.630961368256, 4639.698419602782, 4650.256153942271, 4726.503717109723, 4745.335653008581, 2649.5098406794805, 2667.7328269072036, 2684.9797077110575, 2686.449277898026, 2692.030868887199, 5131.589472842164, 5158.432572417031, 5172.655109671513, 5199.896002079937, 5200.739963001911, 4775.641826863, 5013.724245166478, 5031.874203144951, 5036.194208926554, 5053.67151135175, 5092.932532130554, 5134.512221338967, 5135.974320128375, 5181.611379146504, 5250.711210883438, 4806.711597304173, 4985.6011519077665, 5015.498450155102, 5032.521910418504, 5049.823256186016, 4826.300186473012, 4838.927416088691, 4930.704157750546, 4956.950430495649, 4980.228064649985, 5112.054269960069, 5129.384473863011, 5131.589472842238, 5149.0, 5229.189475631283, 3691.3724666807243, 3713.814309284579, 3716.9442458363687, 3719.126005388677, 3719.85120595184, 4768.356271903249, 4913.533214344631, 4928.433230178575, 4933.679310844784, 4958.776855041604, 4853.223484242504, 4867.318575399376, 4914.189158788903, 4917.28699338601, 4960.131976903956, 4829.73436460998, 4870.09903167915, 4871.87820304481, 4925.251535704773, 4930.6055515557955, 4590.360542687901, 4888.169011268022, 4926.802927882844, 4930.186519224288, 4933.777979990838, 4899.534544218293, 4920.065187614342, 4956.067133817742, 4967.925481117858, 5006.799728010838, 4793.23308270675, 4807.687500312469, 4852.514748525119, 4893.461719210955, 4916.311716359641], "value": 3951.426734433588, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.970601175953, 739.4934469888127, 743.1602289412964, 802.9116797152312, 847.3814115695538, 15353.769693454607, 16196.271167797448, 16526.91736541317, 16588.419405320816, 16606.25271862766, 14995.325210365532, 15158.924205378986, 15164.469243576477, 15164.696706065899, 15209.543713688607, 639.6002498438476, 751.7293774241268, 757.1482082657025, 781.5506084001722, 785.3481610263468, 760.8250102476434, 765.8812884002989, 767.3477544087509, 768.1857231334803, 768.6848392159216, 819.3608984991716, 819.7663665855232, 819.8647223208163, 820.831729495452, 821.0229826506468, 670.088679396021, 803.9035315762117, 825.22428916818, 825.4593241426845, 826.9545175015372, 601.4737105033096, 601.503759398498, 601.7683191971079, 602.0878369270558, 602.6956387024568, 14857.331420086122, 14904.403823847033, 14923.0, 14927.477538286217, 14928.10431374121, 14216.289185540785, 14518.20149891766, 14522.782158267635, 14570.854291457055, 14648.267586620626, 13020.674483137902, 13390.687299456516, 13471.66320841977, 13586.320683965761, 13783.931080344635, 4512.684112112153, 4514.210013247669, 4553.612942899857, 4566.223741963874, 4680.789364478606, 73930.0, 75004.0, 77491.22508774897, 77523.61238193772, 77915.61042194752, 11481.196316257781, 11572.59495917639, 11645.475953582109, 11754.588589399329, 11843.170978031456, 20678.379648610568, 20740.06669699867, 20853.37439876806, 20863.37409877706, 20876.37370878876, 8648.308135349156, 8678.088800675965, 8773.122687731304, 8788.736337909873, 8821.735347939572, 4826.155422800995, 4858.8299409521205, 4887.3890763654545, 4996.800127994839, 5018.473060328686, 3320.8505617247283, 3414.5219669246326, 3420.3672320620763, 3424.092615456906, 3430.468277417004, 561.3852831149884, 574.4600075928614, 585.2128886647453, 587.3803137689692, 600.9939900601025, 615.7290792051483, 681.3084719010209, 692.536000879412, 710.0627172132736, 716.2085895085959, 9510.38182518134, 9717.56270967808, 9777.168940640126, 10033.097021267975, 10064.144547713526, 637.5664548107239, 637.8628594852037, 695.7564852301755, 703.9753608623673, 705.9399951004119, 4435.866923992286, 4663.370444989883, 4687.882802929886, 4758.976205118952, 4822.95177048225, 73137.0, 128103.0, 129169.0, 129994.0, 130443.34778326238, 105259.0, 109337.45331273452, 109412.0, 109548.4522577398, 111347.44326278479, 94696.0, 95147.0, 96638.51680741551, 96943.51528242455, 100449.49775251077, 9222.308326875645, 9475.099865512766, 9488.003759605142, 9505.762355941157, 9602.66390676323, 49393.259101112795, 55762.0, 56246.43753562576, 57206.0, 57522.42477575171, 49728.0, 73300.0, 76219.0, 79302.2069779318, 79604.60197698974, 11154.721131971766, 11209.943950280196, 11372.0, 13598.728025439634, 13895.444182232597, 13613.591592252249, 13778.862211377758, 14109.435622574982, 14248.430062797372, 15734.9213253933, 14079.225642589756, 14276.357563909442, 14788.852111478747, 15287.0, 15663.921680391524, 14546.636334091732, 14560.509111487341, 15107.169105699291, 15200.695986079996, 15238.695226095195, 14454.132752034911, 14565.053271537316, 15553.922230388776, 15604.531864044096, 15665.451709190123, 11507.194496385173, 11931.701707457383, 12090.637280881587, 12154.149209555246, 12168.365826029873, 11779.411029448665, 12206.206596571194, 12272.570460033856, 12278.631641050782, 12661.493540258654], "value": 7684.078387204414, "unit": "score"}], "name": "dromaeo_css", "value": 7054.03984741015, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 112.0, 113.0, 113.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 119.0, 177.0, 120.0, 117.0, 144.0, 116.0, 165.0, 117.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 161.0, 159.0, 161.0, 160.0, 158.0, 162.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 117.0, 75.0, 76.0, 74.0, 74.0, 96.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 114.0, 83.0, 83.0, 83.0, 122.0, 83.0, 84.0, 126.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 63.0, 61.0, 61.0, 60.0, 61.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 75.0, 75.0, 75.0, 75.0, 75.0, 75.0, 83.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 127.0, 135.0, 122.0, 123.0, 126.0, 119.0, 163.0, 129.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 158.0, 158.0, 156.0, 156.0, 162.0, 156.0, 161.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 64.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1479.7, "alertThreshold": 2.0}]} 06:03:45 INFO - Return code: 0 06:03:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:03:45 INFO - # TBPL SUCCESS # 06:03:45 INFO - Running post-action listener: _resource_record_post_action 06:03:45 INFO - ##### 06:03:45 INFO - ##### Finished run-tests step (success) 06:03:45 INFO - ##### 06:03:45 INFO - Running post-run listener: _resource_record_post_run 06:03:46 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553054208; Read time: 156; Write time: 524488 06:03:46 INFO - TinderboxPrint: CPU usage
13.1% 06:03:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 156 06:03:46 INFO - TinderboxPrint: I/O write bytes / time
553,054,208 / 524,488 06:03:46 INFO - TinderboxPrint: CPU idle
8,262.9 (86.9%) 06:03:46 INFO - TinderboxPrint: CPU user
1,200.2 (12.6%) 06:03:46 INFO - TinderboxPrint: Swap in / out
0 / 0 06:03:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256409600; Read time: 0; Write time: 270184 06:03:46 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296644608; Read time: 156; Write time: 254304 06:03:46 INFO - Running post-run listener: _upload_blobber_files 06:03:46 INFO - Blob upload gear active. 06:03:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:03:46 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:03:46 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:03:46 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:03:47 INFO - (blobuploader) - INFO - Open directory for files ... 06:03:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:03:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:03:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:47 INFO - (blobuploader) - INFO - Done attempting. 06:03:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:03:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:03:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:50 INFO - (blobuploader) - INFO - Done attempting. 06:03:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:03:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:03:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:51 INFO - (blobuploader) - INFO - Done attempting. 06:03:51 INFO - (blobuploader) - INFO - Iteration through files over. 06:03:51 INFO - Return code: 0 06:03:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:03:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:03:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01114e7d02dfb5c4879cf2d6862cdad49b314b768b7a743f416844f04a08383206bd6767d7662414f97afb940abf6f44e10cc2ca53790f35cba900df71f4f8a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585707d0150613f73d98ae9bd197b61c9e89bc52fcd993f77a80b4926981919afad0225ac23f81103415f97ce81be31bae9c8d8b7407be11ff9fb4d2f0d7b903", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc962a5a9db85733a0f6db1834663316319a356248fb5fda73fab691a0b01ce33ea342c3d50c1bfde5b9fc4e83ed187f1523371b228f9c99df637002f0066446"} 06:03:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:03:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:03:51 INFO - Contents: 06:03:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01114e7d02dfb5c4879cf2d6862cdad49b314b768b7a743f416844f04a08383206bd6767d7662414f97afb940abf6f44e10cc2ca53790f35cba900df71f4f8a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585707d0150613f73d98ae9bd197b61c9e89bc52fcd993f77a80b4926981919afad0225ac23f81103415f97ce81be31bae9c8d8b7407be11ff9fb4d2f0d7b903", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc962a5a9db85733a0f6db1834663316319a356248fb5fda73fab691a0b01ce33ea342c3d50c1bfde5b9fc4e83ed187f1523371b228f9c99df637002f0066446"} 06:03:51 INFO - Running post-run listener: copy_logs_to_upload_dir 06:03:51 INFO - Copying logs to upload dir... 06:03:51 INFO - mkdir: /builds/slave/test/build/upload/logs 06:03:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.199994 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-10 06:03:51.081331) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-10 06:03:51.084955) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01114e7d02dfb5c4879cf2d6862cdad49b314b768b7a743f416844f04a08383206bd6767d7662414f97afb940abf6f44e10cc2ca53790f35cba900df71f4f8a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585707d0150613f73d98ae9bd197b61c9e89bc52fcd993f77a80b4926981919afad0225ac23f81103415f97ce81be31bae9c8d8b7407be11ff9fb4d2f0d7b903", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc962a5a9db85733a0f6db1834663316319a356248fb5fda73fab691a0b01ce33ea342c3d50c1bfde5b9fc4e83ed187f1523371b228f9c99df637002f0066446"} build_url:https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/NCLeba1eSqiEvIrfai9whg/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/Firefox/sha512/01114e7d02dfb5c4879cf2d6862cdad49b314b768b7a743f416844f04a08383206bd6767d7662414f97afb940abf6f44e10cc2ca53790f35cba900df71f4f8a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585707d0150613f73d98ae9bd197b61c9e89bc52fcd993f77a80b4926981919afad0225ac23f81103415f97ce81be31bae9c8d8b7407be11ff9fb4d2f0d7b903", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc962a5a9db85733a0f6db1834663316319a356248fb5fda73fab691a0b01ce33ea342c3d50c1bfde5b9fc4e83ed187f1523371b228f9c99df637002f0066446"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-10 06:03:51.110557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 06:03:51.110939) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468152775.264905-108952976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 06:03:51.195589) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-10 06:03:51.195902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-10 06:03:51.196241) ========= ========= Total master_lag: 0.19 =========