builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1467411360.53 results: success (0) buildid: 20160701144122 builduid: 1715727f5e6b495aa03f3e3444ef861c revision: 2256463545d7e69ebe2c36e0fdea569df1db8fbb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 15:16:00.529785) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 15:16:00.530357) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 15:16:00.530881) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 15:16:00.570021) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:16:00.570557) ========= 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=fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 15:16: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% 219M=0s 2016-07-01 15:16:01 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101643 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:16:00.700426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:16:00.700786) ========= 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=fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020818 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:16:00.764141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 15:16:00.764782) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2256463545d7e69ebe2c36e0fdea569df1db8fbb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2256463545d7e69ebe2c36e0fdea569df1db8fbb --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=fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 15:16:01,701 truncating revision to first 12 chars 2016-07-01 15:16:01,701 Setting DEBUG logging. 2016-07-01 15:16:01,701 attempt 1/10 2016-07-01 15:16:01,701 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2256463545d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 15:16:02,422 unpacking tar archive at: fx-team-2256463545d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.073425 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 15:16:01.857842) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 15:16:01.858152) ========= script_repo_revision: 2256463545d7e69ebe2c36e0fdea569df1db8fbb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 15:16:01.858573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 15:16:01.858851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 15:16:01.871526) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-07-01 15:16:01.871813) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:16:02 INFO - MultiFileLogger online at 20160701 15:16:02 in /builds/slave/test 15:16:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:16:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:16:02 INFO - {'append_to_log': False, 15:16:02 INFO - 'base_work_dir': '/builds/slave/test', 15:16:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:16:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:16:02 INFO - 'branch': 'Fx-Team-Non-PGO', 15:16:02 INFO - 'buildbot_json_path': 'buildprops.json', 15:16:02 INFO - 'config_files': ('talos/linux_config.py',), 15:16:02 INFO - 'default_actions': ('clobber', 15:16:02 INFO - 'read-buildbot-config', 15:16:02 INFO - 'download-and-extract', 15:16:02 INFO - 'populate-webroot', 15:16:02 INFO - 'create-virtualenv', 15:16:02 INFO - 'install', 15:16:02 INFO - 'run-tests'), 15:16:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:16:02 INFO - 'download_minidump_stackwalk': True, 15:16:02 INFO - 'download_symbols': 'ondemand', 15:16:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:16:02 INFO - 'tooltool.py': '/tools/tooltool.py', 15:16:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:16:02 INFO - '/tools/misc-python/virtualenv.py')}, 15:16:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:16:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:16:02 INFO - 'installer_path': 'installer.exe', 15:16:02 INFO - 'log_level': 'info', 15:16:02 INFO - 'log_name': 'talos', 15:16:02 INFO - 'log_to_console': True, 15:16:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:16:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:16:02 INFO - 'opt_config_files': (), 15:16:02 INFO - 'pip_index': False, 15:16:02 INFO - 'sps_profile': False, 15:16:02 INFO - 'sps_profile_interval': 0, 15:16:02 INFO - 'suite': 'dromaeojs', 15:16:02 INFO - 'system_bits': '32', 15:16:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:16:02 INFO - 'title': 'talos-linux64-ix-048', 15:16:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:16:02 INFO - 'use_talos_json': True, 15:16:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:16:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:16:02 INFO - 'work_dir': 'build'} 15:16:02 INFO - ##### 15:16:02 INFO - ##### Running clobber step. 15:16:02 INFO - ##### 15:16:02 INFO - Running pre-action listener: _resource_record_pre_action 15:16:02 INFO - Running main action method: clobber 15:16:02 INFO - rmtree: /builds/slave/test/build 15:16:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:16:03 INFO - Running post-action listener: _resource_record_post_action 15:16:03 INFO - ##### 15:16:03 INFO - ##### Finished clobber step (success) 15:16:03 INFO - ##### 15:16:03 INFO - ##### 15:16:03 INFO - ##### Running read-buildbot-config step. 15:16:03 INFO - ##### 15:16:03 INFO - Running pre-action listener: _resource_record_pre_action 15:16:03 INFO - Running main action method: read_buildbot_config 15:16:03 INFO - Using buildbot properties: 15:16:03 INFO - { 15:16:03 INFO - "project": "", 15:16:03 INFO - "product": "firefox", 15:16:03 INFO - "script_repo_revision": "production", 15:16:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:16:03 INFO - "repository": "", 15:16:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:16:03 INFO - "buildid": "20160701144122", 15:16:03 INFO - "pgo_build": "False", 15:16:03 INFO - "basedir": "/builds/slave/test", 15:16:03 INFO - "buildnumber": 1921, 15:16:03 INFO - "slavename": "talos-linux64-ix-048", 15:16:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:16:03 INFO - "platform": "ubuntu64_hw", 15:16:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:16:03 INFO - "branch": "fx-team", 15:16:03 INFO - "repo_path": "integration/fx-team", 15:16:03 INFO - "revision": "2256463545d7e69ebe2c36e0fdea569df1db8fbb", 15:16:03 INFO - "stage_platform": "linux64", 15:16:03 INFO - "builduid": "1715727f5e6b495aa03f3e3444ef861c", 15:16:03 INFO - "slavebuilddir": "test" 15:16:03 INFO - } 15:16:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:16:03 INFO - Running post-action listener: _resource_record_post_action 15:16:03 INFO - ##### 15:16:03 INFO - ##### Finished read-buildbot-config step (success) 15:16:03 INFO - ##### 15:16:03 INFO - ##### 15:16:03 INFO - ##### Running download-and-extract step. 15:16:03 INFO - ##### 15:16:03 INFO - Running pre-action listener: _resource_record_pre_action 15:16:03 INFO - Running main action method: download_and_extract 15:16:03 INFO - mkdir: /builds/slave/test/build/tests 15:16: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')]} 15:16:03 INFO - https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:16:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:16:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:16:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/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 15:16:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/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 15:16:04 INFO - Downloaded 1361 bytes. 15:16:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:16:04 INFO - Using the following test package requirements: 15:16:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:16:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:16:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:16:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:04 INFO - u'jsshell-linux-x86_64.zip'], 15:16:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:16:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:16:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:16:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:16:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:16:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:16:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:16:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:04 INFO - https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:16:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:16:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:16:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/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 15:16:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/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 15:16:05 INFO - Downloaded 22704123 bytes. 15:16:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:16:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:16:06 INFO - Return code: 0 15:16:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:06 INFO - https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:16:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:16:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:16:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/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 15:16:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/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 15:16:28 INFO - Downloaded 22704123 bytes. 15:16: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'] 15:16: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 15:16:29 INFO - Return code: 0 15:16:29 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')]} 15:16:29 INFO - https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:16:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:16:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:16:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/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 15:16:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/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 15:16:31 INFO - Downloaded 14405242 bytes. 15:16: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'] 15:16: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 15:16:31 INFO - Return code: 0 15:16: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')]} 15:16:31 INFO - https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/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 15:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H958PXorRYihKDN6C2l-_w/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 15:16:43 INFO - Downloaded 56459650 bytes. 15:16:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:16:43 INFO - mkdir: /builds/slave/test/properties 15:16:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:16:43 INFO - Writing to file /builds/slave/test/properties/build_url 15:16:43 INFO - Contents: 15:16:43 INFO - build_url:https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:16:44 INFO - Running post-action listener: _resource_record_post_action 15:16:44 INFO - Running post-action listener: set_extra_try_arguments 15:16:44 INFO - ##### 15:16:44 INFO - ##### Finished download-and-extract step (success) 15:16:44 INFO - ##### 15:16:44 INFO - ##### 15:16:44 INFO - ##### Running populate-webroot step. 15:16:44 INFO - ##### 15:16:44 INFO - Running pre-action listener: _resource_record_pre_action 15:16:44 INFO - Running main action method: populate_webroot 15:16:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:16:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:16:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:16:44 INFO - '--tppagecycles', 15:16:44 INFO - '7'], 15:16:44 INFO - 'tests': ['tsvgm']}}, 15:16:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:16:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:16:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:16:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:16:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:16:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:16:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'talos_options': ['--disable-e10s'], 15:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'talos_options': ['--disable-e10s'], 15:16:44 INFO - 'tests': ['damp', 'tps']}, 15:16:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'tests': ['damp', 'tps']}, 15:16:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:16:44 INFO - 'tests': ['dromaeo_dom']}, 15:16:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:16:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:16:44 INFO - 'tests': ['basic_compositor_video']}, 15:16:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:16:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:16:44 INFO - 'tests': ['a11yr', 15:16:44 INFO - 'ts_paint', 15:16:44 INFO - 'tpaint', 15:16:44 INFO - 'sessionrestore', 15:16:44 INFO - 'sessionrestore_no_auto_restore', 15:16:44 INFO - 'tabpaint']}, 15:16:44 INFO - 'other-e10s': {'tests': ['a11yr', 15:16:44 INFO - 'ts_paint', 15:16:44 INFO - 'tpaint', 15:16:44 INFO - 'sessionrestore', 15:16:44 INFO - 'sessionrestore_no_auto_restore', 15:16:44 INFO - 'tabpaint']}, 15:16:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:16:44 INFO - 'ts_paint', 15:16:44 INFO - 'tpaint', 15:16:44 INFO - 'sessionrestore', 15:16:44 INFO - 'sessionrestore_no_auto_restore', 15:16:44 INFO - 'tabpaint']}, 15:16:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:16:44 INFO - 'ts_paint', 15:16:44 INFO - 'tpaint', 15:16:44 INFO - 'sessionrestore', 15:16:44 INFO - 'sessionrestore_no_auto_restore', 15:16:44 INFO - 'tabpaint']}, 15:16:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:16:44 INFO - 'tests': ['a11yr', 15:16:44 INFO - 'ts_paint', 15:16:44 INFO - 'tpaint', 15:16:44 INFO - 'sessionrestore', 15:16:44 INFO - 'sessionrestore_no_auto_restore', 15:16:44 INFO - 'tabpaint']}, 15:16:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:16:44 INFO - 'tests': ['a11yr', 15:16:44 INFO - 'ts_paint', 15:16:44 INFO - 'tpaint', 15:16:44 INFO - 'sessionrestore', 15:16:44 INFO - 'sessionrestore_no_auto_restore', 15:16:44 INFO - 'tabpaint']}, 15:16:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:16:44 INFO - 'tests': ['tsvgx', 15:16:44 INFO - 'tsvgr_opacity', 15:16:44 INFO - 'tart', 15:16:44 INFO - 'tscrollx', 15:16:44 INFO - 'cart']}, 15:16:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:16:44 INFO - 'tsvgr_opacity', 15:16:44 INFO - 'tart', 15:16:44 INFO - 'tscrollx', 15:16:44 INFO - 'cart']}, 15:16:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'talos_options': ['--disable-e10s'], 15:16:44 INFO - 'tests': ['tp5o']}, 15:16:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'tests': ['tp5o']}, 15:16:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'talos_options': ['--disable-e10s', 15:16:44 INFO - '--xperf_path', 15:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:44 INFO - 'tests': ['tp5n']}, 15:16:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:44 INFO - 'talos_options': ['--xperf_path', 15:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:44 INFO - 'tests': ['tp5n']}}, 15:16:44 INFO - 'talos.zip': {'path': '', 15:16:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:16:44 INFO - Running post-action listener: _resource_record_post_action 15:16:44 INFO - ##### 15:16:44 INFO - ##### Finished populate-webroot step (success) 15:16:44 INFO - ##### 15:16:44 INFO - ##### 15:16:44 INFO - ##### Running create-virtualenv step. 15:16:44 INFO - ##### 15:16:44 INFO - Running pre-action listener: _resource_record_pre_action 15:16:44 INFO - Running main action method: create_virtualenv 15:16:44 INFO - Creating virtualenv /builds/slave/test/build/venv 15:16:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:16:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:16:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:16:44 INFO - Using real prefix '/usr' 15:16:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:16:45 INFO - Installing distribute.............................................................................................................................................................................................done. 15:16:47 INFO - Installing pip.................done. 15:16:47 INFO - Return code: 0 15:16:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ace3b0>, '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 0x1acf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acf740>, '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': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', '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 15:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:16:47 INFO - Using env: {'DISPLAY': ':0', 15:16:47 INFO - 'HOME': '/home/cltbld', 15:16:47 INFO - 'LANG': 'en_US.UTF-8', 15:16:47 INFO - 'LANGUAGE': 'en_US:en', 15:16:47 INFO - 'LOGNAME': 'cltbld', 15:16:47 INFO - 'MAIL': '/var/mail/cltbld', 15:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:47 INFO - 'MOZ_NO_REMOTE': '1', 15:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:47 INFO - 'NO_EM_RESTART': '1', 15:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:47 INFO - 'PWD': '/builds/slave/test', 15:16:47 INFO - 'SHELL': '/bin/bash', 15:16:47 INFO - 'SHLVL': '1', 15:16:47 INFO - 'TERM': 'linux', 15:16:47 INFO - 'TMOUT': '86400', 15:16:47 INFO - 'USER': 'cltbld', 15:16:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', 15:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:47 INFO - '_': '/tools/buildbot/bin/python'} 15:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:16:47 INFO - Cleaning up... 15:16:47 INFO - Return code: 0 15:16:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ace3b0>, '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 0x1acf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acf740>, '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': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', '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 15:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:16:47 INFO - Using env: {'DISPLAY': ':0', 15:16:47 INFO - 'HOME': '/home/cltbld', 15:16:47 INFO - 'LANG': 'en_US.UTF-8', 15:16:47 INFO - 'LANGUAGE': 'en_US:en', 15:16:47 INFO - 'LOGNAME': 'cltbld', 15:16:47 INFO - 'MAIL': '/var/mail/cltbld', 15:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:47 INFO - 'MOZ_NO_REMOTE': '1', 15:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:47 INFO - 'NO_EM_RESTART': '1', 15:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:47 INFO - 'PWD': '/builds/slave/test', 15:16:47 INFO - 'SHELL': '/bin/bash', 15:16:47 INFO - 'SHLVL': '1', 15:16:47 INFO - 'TERM': 'linux', 15:16:47 INFO - 'TMOUT': '86400', 15:16:47 INFO - 'USER': 'cltbld', 15:16:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', 15:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:47 INFO - '_': '/tools/buildbot/bin/python'} 15:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:47 INFO - Downloading/unpacking psutil>=3.1.1 15:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:16:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:49 INFO - Installing collected packages: psutil 15:16:49 INFO - Running setup.py install for psutil 15:16:49 INFO - building 'psutil._psutil_linux' extension 15:16:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:16:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:16:49 INFO - building 'psutil._psutil_posix' extension 15:16:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:16:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:16:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:50 INFO - Successfully installed psutil 15:16:50 INFO - Cleaning up... 15:16:50 INFO - Return code: 0 15:16:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ace3b0>, '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 0x1acf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acf740>, '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': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', '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 15:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:16:50 INFO - Using env: {'DISPLAY': ':0', 15:16:50 INFO - 'HOME': '/home/cltbld', 15:16:50 INFO - 'LANG': 'en_US.UTF-8', 15:16:50 INFO - 'LANGUAGE': 'en_US:en', 15:16:50 INFO - 'LOGNAME': 'cltbld', 15:16:50 INFO - 'MAIL': '/var/mail/cltbld', 15:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:50 INFO - 'MOZ_NO_REMOTE': '1', 15:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:50 INFO - 'NO_EM_RESTART': '1', 15:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:50 INFO - 'PWD': '/builds/slave/test', 15:16:50 INFO - 'SHELL': '/bin/bash', 15:16:50 INFO - 'SHLVL': '1', 15:16:50 INFO - 'TERM': 'linux', 15:16:50 INFO - 'TMOUT': '86400', 15:16:50 INFO - 'USER': 'cltbld', 15:16:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', 15:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:50 INFO - '_': '/tools/buildbot/bin/python'} 15:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:16:52 INFO - Installing collected packages: mozsystemmonitor 15:16:52 INFO - Running setup.py install for mozsystemmonitor 15:16:52 INFO - Successfully installed mozsystemmonitor 15:16:52 INFO - Cleaning up... 15:16:52 INFO - Return code: 0 15:16:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x180f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ace3b0>, '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 0x1acf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acf740>, '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': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', '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 15:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:16:52 INFO - Using env: {'DISPLAY': ':0', 15:16:52 INFO - 'HOME': '/home/cltbld', 15:16:52 INFO - 'LANG': 'en_US.UTF-8', 15:16:52 INFO - 'LANGUAGE': 'en_US:en', 15:16:52 INFO - 'LOGNAME': 'cltbld', 15:16:52 INFO - 'MAIL': '/var/mail/cltbld', 15:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:52 INFO - 'MOZ_NO_REMOTE': '1', 15:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:52 INFO - 'NO_EM_RESTART': '1', 15:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:52 INFO - 'PWD': '/builds/slave/test', 15:16:52 INFO - 'SHELL': '/bin/bash', 15:16:52 INFO - 'SHLVL': '1', 15:16:52 INFO - 'TERM': 'linux', 15:16:52 INFO - 'TMOUT': '86400', 15:16:52 INFO - 'USER': 'cltbld', 15:16:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', 15:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:52 INFO - '_': '/tools/buildbot/bin/python'} 15:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:52 INFO - Downloading/unpacking jsonschema==2.5.1 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:16:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:54 INFO - Downloading functools32-3.2.3-2.tar.gz 15:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:16:54 INFO - warning: no files found matching '*.txt' 15:16:54 INFO - no previously-included directories found matching 'build' 15:16:54 INFO - no previously-included directories found matching 'dist' 15:16:54 INFO - no previously-included directories found matching '.git*' 15:16:54 INFO - Installing collected packages: jsonschema, functools32 15:16:54 INFO - Running setup.py install for functools32 15:16:54 INFO - warning: no files found matching '*.txt' 15:16:54 INFO - no previously-included directories found matching 'build' 15:16:54 INFO - no previously-included directories found matching 'dist' 15:16:54 INFO - no previously-included directories found matching '.git*' 15:16:54 INFO - Successfully installed jsonschema functools32 15:16:54 INFO - Cleaning up... 15:16:54 INFO - Return code: 0 15:16:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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', '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 0x180f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ace3b0>, '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 0x1acf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acf740>, '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': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', '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 15:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:16: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 blobuploader==1.2.4 15:16:54 INFO - Using env: {'DISPLAY': ':0', 15:16:54 INFO - 'HOME': '/home/cltbld', 15:16:54 INFO - 'LANG': 'en_US.UTF-8', 15:16:54 INFO - 'LANGUAGE': 'en_US:en', 15:16:54 INFO - 'LOGNAME': 'cltbld', 15:16:54 INFO - 'MAIL': '/var/mail/cltbld', 15:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:54 INFO - 'MOZ_NO_REMOTE': '1', 15:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:54 INFO - 'NO_EM_RESTART': '1', 15:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:54 INFO - 'PWD': '/builds/slave/test', 15:16:54 INFO - 'SHELL': '/bin/bash', 15:16:54 INFO - 'SHLVL': '1', 15:16:54 INFO - 'TERM': 'linux', 15:16:54 INFO - 'TMOUT': '86400', 15:16:54 INFO - 'USER': 'cltbld', 15:16:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', 15:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:54 INFO - '_': '/tools/buildbot/bin/python'} 15:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:55 INFO - Downloading/unpacking blobuploader==1.2.4 15:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:57 INFO - Downloading blobuploader-1.2.4.tar.gz 15:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:16:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:16:57 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 15:16:57 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 15:16:57 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 15:16:57 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 15:16:57 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 15:16:57 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 15:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:16:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:16:57 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 15:16:57 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 15:16:57 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 15:16:57 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 15:16:57 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 15:16:57 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 15:16:57 INFO - Downloading docopt-0.6.1.tar.gz 15:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:16:57 INFO - Installing collected packages: blobuploader, requests, docopt 15:16:57 INFO - Running setup.py install for blobuploader 15:16:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:16:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:16:57 INFO - Running setup.py install for requests 15:16:58 INFO - Running setup.py install for docopt 15:16:58 INFO - Successfully installed blobuploader requests docopt 15:16:58 INFO - Cleaning up... 15:16:58 INFO - Return code: 0 15:16:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:58 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')]} 15:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:58 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')]} 15:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:58 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 0x180f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ace3b0>, '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 0x1acf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acf740>, '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': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', '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 15:16:58 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 15:16:58 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 15:16:58 INFO - Using env: {'DISPLAY': ':0', 15:16:58 INFO - 'HOME': '/home/cltbld', 15:16:58 INFO - 'LANG': 'en_US.UTF-8', 15:16:58 INFO - 'LANGUAGE': 'en_US:en', 15:16:58 INFO - 'LOGNAME': 'cltbld', 15:16:58 INFO - 'MAIL': '/var/mail/cltbld', 15:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:58 INFO - 'MOZ_NO_REMOTE': '1', 15:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:58 INFO - 'NO_EM_RESTART': '1', 15:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:58 INFO - 'PWD': '/builds/slave/test', 15:16:58 INFO - 'SHELL': '/bin/bash', 15:16:58 INFO - 'SHLVL': '1', 15:16:58 INFO - 'TERM': 'linux', 15:16:58 INFO - 'TMOUT': '86400', 15:16:58 INFO - 'USER': 'cltbld', 15:16:58 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', 15:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:58 INFO - '_': '/tools/buildbot/bin/python'} 15:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:58 INFO - Running setup.py (path:/tmp/pip-wYs2lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:58 INFO - Running setup.py (path:/tmp/pip-ni5yUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:58 INFO - Running setup.py (path:/tmp/pip-FPcmY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:58 INFO - Running setup.py (path:/tmp/pip-DY6kAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:58 INFO - Running setup.py (path:/tmp/pip-qA4WER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:59 INFO - Running setup.py (path:/tmp/pip-O98SDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:59 INFO - Running setup.py (path:/tmp/pip-arqwcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:59 INFO - Running setup.py (path:/tmp/pip-p_D01l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:59 INFO - Running setup.py (path:/tmp/pip-qDBU3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:59 INFO - Running setup.py (path:/tmp/pip-zlGTw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:59 INFO - Running setup.py (path:/tmp/pip-2gxtsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:59 INFO - Running setup.py (path:/tmp/pip-5zWS4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:59 INFO - Running setup.py (path:/tmp/pip-rGTQaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:59 INFO - Running setup.py (path:/tmp/pip-_Zsu_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:59 INFO - Running setup.py (path:/tmp/pip-5S3BV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:59 INFO - Running setup.py (path:/tmp/pip-gg0G5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:59 INFO - Running setup.py (path:/tmp/pip-luglqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:16:59 INFO - Running setup.py install for manifestparser 15:16:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:17:00 INFO - Running setup.py install for mozcrash 15:17:00 INFO - Running setup.py install for mozdebug 15:17:00 INFO - Running setup.py install for mozdevice 15:17:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:17:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:17:00 INFO - Running setup.py install for mozfile 15:17:00 INFO - Running setup.py install for mozhttpd 15:17:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:17:00 INFO - Running setup.py install for mozinfo 15:17:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:17:00 INFO - Running setup.py install for mozInstall 15:17:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:17:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:17:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:17:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:17:00 INFO - Running setup.py install for mozleak 15:17:00 INFO - Running setup.py install for mozlog 15:17:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:17:00 INFO - Running setup.py install for moznetwork 15:17:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:17:01 INFO - Running setup.py install for mozprocess 15:17:01 INFO - Running setup.py install for mozprofile 15:17:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:17:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:17:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:17:01 INFO - Running setup.py install for mozrunner 15:17:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:17:01 INFO - Running setup.py install for mozscreenshot 15:17:01 INFO - Running setup.py install for moztest 15:17:01 INFO - Running setup.py install for mozversion 15:17:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:17:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:17:01 INFO - Cleaning up... 15:17:01 INFO - Return code: 0 15:17:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:01 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 0x180f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ace3b0>, '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 0x1acf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acf740>, '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': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', '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 15:17:01 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 15:17:01 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 15:17:01 INFO - Using env: {'DISPLAY': ':0', 15:17:01 INFO - 'HOME': '/home/cltbld', 15:17:01 INFO - 'LANG': 'en_US.UTF-8', 15:17:01 INFO - 'LANGUAGE': 'en_US:en', 15:17:01 INFO - 'LOGNAME': 'cltbld', 15:17:01 INFO - 'MAIL': '/var/mail/cltbld', 15:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:01 INFO - 'MOZ_NO_REMOTE': '1', 15:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:01 INFO - 'NO_EM_RESTART': '1', 15:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:01 INFO - 'PWD': '/builds/slave/test', 15:17:01 INFO - 'SHELL': '/bin/bash', 15:17:01 INFO - 'SHLVL': '1', 15:17:01 INFO - 'TERM': 'linux', 15:17:01 INFO - 'TMOUT': '86400', 15:17:01 INFO - 'USER': 'cltbld', 15:17:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', 15:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:01 INFO - '_': '/tools/buildbot/bin/python'} 15:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:01 INFO - Running setup.py (path:/tmp/pip-JL9ZM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:02 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)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:02 INFO - Running setup.py (path:/tmp/pip-5wIbee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:02 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)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:02 INFO - Running setup.py (path:/tmp/pip-rGfSev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:02 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)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:02 INFO - Running setup.py (path:/tmp/pip-Freu5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:02 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)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:02 INFO - Running setup.py (path:/tmp/pip-zJc0p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:02 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)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:02 INFO - Running setup.py (path:/tmp/pip-p2im6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:02 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)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:02 INFO - Running setup.py (path:/tmp/pip-qxynIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:02 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)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:02 INFO - Running setup.py (path:/tmp/pip-uoqbSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:02 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)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:02 INFO - Running setup.py (path:/tmp/pip-IAD_aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:02 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)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:02 INFO - Running setup.py (path:/tmp/pip-V2AKSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:02 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)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:02 INFO - Running setup.py (path:/tmp/pip-i6HP1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:02 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)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:02 INFO - Running setup.py (path:/tmp/pip-QR1gUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:02 INFO - Running setup.py (path:/tmp/pip-KQ_ms_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:02 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)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:02 INFO - Running setup.py (path:/tmp/pip-pe3xle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:02 INFO - Running setup.py (path:/tmp/pip-jRO4Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:03 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)) 15:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:03 INFO - Running setup.py (path:/tmp/pip-iVOhZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:03 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)) 15:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:03 INFO - Running setup.py (path:/tmp/pip-DaUDwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:03 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)) 15:17:03 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)) 15:17:03 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)) 15:17:03 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)) 15:17:03 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)) 15:17:03 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)) 15:17:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:05 INFO - Downloading blessings-1.6.tar.gz 15:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:17:05 INFO - Installing collected packages: blessings 15:17:05 INFO - Running setup.py install for blessings 15:17:05 INFO - Successfully installed blessings 15:17:05 INFO - Cleaning up... 15:17:05 INFO - Return code: 0 15:17:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:17:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:05 INFO - Reading from file tmpfile_stdout 15:17:05 INFO - Current package versions: 15:17:05 INFO - argparse == 1.2.1 15:17:05 INFO - blessings == 1.6 15:17:05 INFO - blobuploader == 1.2.4 15:17:05 INFO - docopt == 0.6.1 15:17:05 INFO - functools32 == 3.2.3-2 15:17:05 INFO - jsonschema == 2.5.1 15:17:05 INFO - manifestparser == 1.1 15:17:05 INFO - mozInstall == 1.12 15:17:05 INFO - mozcrash == 0.17 15:17:05 INFO - mozdebug == 0.1 15:17:05 INFO - mozdevice == 0.48 15:17:05 INFO - mozfile == 1.2 15:17:05 INFO - mozhttpd == 0.7 15:17:05 INFO - mozinfo == 0.9 15:17:05 INFO - mozleak == 0.1 15:17:05 INFO - mozlog == 3.2 15:17:05 INFO - moznetwork == 0.27 15:17:05 INFO - mozprocess == 0.22 15:17:05 INFO - mozprofile == 0.28 15:17:05 INFO - mozrunner == 6.11 15:17:05 INFO - mozscreenshot == 0.1 15:17:05 INFO - mozsystemmonitor == 0.3 15:17:05 INFO - moztest == 0.7 15:17:05 INFO - mozversion == 1.4 15:17:05 INFO - psutil == 3.1.1 15:17:05 INFO - requests == 1.2.3 15:17:05 INFO - wsgiref == 0.1.2 15:17:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:05 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 0x180f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ace3b0>, '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 0x1acf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acf740>, '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': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', '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 15:17:05 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 15:17:05 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 15:17:05 INFO - Using env: {'DISPLAY': ':0', 15:17:05 INFO - 'HOME': '/home/cltbld', 15:17:05 INFO - 'LANG': 'en_US.UTF-8', 15:17:05 INFO - 'LANGUAGE': 'en_US:en', 15:17:05 INFO - 'LOGNAME': 'cltbld', 15:17:05 INFO - 'MAIL': '/var/mail/cltbld', 15:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:05 INFO - 'MOZ_NO_REMOTE': '1', 15:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:05 INFO - 'NO_EM_RESTART': '1', 15:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:05 INFO - 'PWD': '/builds/slave/test', 15:17:05 INFO - 'SHELL': '/bin/bash', 15:17:05 INFO - 'SHLVL': '1', 15:17:05 INFO - 'TERM': 'linux', 15:17:05 INFO - 'TMOUT': '86400', 15:17:05 INFO - 'USER': 'cltbld', 15:17:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', 15:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:05 INFO - '_': '/tools/buildbot/bin/python'} 15:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:05 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)) 15:17:05 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)) 15:17:05 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)) 15:17:05 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)) 15:17:05 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)) 15:17:05 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)) 15:17:05 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)) 15:17:05 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)) 15:17:05 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)) 15:17:05 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)) 15:17:05 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)) 15:17:05 INFO - Cleaning up... 15:17:05 INFO - Return code: 0 15:17:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ace3b0>, '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 0x1acf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acf740>, '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': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', '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 15:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:17:05 INFO - Using env: {'DISPLAY': ':0', 15:17:05 INFO - 'HOME': '/home/cltbld', 15:17:05 INFO - 'LANG': 'en_US.UTF-8', 15:17:05 INFO - 'LANGUAGE': 'en_US:en', 15:17:05 INFO - 'LOGNAME': 'cltbld', 15:17:05 INFO - 'MAIL': '/var/mail/cltbld', 15:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:05 INFO - 'MOZ_NO_REMOTE': '1', 15:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:05 INFO - 'NO_EM_RESTART': '1', 15:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:05 INFO - 'PWD': '/builds/slave/test', 15:17:05 INFO - 'SHELL': '/bin/bash', 15:17:05 INFO - 'SHLVL': '1', 15:17:05 INFO - 'TERM': 'linux', 15:17:05 INFO - 'TMOUT': '86400', 15:17:05 INFO - 'USER': 'cltbld', 15:17:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', 15:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:05 INFO - '_': '/tools/buildbot/bin/python'} 15:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:17:05 INFO - Cleaning up... 15:17:05 INFO - Return code: 0 15:17:05 INFO - Running post-action listener: _resource_record_post_action 15:17:05 INFO - Running post-action listener: _start_resource_monitoring 15:17:05 INFO - Starting resource monitoring. 15:17:05 INFO - ##### 15:17:05 INFO - ##### Finished create-virtualenv step (success) 15:17:05 INFO - ##### 15:17:05 INFO - ##### 15:17:05 INFO - ##### Running install step. 15:17:05 INFO - ##### 15:17:05 INFO - Running pre-action listener: _resource_record_pre_action 15:17:05 INFO - Running main action method: install 15:17:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:06 INFO - Reading from file tmpfile_stdout 15:17:06 INFO - Detecting whether we're running mozinstall >=1.0... 15:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:17:06 INFO - Reading from file tmpfile_stdout 15:17:06 INFO - Output received: 15:17:06 INFO - Usage: mozinstall [options] installer 15:17:06 INFO - Options: 15:17:06 INFO - -h, --help show this help message and exit 15:17:06 INFO - -d DEST, --destination=DEST 15:17:06 INFO - Directory to install application into. [default: 15:17:06 INFO - "/builds/slave/test"] 15:17:06 INFO - --app=APP Application being installed. [default: firefox] 15:17:06 INFO - mkdir: /builds/slave/test/build/application 15:17:06 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'] 15:17:06 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 15:17:22 INFO - Reading from file tmpfile_stdout 15:17:22 INFO - Output received: 15:17:22 INFO - /builds/slave/test/build/application/firefox/firefox 15:17:22 INFO - Running post-action listener: _resource_record_post_action 15:17:22 INFO - ##### 15:17:22 INFO - ##### Finished install step (success) 15:17:22 INFO - ##### 15:17:22 INFO - ##### 15:17:22 INFO - ##### Running run-tests step. 15:17:22 INFO - ##### 15:17:22 INFO - Running pre-action listener: _resource_record_pre_action 15:17:22 INFO - Running main action method: run_tests 15:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:17:22 INFO - Python 2.7.3 15:17:22 INFO - Return code: 0 15:17:22 INFO - grabbing minidump binary from tooltool 15:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ace3b0>, '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 0x1acf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acf740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:17:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:17:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:17:22 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 15:17:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:17:22 INFO - Return code: 0 15:17:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:17:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:17:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:17:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:17:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 15:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 15:17:22 INFO - Using env: {'DISPLAY': ':0', 15:17:22 INFO - 'HOME': '/home/cltbld', 15:17:22 INFO - 'LANG': 'en_US.UTF-8', 15:17:22 INFO - 'LANGUAGE': 'en_US:en', 15:17:22 INFO - 'LOGNAME': 'cltbld', 15:17:22 INFO - 'MAIL': '/var/mail/cltbld', 15:17:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:17:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:22 INFO - 'MOZ_NO_REMOTE': '1', 15:17:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:22 INFO - 'NO_EM_RESTART': '1', 15:17:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:22 INFO - 'PWD': '/builds/slave/test', 15:17:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:17:22 INFO - 'SHELL': '/bin/bash', 15:17:22 INFO - 'SHLVL': '1', 15:17:22 INFO - 'TERM': 'linux', 15:17:22 INFO - 'TMOUT': '86400', 15:17:22 INFO - 'USER': 'cltbld', 15:17:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704', 15:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:22 INFO - '_': '/tools/buildbot/bin/python'} 15:17:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 15:17:22 INFO - mozversion application_buildid: 20160701144122 15:17:22 INFO - mozversion application_changeset: 2256463545d7e69ebe2c36e0fdea569df1db8fbb 15:17:22 INFO - mozversion application_display_name: Nightly 15:17:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:17:22 INFO - mozversion application_name: Firefox 15:17:22 INFO - mozversion application_remotingname: firefox 15:17:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:17:22 INFO - mozversion application_vendor: Mozilla 15:17:22 INFO - mozversion application_version: 50.0a1 15:17:22 INFO - mozversion platform_buildid: 20160701144122 15:17:22 INFO - mozversion platform_changeset: 2256463545d7e69ebe2c36e0fdea569df1db8fbb 15:17:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:17:22 INFO - mozversion platform_version: 50.0a1 15:17:22 INFO - using testdate: 1467411442 15:17:22 INFO - actual date: 1467411442 15:17:22 INFO - starting webserver on 'localhost:46794' 15:17:22 INFO - SUITE-START | Running 2 tests 15:17:22 INFO - TEST-START | dromaeo_css 15:17:22 INFO - operating with platform_type : linux_ 15:17:22 INFO - Initialising browser for dromaeo_css test... 15:17:22 INFO - TEST-INFO | started process 9572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNXLpGP/profile http://localhost:46794/getInfo.html) 15:17:27 INFO - PROCESS | 9572 | __metrics Screen width/height:1600/1200 15:17:27 INFO - PROCESS | 9572 | colorDepth:24 15:17:27 INFO - PROCESS | 9572 | Browser inner width/height: 1024/697 15:17:27 INFO - PROCESS | 9572 | __metrics 15:17:28 INFO - PROCESS | 9572 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:17:28 INFO - PROCESS | 9572 | console.error: PushService: 15:17:28 INFO - PROCESS | 9572 | stateChangeProcessEnqueue: Error transitioning state 15:17:28 INFO - PROCESS | 9572 | UnknownError 15:17:29 INFO - TEST-INFO | 9572: exit 0 15:17:29 INFO - Browser initialized. 15:17:29 INFO - Running cycle 1/1 for dromaeo_css test... 15:17:29 INFO - TEST-INFO | started process 9658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNXLpGP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:41 INFO - PROCESS | 9658 | RSS: Main: 158535680 15:17:41 INFO - PROCESS | 9658 | 15:18:31 INFO - PROCESS | 9658 | 1467411511987 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] 15:20:44 INFO - PROCESS | 9658 | Cycle 1(1): loaded http://localhost:46794/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46794/tests/dromaeo/cssquery-ext.html) 15:20:45 INFO - PROCESS | 9658 | RSS: Main: 239972352 15:20:45 INFO - PROCESS | 9658 | 15:23:48 INFO - PROCESS | 9658 | Cycle 1(1): loaded http://localhost:46794/tests/dromaeo/cssquery-ext.html (next: http://localhost:46794/tests/dromaeo/cssquery-jquery.html) 15:23:49 INFO - PROCESS | 9658 | RSS: Main: 249286656 15:23:49 INFO - PROCESS | 9658 | 15:26:51 INFO - PROCESS | 9658 | Cycle 1(1): loaded http://localhost:46794/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46794/tests/dromaeo/cssquery-mootools.html) 15:26:51 INFO - PROCESS | 9658 | RSS: Main: 245035008 15:26:51 INFO - PROCESS | 9658 | 15:29:54 INFO - PROCESS | 9658 | Cycle 1(1): loaded http://localhost:46794/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46794/tests/dromaeo/cssquery-prototype.html) 15:29:54 INFO - PROCESS | 9658 | RSS: Main: 241434624 15:29:54 INFO - PROCESS | 9658 | 15:32:57 INFO - PROCESS | 9658 | Cycle 1(1): loaded http://localhost:46794/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46794/tests/dromaeo/cssquery-yui.html) 15:32:58 INFO - PROCESS | 9658 | RSS: Main: 224837632 15:32:58 INFO - PROCESS | 9658 | 15:36:01 INFO - PROCESS | 9658 | Cycle 1(1): loaded http://localhost:46794/tests/dromaeo/cssquery-yui.html (next: http://localhost:46794/tests/dromaeo/cssquery-dojo.html) 15:36:01 INFO - PROCESS | 9658 | RSS: Main: 284311552 15:36:01 INFO - PROCESS | 9658 | 15:36:01 INFO - PROCESS | 9658 | __start_tp_report 15:36:01 INFO - PROCESS | 9658 | _x_x_mozilla_page_load 15:36:01 INFO - PROCESS | 9658 | _x_x_mozilla_page_load_details 15:36:01 INFO - PROCESS | 9658 | |i|pagename|runs| 15:36:01 INFO - PROCESS | 9658 | |0;dojo.html;2619.528484872723;2628.4086080631873;2659.627652128702;2671.091828778216;2672.59911013348;4651.348811166439;4728.101660684468;4745.240761478164;4792.496787837279;4832.589229915457;4732.763361831911;4758.167320718869;4778.737169455679;4812.494688057747;4816.446108697501;4274.2733735265;4314.654827613784;4379.58393952574;4415.933760993587;4492.910141797162;4422.513523512411;4431.800568974404;4435.090806384699;4473.530279320673;4474.463064432272;4271.67962402821;4279.229738647058;4321.114171594815;4323.718958267703;4324.675649326313;4332.198543269474;4380.408644832939;4384.079343337903;4394.824207031715;4435.334699795024;4366.956330436687;4377.277749171415;4380.189664912002;4405.273129933557;4412.602865742098;4653.6277097832435;4701.247800351927;4764;4783.210770222909;4842.878928026827;5139.563137133348;5141.53726164647;5148.588112950955;5154;5156.587473002151;4995.800167993276;5157.432682404932;5178.508041736029;5187.19598462239;5189.714565698885;4721.929171062437;4788.353572267769;4790.353302304145;4809.398825146856;4840.903181936342;5317.441668624816;5317.973410133002;5319.228711836762;5321.388040375329;5330.333708286465;4856.805727770849;4939.629527785431;5079.263506791494;5081.339425874613;5095.337606111182;5079.161938280216;5105.744712764421;5132.769025393866;5172.741362931838;5180.585553155738;5044.974775126174;5047.520485553867;5052.69683818972;5060.038592667455;5108.335916330853;4888.291197776302;4900.607951363882;4975.228839529878;5045.142325804622;5055.671381360274;4273.294906340419;4292.785360732013;4311.611954924072;4324.0919406924895;4332.458442694663;3746.8501259949844;3752.568454627698;3757.492738480325;3791.4881490998914;3794.829232684536;4276.102018576134;4336.241157797373;4339.869803905888;4382.539833317455;4390;5085.084684756779;5097.796088156432;5105.8723531912;5116.897662046738;5148.9485105149215;4385.583369579885;4389.341598760211;4394.538573449741;4421.182081314967;4444.088961762831;4491.752953587584;4526.434195725535;4538.9546104539195;4542.750148741851;4605.4933957264675;4803.18345881208;4822.68652537584;4826.251930950708;4843.927341089887;4886.731229782396;5131.204663277198;5134.229865520202;5143.048536020848;5144.511271429208;5144.717040562805;4659.487456379863;4705.976470117627;4746.430428348483;4755;4775.21209000511;4980.427250866197;5021.6735912165595;5024.045431368028;5034.974825125851;5074.314967479343;5075.695458272516;5081.517255860687;5083.110455670317;5087.338645976148;5090.211017292326;4808.7595620219545;4839.491853355347;4893.73084480357;4898.069366820293;4957.652964292465;4914.533119353656;4946.431160416454;4946.901061978812;4952.306677065142;5018.44797072329;4729.645276604338;4881.658283920092;4893.584045356185;4913.213885778258;4944.579710724484;4874.658773885794;4923.064617722621;4937.259411088366;4939.60483161339;4955.72743499111;4839.637027223042;4845.8061677532505;4846.684965477374;4862.610991120772;4895.485973972682 15:36:01 INFO - PROCESS | 9658 | |1;ext.html;586.8562202260446;599.7301214453496;616.5037145098194;635.3138610300875;636.7675798333606;40483.19033619329;42012.369814452766;42045.579544204586;46204.53795462044;46338.768306158505;41760.37359439611;42140.36789448153;42144;42219.36670949931;42260.57739422605;7529;7869.331106855924;8022.799430014267;8036.879446808302;10213;10053.94973025134;10408.583656653762;10418.062374386303;10420.478976051167;10426.374417534935;10444.11225045872;10488.842667359995;10488.895111048869;10492.842607360895;10493.475326233696;7713.922860771377;10046.19630429564;10286.588536458532;10317.277790554665;10387.22095842811;10143;10156.898431015743;10236.59053637861;10238.795224095476;10239.89760102397;38849.61150388488;39013.219735605126;39119;39120.60879391198;39130.413043804365;2645.378336091017;2938.9412211755857;3531.8940431787087;3709.239605880788;3721.925561488782;29524;29590.26024349387;29844.403111937856;30093.09720708382;30245.848770756227;3345.414552453311;3370.174307294704;3409.9829500852584;3470.4794280857823;3508.1405055761247;181196;181431;181749;181833;182266;45911.54088459073;54437;54834.72582637141;54888.72555637276;54893.45106548963;43463.56536434595;47734.76132619384;47753.761231193625;56763.43236567581;58791;13907.721845563234;13995.930020349833;14009;14011;14016.509422170175;9783;10902.727431814268;11134;11219.214654974074;11500.712482188012;16703.415380461625;16811;16825.242864071148;16852.662946740995;16883.32466701343;6057.151998720183;6111.663858487737;6208;6219.191505104308;6226.937730622726;852.5864955496579;921.5898924978454;960.9039096090335;1015.9941657758766;1026.071405378134;27252;28478.288042799097;28610.14169574916;28620.71379286222;28714.425711485652;955.9091886270793;974.9805003900024;993.1707024634367;997.1204279932235;1010.4998025977188;14472.927635361755;15062;15065.246737663074;15235.693172698611;15559.611009724622;379054;381527;382232;382885;384002;49653.50346496489;49970.250446243335;49978;50026;50167.74916125469;1090.2041509697965;1166.1661911733152;1195.3903509210365;1230.680023193958;1230.6923269182705;28451.573226401208;29427.852860736417;29595;29959;30433.391332173676;42295.7885210572;42767.78616107024;42895.14209715726;42908.57091429046;42954.570454295055;246818;248035;248047;248152;248262;30347;37605.81197093997;37856;39892.800535997136;41201.79399102985;41853.58146418619;42339.364909525764;42344.788276058425;42968;43385.78307108444;35679.10802229965;35919.28161436809;35938;36467.817660911525;37100.25799484049;36232.81883590565;36522.634773651924;36613.08467288339;36843;37558;35905.28189436249;36142.457863131545;37513.81243093767;37653;40387.1922561553;30602.84698576493;33479.83260083684;33600.66399336073;33653.831730841186;33683.66316336805;25223.24330270095;25505.87247063753;25656;25785.355366115997;26027.47945041051 15:36:01 INFO - PROCESS | 9658 | |2;jquery.html;356.19855325517585;362.9346717590834;365.2712837888413;383.34256749674336;385.323756806804;16742.330306787728;17115.40096096637;17848.64302713945;17853.821461785377;17864.553386165353;16546;16734.58163545912;17353.132343382844;17467.301307947666;17490.56273593161;5135.152699804537;5308.256844041837;5337.67973921564;5350.35795704516;5359.892802143974;3737.86917457889;3934.055826601609;5181.145111056671;5926.377730338317;6230.127782110508;6246.125542424064;6251.437370636641;6275.592086514362;6282.371762823726;6283.937160628404;5940.910886336708;6129.233845769279;6131.448169664707;6191.19514463117;6200.534959878005;3435.862565497377;5117.948820511784;5419.160030195326;5419.214213938957;5498.5876059295315;20924.581508369898;21079.26222582202;21256.681149782766;21633.567328653495;21810.236641717463;1954.452753229098;1976.4070778766313;1979.4457551885496;1991;2035.39955713065;13481.797773033413;13491.257980811051;13621;13908.095973761774;14148.504802331869;1750.9212085456186;1815.6368726254802;1822.3986084592052;1860.2466001269509;1903.6573416784972;66667.3333266666;68000;69482.3051769481;69649.65175174142;69970;9640.662576809778;9644.18024467914;9994.300398972002;10180.134688551409;10209.132223760915;13378.598642040753;13427.865721342661;13477.595672129852;13489.527866524624;13490.595282141552;7352.448566357544;7406.814829629302;7412.4440666950195;7453.403727701771;7484;7036.6481675916;7048.118985126859;7091.468139889425;7176.246494118147;7261.346478816932;6242.219722534684;6250.406211409909;6285.560010799291;6358.682065896779;6416.679166041773;1579.344572002629;1689.2651696512057;1721.2512557037728;1754.1843042985074;1792.4622613215984;778.4784194589638;893.9374243803002;898.4654130792168;926.8007378413673;932.3219897504281;17171.656566868594;17258.82741172572;17819.46541603754;18002.729959050626;18266.543336416697;850.8170743290223;863.1325517854516;867.1761826264948;895.7223260789176;899.4648184330313;9507.714768556816;10274.948625256975;10307.74230644225;10354;10402.510710371655;394604;431393;434154;441533;449639;81335.593322033;83418;84261;84329.99999999878;85097.57451212704;903.575319599787;905.968291109808;924.8797656304637;934.9626014959325;948.8339540580371;16273.430429934895;16283.674326513641;16365.181740913145;16501.58746031359;16611.50165495037;39707.40438893361;39783.60216397915;40397;40502.784916452554;41603.16793664049;52332.7383363096;53748;53788;55181.137320387184;55691;6940;7170.462215333767;7870.881936770838;7941.682332706627;7944.165862584346;11609.419529023684;12333.568325108577;12353.3823308836;12430.316332601793;12663.430145643284;9912.950435247778;10303.536340864828;10645.733856653645;10794.568217271535;10976.23166378346;10375.636852710119;10484.161267098461;10486.528106235086;10511.159107271553;10561.313514621525;10384.532696028848;10455.529501172314;10694.73263168427;11030.558777648805;11267.830982535432;7798.454108212371;8062.234087761653;8062.314703250289;8068.717594884386;8112.797180070545;10512.42181680015;10539;10667.146628269875;10701.19741019411;10858.891411085788 15:36:01 INFO - PROCESS | 9658 | |3;mootools.html;1361.727654469106;1397.888168946484;1474.8156480439945;1661.5347702643264;1697.5840918974852;6955.686994085266;7583.848323033536;7649.617519124049;8132.430729848913;8139.430239883211;7852.097008843984;7904.249096335853;7975.4815936964205;8004.319632831216;8005.359571234302;2200.5928903152926;2226.599212141814;2227.3652009177385;2230.553889222154;2231.3306008197474;1903.40042886491;2134.925277615284;2207.5033117548583;2215.634420320645;2218.1127548980458;2204.349716833538;2209.3482422685265;2212.4026512841524;2214.534947660985;2214.7785221477884;2135.3273718778537;2179.2263746370127;2184.715986921698;2185.62844316465;2186.9453263668374;1906.4757191772235;1958.0209895052474;1958.9608207835763;2115.8307335413283;2185.6830759539775;7910.841783164305;7972.242636949481;7981.521108733495;7995.160508146677;8014.3187829034605;4458.175237581026;4604.424446944132;4606.792694328763;4612.146752850734;4616.215243408628;2882.3802882380387;2894.2619631993707;2905.0848982570424;2915.650121985354;2916.3729798093514;888.2228050455851;896.1083721696888;907.6006557114848;911.1480765484293;913.488446469979;10961.232713710044;11002.229843910929;11007.229493935427;11024.889751102546;11071.501782419811;4188.120494696148;4376.803043863034;4429.73752480548;4458.398116254329;4479.574440428154;9319.813603727887;9353.204977576983;9360.34477586576;9373.343865929319;9376.8593471098;4697.506761790031;4699.201135806853;4702.905941881211;4712.882177945578;4715.646326525456;4117.608827161415;4228.725132866354;4236.4704411948505;4244.236037513216;4283.614474697292;3744.719146064056;3751.681107105872;3795.8291876865605;3829.061879839457;3858.0902453285244;1207.335965219126;1209.6129238643725;1212.4422765527956;1222.3155033181447;1225.6384366611871;817.3012074676185;820.2084987986622;831.3100126894662;833.1210572845584;844.8099177684971;4835.830745923876;4992.850214493498;5158.3552055993005;5168.767405466763;5224.242484839677;385.9633334833243;386.2988675553861;391.90398352403275;398.69300638508764;401.51617301152044;3424.5719285089363;3521.647835216509;3721.8697345592773;3736.0286325555553;3779.3952967525065;9913.851292230622;9979.700608981742;10024.248181386425;10155.898441015643;10161.745956351002;9962.601495940226;9992.15066719337;10013.349132306377;10018.3488073275;10029.247806414549;7395.260473952561;7470.402367810562;7579.431542634325;7595.088589369311;7601.6579253933705;5333.973330133324;5353.544948679406;5383.40782513931;5411.107167317348;5441.782328706808;8832.425892316978;9155;9168.495732734496;9316.44101353921;9418.152366287068;8356.665733370597;9339.906600933904;9365.906340936503;9430.10414010668;9597.760055998657;6744.460443164633;6965.199002114619;6995.930040699732;7164.319389657974;7174;7268.67290971897;7469.290417410337;7755.3407960324;7784.766457006299;7792.61036948139;6792.898106528505;6868.7939361817225;6897.448204143757;6925.3074692532355;7036;6602.1747281589805;6614.305497922649;6639.435647969976;6733.966330168318;6745.932540674727;6205;6218.968905155445;6270.059491076375;6274.560780745486;6287;4392.516823149387;4426.380306757121;4477.015056687524;4522.728636281834;4531.682782205346;4361.7819109043785;4482.058767658828;4511.571400716926;4524.796384162786;4622.930656040095 15:36:01 INFO - PROCESS | 9658 | |4;prototype.html;293.76645566774397;299.95650630658554;303.5901532930544;304.3426199409276;305.33894119231866;4643.512431194718;4778.52214778522;4811.494793046728;4869.366982292301;4916.525042487253;4628.490866004745;4729.4797572267025;4758.428988521382;4765.356676848624;4809.8797530061765;3785.829637666298;3791.526059242595;3792.6396992285827;3797.905052373699;3852.84588616455;3645.325614761278;3657.5610926688832;3817.8854634360873;3840.135969406889;3846.8076596170217;3792.146766977422;3798.9810050949704;3801.752886062411;3803.8098095095133;3811.9618803811886;3767.171222331083;3782.8675996340135;3789;3794.430835374702;3799.3161230978412;3356.613989391227;3369.427197376452;3371.578552680915;3376.4260075787174;3377.814220217887;4634.3048542718525;4698.671093023489;4699.600533954618;4730.219513780222;4743.1225223333795;4298.634616057639;4320.82716691332;4330.155619654169;4348.4999225089205;4348.543402942677;5004.299398084271;5025.271335656309;5062.164742817431;5068.72122033288;5069.569086627641;3572.732045096602;3648.2703459307977;3655.597884232732;3661.4987854979595;3693.316736403774;5199.714015729133;5227.137522308814;5232.136697444955;5238.5023422774775;5243.213517972296;3738.925221495555;3748.212875296164;3748.7066961898104;3750.5311836020496;3781.4327850822597;3532.823358832048;3791.109089363997;3803.410471376941;3806.657400833883;3814.1227517670536;4219.78901054946;4226;4231.851885184004;4236.2586547354085;4248.553901840324;4992.277664205843;4993.650444468853;5014.34813474246;5066.265391518209;5089.618278629117;1214.6720385495867;1236.7773800715777;1268.429206856918;1272.0713878868478;1273.0833799664413;850.141357229203;850.9872351914727;866.5225790027987;874.8206617643368;880.6037283222576;4384.386185933972;4390.6169556589575;4408.162449134654;4414.757188354672;4419.248727716296;5121.6427646673665;5126.5652013151275;5132.692038477629;5141.5886729061585;5142.588592912558;4345.630621397154;4411.536788637211;4413.029133590605;4417.879417879371;4418.955810441918;2309.711286089239;2413.734489206186;2420.165043060141;2430.562498750242;2450.534398464286;4218.8523401681405;4265.957340426556;4272.914541709149;4284.335927931175;4390.595009596962;4608.585227329557;4610.132896177053;4629.467611224685;4630.545810720324;4637.698549594333;4102.466679331667;4306.966328081238;4307.741535507879;4340.348947657813;4356.28121359972;4545.454545454567;4548.295014272793;4590.977045114887;4595.862124136282;4626.884327891829;4421.712588681726;4464.866054018385;4487;4496.797644106088;4510.323451482304;4185.3931179979345;4276.738362183226;4290.37789520524;4387.464387464362;4403.229434848953;3291.736661067157;3299.7296041023897;3355.8825441109443;3358.6305506393787;3370.893191755153;4560.33875088117;4617.376654151646;4624.982503849148;4637.536246375335;5017.3226614406585;4835.558043188167;4947.18371468718;4962.975185124052;4968.776405061853;4983.8504844854715;5000.424951130666;5009.323741294878;5009.599232061353;5015.322931404359;5041.647084704182;4693.9765301173275;4739.620830333634;4955.752212389438;4956.281339205723;4973.403191617029;5084.313617661568;5086.237064440364;5097.7706003229205;5102.260172275073;5136.229565565195;4953.603711703127;4962.751862406793;4963.156263435152;4990.47600002009;4990.675606085593 15:36:01 INFO - PROCESS | 9658 | |5;yui.html;624.2883113250892;660.7621256347715;677.4783416769087;733.1825015108157;776.378896882494;12868.678283042917;13661.72676546471;14139;14152.433902643896;14481.131132132079;14596.708065838677;14668.193249371281;14741.262936853142;14787.852121478809;14794.334254958525;632.9430351268385;772.3049255669914;791.5448617045193;812.0215140755405;814.9918500814975;799.5922079739346;808.4381354958306;809.352517985612;809.5021561739517;810.092696180279;839.6053854688317;847.7033038436559;847.9152084791533;848.749618862437;849.1890244816217;656.2748163279603;794.66226853587;826.182079741052;832.2343444031475;832.2717622080679;602.340437221242;602.7829981206762;602.9397060293979;603.1375133559009;603.1887111834576;13871.583852484442;13915.30423478822;13967.37146828395;14012.369443375073;14015.159090454605;12176.878231217663;12577.11960162789;12639.241645501299;12706.61880143588;12889.613311600573;10456;10847.393852978472;10943.56225750969;11041.83437248442;11089.944550277278;3295.983520082384;3357.345317663057;3358.2947581008016;3468.4277094279414;3493.039414161126;61119.69440152771;61382.38617613811;62987.99999999954;63361;63832.36167638311;10254.436006019741;10357.585696572052;10365;10664.413457259925;10774.569017239379;16905.23926423314;17941.7308740369;18121.36575219861;18421.90789046046;18494.35269765552;6326.145970293951;6645.368689974444;7318.7438439655425;7363.963180184065;7366.447516436288;3673.1551743098703;3717.8141092945784;3763.8306276217636;3796.620337966181;3855.5951625078965;2878.611387462666;2916.606258155122;2953.1140657802575;2959.1862237884325;2988.551717242431;513.6584171525968;521.4342438454244;526.0426024635203;527.7150338817073;533.5411546070376;484.54210770821237;499.8900241946766;536.7209051293306;537.4491146574715;586.8738221282445;7637.219675380994;7944.721934732257;8006.879896801553;8159.306458950937;8264.876026859602;485.25513337027496;492.1642274316818;595.8767722842473;601.3265143039823;601.4710319482047;3845.1925095729653;3862.7682339059747;3905.9218815624095;3933.4537654956443;3966.3852102924093;88329;93454;93604.53197733968;97192;97466;46552;47529.76235118802;74937;76234.61882690551;76874.61562692151;68883.31116688868;70930.64534677293;71573.28426715771;72126.27873721301;75962.62018689982;8590.1839325264;8788.516631585324;9013.369064165709;9201.539923003957;9357.403030863088;40360.18379172886;41917.79041104775;42749.35875961801;42833.78583107064;44407.333889992326;58250.42744443195;60631.69684151551;61251.38748612457;63010;63173.209607423705;11108.222424430536;11114.44427778624;11693.941530292293;11704;11764.117691173367;12514.374281285716;12724.109312348046;12748.362581871055;12951.870481295067;13179.736405272033;11567.132465064986;11963.581274655346;12155.81766273489;12629.179103358252;12819.615411537668;12307.20003199789;12503.749925001632;12551.93724031374;12617.621471355875;12726.363681816058;12062.638120856389;12078.09414293949;12187.75624487523;12279.508819647113;13001.544945926848;10135.239857010607;10246.795064098527;10293.948530257301;10528.263021588722;10563.524641391003;10070.295079344376;10375.740606484898;10381.650385449842;10480.737981550523;10506 15:36:01 INFO - PROCESS | 9658 | __end_tp_report 15:36:01 INFO - PROCESS | 9658 | __start_cc_report 15:36:01 INFO - PROCESS | 9658 | _x_x_mozilla_cycle_collect,915 15:36:01 INFO - PROCESS | 9658 | __end_cc_report 15:36:01 INFO - PROCESS | 9658 | __startTimestamp1467412561608__endTimestamp 15:36:01 INFO - PROCESS | 9658 | 15:36:01 INFO - PROCESS | 9658 | ------- Summary: start ------- 15:36:01 INFO - PROCESS | 9658 | Number of tests: 6 15:36:01 INFO - PROCESS | 9658 | 15:36:01 INFO - PROCESS | 9658 | [#0] dojo.html Cycles:165 Average:4702.97 Median:4832.59 stddev:499.19 (10.3%) stddev-sans-first:473.21 15:36:01 INFO - PROCESS | 9658 | Values: 2619.5 2628.4 2659.6 2671.1 2672.6 4651.3 4728.1 4745.2 4792.5 4832.6 4732.8 4758.2 4778.7 4812.5 4816.4 4274.3 4314.7 4379.6 4415.9 4492.9 4422.5 4431.8 4435.1 4473.5 4474.5 4271.7 4279.2 4321.1 4323.7 4324.7 4332.2 4380.4 4384.1 4394.8 4435.3 4367.0 4377.3 4380.2 4405.3 4412.6 4653.6 4701.2 4764.0 4783.2 4842.9 5139.6 5141.5 5148.6 5154.0 5156.6 4995.8 5157.4 5178.5 5187.2 5189.7 4721.9 4788.4 4790.4 4809.4 4840.9 5317.4 5318.0 5319.2 5321.4 5330.3 4856.8 4939.6 5079.3 5081.3 5095.3 5079.2 5105.7 5132.8 5172.7 5180.6 5045.0 5047.5 5052.7 5060.0 5108.3 4888.3 4900.6 4975.2 5045.1 5055.7 4273.3 4292.8 4311.6 4324.1 4332.5 3746.9 3752.6 3757.5 3791.5 3794.8 4276.1 4336.2 4339.9 4382.5 4390.0 5085.1 5097.8 5105.9 5116.9 5148.9 4385.6 4389.3 4394.5 4421.2 4444.1 4491.8 4526.4 4539.0 4542.8 4605.5 4803.2 4822.7 4826.3 4843.9 4886.7 5131.2 5134.2 5143.0 5144.5 5144.7 4659.5 4706.0 4746.4 4755.0 4775.2 4980.4 5021.7 5024.0 5035.0 5074.3 5075.7 5081.5 5083.1 5087.3 5090.2 4808.8 4839.5 4893.7 4898.1 4957.7 4914.5 4946.4 4946.9 4952.3 5018.4 4729.6 4881.7 4893.6 4913.2 4944.6 4874.7 4923.1 4937.3 4939.6 4955.7 4839.6 4845.8 4846.7 4862.6 4895.5 15:36:01 INFO - PROCESS | 9658 | 15:36:01 INFO - PROCESS | 9658 | [#1] ext.html Cycles:180 Average:44224.70 Median:19605.50 stddev:74345.09 (379.2%) stddev-sans-first:74481.45 15:36:01 INFO - PROCESS | 9658 | Values: 586.9 599.7 616.5 635.3 636.8 40483.2 42012.4 42045.6 46204.5 46338.8 41760.4 42140.4 42144.0 42219.4 42260.6 7529.0 7869.3 8022.8 8036.9 10213.0 10053.9 10408.6 10418.1 10420.5 10426.4 10444.1 10488.8 10488.9 10492.8 10493.5 7713.9 10046.2 10286.6 10317.3 10387.2 10143.0 10156.9 10236.6 10238.8 10239.9 38849.6 39013.2 39119.0 39120.6 39130.4 2645.4 2938.9 3531.9 3709.2 3721.9 29524.0 29590.3 29844.4 30093.1 30245.8 3345.4 3370.2 3410.0 3470.5 3508.1 181196.0 181431.0 181749.0 181833.0 182266.0 45911.5 54437.0 54834.7 54888.7 54893.5 43463.6 47734.8 47753.8 56763.4 58791.0 13907.7 13995.9 14009.0 14011.0 14016.5 9783.0 10902.7 11134.0 11219.2 11500.7 16703.4 16811.0 16825.2 16852.7 16883.3 6057.2 6111.7 6208.0 6219.2 6226.9 852.6 921.6 960.9 1016.0 1026.1 27252.0 28478.3 28610.1 28620.7 28714.4 955.9 975.0 993.2 997.1 1010.5 14472.9 15062.0 15065.2 15235.7 15559.6 379054.0 381527.0 382232.0 382885.0 384002.0 49653.5 49970.3 49978.0 50026.0 50167.7 1090.2 1166.2 1195.4 1230.7 1230.7 28451.6 29427.9 29595.0 29959.0 30433.4 42295.8 42767.8 42895.1 42908.6 42954.6 246818.0 248035.0 248047.0 248152.0 248262.0 30347.0 37605.8 37856.0 39892.8 41201.8 41853.6 42339.4 42344.8 42968.0 43385.8 35679.1 35919.3 35938.0 36467.8 37100.3 36232.8 36522.6 36613.1 36843.0 37558.0 35905.3 36142.5 37513.8 37653.0 40387.2 30602.8 33479.8 33600.7 33653.8 33683.7 25223.2 25505.9 25656.0 25785.4 26027.5 15:36:01 INFO - PROCESS | 9658 | 15:36:01 INFO - PROCESS | 9658 | [#2] jquery.html Cycles:180 Average:26166.69 Median:40090.30 stddev:70983.50 (177.1%) stddev-sans-first:71156.17 15:36:01 INFO - PROCESS | 9658 | Values: 356.2 362.9 365.3 383.3 385.3 16742.3 17115.4 17848.6 17853.8 17864.6 16546.0 16734.6 17353.1 17467.3 17490.6 5135.2 5308.3 5337.7 5350.4 5359.9 3737.9 3934.1 5181.1 5926.4 6230.1 6246.1 6251.4 6275.6 6282.4 6283.9 5940.9 6129.2 6131.4 6191.2 6200.5 3435.9 5117.9 5419.2 5419.2 5498.6 20924.6 21079.3 21256.7 21633.6 21810.2 1954.5 1976.4 1979.4 1991.0 2035.4 13481.8 13491.3 13621.0 13908.1 14148.5 1750.9 1815.6 1822.4 1860.2 1903.7 66667.3 68000.0 69482.3 69649.7 69970.0 9640.7 9644.2 9994.3 10180.1 10209.1 13378.6 13427.9 13477.6 13489.5 13490.6 7352.4 7406.8 7412.4 7453.4 7484.0 7036.6 7048.1 7091.5 7176.2 7261.3 6242.2 6250.4 6285.6 6358.7 6416.7 1579.3 1689.3 1721.3 1754.2 1792.5 778.5 893.9 898.5 926.8 932.3 17171.7 17258.8 17819.5 18002.7 18266.5 850.8 863.1 867.2 895.7 899.5 9507.7 10274.9 10307.7 10354.0 10402.5 394604.0 431393.0 434154.0 441533.0 449639.0 81335.6 83418.0 84261.0 84330.0 85097.6 903.6 906.0 924.9 935.0 948.8 16273.4 16283.7 16365.2 16501.6 16611.5 39707.4 39783.6 40397.0 40502.8 41603.2 52332.7 53748.0 53788.0 55181.1 55691.0 6940.0 7170.5 7870.9 7941.7 7944.2 11609.4 12333.6 12353.4 12430.3 12663.4 9913.0 10303.5 10645.7 10794.6 10976.2 10375.6 10484.2 10486.5 10511.2 10561.3 10384.5 10455.5 10694.7 11030.6 11267.8 7798.5 8062.2 8062.3 8068.7 8112.8 10512.4 10539.0 10667.1 10701.2 10858.9 15:36:01 INFO - PROCESS | 9658 | 15:36:01 INFO - PROCESS | 9658 | [#3] mootools.html Cycles:180 Average:5213.76 Median:4660.22 stddev:2998.70 (64.3%) stddev-sans-first:2993.14 15:36:01 INFO - PROCESS | 9658 | Values: 1361.7 1397.9 1474.8 1661.5 1697.6 6955.7 7583.8 7649.6 8132.4 8139.4 7852.1 7904.2 7975.5 8004.3 8005.4 2200.6 2226.6 2227.4 2230.6 2231.3 1903.4 2134.9 2207.5 2215.6 2218.1 2204.3 2209.3 2212.4 2214.5 2214.8 2135.3 2179.2 2184.7 2185.6 2186.9 1906.5 1958.0 1959.0 2115.8 2185.7 7910.8 7972.2 7981.5 7995.2 8014.3 4458.2 4604.4 4606.8 4612.1 4616.2 2882.4 2894.3 2905.1 2915.7 2916.4 888.2 896.1 907.6 911.1 913.5 10961.2 11002.2 11007.2 11024.9 11071.5 4188.1 4376.8 4429.7 4458.4 4479.6 9319.8 9353.2 9360.3 9373.3 9376.9 4697.5 4699.2 4702.9 4712.9 4715.6 4117.6 4228.7 4236.5 4244.2 4283.6 3744.7 3751.7 3795.8 3829.1 3858.1 1207.3 1209.6 1212.4 1222.3 1225.6 817.3 820.2 831.3 833.1 844.8 4835.8 4992.9 5158.4 5168.8 5224.2 386.0 386.3 391.9 398.7 401.5 3424.6 3521.6 3721.9 3736.0 3779.4 9913.9 9979.7 10024.2 10155.9 10161.7 9962.6 9992.2 10013.3 10018.3 10029.2 7395.3 7470.4 7579.4 7595.1 7601.7 5334.0 5353.5 5383.4 5411.1 5441.8 8832.4 9155.0 9168.5 9316.4 9418.2 8356.7 9339.9 9365.9 9430.1 9597.8 6744.5 6965.2 6995.9 7164.3 7174.0 7268.7 7469.3 7755.3 7784.8 7792.6 6792.9 6868.8 6897.4 6925.3 7036.0 6602.2 6614.3 6639.4 6734.0 6745.9 6205.0 6219.0 6270.1 6274.6 6287.0 4392.5 4426.4 4477.0 4522.7 4531.7 4361.8 4482.1 4511.6 4524.8 4622.9 15:36:01 INFO - PROCESS | 9658 | 15:36:01 INFO - PROCESS | 9658 | [#4] prototype.html Cycles:180 Average:4056.23 Median:4413.89 stddev:1163.81 (26.4%) stddev-sans-first:1132.29 15:36:01 INFO - PROCESS | 9658 | Values: 293.8 300.0 303.6 304.3 305.3 4643.5 4778.5 4811.5 4869.4 4916.5 4628.5 4729.5 4758.4 4765.4 4809.9 3785.8 3791.5 3792.6 3797.9 3852.8 3645.3 3657.6 3817.9 3840.1 3846.8 3792.1 3799.0 3801.8 3803.8 3812.0 3767.2 3782.9 3789.0 3794.4 3799.3 3356.6 3369.4 3371.6 3376.4 3377.8 4634.3 4698.7 4699.6 4730.2 4743.1 4298.6 4320.8 4330.2 4348.5 4348.5 5004.3 5025.3 5062.2 5068.7 5069.6 3572.7 3648.3 3655.6 3661.5 3693.3 5199.7 5227.1 5232.1 5238.5 5243.2 3738.9 3748.2 3748.7 3750.5 3781.4 3532.8 3791.1 3803.4 3806.7 3814.1 4219.8 4226.0 4231.9 4236.3 4248.6 4992.3 4993.7 5014.3 5066.3 5089.6 1214.7 1236.8 1268.4 1272.1 1273.1 850.1 851.0 866.5 874.8 880.6 4384.4 4390.6 4408.2 4414.8 4419.2 5121.6 5126.6 5132.7 5141.6 5142.6 4345.6 4411.5 4413.0 4417.9 4419.0 2309.7 2413.7 2420.2 2430.6 2450.5 4218.9 4266.0 4272.9 4284.3 4390.6 4608.6 4610.1 4629.5 4630.5 4637.7 4102.5 4307.0 4307.7 4340.3 4356.3 4545.5 4548.3 4591.0 4595.9 4626.9 4421.7 4464.9 4487.0 4496.8 4510.3 4185.4 4276.7 4290.4 4387.5 4403.2 3291.7 3299.7 3355.9 3358.6 3370.9 4560.3 4617.4 4625.0 4637.5 5017.3 4835.6 4947.2 4963.0 4968.8 4983.9 5000.4 5009.3 5009.6 5015.3 5041.6 4694.0 4739.6 4955.8 4956.3 4973.4 5084.3 5086.2 5097.8 5102.3 5136.2 4953.6 4962.8 4963.2 4990.5 4990.7 15:36:01 INFO - PROCESS | 9658 | 15:36:01 INFO - PROCESS | 9658 | [#5] yui.html Cycles:180 Average:17146.32 Median:41138.99 stddev:23515.46 (57.2%) stddev-sans-first:23548.70 15:36:01 INFO - PROCESS | 9658 | Values: 624.3 660.8 677.5 733.2 776.4 12868.7 13661.7 14139.0 14152.4 14481.1 14596.7 14668.2 14741.3 14787.9 14794.3 632.9 772.3 791.5 812.0 815.0 799.6 808.4 809.4 809.5 810.1 839.6 847.7 847.9 848.7 849.2 656.3 794.7 826.2 832.2 832.3 602.3 602.8 602.9 603.1 603.2 13871.6 13915.3 13967.4 14012.4 14015.2 12176.9 12577.1 12639.2 12706.6 12889.6 10456.0 10847.4 10943.6 11041.8 11089.9 3296.0 3357.3 3358.3 3468.4 3493.0 61119.7 61382.4 62988.0 63361.0 63832.4 10254.4 10357.6 10365.0 10664.4 10774.6 16905.2 17941.7 18121.4 18421.9 18494.4 6326.1 6645.4 7318.7 7364.0 7366.4 3673.2 3717.8 3763.8 3796.6 3855.6 2878.6 2916.6 2953.1 2959.2 2988.6 513.7 521.4 526.0 527.7 533.5 484.5 499.9 536.7 537.4 586.9 7637.2 7944.7 8006.9 8159.3 8264.9 485.3 492.2 595.9 601.3 601.5 3845.2 3862.8 3905.9 3933.5 3966.4 88329.0 93454.0 93604.5 97192.0 97466.0 46552.0 47529.8 74937.0 76234.6 76874.6 68883.3 70930.6 71573.3 72126.3 75962.6 8590.2 8788.5 9013.4 9201.5 9357.4 40360.2 41917.8 42749.4 42833.8 44407.3 58250.4 60631.7 61251.4 63010.0 63173.2 11108.2 11114.4 11693.9 11704.0 11764.1 12514.4 12724.1 12748.4 12951.9 13179.7 11567.1 11963.6 12155.8 12629.2 12819.6 12307.2 12503.7 12551.9 12617.6 12726.4 12062.6 12078.1 12187.8 12279.5 13001.5 10135.2 10246.8 10293.9 10528.3 10563.5 10070.3 10375.7 10381.7 10480.7 10506.0 15:36:01 INFO - PROCESS | 9658 | -------- Summary: end -------- 15:36:01 INFO - PROCESS | 9658 | 15:36:02 INFO - TEST-INFO | 9658: exit 0 15:36:02 INFO - TEST-OK | dromaeo_css | took 1119621ms 15:36:02 INFO - TEST-START | kraken 15:36:02 INFO - operating with platform_type : linux_ 15:36:02 INFO - Initialising browser for kraken test... 15:36:02 INFO - TEST-INFO | started process 9850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ022lS/profile http://localhost:46794/getInfo.html) 15:36:06 INFO - PROCESS | 9850 | __metrics Screen width/height:1600/1200 15:36:06 INFO - PROCESS | 9850 | colorDepth:24 15:36:06 INFO - PROCESS | 9850 | Browser inner width/height: 1024/697 15:36:06 INFO - PROCESS | 9850 | __metrics 15:36:07 INFO - PROCESS | 9850 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:36:08 INFO - TEST-INFO | 9850: exit 0 15:36:08 INFO - Browser initialized. 15:36:08 INFO - Running cycle 1/1 for kraken test... 15:36:08 INFO - TEST-INFO | started process 9931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ022lS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:36:20 INFO - PROCESS | 9931 | RSS: Main: 158662656 15:36:20 INFO - PROCESS | 9931 | 15:36:23 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46794/tests/kraken/driver.html?testName=audio-beat-detection) 15:36:24 INFO - PROCESS | 9931 | RSS: Main: 216215552 15:36:24 INFO - PROCESS | 9931 | 15:36:27 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46794/tests/kraken/driver.html?testName=audio-dft) 15:36:27 INFO - PROCESS | 9931 | RSS: Main: 202936320 15:36:27 INFO - PROCESS | 9931 | 15:36:30 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46794/tests/kraken/driver.html?testName=audio-fft) 15:36:31 INFO - PROCESS | 9931 | RSS: Main: 270761984 15:36:31 INFO - PROCESS | 9931 | 15:36:33 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46794/tests/kraken/driver.html?testName=audio-oscillator) 15:36:34 INFO - PROCESS | 9931 | RSS: Main: 181374976 15:36:34 INFO - PROCESS | 9931 | 15:36:36 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46794/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:36:37 INFO - PROCESS | 9931 | RSS: Main: 186302464 15:36:37 INFO - PROCESS | 9931 | 15:36:40 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46794/tests/kraken/driver.html?testName=imaging-darkroom) 15:36:40 INFO - PROCESS | 9931 | RSS: Main: 221511680 15:36:40 INFO - PROCESS | 9931 | 15:36:44 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46794/tests/kraken/driver.html?testName=imaging-desaturate) 15:36:44 INFO - PROCESS | 9931 | RSS: Main: 217726976 15:36:44 INFO - PROCESS | 9931 | 15:36:47 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46794/tests/kraken/driver.html?testName=json-parse-financial) 15:36:48 INFO - PROCESS | 9931 | RSS: Main: 220655616 15:36:48 INFO - PROCESS | 9931 | 15:36:50 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46794/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:36:50 INFO - PROCESS | 9931 | RSS: Main: 206311424 15:36:50 INFO - PROCESS | 9931 | 15:36:52 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46794/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:36:53 INFO - PROCESS | 9931 | RSS: Main: 210358272 15:36:53 INFO - PROCESS | 9931 | 15:36:55 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46794/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:36:56 INFO - PROCESS | 9931 | RSS: Main: 209018880 15:36:56 INFO - PROCESS | 9931 | 15:36:59 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46794/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:36:59 INFO - PROCESS | 9931 | RSS: Main: 224096256 15:36:59 INFO - PROCESS | 9931 | 15:37:02 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46794/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:37:03 INFO - PROCESS | 9931 | RSS: Main: 224444416 15:37:03 INFO - PROCESS | 9931 | 15:37:04 INFO - PROCESS | 9931 | Cycle 1(1): loaded http://localhost:46794/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46794/tests/kraken/driver.html?testName=ai-astar) 15:37:05 INFO - PROCESS | 9931 | RSS: Main: 266661888 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | __start_tp_report 15:37:05 INFO - PROCESS | 9931 | _x_x_mozilla_page_load 15:37:05 INFO - PROCESS | 9931 | _x_x_mozilla_page_load_details 15:37:05 INFO - PROCESS | 9931 | |i|pagename|runs| 15:37:05 INFO - PROCESS | 9931 | |0;ai-astar;109;116;114;115;114;116;112;115;116;115 15:37:05 INFO - PROCESS | 9931 | |1;audio-beat-detection;159;121;129;186;122;128;144;122;155;127 15:37:05 INFO - PROCESS | 9931 | |2;audio-dft;161;163;161;161;161;161;162;162;161;162 15:37:05 INFO - PROCESS | 9931 | |3;audio-fft;76;75;77;123;76;82;75;76;100;75 15:37:05 INFO - PROCESS | 9931 | |4;audio-oscillator;85;87;110;85;84;85;116;86;85;119 15:37:05 INFO - PROCESS | 9931 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 15:37:05 INFO - PROCESS | 9931 | |6;imaging-darkroom;147;147;146;146;147;147;146;145;147;146 15:37:05 INFO - PROCESS | 9931 | |7;imaging-desaturate;95;95;95;95;95;96;95;96;95;95 15:37:05 INFO - PROCESS | 9931 | |8;json-parse-financial;66;64;65;64;65;65;70;65;65;64 15:37:05 INFO - PROCESS | 9931 | |9;json-stringify-tinderbox;66;65;65;66;65;64;76;64;64;65 15:37:05 INFO - PROCESS | 9931 | |10;stanford-crypto-aes;80;79;78;78;78;78;79;78;77;86 15:37:05 INFO - PROCESS | 9931 | |11;stanford-crypto-ccm;129;133;137;129;128;128;137;130;207;136 15:37:05 INFO - PROCESS | 9931 | |12;stanford-crypto-pbkdf2;168;171;168;165;166;165;167;166;165;165 15:37:05 INFO - PROCESS | 9931 | |13;stanford-crypto-sha256-iterative;68;68;67;67;67;72;67;69;70;66 15:37:05 INFO - PROCESS | 9931 | __end_tp_report 15:37:05 INFO - PROCESS | 9931 | __start_cc_report 15:37:05 INFO - PROCESS | 9931 | _x_x_mozilla_cycle_collect,1888 15:37:05 INFO - PROCESS | 9931 | __end_cc_report 15:37:05 INFO - PROCESS | 9931 | __startTimestamp1467412625151__endTimestamp 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | ------- Summary: start ------- 15:37:05 INFO - PROCESS | 9931 | Number of tests: 14 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:2.20 (1.9%) stddev-sans-first:1.30 15:37:05 INFO - PROCESS | 9931 | Values: 109.0 116.0 114.0 115.0 114.0 116.0 112.0 115.0 116.0 115.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:136.50 stddev:21.49 (15.7%) stddev-sans-first:21.58 15:37:05 INFO - PROCESS | 9931 | Values: 159.0 121.0 129.0 186.0 122.0 128.0 144.0 122.0 155.0 127.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 15:37:05 INFO - PROCESS | 9931 | Values: 161.0 163.0 161.0 161.0 161.0 161.0 162.0 162.0 161.0 162.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:15.86 (20.9%) stddev-sans-first:16.58 15:37:05 INFO - PROCESS | 9931 | Values: 76.0 75.0 77.0 123.0 76.0 82.0 75.0 76.0 100.0 75.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:85.00 stddev:14.54 (17.1%) stddev-sans-first:15.03 15:37:05 INFO - PROCESS | 9931 | Values: 85.0 87.0 110.0 85.0 84.0 85.0 116.0 86.0 85.0 119.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:37:05 INFO - PROCESS | 9931 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 15:37:05 INFO - PROCESS | 9931 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 146.0 145.0 147.0 146.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:37:05 INFO - PROCESS | 9931 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:1.77 (2.7%) stddev-sans-first:1.86 15:37:05 INFO - PROCESS | 9931 | Values: 66.0 64.0 65.0 64.0 65.0 65.0 70.0 65.0 65.0 64.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:65.00 stddev:3.59 (5.5%) stddev-sans-first:3.81 15:37:05 INFO - PROCESS | 9931 | Values: 66.0 65.0 65.0 66.0 65.0 64.0 76.0 64.0 64.0 65.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:78.50 stddev:2.56 (3.3%) stddev-sans-first:2.69 15:37:05 INFO - PROCESS | 9931 | Values: 80.0 79.0 78.0 78.0 78.0 78.0 79.0 78.0 77.0 86.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:134.50 stddev:24.03 (17.9%) stddev-sans-first:25.19 15:37:05 INFO - PROCESS | 9931 | Values: 129.0 133.0 137.0 129.0 128.0 128.0 137.0 130.0 207.0 136.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:166.50 stddev:1.96 (1.2%) stddev-sans-first:2.01 15:37:05 INFO - PROCESS | 9931 | Values: 168.0 171.0 168.0 165.0 166.0 165.0 167.0 166.0 165.0 165.0 15:37:05 INFO - PROCESS | 9931 | 15:37:05 INFO - PROCESS | 9931 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.79 (2.6%) stddev-sans-first:1.90 15:37:05 INFO - PROCESS | 9931 | Values: 68.0 68.0 67.0 67.0 67.0 72.0 67.0 69.0 70.0 66.0 15:37:05 INFO - PROCESS | 9931 | -------- Summary: end -------- 15:37:05 INFO - PROCESS | 9931 | 15:37:06 INFO - TEST-INFO | 9931: exit 0 15:37:06 INFO - TEST-OK | kraken | took 63839ms 15:37:06 INFO - SUITE-END | took 1183s 15:37:06 INFO - Completed test suite (00:19:43) 15:37:06 INFO - javascript benchmark 15:37:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.528484872723, 2628.4086080631873, 2659.627652128702, 2671.091828778216, 2672.59911013348, 4651.348811166439, 4728.101660684468, 4745.240761478164, 4792.496787837279, 4832.589229915457, 4732.763361831911, 4758.167320718869, 4778.737169455679, 4812.494688057747, 4816.446108697501, 4274.2733735265, 4314.654827613784, 4379.58393952574, 4415.933760993587, 4492.910141797162, 4422.513523512411, 4431.800568974404, 4435.090806384699, 4473.530279320673, 4474.463064432272, 4271.67962402821, 4279.229738647058, 4321.114171594815, 4323.718958267703, 4324.675649326313, 4332.198543269474, 4380.408644832939, 4384.079343337903, 4394.824207031715, 4435.334699795024, 4366.956330436687, 4377.277749171415, 4380.189664912002, 4405.273129933557, 4412.602865742098, 4653.6277097832435, 4701.247800351927, 4764.0, 4783.210770222909, 4842.878928026827, 5139.563137133348, 5141.53726164647, 5148.588112950955, 5154.0, 5156.587473002151, 4995.800167993276, 5157.432682404932, 5178.508041736029, 5187.19598462239, 5189.714565698885, 4721.929171062437, 4788.353572267769, 4790.353302304145, 4809.398825146856, 4840.903181936342, 5317.441668624816, 5317.973410133002, 5319.228711836762, 5321.388040375329, 5330.333708286465, 4856.805727770849, 4939.629527785431, 5079.263506791494, 5081.339425874613, 5095.337606111182, 5079.161938280216, 5105.744712764421, 5132.769025393866, 5172.741362931838, 5180.585553155738, 5044.974775126174, 5047.520485553867, 5052.69683818972, 5060.038592667455, 5108.335916330853, 4888.291197776302, 4900.607951363882, 4975.228839529878, 5045.142325804622, 5055.671381360274, 4273.294906340419, 4292.785360732013, 4311.611954924072, 4324.0919406924895, 4332.458442694663, 3746.8501259949844, 3752.568454627698, 3757.492738480325, 3791.4881490998914, 3794.829232684536, 4276.102018576134, 4336.241157797373, 4339.869803905888, 4382.539833317455, 4390.0, 5085.084684756779, 5097.796088156432, 5105.8723531912, 5116.897662046738, 5148.9485105149215, 4385.583369579885, 4389.341598760211, 4394.538573449741, 4421.182081314967, 4444.088961762831, 4491.752953587584, 4526.434195725535, 4538.9546104539195, 4542.750148741851, 4605.4933957264675, 4803.18345881208, 4822.68652537584, 4826.251930950708, 4843.927341089887, 4886.731229782396, 5131.204663277198, 5134.229865520202, 5143.048536020848, 5144.511271429208, 5144.717040562805, 4659.487456379863, 4705.976470117627, 4746.430428348483, 4755.0, 4775.21209000511, 4980.427250866197, 5021.6735912165595, 5024.045431368028, 5034.974825125851, 5074.314967479343, 5075.695458272516, 5081.517255860687, 5083.110455670317, 5087.338645976148, 5090.211017292326, 4808.7595620219545, 4839.491853355347, 4893.73084480357, 4898.069366820293, 4957.652964292465, 4914.533119353656, 4946.431160416454, 4946.901061978812, 4952.306677065142, 5018.44797072329, 4729.645276604338, 4881.658283920092, 4893.584045356185, 4913.213885778258, 4944.579710724484, 4874.658773885794, 4923.064617722621, 4937.259411088366, 4939.60483161339, 4955.72743499111, 4839.637027223042, 4845.8061677532505, 4846.684965477374, 4862.610991120772, 4895.485973972682], "value": 4670.766503155518, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.8562202260446, 599.7301214453496, 616.5037145098194, 635.3138610300875, 636.7675798333606, 40483.19033619329, 42012.369814452766, 42045.579544204586, 46204.53795462044, 46338.768306158505, 41760.37359439611, 42140.36789448153, 42144.0, 42219.36670949931, 42260.57739422605, 7529.0, 7869.331106855924, 8022.799430014267, 8036.879446808302, 10213.0, 10053.94973025134, 10408.583656653762, 10418.062374386303, 10420.478976051167, 10426.374417534935, 10444.11225045872, 10488.842667359995, 10488.895111048869, 10492.842607360895, 10493.475326233696, 7713.922860771377, 10046.19630429564, 10286.588536458532, 10317.277790554665, 10387.22095842811, 10143.0, 10156.898431015743, 10236.59053637861, 10238.795224095476, 10239.89760102397, 38849.61150388488, 39013.219735605126, 39119.0, 39120.60879391198, 39130.413043804365, 2645.378336091017, 2938.9412211755857, 3531.8940431787087, 3709.239605880788, 3721.925561488782, 29524.0, 29590.26024349387, 29844.403111937856, 30093.09720708382, 30245.848770756227, 3345.414552453311, 3370.174307294704, 3409.9829500852584, 3470.4794280857823, 3508.1405055761247, 181196.0, 181431.0, 181749.0, 181833.0, 182266.0, 45911.54088459073, 54437.0, 54834.72582637141, 54888.72555637276, 54893.45106548963, 43463.56536434595, 47734.76132619384, 47753.761231193625, 56763.43236567581, 58791.0, 13907.721845563234, 13995.930020349833, 14009.0, 14011.0, 14016.509422170175, 9783.0, 10902.727431814268, 11134.0, 11219.214654974074, 11500.712482188012, 16703.415380461625, 16811.0, 16825.242864071148, 16852.662946740995, 16883.32466701343, 6057.151998720183, 6111.663858487737, 6208.0, 6219.191505104308, 6226.937730622726, 852.5864955496579, 921.5898924978454, 960.9039096090335, 1015.9941657758766, 1026.071405378134, 27252.0, 28478.288042799097, 28610.14169574916, 28620.71379286222, 28714.425711485652, 955.9091886270793, 974.9805003900024, 993.1707024634367, 997.1204279932235, 1010.4998025977188, 14472.927635361755, 15062.0, 15065.246737663074, 15235.693172698611, 15559.611009724622, 379054.0, 381527.0, 382232.0, 382885.0, 384002.0, 49653.50346496489, 49970.250446243335, 49978.0, 50026.0, 50167.74916125469, 1090.2041509697965, 1166.1661911733152, 1195.3903509210365, 1230.680023193958, 1230.6923269182705, 28451.573226401208, 29427.852860736417, 29595.0, 29959.0, 30433.391332173676, 42295.7885210572, 42767.78616107024, 42895.14209715726, 42908.57091429046, 42954.570454295055, 246818.0, 248035.0, 248047.0, 248152.0, 248262.0, 30347.0, 37605.81197093997, 37856.0, 39892.800535997136, 41201.79399102985, 41853.58146418619, 42339.364909525764, 42344.788276058425, 42968.0, 43385.78307108444, 35679.10802229965, 35919.28161436809, 35938.0, 36467.817660911525, 37100.25799484049, 36232.81883590565, 36522.634773651924, 36613.08467288339, 36843.0, 37558.0, 35905.28189436249, 36142.457863131545, 37513.81243093767, 37653.0, 40387.1922561553, 30602.84698576493, 33479.83260083684, 33600.66399336073, 33653.831730841186, 33683.66316336805, 25223.24330270095, 25505.87247063753, 25656.0, 25785.355366115997, 26027.47945041051], "value": 18126.192853291093, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.19855325517585, 362.9346717590834, 365.2712837888413, 383.34256749674336, 385.323756806804, 16742.330306787728, 17115.40096096637, 17848.64302713945, 17853.821461785377, 17864.553386165353, 16546.0, 16734.58163545912, 17353.132343382844, 17467.301307947666, 17490.56273593161, 5135.152699804537, 5308.256844041837, 5337.67973921564, 5350.35795704516, 5359.892802143974, 3737.86917457889, 3934.055826601609, 5181.145111056671, 5926.377730338317, 6230.127782110508, 6246.125542424064, 6251.437370636641, 6275.592086514362, 6282.371762823726, 6283.937160628404, 5940.910886336708, 6129.233845769279, 6131.448169664707, 6191.19514463117, 6200.534959878005, 3435.862565497377, 5117.948820511784, 5419.160030195326, 5419.214213938957, 5498.5876059295315, 20924.581508369898, 21079.26222582202, 21256.681149782766, 21633.567328653495, 21810.236641717463, 1954.452753229098, 1976.4070778766313, 1979.4457551885496, 1991.0, 2035.39955713065, 13481.797773033413, 13491.257980811051, 13621.0, 13908.095973761774, 14148.504802331869, 1750.9212085456186, 1815.6368726254802, 1822.3986084592052, 1860.2466001269509, 1903.6573416784972, 66667.3333266666, 68000.0, 69482.3051769481, 69649.65175174142, 69970.0, 9640.662576809778, 9644.18024467914, 9994.300398972002, 10180.134688551409, 10209.132223760915, 13378.598642040753, 13427.865721342661, 13477.595672129852, 13489.527866524624, 13490.595282141552, 7352.448566357544, 7406.814829629302, 7412.4440666950195, 7453.403727701771, 7484.0, 7036.6481675916, 7048.118985126859, 7091.468139889425, 7176.246494118147, 7261.346478816932, 6242.219722534684, 6250.406211409909, 6285.560010799291, 6358.682065896779, 6416.679166041773, 1579.344572002629, 1689.2651696512057, 1721.2512557037728, 1754.1843042985074, 1792.4622613215984, 778.4784194589638, 893.9374243803002, 898.4654130792168, 926.8007378413673, 932.3219897504281, 17171.656566868594, 17258.82741172572, 17819.46541603754, 18002.729959050626, 18266.543336416697, 850.8170743290223, 863.1325517854516, 867.1761826264948, 895.7223260789176, 899.4648184330313, 9507.714768556816, 10274.948625256975, 10307.74230644225, 10354.0, 10402.510710371655, 394604.0, 431393.0, 434154.0, 441533.0, 449639.0, 81335.593322033, 83418.0, 84261.0, 84329.99999999878, 85097.57451212704, 903.575319599787, 905.968291109808, 924.8797656304637, 934.9626014959325, 948.8339540580371, 16273.430429934895, 16283.674326513641, 16365.181740913145, 16501.58746031359, 16611.50165495037, 39707.40438893361, 39783.60216397915, 40397.0, 40502.784916452554, 41603.16793664049, 52332.7383363096, 53748.0, 53788.0, 55181.137320387184, 55691.0, 6940.0, 7170.462215333767, 7870.881936770838, 7941.682332706627, 7944.165862584346, 11609.419529023684, 12333.568325108577, 12353.3823308836, 12430.316332601793, 12663.430145643284, 9912.950435247778, 10303.536340864828, 10645.733856653645, 10794.568217271535, 10976.23166378346, 10375.636852710119, 10484.161267098461, 10486.528106235086, 10511.159107271553, 10561.313514621525, 10384.532696028848, 10455.529501172314, 10694.73263168427, 11030.558777648805, 11267.830982535432, 7798.454108212371, 8062.234087761653, 8062.314703250289, 8068.717594884386, 8112.797180070545, 10512.42181680015, 10539.0, 10667.146628269875, 10701.19741019411, 10858.891411085788], "value": 8629.420591453589, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.727654469106, 1397.888168946484, 1474.8156480439945, 1661.5347702643264, 1697.5840918974852, 6955.686994085266, 7583.848323033536, 7649.617519124049, 8132.430729848913, 8139.430239883211, 7852.097008843984, 7904.249096335853, 7975.4815936964205, 8004.319632831216, 8005.359571234302, 2200.5928903152926, 2226.599212141814, 2227.3652009177385, 2230.553889222154, 2231.3306008197474, 1903.40042886491, 2134.925277615284, 2207.5033117548583, 2215.634420320645, 2218.1127548980458, 2204.349716833538, 2209.3482422685265, 2212.4026512841524, 2214.534947660985, 2214.7785221477884, 2135.3273718778537, 2179.2263746370127, 2184.715986921698, 2185.62844316465, 2186.9453263668374, 1906.4757191772235, 1958.0209895052474, 1958.9608207835763, 2115.8307335413283, 2185.6830759539775, 7910.841783164305, 7972.242636949481, 7981.521108733495, 7995.160508146677, 8014.3187829034605, 4458.175237581026, 4604.424446944132, 4606.792694328763, 4612.146752850734, 4616.215243408628, 2882.3802882380387, 2894.2619631993707, 2905.0848982570424, 2915.650121985354, 2916.3729798093514, 888.2228050455851, 896.1083721696888, 907.6006557114848, 911.1480765484293, 913.488446469979, 10961.232713710044, 11002.229843910929, 11007.229493935427, 11024.889751102546, 11071.501782419811, 4188.120494696148, 4376.803043863034, 4429.73752480548, 4458.398116254329, 4479.574440428154, 9319.813603727887, 9353.204977576983, 9360.34477586576, 9373.343865929319, 9376.8593471098, 4697.506761790031, 4699.201135806853, 4702.905941881211, 4712.882177945578, 4715.646326525456, 4117.608827161415, 4228.725132866354, 4236.4704411948505, 4244.236037513216, 4283.614474697292, 3744.719146064056, 3751.681107105872, 3795.8291876865605, 3829.061879839457, 3858.0902453285244, 1207.335965219126, 1209.6129238643725, 1212.4422765527956, 1222.3155033181447, 1225.6384366611871, 817.3012074676185, 820.2084987986622, 831.3100126894662, 833.1210572845584, 844.8099177684971, 4835.830745923876, 4992.850214493498, 5158.3552055993005, 5168.767405466763, 5224.242484839677, 385.9633334833243, 386.2988675553861, 391.90398352403275, 398.69300638508764, 401.51617301152044, 3424.5719285089363, 3521.647835216509, 3721.8697345592773, 3736.0286325555553, 3779.3952967525065, 9913.851292230622, 9979.700608981742, 10024.248181386425, 10155.898441015643, 10161.745956351002, 9962.601495940226, 9992.15066719337, 10013.349132306377, 10018.3488073275, 10029.247806414549, 7395.260473952561, 7470.402367810562, 7579.431542634325, 7595.088589369311, 7601.6579253933705, 5333.973330133324, 5353.544948679406, 5383.40782513931, 5411.107167317348, 5441.782328706808, 8832.425892316978, 9155.0, 9168.495732734496, 9316.44101353921, 9418.152366287068, 8356.665733370597, 9339.906600933904, 9365.906340936503, 9430.10414010668, 9597.760055998657, 6744.460443164633, 6965.199002114619, 6995.930040699732, 7164.319389657974, 7174.0, 7268.67290971897, 7469.290417410337, 7755.3407960324, 7784.766457006299, 7792.61036948139, 6792.898106528505, 6868.7939361817225, 6897.448204143757, 6925.3074692532355, 7036.0, 6602.1747281589805, 6614.305497922649, 6639.435647969976, 6733.966330168318, 6745.932540674727, 6205.0, 6218.968905155445, 6270.059491076375, 6274.560780745486, 6287.0, 4392.516823149387, 4426.380306757121, 4477.015056687524, 4522.728636281834, 4531.682782205346, 4361.7819109043785, 4482.058767658828, 4511.571400716926, 4524.796384162786, 4622.930656040095], "value": 4094.6228653872836, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.76645566774397, 299.95650630658554, 303.5901532930544, 304.3426199409276, 305.33894119231866, 4643.512431194718, 4778.52214778522, 4811.494793046728, 4869.366982292301, 4916.525042487253, 4628.490866004745, 4729.4797572267025, 4758.428988521382, 4765.356676848624, 4809.8797530061765, 3785.829637666298, 3791.526059242595, 3792.6396992285827, 3797.905052373699, 3852.84588616455, 3645.325614761278, 3657.5610926688832, 3817.8854634360873, 3840.135969406889, 3846.8076596170217, 3792.146766977422, 3798.9810050949704, 3801.752886062411, 3803.8098095095133, 3811.9618803811886, 3767.171222331083, 3782.8675996340135, 3789.0, 3794.430835374702, 3799.3161230978412, 3356.613989391227, 3369.427197376452, 3371.578552680915, 3376.4260075787174, 3377.814220217887, 4634.3048542718525, 4698.671093023489, 4699.600533954618, 4730.219513780222, 4743.1225223333795, 4298.634616057639, 4320.82716691332, 4330.155619654169, 4348.4999225089205, 4348.543402942677, 5004.299398084271, 5025.271335656309, 5062.164742817431, 5068.72122033288, 5069.569086627641, 3572.732045096602, 3648.2703459307977, 3655.597884232732, 3661.4987854979595, 3693.316736403774, 5199.714015729133, 5227.137522308814, 5232.136697444955, 5238.5023422774775, 5243.213517972296, 3738.925221495555, 3748.212875296164, 3748.7066961898104, 3750.5311836020496, 3781.4327850822597, 3532.823358832048, 3791.109089363997, 3803.410471376941, 3806.657400833883, 3814.1227517670536, 4219.78901054946, 4226.0, 4231.851885184004, 4236.2586547354085, 4248.553901840324, 4992.277664205843, 4993.650444468853, 5014.34813474246, 5066.265391518209, 5089.618278629117, 1214.6720385495867, 1236.7773800715777, 1268.429206856918, 1272.0713878868478, 1273.0833799664413, 850.141357229203, 850.9872351914727, 866.5225790027987, 874.8206617643368, 880.6037283222576, 4384.386185933972, 4390.6169556589575, 4408.162449134654, 4414.757188354672, 4419.248727716296, 5121.6427646673665, 5126.5652013151275, 5132.692038477629, 5141.5886729061585, 5142.588592912558, 4345.630621397154, 4411.536788637211, 4413.029133590605, 4417.879417879371, 4418.955810441918, 2309.711286089239, 2413.734489206186, 2420.165043060141, 2430.562498750242, 2450.534398464286, 4218.8523401681405, 4265.957340426556, 4272.914541709149, 4284.335927931175, 4390.595009596962, 4608.585227329557, 4610.132896177053, 4629.467611224685, 4630.545810720324, 4637.698549594333, 4102.466679331667, 4306.966328081238, 4307.741535507879, 4340.348947657813, 4356.28121359972, 4545.454545454567, 4548.295014272793, 4590.977045114887, 4595.862124136282, 4626.884327891829, 4421.712588681726, 4464.866054018385, 4487.0, 4496.797644106088, 4510.323451482304, 4185.3931179979345, 4276.738362183226, 4290.37789520524, 4387.464387464362, 4403.229434848953, 3291.736661067157, 3299.7296041023897, 3355.8825441109443, 3358.6305506393787, 3370.893191755153, 4560.33875088117, 4617.376654151646, 4624.982503849148, 4637.536246375335, 5017.3226614406585, 4835.558043188167, 4947.18371468718, 4962.975185124052, 4968.776405061853, 4983.8504844854715, 5000.424951130666, 5009.323741294878, 5009.599232061353, 5015.322931404359, 5041.647084704182, 4693.9765301173275, 4739.620830333634, 4955.752212389438, 4956.281339205723, 4973.403191617029, 5084.313617661568, 5086.237064440364, 5097.7706003229205, 5102.260172275073, 5136.229565565195, 4953.603711703127, 4962.751862406793, 4963.156263435152, 4990.47600002009, 4990.675606085593], "value": 3690.7476326949804, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.2883113250892, 660.7621256347715, 677.4783416769087, 733.1825015108157, 776.378896882494, 12868.678283042917, 13661.72676546471, 14139.0, 14152.433902643896, 14481.131132132079, 14596.708065838677, 14668.193249371281, 14741.262936853142, 14787.852121478809, 14794.334254958525, 632.9430351268385, 772.3049255669914, 791.5448617045193, 812.0215140755405, 814.9918500814975, 799.5922079739346, 808.4381354958306, 809.352517985612, 809.5021561739517, 810.092696180279, 839.6053854688317, 847.7033038436559, 847.9152084791533, 848.749618862437, 849.1890244816217, 656.2748163279603, 794.66226853587, 826.182079741052, 832.2343444031475, 832.2717622080679, 602.340437221242, 602.7829981206762, 602.9397060293979, 603.1375133559009, 603.1887111834576, 13871.583852484442, 13915.30423478822, 13967.37146828395, 14012.369443375073, 14015.159090454605, 12176.878231217663, 12577.11960162789, 12639.241645501299, 12706.61880143588, 12889.613311600573, 10456.0, 10847.393852978472, 10943.56225750969, 11041.83437248442, 11089.944550277278, 3295.983520082384, 3357.345317663057, 3358.2947581008016, 3468.4277094279414, 3493.039414161126, 61119.69440152771, 61382.38617613811, 62987.99999999954, 63361.0, 63832.36167638311, 10254.436006019741, 10357.585696572052, 10365.0, 10664.413457259925, 10774.569017239379, 16905.23926423314, 17941.7308740369, 18121.36575219861, 18421.90789046046, 18494.35269765552, 6326.145970293951, 6645.368689974444, 7318.7438439655425, 7363.963180184065, 7366.447516436288, 3673.1551743098703, 3717.8141092945784, 3763.8306276217636, 3796.620337966181, 3855.5951625078965, 2878.611387462666, 2916.606258155122, 2953.1140657802575, 2959.1862237884325, 2988.551717242431, 513.6584171525968, 521.4342438454244, 526.0426024635203, 527.7150338817073, 533.5411546070376, 484.54210770821237, 499.8900241946766, 536.7209051293306, 537.4491146574715, 586.8738221282445, 7637.219675380994, 7944.721934732257, 8006.879896801553, 8159.306458950937, 8264.876026859602, 485.25513337027496, 492.1642274316818, 595.8767722842473, 601.3265143039823, 601.4710319482047, 3845.1925095729653, 3862.7682339059747, 3905.9218815624095, 3933.4537654956443, 3966.3852102924093, 88329.0, 93454.0, 93604.53197733968, 97192.0, 97466.0, 46552.0, 47529.76235118802, 74937.0, 76234.61882690551, 76874.61562692151, 68883.31116688868, 70930.64534677293, 71573.28426715771, 72126.27873721301, 75962.62018689982, 8590.1839325264, 8788.516631585324, 9013.369064165709, 9201.539923003957, 9357.403030863088, 40360.18379172886, 41917.79041104775, 42749.35875961801, 42833.78583107064, 44407.333889992326, 58250.42744443195, 60631.69684151551, 61251.38748612457, 63010.0, 63173.209607423705, 11108.222424430536, 11114.44427778624, 11693.941530292293, 11704.0, 11764.117691173367, 12514.374281285716, 12724.109312348046, 12748.362581871055, 12951.870481295067, 13179.736405272033, 11567.132465064986, 11963.581274655346, 12155.81766273489, 12629.179103358252, 12819.615411537668, 12307.20003199789, 12503.749925001632, 12551.93724031374, 12617.621471355875, 12726.363681816058, 12062.638120856389, 12078.09414293949, 12187.75624487523, 12279.508819647113, 13001.544945926848, 10135.239857010607, 10246.795064098527, 10293.948530257301, 10528.263021588722, 10563.524641391003, 10070.295079344376, 10375.740606484898, 10381.650385449842, 10480.737981550523, 10506.0], "value": 6593.742479989297, "unit": "score"}], "name": "dromaeo_css", "value": 6461.971512639659, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 114.0, 115.0, 114.0, 116.0, 112.0, 115.0, 116.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 121.0, 129.0, 186.0, 122.0, 128.0, 144.0, 122.0, 155.0, 127.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 123.0, 76.0, 82.0, 75.0, 76.0, 100.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 110.0, 85.0, 84.0, 85.0, 116.0, 86.0, 85.0, 119.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 145.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 64.0, 65.0, 65.0, 70.0, 65.0, 65.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 65.0, 64.0, 76.0, 64.0, 64.0, 65.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 78.0, 78.0, 78.0, 79.0, 78.0, 77.0, 86.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 133.0, 137.0, 129.0, 128.0, 128.0, 137.0, 130.0, 207.0, 136.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 168.0, 165.0, 166.0, 165.0, 167.0, 166.0, 165.0, 165.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 72.0, 67.0, 69.0, 70.0, 66.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1535.6999999999998, "alertThreshold": 2.0}]} 15:37:06 INFO - Return code: 0 15:37:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:37:06 INFO - # TBPL SUCCESS # 15:37:06 INFO - Running post-action listener: _resource_record_post_action 15:37:06 INFO - ##### 15:37:06 INFO - ##### Finished run-tests step (success) 15:37:06 INFO - ##### 15:37:06 INFO - Running post-run listener: _resource_record_post_run 15:37:06 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 359792640; Read time: 12; Write time: 396452 15:37:06 INFO - TinderboxPrint: CPU usage
13.0% 15:37:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:37:06 INFO - TinderboxPrint: I/O write bytes / time
359,792,640 / 396,452 15:37:06 INFO - TinderboxPrint: CPU idle
8,328.6 (86.9%) 15:37:06 INFO - TinderboxPrint: CPU user
1,206.2 (12.6%) 15:37:06 INFO - TinderboxPrint: Swap in / out
0 / 0 15:37:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 76414976; Read time: 0; Write time: 82492 15:37:06 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 282763264; Read time: 0; Write time: 313960 15:37:07 INFO - Running post-run listener: _upload_blobber_files 15:37:07 INFO - Blob upload gear active. 15:37:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:37:07 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 15:37:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:37:07 INFO - (blobuploader) - INFO - Open directory for files ... 15:37:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:37:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:37:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:10 INFO - (blobuploader) - INFO - Done attempting. 15:37:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:37:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:37:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:11 INFO - (blobuploader) - INFO - Done attempting. 15:37:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:37:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:37:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:12 INFO - (blobuploader) - INFO - Done attempting. 15:37:12 INFO - (blobuploader) - INFO - Iteration through files over. 15:37:12 INFO - Return code: 0 15:37:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:37:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:37:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9500c9c40e4e9d91cdd8c56e58e7e65867365af172a74901ba6d85df89ab8afb7f3d5bae4e8597c60832faae090e5719dbcb725a3d8aa0055b41c412734ec8a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/640c5754737aab6c53664d646933c7bd3067ad944a1ce99b340301bc0db9f554294dc4c2ebcfa9ad6a596e7ac4cdc6067940b876a0f9dc7a027afa7fd20f0179", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c701ea3d9bc97fef129321816ffe8d666a2d45f9d8598c3c90efd0e6d17f1c1bb8cc9c8acd18f81785c41b4e959601bfd606c6e5c5efe307e542bcd40fc3809"} 15:37:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:37:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:37:12 INFO - Contents: 15:37:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9500c9c40e4e9d91cdd8c56e58e7e65867365af172a74901ba6d85df89ab8afb7f3d5bae4e8597c60832faae090e5719dbcb725a3d8aa0055b41c412734ec8a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/640c5754737aab6c53664d646933c7bd3067ad944a1ce99b340301bc0db9f554294dc4c2ebcfa9ad6a596e7ac4cdc6067940b876a0f9dc7a027afa7fd20f0179", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c701ea3d9bc97fef129321816ffe8d666a2d45f9d8598c3c90efd0e6d17f1c1bb8cc9c8acd18f81785c41b4e959601bfd606c6e5c5efe307e542bcd40fc3809"} 15:37:12 INFO - Running post-run listener: copy_logs_to_upload_dir 15:37:12 INFO - Copying logs to upload dir... 15:37:12 INFO - mkdir: /builds/slave/test/build/upload/logs 15:37:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.568740 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-07-01 15:37:11.442789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 15:37:11.446009) ========= 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=fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9500c9c40e4e9d91cdd8c56e58e7e65867365af172a74901ba6d85df89ab8afb7f3d5bae4e8597c60832faae090e5719dbcb725a3d8aa0055b41c412734ec8a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/640c5754737aab6c53664d646933c7bd3067ad944a1ce99b340301bc0db9f554294dc4c2ebcfa9ad6a596e7ac4cdc6067940b876a0f9dc7a027afa7fd20f0179", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c701ea3d9bc97fef129321816ffe8d666a2d45f9d8598c3c90efd0e6d17f1c1bb8cc9c8acd18f81785c41b4e959601bfd606c6e5c5efe307e542bcd40fc3809"} build_url:https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/H958PXorRYihKDN6C2l-_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9500c9c40e4e9d91cdd8c56e58e7e65867365af172a74901ba6d85df89ab8afb7f3d5bae4e8597c60832faae090e5719dbcb725a3d8aa0055b41c412734ec8a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/640c5754737aab6c53664d646933c7bd3067ad944a1ce99b340301bc0db9f554294dc4c2ebcfa9ad6a596e7ac4cdc6067940b876a0f9dc7a027afa7fd20f0179", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c701ea3d9bc97fef129321816ffe8d666a2d45f9d8598c3c90efd0e6d17f1c1bb8cc9c8acd18f81785c41b4e959601bfd606c6e5c5efe307e542bcd40fc3809"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 15:37:11.471369) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:37:11.471711) ========= 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=fa44defc139c4ba8574fe040000001db-1467409185.917131-87787704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:37:11.555459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 15:37:11.555790) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 15:37:11.556079) ========= ========= Total master_lag: 0.19 =========