builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1468613342.61 results: success (0) buildid: 20160714113033 builduid: 54d19874f43f4ccbabe49a8cd26e2573 revision: 18e2d06b428f411f6624dfe520df59640ea9b2c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:02.614355) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:02.614876) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:02.615196) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:02.630597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:02.630976) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 13:09:02-- 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% 45.3M=0s 2016-07-15 13:09:02 (45.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114123 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:02.762924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:02.763673) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018035 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:02.815063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:02.815453) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 18e2d06b428f411f6624dfe520df59640ea9b2c0 --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 18e2d06b428f411f6624dfe520df59640ea9b2c0 --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=652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 13:09:03,032 truncating revision to first 12 chars 2016-07-15 13:09:03,032 Setting DEBUG logging. 2016-07-15 13:09:03,032 attempt 1/10 2016-07-15 13:09:03,032 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/18e2d06b428f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 13:09:03,329 unpacking tar archive at: fx-team-18e2d06b428f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620033 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:03.452605) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:03.453302) ========= script_repo_revision: 18e2d06b428f411f6624dfe520df59640ea9b2c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:03.454210) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:03.454871) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 13:09:03.466682) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-15 13:09:03.466980) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:09:03 INFO - MultiFileLogger online at 20160715 13:09:03 in /builds/slave/test 13:09:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:09:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:09:03 INFO - {'append_to_log': False, 13:09:03 INFO - 'base_work_dir': '/builds/slave/test', 13:09:03 INFO - 'blob_upload_branch': 'Fx-Team', 13:09:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:09:03 INFO - 'branch': 'Fx-Team', 13:09:03 INFO - 'buildbot_json_path': 'buildprops.json', 13:09:03 INFO - 'config_files': ('talos/linux_config.py',), 13:09:03 INFO - 'default_actions': ('clobber', 13:09:03 INFO - 'read-buildbot-config', 13:09:03 INFO - 'download-and-extract', 13:09:03 INFO - 'populate-webroot', 13:09:03 INFO - 'create-virtualenv', 13:09:03 INFO - 'install', 13:09:03 INFO - 'run-tests'), 13:09:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:09:03 INFO - 'download_minidump_stackwalk': True, 13:09:03 INFO - 'download_symbols': 'ondemand', 13:09:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:09:03 INFO - 'tooltool.py': '/tools/tooltool.py', 13:09:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:09:03 INFO - '/tools/misc-python/virtualenv.py')}, 13:09:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:09:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:09:03 INFO - 'installer_path': 'installer.exe', 13:09:03 INFO - 'log_level': 'info', 13:09:03 INFO - 'log_name': 'talos', 13:09:03 INFO - 'log_to_console': True, 13:09:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:09:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:09:03 INFO - 'opt_config_files': (), 13:09:03 INFO - 'pip_index': False, 13:09:03 INFO - 'sps_profile': False, 13:09:03 INFO - 'sps_profile_interval': 0, 13:09:03 INFO - 'suite': 'dromaeojs', 13:09:03 INFO - 'system_bits': '32', 13:09:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:09:03 INFO - 'title': 'talos-linux64-ix-046', 13:09:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:09:03 INFO - 'use_talos_json': True, 13:09:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:09:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:09:03 INFO - 'work_dir': 'build'} 13:09:03 INFO - ##### 13:09:03 INFO - ##### Running clobber step. 13:09:03 INFO - ##### 13:09:03 INFO - Running pre-action listener: _resource_record_pre_action 13:09:03 INFO - Running main action method: clobber 13:09:03 INFO - rmtree: /builds/slave/test/build 13:09:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:09:04 INFO - Running post-action listener: _resource_record_post_action 13:09:04 INFO - ##### 13:09:04 INFO - ##### Finished clobber step (success) 13:09:04 INFO - ##### 13:09:04 INFO - ##### 13:09:04 INFO - ##### Running read-buildbot-config step. 13:09:04 INFO - ##### 13:09:04 INFO - Running pre-action listener: _resource_record_pre_action 13:09:04 INFO - Running main action method: read_buildbot_config 13:09:04 INFO - Using buildbot properties: 13:09:04 INFO - { 13:09:04 INFO - "project": "", 13:09:04 INFO - "product": "firefox", 13:09:04 INFO - "script_repo_revision": "production", 13:09:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:09:04 INFO - "repository": "", 13:09:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:09:04 INFO - "buildid": "20160714113033", 13:09:04 INFO - "pgo_build": "True", 13:09:04 INFO - "basedir": "/builds/slave/test", 13:09:04 INFO - "buildnumber": 1326, 13:09:04 INFO - "slavename": "talos-linux64-ix-046", 13:09:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:09:04 INFO - "platform": "ubuntu64_hw", 13:09:04 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:09:04 INFO - "branch": "fx-team", 13:09:04 INFO - "repo_path": "integration/fx-team", 13:09:04 INFO - "revision": "18e2d06b428f411f6624dfe520df59640ea9b2c0", 13:09:04 INFO - "stage_platform": "linux64-pgo", 13:09:04 INFO - "builduid": "54d19874f43f4ccbabe49a8cd26e2573", 13:09:04 INFO - "slavebuilddir": "test" 13:09:04 INFO - } 13:09:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:09:04 INFO - Running post-action listener: _resource_record_post_action 13:09:04 INFO - ##### 13:09:04 INFO - ##### Finished read-buildbot-config step (success) 13:09:04 INFO - ##### 13:09:04 INFO - ##### 13:09:04 INFO - ##### Running download-and-extract step. 13:09:04 INFO - ##### 13:09:04 INFO - Running pre-action listener: _resource_record_pre_action 13:09:04 INFO - Running main action method: download_and_extract 13:09:04 INFO - mkdir: /builds/slave/test/build/tests 13:09: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')]} 13:09:04 INFO - https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:09:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:09:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:09:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/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 13:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/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 13:09:05 INFO - Downloaded 1361 bytes. 13:09:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:09:05 INFO - Using the following test package requirements: 13:09:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:09:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:09:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:09:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:05 INFO - u'jsshell-linux-x86_64.zip'], 13:09:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:09:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:09:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:09:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:09:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:09:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:09:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:09: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')]} 13:09:05 INFO - https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:09:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/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 13:09:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/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 13:09:06 INFO - Downloaded 24326002 bytes. 13:09:06 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'] 13:09:06 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 13:09:08 INFO - Return code: 0 13:09:08 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 13:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:08 INFO - https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:09:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/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 13:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/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 13:09:09 INFO - Downloaded 24326002 bytes. 13:09:09 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'] 13:09:09 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 13:09:11 INFO - Return code: 0 13:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:11 INFO - https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:09:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:09:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:09:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/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 13:09:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/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 13:09:12 INFO - Downloaded 14403317 bytes. 13:09:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:09:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:09:12 INFO - Return code: 0 13:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:12 INFO - https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/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 13:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XgWzH36cTxGZq_FUgTPxWA/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 13:09:13 INFO - Downloaded 60815526 bytes. 13:09:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:13 INFO - mkdir: /builds/slave/test/properties 13:09:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:09:13 INFO - Writing to file /builds/slave/test/properties/build_url 13:09:13 INFO - Contents: 13:09:13 INFO - build_url:https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:14 INFO - Running post-action listener: _resource_record_post_action 13:09:14 INFO - Running post-action listener: set_extra_try_arguments 13:09:14 INFO - ##### 13:09:14 INFO - ##### Finished download-and-extract step (success) 13:09:14 INFO - ##### 13:09:14 INFO - ##### 13:09:14 INFO - ##### Running populate-webroot step. 13:09:14 INFO - ##### 13:09:14 INFO - Running pre-action listener: _resource_record_pre_action 13:09:14 INFO - Running main action method: populate_webroot 13:09:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:09:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:09:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:09:14 INFO - '--tppagecycles', 13:09:14 INFO - '7'], 13:09:14 INFO - 'tests': ['tsvgm']}}, 13:09:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:09:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:09:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:09:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:09:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:09:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:09:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:14 INFO - 'talos_options': ['--disable-e10s'], 13:09:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:14 INFO - 'talos_options': ['--disable-e10s'], 13:09:14 INFO - 'tests': ['damp', 'tps']}, 13:09:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:14 INFO - 'tests': ['damp', 'tps']}, 13:09:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:09:14 INFO - 'tests': ['dromaeo_dom']}, 13:09:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:09:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:09:14 INFO - 'tests': ['basic_compositor_video']}, 13:09:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:09:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:09:14 INFO - 'tests': ['a11yr', 13:09:14 INFO - 'ts_paint', 13:09:14 INFO - 'tpaint', 13:09:14 INFO - 'sessionrestore', 13:09:14 INFO - 'sessionrestore_no_auto_restore', 13:09:14 INFO - 'tabpaint']}, 13:09:14 INFO - 'other-e10s': {'tests': ['a11yr', 13:09:14 INFO - 'ts_paint', 13:09:14 INFO - 'tpaint', 13:09:14 INFO - 'sessionrestore', 13:09:14 INFO - 'sessionrestore_no_auto_restore', 13:09:14 INFO - 'tabpaint']}, 13:09:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:09:14 INFO - 'ts_paint', 13:09:14 INFO - 'tpaint', 13:09:14 INFO - 'sessionrestore', 13:09:14 INFO - 'sessionrestore_no_auto_restore', 13:09:14 INFO - 'tabpaint']}, 13:09:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:09:14 INFO - 'ts_paint', 13:09:14 INFO - 'tpaint', 13:09:14 INFO - 'sessionrestore', 13:09:14 INFO - 'sessionrestore_no_auto_restore', 13:09:14 INFO - 'tabpaint']}, 13:09:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:09:14 INFO - 'tests': ['a11yr', 13:09:14 INFO - 'ts_paint', 13:09:14 INFO - 'tpaint', 13:09:14 INFO - 'sessionrestore', 13:09:14 INFO - 'sessionrestore_no_auto_restore', 13:09:14 INFO - 'tabpaint']}, 13:09:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:09:14 INFO - 'tests': ['a11yr', 13:09:14 INFO - 'ts_paint', 13:09:14 INFO - 'tpaint', 13:09:14 INFO - 'sessionrestore', 13:09:14 INFO - 'sessionrestore_no_auto_restore', 13:09:14 INFO - 'tabpaint']}, 13:09:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:09:14 INFO - 'tests': ['tsvgx', 13:09:14 INFO - 'tsvgr_opacity', 13:09:14 INFO - 'tart', 13:09:14 INFO - 'tscrollx', 13:09:14 INFO - 'cart']}, 13:09:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:09:14 INFO - 'tsvgr_opacity', 13:09:14 INFO - 'tart', 13:09:14 INFO - 'tscrollx', 13:09:14 INFO - 'cart']}, 13:09:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:14 INFO - 'talos_options': ['--disable-e10s'], 13:09:14 INFO - 'tests': ['tp5o']}, 13:09:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:14 INFO - 'tests': ['tp5o']}, 13:09:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:14 INFO - 'talos_options': ['--disable-e10s', 13:09:14 INFO - '--xperf_path', 13:09:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:14 INFO - 'tests': ['tp5n']}, 13:09:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:14 INFO - 'talos_options': ['--xperf_path', 13:09:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:14 INFO - 'tests': ['tp5n']}}, 13:09:14 INFO - 'talos.zip': {'path': '', 13:09:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:09:14 INFO - Running post-action listener: _resource_record_post_action 13:09:14 INFO - ##### 13:09:14 INFO - ##### Finished populate-webroot step (success) 13:09:14 INFO - ##### 13:09:14 INFO - ##### 13:09:14 INFO - ##### Running create-virtualenv step. 13:09:14 INFO - ##### 13:09:14 INFO - Running pre-action listener: _resource_record_pre_action 13:09:14 INFO - Running main action method: create_virtualenv 13:09:14 INFO - Creating virtualenv /builds/slave/test/build/venv 13:09:14 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 13:09:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:09:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:09:14 INFO - Using real prefix '/usr' 13:09:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:09:15 INFO - Installing distribute.............................................................................................................................................................................................done. 13:09:17 INFO - Installing pip.................done. 13:09:17 INFO - Return code: 0 13:09:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:09:17 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')]} 13:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:17 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')]} 13:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:17 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 0x20cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c3b0>, '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 0x238d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238d740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', '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 13:09:17 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 13:09:17 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 13:09:17 INFO - Using env: {'DISPLAY': ':0', 13:09:17 INFO - 'HOME': '/home/cltbld', 13:09:17 INFO - 'LANG': 'en_US.UTF-8', 13:09:17 INFO - 'LANGUAGE': 'en_US:en', 13:09:17 INFO - 'LOGNAME': 'cltbld', 13:09:17 INFO - 'MAIL': '/var/mail/cltbld', 13:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:17 INFO - 'MOZ_NO_REMOTE': '1', 13:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:17 INFO - 'NO_EM_RESTART': '1', 13:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:17 INFO - 'PWD': '/builds/slave/test', 13:09:17 INFO - 'SHELL': '/bin/bash', 13:09:17 INFO - 'SHLVL': '1', 13:09:17 INFO - 'TERM': 'linux', 13:09:17 INFO - 'TMOUT': '86400', 13:09:17 INFO - 'USER': 'cltbld', 13:09:17 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', 13:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:17 INFO - '_': '/tools/buildbot/bin/python'} 13:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:17 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 13:09:17 INFO - Cleaning up... 13:09:17 INFO - Return code: 0 13:09:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:09:17 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')]} 13:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:17 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')]} 13:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:17 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 0x20cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c3b0>, '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 0x238d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238d740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', '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 13:09:17 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 13:09:17 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 13:09:17 INFO - Using env: {'DISPLAY': ':0', 13:09:17 INFO - 'HOME': '/home/cltbld', 13:09:17 INFO - 'LANG': 'en_US.UTF-8', 13:09:17 INFO - 'LANGUAGE': 'en_US:en', 13:09:17 INFO - 'LOGNAME': 'cltbld', 13:09:17 INFO - 'MAIL': '/var/mail/cltbld', 13:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:17 INFO - 'MOZ_NO_REMOTE': '1', 13:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:17 INFO - 'NO_EM_RESTART': '1', 13:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:17 INFO - 'PWD': '/builds/slave/test', 13:09:17 INFO - 'SHELL': '/bin/bash', 13:09:17 INFO - 'SHLVL': '1', 13:09:17 INFO - 'TERM': 'linux', 13:09:17 INFO - 'TMOUT': '86400', 13:09:17 INFO - 'USER': 'cltbld', 13:09:17 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', 13:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:17 INFO - '_': '/tools/buildbot/bin/python'} 13:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:17 INFO - Downloading/unpacking psutil>=3.1.1 13:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:09:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:19 INFO - Installing collected packages: psutil 13:09:19 INFO - Running setup.py install for psutil 13:09:19 INFO - building 'psutil._psutil_linux' extension 13:09:19 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 13:09:20 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 13:09:20 INFO - building 'psutil._psutil_posix' extension 13:09:20 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 13:09:20 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 13:09:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:20 INFO - Successfully installed psutil 13:09:20 INFO - Cleaning up... 13:09:20 INFO - Return code: 0 13:09:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:09:20 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')]} 13:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:20 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')]} 13:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:20 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 0x20cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c3b0>, '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 0x238d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238d740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', '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 13:09:20 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 13:09:20 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 13:09:20 INFO - Using env: {'DISPLAY': ':0', 13:09:20 INFO - 'HOME': '/home/cltbld', 13:09:20 INFO - 'LANG': 'en_US.UTF-8', 13:09:20 INFO - 'LANGUAGE': 'en_US:en', 13:09:20 INFO - 'LOGNAME': 'cltbld', 13:09:20 INFO - 'MAIL': '/var/mail/cltbld', 13:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:20 INFO - 'MOZ_NO_REMOTE': '1', 13:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:20 INFO - 'NO_EM_RESTART': '1', 13:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:20 INFO - 'PWD': '/builds/slave/test', 13:09:20 INFO - 'SHELL': '/bin/bash', 13:09:20 INFO - 'SHLVL': '1', 13:09:20 INFO - 'TERM': 'linux', 13:09:20 INFO - 'TMOUT': '86400', 13:09:20 INFO - 'USER': 'cltbld', 13:09:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', 13:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:20 INFO - '_': '/tools/buildbot/bin/python'} 13:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:09:20 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 13:09:20 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 13:09:20 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 13:09:20 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 13:09:20 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 13:09:20 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 13:09:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:09:22 INFO - Installing collected packages: mozsystemmonitor 13:09:22 INFO - Running setup.py install for mozsystemmonitor 13:09:22 INFO - Successfully installed mozsystemmonitor 13:09:22 INFO - Cleaning up... 13:09:22 INFO - Return code: 0 13:09:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c3b0>, '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 0x238d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238d740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', '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 13:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:09:22 INFO - Using env: {'DISPLAY': ':0', 13:09:22 INFO - 'HOME': '/home/cltbld', 13:09:22 INFO - 'LANG': 'en_US.UTF-8', 13:09:22 INFO - 'LANGUAGE': 'en_US:en', 13:09:22 INFO - 'LOGNAME': 'cltbld', 13:09:22 INFO - 'MAIL': '/var/mail/cltbld', 13:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:22 INFO - 'MOZ_NO_REMOTE': '1', 13:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:22 INFO - 'NO_EM_RESTART': '1', 13:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:22 INFO - 'PWD': '/builds/slave/test', 13:09:22 INFO - 'SHELL': '/bin/bash', 13:09:22 INFO - 'SHLVL': '1', 13:09:22 INFO - 'TERM': 'linux', 13:09:22 INFO - 'TMOUT': '86400', 13:09:22 INFO - 'USER': 'cltbld', 13:09:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', 13:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:22 INFO - '_': '/tools/buildbot/bin/python'} 13:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:22 INFO - Downloading/unpacking jsonschema==2.5.1 13:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:09:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:24 INFO - Downloading functools32-3.2.3-2.tar.gz 13:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:09:25 INFO - warning: no files found matching '*.txt' 13:09:25 INFO - no previously-included directories found matching 'build' 13:09:25 INFO - no previously-included directories found matching 'dist' 13:09:25 INFO - no previously-included directories found matching '.git*' 13:09:25 INFO - Installing collected packages: jsonschema, functools32 13:09:25 INFO - Running setup.py install for functools32 13:09:25 INFO - warning: no files found matching '*.txt' 13:09:25 INFO - no previously-included directories found matching 'build' 13:09:25 INFO - no previously-included directories found matching 'dist' 13:09:25 INFO - no previously-included directories found matching '.git*' 13:09:25 INFO - Successfully installed jsonschema functools32 13:09:25 INFO - Cleaning up... 13:09:25 INFO - Return code: 0 13:09:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:09:25 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')]} 13:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:25 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')]} 13:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:25 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 0x20cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c3b0>, '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 0x238d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238d740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', '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 13:09:25 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 13:09:25 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 13:09:25 INFO - Using env: {'DISPLAY': ':0', 13:09:25 INFO - 'HOME': '/home/cltbld', 13:09:25 INFO - 'LANG': 'en_US.UTF-8', 13:09:25 INFO - 'LANGUAGE': 'en_US:en', 13:09:25 INFO - 'LOGNAME': 'cltbld', 13:09:25 INFO - 'MAIL': '/var/mail/cltbld', 13:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:25 INFO - 'MOZ_NO_REMOTE': '1', 13:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:25 INFO - 'NO_EM_RESTART': '1', 13:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:25 INFO - 'PWD': '/builds/slave/test', 13:09:25 INFO - 'SHELL': '/bin/bash', 13:09:25 INFO - 'SHLVL': '1', 13:09:25 INFO - 'TERM': 'linux', 13:09:25 INFO - 'TMOUT': '86400', 13:09:25 INFO - 'USER': 'cltbld', 13:09:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', 13:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:25 INFO - '_': '/tools/buildbot/bin/python'} 13:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:25 INFO - Downloading/unpacking blobuploader==1.2.4 13:09:25 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 13:09:25 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 13:09:25 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 13:09:25 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 13:09:25 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 13:09:25 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 13:09:27 INFO - Downloading blobuploader-1.2.4.tar.gz 13:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:09:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:09:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:28 INFO - Downloading docopt-0.6.1.tar.gz 13:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:09:28 INFO - Installing collected packages: blobuploader, requests, docopt 13:09:28 INFO - Running setup.py install for blobuploader 13:09:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:09:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:09:28 INFO - Running setup.py install for requests 13:09:28 INFO - Running setup.py install for docopt 13:09:28 INFO - Successfully installed blobuploader requests docopt 13:09:28 INFO - Cleaning up... 13:09:28 INFO - Return code: 0 13:09:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:28 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')]} 13:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:28 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')]} 13:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:28 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 0x20cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c3b0>, '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 0x238d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238d740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', '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 13:09:28 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 13:09:28 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 13:09:28 INFO - Using env: {'DISPLAY': ':0', 13:09:28 INFO - 'HOME': '/home/cltbld', 13:09:28 INFO - 'LANG': 'en_US.UTF-8', 13:09:28 INFO - 'LANGUAGE': 'en_US:en', 13:09:28 INFO - 'LOGNAME': 'cltbld', 13:09:28 INFO - 'MAIL': '/var/mail/cltbld', 13:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:28 INFO - 'MOZ_NO_REMOTE': '1', 13:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:28 INFO - 'NO_EM_RESTART': '1', 13:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:28 INFO - 'PWD': '/builds/slave/test', 13:09:28 INFO - 'SHELL': '/bin/bash', 13:09:28 INFO - 'SHLVL': '1', 13:09:28 INFO - 'TERM': 'linux', 13:09:28 INFO - 'TMOUT': '86400', 13:09:28 INFO - 'USER': 'cltbld', 13:09:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', 13:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:28 INFO - '_': '/tools/buildbot/bin/python'} 13:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:28 INFO - Running setup.py (path:/tmp/pip-Ok88lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:29 INFO - Running setup.py (path:/tmp/pip-C1sFcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:29 INFO - Running setup.py (path:/tmp/pip-MvnhPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:29 INFO - Running setup.py (path:/tmp/pip-s1vM_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:29 INFO - Running setup.py (path:/tmp/pip-j1gTvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:29 INFO - Running setup.py (path:/tmp/pip-Sqz9a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:29 INFO - Running setup.py (path:/tmp/pip-PMXoEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:29 INFO - Running setup.py (path:/tmp/pip-ol8Swz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:29 INFO - Running setup.py (path:/tmp/pip-SU7oih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:29 INFO - Running setup.py (path:/tmp/pip-1GNNMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:29 INFO - Running setup.py (path:/tmp/pip-IByGsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:29 INFO - Running setup.py (path:/tmp/pip-HSrpXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:29 INFO - Running setup.py (path:/tmp/pip-FZK7M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:29 INFO - Running setup.py (path:/tmp/pip-QnO_fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:29 INFO - Running setup.py (path:/tmp/pip-8unkIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:30 INFO - Running setup.py (path:/tmp/pip-tDLBC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:30 INFO - Running setup.py (path:/tmp/pip-n88g2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:09:30 INFO - Running setup.py install for manifestparser 13:09:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:09:30 INFO - Running setup.py install for mozcrash 13:09:30 INFO - Running setup.py install for mozdebug 13:09:30 INFO - Running setup.py install for mozdevice 13:09:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:09:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:09:30 INFO - Running setup.py install for mozfile 13:09:30 INFO - Running setup.py install for mozhttpd 13:09:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:09:30 INFO - Running setup.py install for mozinfo 13:09:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:09:30 INFO - Running setup.py install for mozInstall 13:09:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:09:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:09:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:09:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:09:30 INFO - Running setup.py install for mozleak 13:09:31 INFO - Running setup.py install for mozlog 13:09:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:09:31 INFO - Running setup.py install for moznetwork 13:09:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:09:31 INFO - Running setup.py install for mozprocess 13:09:31 INFO - Running setup.py install for mozprofile 13:09:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:09:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:09:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:09:31 INFO - Running setup.py install for mozrunner 13:09:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:09:31 INFO - Running setup.py install for mozscreenshot 13:09:31 INFO - Running setup.py install for moztest 13:09:31 INFO - Running setup.py install for mozversion 13:09:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:09:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:09:31 INFO - Cleaning up... 13:09:31 INFO - Return code: 0 13:09:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:31 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 0x20cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c3b0>, '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 0x238d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238d740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', '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 13:09:31 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 13:09:31 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 13:09:31 INFO - Using env: {'DISPLAY': ':0', 13:09:31 INFO - 'HOME': '/home/cltbld', 13:09:31 INFO - 'LANG': 'en_US.UTF-8', 13:09:31 INFO - 'LANGUAGE': 'en_US:en', 13:09:31 INFO - 'LOGNAME': 'cltbld', 13:09:31 INFO - 'MAIL': '/var/mail/cltbld', 13:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:31 INFO - 'MOZ_NO_REMOTE': '1', 13:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:31 INFO - 'NO_EM_RESTART': '1', 13:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:31 INFO - 'PWD': '/builds/slave/test', 13:09:31 INFO - 'SHELL': '/bin/bash', 13:09:31 INFO - 'SHLVL': '1', 13:09:31 INFO - 'TERM': 'linux', 13:09:31 INFO - 'TMOUT': '86400', 13:09:31 INFO - 'USER': 'cltbld', 13:09:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', 13:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:31 INFO - '_': '/tools/buildbot/bin/python'} 13:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:32 INFO - Running setup.py (path:/tmp/pip-9mztdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:32 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)) 13:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:32 INFO - Running setup.py (path:/tmp/pip-NTwLFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:32 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)) 13:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:32 INFO - Running setup.py (path:/tmp/pip-LKh0sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:32 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)) 13:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:32 INFO - Running setup.py (path:/tmp/pip-kXpenq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:32 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)) 13:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:32 INFO - Running setup.py (path:/tmp/pip-OtnB7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:32 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)) 13:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:32 INFO - Running setup.py (path:/tmp/pip-xB7rnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:32 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)) 13:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:32 INFO - Running setup.py (path:/tmp/pip-DmV5Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:32 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)) 13:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:32 INFO - Running setup.py (path:/tmp/pip-pIMhzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:32 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)) 13:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:32 INFO - Running setup.py (path:/tmp/pip-dSvFQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:32 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)) 13:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:32 INFO - Running setup.py (path:/tmp/pip-Zyqv2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:32 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)) 13:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:32 INFO - Running setup.py (path:/tmp/pip-_31RIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:32 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)) 13:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:32 INFO - Running setup.py (path:/tmp/pip-tWyWqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:33 INFO - Running setup.py (path:/tmp/pip-4MmoQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:33 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)) 13:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:33 INFO - Running setup.py (path:/tmp/pip-VTjfbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:33 INFO - Running setup.py (path:/tmp/pip-jnSt_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:33 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)) 13:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:33 INFO - Running setup.py (path:/tmp/pip-k3as7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:33 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)) 13:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:33 INFO - Running setup.py (path:/tmp/pip-MTcIi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:33 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)) 13:09:33 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)) 13:09:33 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)) 13:09:33 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)) 13:09:33 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)) 13:09:33 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)) 13:09:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09:33 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 13:09:33 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 13:09:33 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 13:09:33 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 13:09:33 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 13:09:33 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 13:09:35 INFO - Downloading blessings-1.6.tar.gz 13:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:09:35 INFO - Installing collected packages: blessings 13:09:35 INFO - Running setup.py install for blessings 13:09:35 INFO - Successfully installed blessings 13:09:35 INFO - Cleaning up... 13:09:35 INFO - Return code: 0 13:09:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:35 INFO - Reading from file tmpfile_stdout 13:09:35 INFO - Current package versions: 13:09:35 INFO - argparse == 1.2.1 13:09:35 INFO - blessings == 1.6 13:09:35 INFO - blobuploader == 1.2.4 13:09:35 INFO - docopt == 0.6.1 13:09:35 INFO - functools32 == 3.2.3-2 13:09:35 INFO - jsonschema == 2.5.1 13:09:35 INFO - manifestparser == 1.1 13:09:35 INFO - mozInstall == 1.12 13:09:35 INFO - mozcrash == 0.17 13:09:35 INFO - mozdebug == 0.1 13:09:35 INFO - mozdevice == 0.48 13:09:35 INFO - mozfile == 1.2 13:09:35 INFO - mozhttpd == 0.7 13:09:35 INFO - mozinfo == 0.9 13:09:35 INFO - mozleak == 0.1 13:09:35 INFO - mozlog == 3.2 13:09:35 INFO - moznetwork == 0.27 13:09:35 INFO - mozprocess == 0.23 13:09:35 INFO - mozprofile == 0.28 13:09:35 INFO - mozrunner == 6.12 13:09:35 INFO - mozscreenshot == 0.1 13:09:35 INFO - mozsystemmonitor == 0.3 13:09:35 INFO - moztest == 0.7 13:09:35 INFO - mozversion == 1.4 13:09:35 INFO - psutil == 3.1.1 13:09:35 INFO - requests == 1.2.3 13:09:35 INFO - wsgiref == 0.1.2 13:09:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:35 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')]} 13:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:35 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')]} 13:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:35 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 0x20cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c3b0>, '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 0x238d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238d740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', '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 13:09:35 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 13:09:35 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 13:09:35 INFO - Using env: {'DISPLAY': ':0', 13:09:35 INFO - 'HOME': '/home/cltbld', 13:09:35 INFO - 'LANG': 'en_US.UTF-8', 13:09:35 INFO - 'LANGUAGE': 'en_US:en', 13:09:35 INFO - 'LOGNAME': 'cltbld', 13:09:35 INFO - 'MAIL': '/var/mail/cltbld', 13:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:35 INFO - 'MOZ_NO_REMOTE': '1', 13:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:35 INFO - 'NO_EM_RESTART': '1', 13:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:35 INFO - 'PWD': '/builds/slave/test', 13:09:35 INFO - 'SHELL': '/bin/bash', 13:09:35 INFO - 'SHLVL': '1', 13:09:35 INFO - 'TERM': 'linux', 13:09:35 INFO - 'TMOUT': '86400', 13:09:35 INFO - 'USER': 'cltbld', 13:09:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', 13:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:35 INFO - '_': '/tools/buildbot/bin/python'} 13:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:35 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)) 13:09:35 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)) 13:09:35 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)) 13:09:35 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)) 13:09:35 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)) 13:09:35 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)) 13:09:35 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)) 13:09:35 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)) 13:09:35 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)) 13:09:35 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)) 13:09:35 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)) 13:09:35 INFO - Cleaning up... 13:09:35 INFO - Return code: 0 13:09:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:09:35 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')]} 13:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:35 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')]} 13:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:35 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 0x20cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c3b0>, '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 0x238d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238d740>, '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': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', '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 13:09:35 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 13:09:35 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 13:09:35 INFO - Using env: {'DISPLAY': ':0', 13:09:35 INFO - 'HOME': '/home/cltbld', 13:09:35 INFO - 'LANG': 'en_US.UTF-8', 13:09:35 INFO - 'LANGUAGE': 'en_US:en', 13:09:35 INFO - 'LOGNAME': 'cltbld', 13:09:35 INFO - 'MAIL': '/var/mail/cltbld', 13:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:35 INFO - 'MOZ_NO_REMOTE': '1', 13:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:35 INFO - 'NO_EM_RESTART': '1', 13:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:35 INFO - 'PWD': '/builds/slave/test', 13:09:35 INFO - 'SHELL': '/bin/bash', 13:09:35 INFO - 'SHLVL': '1', 13:09:35 INFO - 'TERM': 'linux', 13:09:35 INFO - 'TMOUT': '86400', 13:09:35 INFO - 'USER': 'cltbld', 13:09:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', 13:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:35 INFO - '_': '/tools/buildbot/bin/python'} 13:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:09:36 INFO - Cleaning up... 13:09:36 INFO - Return code: 0 13:09:36 INFO - Running post-action listener: _resource_record_post_action 13:09:36 INFO - Running post-action listener: _start_resource_monitoring 13:09:36 INFO - Starting resource monitoring. 13:09:36 INFO - ##### 13:09:36 INFO - ##### Finished create-virtualenv step (success) 13:09:36 INFO - ##### 13:09:36 INFO - ##### 13:09:36 INFO - ##### Running install step. 13:09:36 INFO - ##### 13:09:36 INFO - Running pre-action listener: _resource_record_pre_action 13:09:36 INFO - Running main action method: install 13:09:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:36 INFO - Reading from file tmpfile_stdout 13:09:36 INFO - Detecting whether we're running mozinstall >=1.0... 13:09:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:09:36 INFO - Reading from file tmpfile_stdout 13:09:36 INFO - Output received: 13:09:36 INFO - Usage: mozinstall [options] installer 13:09:36 INFO - Options: 13:09:36 INFO - -h, --help show this help message and exit 13:09:36 INFO - -d DEST, --destination=DEST 13:09:36 INFO - Directory to install application into. [default: 13:09:36 INFO - "/builds/slave/test"] 13:09:36 INFO - --app=APP Application being installed. [default: firefox] 13:09:36 INFO - mkdir: /builds/slave/test/build/application 13:09:36 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'] 13:09:36 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 13:09:53 INFO - Reading from file tmpfile_stdout 13:09:53 INFO - Output received: 13:09:53 INFO - /builds/slave/test/build/application/firefox/firefox 13:09:53 INFO - Running post-action listener: _resource_record_post_action 13:09:53 INFO - ##### 13:09:53 INFO - ##### Finished install step (success) 13:09:53 INFO - ##### 13:09:53 INFO - ##### 13:09:53 INFO - ##### Running run-tests step. 13:09:53 INFO - ##### 13:09:53 INFO - Running pre-action listener: _resource_record_pre_action 13:09:53 INFO - Running main action method: run_tests 13:09:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:09:53 INFO - Python 2.7.3 13:09:53 INFO - Return code: 0 13:09:53 INFO - grabbing minidump binary from tooltool 13:09:53 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')]} 13:09:53 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 0x238c3b0>, '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 0x238d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:09:53 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 13:09:53 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 13:09:53 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 13:09:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:09:53 INFO - Return code: 0 13:09:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:09:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:09:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:09:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:09:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:09:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 13:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 13:09:53 INFO - Using env: {'DISPLAY': ':0', 13:09:53 INFO - 'HOME': '/home/cltbld', 13:09:53 INFO - 'LANG': 'en_US.UTF-8', 13:09:53 INFO - 'LANGUAGE': 'en_US:en', 13:09:53 INFO - 'LOGNAME': 'cltbld', 13:09:53 INFO - 'MAIL': '/var/mail/cltbld', 13:09:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:09:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:53 INFO - 'MOZ_NO_REMOTE': '1', 13:09:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:53 INFO - 'NO_EM_RESTART': '1', 13:09:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:53 INFO - 'PWD': '/builds/slave/test', 13:09:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:09:53 INFO - 'SHELL': '/bin/bash', 13:09:53 INFO - 'SHLVL': '1', 13:09:53 INFO - 'TERM': 'linux', 13:09:53 INFO - 'TMOUT': '86400', 13:09:53 INFO - 'USER': 'cltbld', 13:09:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198', 13:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:53 INFO - '_': '/tools/buildbot/bin/python'} 13:09:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 13:09:53 INFO - mozversion application_buildid: 20160714113033 13:09:53 INFO - mozversion application_changeset: 18e2d06b428f411f6624dfe520df59640ea9b2c0 13:09:53 INFO - mozversion application_display_name: Nightly 13:09:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:09:53 INFO - mozversion application_name: Firefox 13:09:53 INFO - mozversion application_remotingname: firefox 13:09:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:09:53 INFO - mozversion application_vendor: Mozilla 13:09:53 INFO - mozversion application_version: 50.0a1 13:09:53 INFO - mozversion platform_buildid: 20160714113033 13:09:53 INFO - mozversion platform_changeset: 18e2d06b428f411f6624dfe520df59640ea9b2c0 13:09:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:09:53 INFO - mozversion platform_version: 50.0a1 13:09:53 INFO - using testdate: 1468613393 13:09:53 INFO - actual date: 1468613393 13:09:53 INFO - starting webserver on 'localhost:58019' 13:09:53 INFO - SUITE-START | Running 2 tests 13:09:53 INFO - TEST-START | dromaeo_css 13:09:53 INFO - operating with platform_type : linux_ 13:09:53 INFO - Initialising browser for dromaeo_css test... 13:09:53 INFO - TEST-INFO | started process 24355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpILXnhR/profile http://localhost:58019/getInfo.html) 13:09:57 INFO - PROCESS | 24355 | __metrics Screen width/height:1600/1200 13:09:57 INFO - PROCESS | 24355 | colorDepth:24 13:09:57 INFO - PROCESS | 24355 | Browser inner width/height: 1024/697 13:09:57 INFO - PROCESS | 24355 | __metrics 13:09:58 INFO - PROCESS | 24355 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:09:58 INFO - PROCESS | 24355 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:09:59 INFO - TEST-INFO | 24355: exit 0 13:09:59 INFO - Browser initialized. 13:09:59 INFO - Running cycle 1/1 for dromaeo_css test... 13:09:59 INFO - TEST-INFO | started process 24436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpILXnhR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:11 INFO - PROCESS | 24436 | RSS: Main: 156811264 13:10:11 INFO - PROCESS | 24436 | 13:11:02 INFO - PROCESS | 24436 | 1468613462990 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] 13:13:10 INFO - PROCESS | 24436 | Cycle 1(1): loaded http://localhost:58019/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58019/tests/dromaeo/cssquery-ext.html) 13:13:12 INFO - PROCESS | 24436 | RSS: Main: 263393280 13:13:12 INFO - PROCESS | 24436 | 13:16:14 INFO - PROCESS | 24436 | Cycle 1(1): loaded http://localhost:58019/tests/dromaeo/cssquery-ext.html (next: http://localhost:58019/tests/dromaeo/cssquery-jquery.html) 13:16:15 INFO - PROCESS | 24436 | RSS: Main: 245383168 13:16:15 INFO - PROCESS | 24436 | 13:19:17 INFO - PROCESS | 24436 | Cycle 1(1): loaded http://localhost:58019/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58019/tests/dromaeo/cssquery-mootools.html) 13:19:17 INFO - PROCESS | 24436 | RSS: Main: 239169536 13:19:17 INFO - PROCESS | 24436 | 13:22:19 INFO - PROCESS | 24436 | Cycle 1(1): loaded http://localhost:58019/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58019/tests/dromaeo/cssquery-prototype.html) 13:22:20 INFO - PROCESS | 24436 | RSS: Main: 249630720 13:22:20 INFO - PROCESS | 24436 | 13:25:22 INFO - PROCESS | 24436 | Cycle 1(1): loaded http://localhost:58019/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58019/tests/dromaeo/cssquery-yui.html) 13:25:23 INFO - PROCESS | 24436 | RSS: Main: 228110336 13:25:23 INFO - PROCESS | 24436 | 13:28:26 INFO - PROCESS | 24436 | Cycle 1(1): loaded http://localhost:58019/tests/dromaeo/cssquery-yui.html (next: http://localhost:58019/tests/dromaeo/cssquery-dojo.html) 13:28:26 INFO - PROCESS | 24436 | RSS: Main: 288550912 13:28:26 INFO - PROCESS | 24436 | 13:28:26 INFO - PROCESS | 24436 | __start_tp_report 13:28:26 INFO - PROCESS | 24436 | _x_x_mozilla_page_load 13:28:26 INFO - PROCESS | 24436 | _x_x_mozilla_page_load_details 13:28:26 INFO - PROCESS | 24436 | |i|pagename|runs| 13:28:26 INFO - PROCESS | 24436 | |0;dojo.html;3058.694130586941;3059.281068948795;3099.876004959801;3111.8132912025267;3125.062481255623;5227.555657769094;5249.212618107276;5308.203769434586;5387.838364849056;5425.7287135643255;5298.337707786527;5311.389190243123;5338.27933229015;5338.492843179902;5379.9731001344935;4769.117713223048;4840.201366774478;4849.199882019462;4857.635677324197;4963;4876.4148302203785;4880.316755654194;4906.337644417994;4933.284673722308;4966.404031516223;4811.4707382187935;4812.446568644598;4816.964352664177;4869.293952376921;4873.415190177184;4791.6166706663735;4807.567318941277;4811.350467686888;4881.731504767236;4926.334944782444;4853.102176097434;4860.781264843091;4861.173600487926;4866.391701037371;4873.244647079673;5219.399769026572;5220.1647736362;5323.707196104213;5385.3268341457315;5404.189371594253;5729.656220626775;5745.798897038583;5752.309722833287;5775.335836378828;5783.392743761929;5610.69141197234;5704.201411802351;5778.393268706767;5819.67991760453;5825.650460972355;5078.31442755227;5443.836684899459;5452.563794896439;5457.727113644341;5458.45415458459;5939.643621382731;5962.850928726816;5965;5965.284165900033;5972.40275972408;5482.643628164156;5530.695811730313;5542.8337149885565;5727.654001309689;5729.140628905698;5667.008273552112;5668.0647693130995;5711.885762284731;5715.371309155989;5723.771049157987;5669.262995810601;5673.035583950738;5677.233573467612;5680.77276908919;5681.9431805681415;5626.971865140648;5630.577706672016;5663.065594176915;5679.545636349082;5681.431856814285;4367.825286988485;4368.7815609219415;4371.038371558252;4375.518692943773;4416.3596278539435;3878.4182372644327;3893.7858417787293;3903.1413089120347;3937.2716047530726;3946.309395855714;5340.332458442695;5401.297831281908;5403.729813509309;5421.1055175895535;5461.781528738886;5803.970980145073;5837.066069428871;5840.153177789197;5845.210896528999;5885.823425297248;5458.426865179178;5496.5053145217125;5502.504774570228;5508.697021663847;5509.118541033416;4777.928331075037;4826.131296366688;4836.564709176191;4882.048000639912;4922.581580565692;5807.912881306784;5809.041508151107;5812.680302583483;5819.330776960619;5820.359760426434;5673.035583950821;5683.261176047087;5687.516561092353;5688.516476099578;5691.089425691869;5748.6838223898085;5827.504662103769;5844.824655260349;5853.824385268449;5911.201987731602;5608.046632072476;5629.943700562942;5631.577631677723;5646.2942132233475;5646.491815736604;5687.090065589486;5688.516476099578;5691.430856914276;5750.367459579526;5763.596548241583;5610.495055444866;5613.550915926798;5620.775168993358;5622.353429355513;5622.578306626938;5545.085060965057;5606.803761868315;5612.410696876769;5612.887742245214;5619.157126431068;5465.590080744039;5479.178123281539;5511.669299842022;5514.944850551443;5599.1041433370465;5642.23829782974;5656.773729050957;5661.207430959586;5703.7433315500075;5717.485426311652;5532.834014979557;5537.2524709163745;5546.75039623226;5551.944480555143;5557.3331200256225 13:28:26 INFO - PROCESS | 24436 | |1;ext.html;601.1043545117776;617.9752809887605;636.5734957578422;642.4314481683708;662.6189940784051;43636.56363436364;44980.77509612451;45081.77459112708;45182.999999999956;49457;47071.29393059098;47452;47462.76268618661;47473.76263118688;47545.28682069763;8963.775905602362;9101.590428430736;9104.226140778008;9108.681196158135;9109.31477676632;9064.818703625924;9144.314176436761;9149.67976120836;9154.954225228865;9155.176034156924;9199.540022998857;9229.6308147674;9229.723108306762;9240.815183696322;9241.722748317561;9116.772080697969;9126.726198214064;9156.542172891395;9168.358214924925;9171.037041110687;8968.775780605472;9033.728988130366;9051.366404351698;9052.547372631409;9052.637894484213;43525.12949741019;43757.34363984511;43979;43984;43987.56012439899;3393.5718014367794;3879.3792993120965;3896.2597106549665;3981.6217459341606;4065.349544072964;33324.33351332984;34270.82864585686;34396.6560334396;34813.30373392518;35118.82440587781;4293.334533147367;4329.631981281595;4331.436913201295;4369.519352871182;4398.7580683062415;366165;366448;368833.9999999973;368992;369283;59187.11219331714;59282.703586482654;59333.70333148393;59485.702571486865;59578.999999999134;62871.6856415715;63375.36624633787;63455.36544634494;63455.365446345866;63491.41271468158;14809.33357998871;16391.754123688155;16501.422450214184;16939.407120750715;16963.491095267163;13284.601461956157;13387.196768193939;13388.93305533466;13393.129446585941;13393.397297121654;17252;17306;17371.56571085733;17386.21762020712;17387.56531086733;5170.922436163461;6094.695265236809;6207.534434917399;6243.250809902841;6252.154924721354;918.2103391083663;991.9057689519484;1093.868735751715;1108.5510368300852;1145.6963904565298;32832.343353132805;32909.341813163606;33104.1723956903;33208.33583328368;33404.83297583545;1088.6298658456162;1091.3124731419314;1098.6703988803326;1117.385438009108;1204.897583705395;17047.659046818993;17293.827061729222;17304.394346197823;17358.91320543389;17477.475675729747;519213;524493;524621;524718;525924;57813.421865781645;59060.409395906354;59095;59159.40840591625;59190.40809591849;1236.449779847977;1346.8922486201081;1374.4776984745733;1387.4519564771858;1396.804447377368;32055.6794432062;34451.13872153216;34503;34521.136971575914;34864;50349.496505035946;50848;50911.49088509216;50967.2354914684;50989;406433;406829;408337;409279;409943;36422.63577364192;41810.58189418067;42730;42988.78505607452;44981.775091124335;49523.17465687022;49670.75164624154;49934.75032624813;50417.243741343176;50659.493405066954;40796.1840763189;41634.79182604067;42453.787731061144;43043.56956430396;45954.770226148656;42261.57738422576;42824.85258247701;42913.5708642922;42941;43328.350074748276;40452.39321410123;40740.38889416602;40792.1841563173;41248.38127428031;41509.79245103755;36791.26417471689;38108;38154;38624;38868;28745.63334509406;28995.13014609565;29019.85490072536;29078;29176.7082329174 13:28:26 INFO - PROCESS | 24436 | |2;jquery.html;396.17990759128577;399.8180827723385;401.63451259353974;401.64053172410695;420.03423975793277;18460.815391846096;20344.491387715316;20363.898180509113;20425.99999999998;20442.48893777656;18948.147333369998;19352.419427417164;20056.398308050782;20091.497712557157;20122;5709.486985948727;5750.252467179261;5911.438413350725;5912.142739302799;5955.761769529214;5753.165790960308;5811.651300921937;5816.214811000503;5817.069268916975;5822.184894114827;5783.537317014629;5814.24414826072;5887.352391236982;5922.733476993546;5927.762889484416;5829.09649004405;5903.616264942786;5906.881862362771;5911.852203694921;5973.163757074013;5147.176451767737;5242.187460943522;5269.947300527022;5286.577073834084;5286.709230992294;20918.372448826558;22005.559888802134;22010.779892201033;22723.431914202112;23510.882445587664;2295.5179412323264;2373.1931143411152;2394.317619478458;2429.866357350345;2529.178017144417;9702.805943881154;10192.694219173436;10220.386776793417;10373.636922707745;10580.576776928914;1804.6661367647027;1896.3931541906595;1937.9229593760565;1962.4407043992537;1983.6429442700307;83050;85120;85799.99999999937;86408;87060;10168.186545076376;10189.643362482277;10296.485175741333;10335.483225838678;10466.215033872339;14275.286235688174;14309.356078976263;14373.209473479059;14570.781438278435;14608.561743147722;7939.3251573615735;7947.483413578215;8006.119326874039;8143.552104634184;8268.917310826935;7932.325752311002;7960.721374751856;8020.679172833138;8081.797955051054;8256;4644.140833945731;4669.369635099286;4680.087382960358;4703.035877645075;4742.4309082909585;1968.5964377302905;1993.2624928776156;2004.1181879972764;2005;2014.8891810950245;916.7616419730784;972.3679608254549;978.4276198424002;988.8615593816871;1030.5723124903232;19281.22875085009;19803.50491237702;19908.203671853254;19915;19949.506311711037;1012.3318609717551;1016.7254841192837;1030.6907927621683;1041.6614600254948;1062.8033813744482;10498.370097794157;10895.291806032583;10940.39827809478;10940.726481837859;11035.44822758875;376252;376262;382985;504111;504306;94844.52577737067;104818;105474;105745;105884;990.7919336939324;1020.7090979071078;1055.488088277185;1058.1799105693149;1059.2532264753331;17631.20659570348;17821;18407.53981150482;18582;18611.441656750318;41187.38218926779;41409.58590414057;42024.789876050425;43014.35478467888;43758.781206093765;57066.42933570611;57894.4210557889;62980.86486056345;63117.68441157765;64020.35979640144;6732.124823772878;7175.677094530654;8645.783855403664;8688;8861.33539984491;12869.485220591447;13255.53605623837;13582.93208533951;13639.727205456034;13789.655258618615;11511.366874821964;11551.191416600757;11634.36011019402;11828.34944078084;11837.585684501;10803.083167544875;11117.27737697047;11162.330260184415;11536.192466527262;11880.940595296968;11924.940375298069;12024.158308918291;12049.879501204876;12113.333766642567;12573.245605263714;8510;8584.055753867195;8619.396642234984;8741.388102832741;8781.297496200417;11092.168087393638;11211.60759373418;11713.180077394842;11876.287422754662;11950.223235489666 13:28:26 INFO - PROCESS | 24436 | |3;mootools.html;1305.4060402516857;1509.2076659753632;1525.016364444933;1676.6143786929006;1827.5431142214454;8393.580320983958;8707.25988290996;8721.345899057564;8952.462852228871;8981.775455613613;8701.477911325324;8914.153155450222;8915.286777057836;8919.01890792014;8924.776880577989;2333.6732857399934;2358.3986083548757;2367.266147494274;2368.1829768729763;2369.123424332999;2331.288956868163;2355.7879790818824;2418.806495480357;2424.6726691896633;2426.454047839231;2297.8851057447146;2321.303608917318;2333.346662934381;2334.9766502335015;2349.2364981381033;2303.193882141254;2314.085936055257;2332.428555004018;2332.7550607186254;2336.906523739048;2239.1603148819195;2280.1905323610044;2280.521090570982;2282.7717228277206;2283.892312228568;8809.867851982226;8845.380823342368;8882.866756998586;8890.155435233642;9027.4132181408;5266.315379000744;5326.520613144797;5403.486668766461;5410.215518749798;5411.269478620376;3269.640339562646;3334.0497958082074;3350.3131857969056;3367.0740546349707;3373.713234375081;1112.227002233448;1120.3893877836517;1133.0538999935063;1139.8632164140356;1141.8686851012158;12306.692332691664;12375.504979800888;12432.254064756053;12433.06751993595;12437.06721995845;4432.091421258634;4514.503404625489;4635.536446355338;4639.072185562901;4648.721076735406;9642.42145471274;9675.564599592895;9699.854502182472;9700.514974251259;9709.757256068655;5304;5312.495312945264;5318.228856815817;5318.494742999409;5319.308489896289;4358.237308471005;4754.477007529169;4899.877503062381;4916.385451818523;4980.626453016038;3832;3852.7303088783515;3857.3442514772555;3934.3311637021775;3952.4268980997595;1166.8016437205695;1175.735459521618;1176.6058370445826;1188.9702757431132;1191.3209470601846;762.527233115472;861.8965724113147;873.8907636545432;1015.9796804063877;1025.251566356549;6247.718852651642;6379.808605741835;6412.198475190601;6445.871082578416;6618.172728408949;943.6461327002374;998.2164001258977;1013.2400699475394;1023.6007956896816;1053.052252972331;4144.715138307134;4280.229558679468;4293.656507479394;4298.26929421999;4371.278739008092;11104.167187460973;11297.322160670386;11395;11428.94285528567;11530.654080377602;10445.268831181744;10707.785844283071;10799.082078023299;10801.945990269998;11282.605108821152;8016.959915200387;8144.4298899077685;8178.059523154794;8361.540115293596;8376.371772117116;6108.786192483241;6342.841428964312;6383;6450.741970321134;6485.254195767358;9988.900110999088;10341.37951722899;10443.738906527398;10451.947740261554;10455.111315538265;10656.946715266684;10774.892251077388;10776.461176941279;10783.730406739895;10804.891951080388;7556.508826926232;8472.915270847212;8565.186307300797;8612.569371531274;8693.956530217562;8809.383343165917;8846.071162527842;8915.910840891767;8921.687740929296;8924.464532128093;7289.854202916018;7737.264959828807;7738.574378409242;7968;8165.428420010542;7818.296353328228;7944.960275198587;7976.441649084509;8011.679532818622;8092.069412017693;7166.928330716834;7297.525660832029;7350.852982940418;7411.7035318588805;7418.554886706815;5254;5321.627486075938;5379.623426360117;5392.245085687929;5455.099908515209;5334.06653835585;5362.812301569583;5487.5609951203005;5569.66582005081;5574.581906357121 13:28:26 INFO - PROCESS | 24436 | |4;prototype.html;326.3114827713525;326.55262290661796;335.8438326178327;336.10763423111615;336.6179386396439;5287;5297.390800057994;5297.735113244332;5319.601029922756;5323.520883120518;5232.267482552436;5240.528352448279;5253.159494480884;5257.973710131453;5258.737063146847;3985.1631157456895;4042.939355909664;4150.377443383486;4152.314868046768;4165.1669666066755;4066.715329926906;4109.835606575748;4121.259362523918;4124.546299907008;4129.876103716878;3911.6870650347905;4132.128170921211;4135.545090040108;4144.834206631731;4155.39746736723;4021.155557332964;4119.855805046809;4125.876223713263;4147.709660323779;4166.229247589191;3648.179159689049;3657.7256705747177;3667.94498082529;3668.743187976843;3675.3751862183226;5170.896582068338;5205.453427390107;5212.50481204285;5227.529522342969;5243.528082472596;4476.015276639134;4694.530546945312;4699.318598803155;4740.881477963044;4743.312219728155;5453.972730136364;5471.945280547223;5483.479069488392;5489.313835770528;5509.063459211943;3973.841046358142;3977.5226972763453;3990.7605543667473;3998.8400463981407;4006.639402453764;5503.257060296849;5670.376258611549;5701.486866182022;5716.228309178249;5730.799422020251;4002.4590532645143;4016.216837716676;4028.879133625996;4033.979830100831;4035.7174997750462;4086.264472394938;4098.831832927602;4106.897327566775;4111.7944102794745;4121.1345617420075;4626.421697287839;4649.930251046237;4702.858914232578;4713.717176969393;4732.810687572459;5495.917561236584;5528;5535.58483113768;5541.418151094077;5553.666779993213;1407.1205496564646;1412.5903487988369;1421.5948454690363;1424.0530047518491;1427.1651084115701;893.6023469555985;916.4404462321813;921.1985572551923;924.2236521321987;967.4823969176598;5233.215017747369;5257.8695580450385;5261.921071183935;5264.210368444687;5276.604254680914;5545.1682247663175;5545.889082218333;5582.302212223472;5597.328320601472;5626.971865140648;5080.923786143211;5230.8169214077325;5262.71055091966;5274.683518988873;5276.129438642658;2953.74893134086;2967.8219306841656;2973.687762784876;2982.9552556711665;2993.3414648777234;5717.084287013653;5749.885002300014;5754.280714910637;5758.88482230353;5765.3369862465515;5454.754536045887;5643.238162847963;5673.716314184274;5683.687397193112;5701.629394089371;5666.206731057655;5674.971625141848;5702.488840457282;5706.229658996065;5754.539636829128;5338.54622357104;5491.258680078138;5497.147942068986;5548.167774833807;5739.540836733135;5653.547716182613;5664.207011018543;5670.971645141748;5675.404082571271;5685.829425117253;5861.912071318849;5875.529957603467;5877.147813566923;5879.588428809942;5895.587308888508;3982.4424580559325;4060.1879624075896;4077;4085.4280400744515;4092.447519584818;5426.864328391664;5599.776008959596;5652.265205523256;5681.318241811009;5744.655320680772;5388.407275199804;5479;5479.397266300624;5482.547125011795;5516.227728118147;5534.391216966211;5537.335519737496;5547.583931205257;5572.9132819101505;5572.944270557243;5332.760025798771;5469;5485.424030476743;5504.697241651747;5506.64206826555;5532.474414930575;5570.053090974625;5573.832785016456;5575.498205161555;5583.637063590853;5265.630935956602;5470.070088084955;5486.478784515464;5486.643368181056;5496.395396506301 13:28:26 INFO - PROCESS | 24436 | |5;yui.html;712.2770388056123;719.2914978745938;790.9960450197749;838.1409055717892;844.4806444036915;13639.11345762526;14063.64840878976;14460.855391446083;14474.638134046654;15338;13943;14111.435542578285;14112.364943577539;14129.929350353259;14136.575902722909;652.2824892618106;755.4409736794787;797.3023604346197;803.7307501986842;815.7348861619968;813.3737022492677;823.983520329593;827.404268926375;827.755812035448;828.5028982610446;868.3834477520968;871.372611719561;871.808202195516;871.9520426376547;872.3413822563987;680.8195828105556;805.9274665280153;844.7043534762845;862.6678728689437;863.6933888469597;627.4415769964735;628.4155735166294;628.5757113948067;628.7956414165415;628.937106289372;14296.285185740775;14307.070040447337;14323.641908952359;14327.212003339811;14342.713145737027;14298.428062877472;14699.485518006926;14771.852281477155;14937.925310373486;15158;13231.536896208587;13289.269090200132;13322.86677133226;13490.190588564717;13680.179189248578;4474.597286244254;4534.36518887356;4610.377599024122;4660.743659098748;4696.929546056812;76807.23192768056;77283.6135819323;77333.22666773373;77666.22333776647;77728.61135694342;11532.654020379403;11585.826212606818;11622.94188529052;11630.476628551736;11727.061835053175;18857.62284754297;19246.615067698847;19519.121639526256;19567.706484402745;19574.21703131859;8388.832223355621;8426.494410335277;8553.101924297858;8684.739457816275;8821.426607270507;4525.389072475239;4556.749378784199;4591.403117594691;4680.53194680536;4718.079974404958;3338.2322065924486;3467.6358982306997;3472.600650925176;3473.9826300868335;3474.409350410436;622.953278504114;626.6866566716642;628.9495352320871;636.0999186151636;638.6327861479667;578.5062671512242;610.5359926455836;681.2506243132614;712.4264966701751;731.3522564105142;8580.570971451403;8657.95671021641;8779.452853023373;8828.249598784047;9115.088491150831;627.3945642454962;670.7193415475045;702.1749444402807;731.1040759794201;733.1743957545673;4048.5748996355546;4124.661273463167;4135.234981528367;4270.572942705705;4273.55127711592;68241.3175868235;100861.49569252107;112018;112136;115242;98925.50537247267;99174.02477925674;100024.49987750014;100153.49923250337;100721.49639251904;76637;87414;88256;88411.11588884158;88547.55726221327;7892.921070789219;8062.234087761653;8117.472364296302;8136.640716986212;8161.143079976517;41059.58940410677;50872;50971.2354314693;52000.73999629977;52141;74300.62849685717;76564.61717691376;77372.61313693396;77381.2261877374;78634;10169.491525423551;10306.742331441774;10601;10763.677089687322;11132.777344453227;10573.312734672221;10650.360978341325;10849.211482015946;11080;11131.165162612675;10787.784244315228;10858;10946.124310055337;10946.343219406861;11121.165912556753;10514.842277365999;10592.682219533426;10676.145908327471;10737;11232.269902456314;10657.25399222047;10971.780564388828;10997.505112269808;11314.547418103513;11383.677414557917;8492.660293588187;8557.021949497092;8706.347023973101;8837.248833849195;8943.642254309754;9464.479453629841;9656.9034309656;9754.561044752862;9798.412095274307;9839.262055345735 13:28:26 INFO - PROCESS | 24436 | __end_tp_report 13:28:26 INFO - PROCESS | 24436 | __start_cc_report 13:28:26 INFO - PROCESS | 24436 | _x_x_mozilla_cycle_collect,961 13:28:26 INFO - PROCESS | 24436 | __end_cc_report 13:28:26 INFO - PROCESS | 24436 | __startTimestamp1468614506701__endTimestamp 13:28:26 INFO - PROCESS | 24436 | 13:28:26 INFO - PROCESS | 24436 | ------- Summary: start ------- 13:28:26 INFO - PROCESS | 24436 | Number of tests: 6 13:28:26 INFO - PROCESS | 24436 | 13:28:26 INFO - PROCESS | 24436 | [#0] dojo.html Cycles:165 Average:5314.07 Median:5537.25 stddev:605.56 (10.9%) stddev-sans-first:581.00 13:28:26 INFO - PROCESS | 24436 | Values: 3058.7 3059.3 3099.9 3111.8 3125.1 5227.6 5249.2 5308.2 5387.8 5425.7 5298.3 5311.4 5338.3 5338.5 5380.0 4769.1 4840.2 4849.2 4857.6 4963.0 4876.4 4880.3 4906.3 4933.3 4966.4 4811.5 4812.4 4817.0 4869.3 4873.4 4791.6 4807.6 4811.4 4881.7 4926.3 4853.1 4860.8 4861.2 4866.4 4873.2 5219.4 5220.2 5323.7 5385.3 5404.2 5729.7 5745.8 5752.3 5775.3 5783.4 5610.7 5704.2 5778.4 5819.7 5825.7 5078.3 5443.8 5452.6 5457.7 5458.5 5939.6 5962.9 5965.0 5965.3 5972.4 5482.6 5530.7 5542.8 5727.7 5729.1 5667.0 5668.1 5711.9 5715.4 5723.8 5669.3 5673.0 5677.2 5680.8 5681.9 5627.0 5630.6 5663.1 5679.5 5681.4 4367.8 4368.8 4371.0 4375.5 4416.4 3878.4 3893.8 3903.1 3937.3 3946.3 5340.3 5401.3 5403.7 5421.1 5461.8 5804.0 5837.1 5840.2 5845.2 5885.8 5458.4 5496.5 5502.5 5508.7 5509.1 4777.9 4826.1 4836.6 4882.0 4922.6 5807.9 5809.0 5812.7 5819.3 5820.4 5673.0 5683.3 5687.5 5688.5 5691.1 5748.7 5827.5 5844.8 5853.8 5911.2 5608.0 5629.9 5631.6 5646.3 5646.5 5687.1 5688.5 5691.4 5750.4 5763.6 5610.5 5613.6 5620.8 5622.4 5622.6 5545.1 5606.8 5612.4 5612.9 5619.2 5465.6 5479.2 5511.7 5514.9 5599.1 5642.2 5656.8 5661.2 5703.7 5717.5 5532.8 5537.3 5546.8 5551.9 5557.3 13:28:26 INFO - PROCESS | 24436 | 13:28:26 INFO - PROCESS | 24436 | [#1] ext.html Cycles:180 Average:60682.04 Median:23686.60 stddev:115853.02 (489.1%) stddev-sans-first:116090.19 13:28:26 INFO - PROCESS | 24436 | Values: 601.1 618.0 636.6 642.4 662.6 43636.6 44980.8 45081.8 45183.0 49457.0 47071.3 47452.0 47462.8 47473.8 47545.3 8963.8 9101.6 9104.2 9108.7 9109.3 9064.8 9144.3 9149.7 9155.0 9155.2 9199.5 9229.6 9229.7 9240.8 9241.7 9116.8 9126.7 9156.5 9168.4 9171.0 8968.8 9033.7 9051.4 9052.5 9052.6 43525.1 43757.3 43979.0 43984.0 43987.6 3393.6 3879.4 3896.3 3981.6 4065.3 33324.3 34270.8 34396.7 34813.3 35118.8 4293.3 4329.6 4331.4 4369.5 4398.8 366165.0 366448.0 368834.0 368992.0 369283.0 59187.1 59282.7 59333.7 59485.7 59579.0 62871.7 63375.4 63455.4 63455.4 63491.4 14809.3 16391.8 16501.4 16939.4 16963.5 13284.6 13387.2 13388.9 13393.1 13393.4 17252.0 17306.0 17371.6 17386.2 17387.6 5170.9 6094.7 6207.5 6243.3 6252.2 918.2 991.9 1093.9 1108.6 1145.7 32832.3 32909.3 33104.2 33208.3 33404.8 1088.6 1091.3 1098.7 1117.4 1204.9 17047.7 17293.8 17304.4 17358.9 17477.5 519213.0 524493.0 524621.0 524718.0 525924.0 57813.4 59060.4 59095.0 59159.4 59190.4 1236.4 1346.9 1374.5 1387.5 1396.8 32055.7 34451.1 34503.0 34521.1 34864.0 50349.5 50848.0 50911.5 50967.2 50989.0 406433.0 406829.0 408337.0 409279.0 409943.0 36422.6 41810.6 42730.0 42988.8 44981.8 49523.2 49670.8 49934.8 50417.2 50659.5 40796.2 41634.8 42453.8 43043.6 45954.8 42261.6 42824.9 42913.6 42941.0 43328.4 40452.4 40740.4 40792.2 41248.4 41509.8 36791.3 38108.0 38154.0 38624.0 38868.0 28745.6 28995.1 29019.9 29078.0 29176.7 13:28:26 INFO - PROCESS | 24436 | 13:28:26 INFO - PROCESS | 24436 | [#2] jquery.html Cycles:180 Average:27851.78 Median:22367.11 stddev:72273.71 (323.1%) stddev-sans-first:72447.06 13:28:26 INFO - PROCESS | 24436 | Values: 396.2 399.8 401.6 401.6 420.0 18460.8 20344.5 20363.9 20426.0 20442.5 18948.1 19352.4 20056.4 20091.5 20122.0 5709.5 5750.3 5911.4 5912.1 5955.8 5753.2 5811.7 5816.2 5817.1 5822.2 5783.5 5814.2 5887.4 5922.7 5927.8 5829.1 5903.6 5906.9 5911.9 5973.2 5147.2 5242.2 5269.9 5286.6 5286.7 20918.4 22005.6 22010.8 22723.4 23510.9 2295.5 2373.2 2394.3 2429.9 2529.2 9702.8 10192.7 10220.4 10373.6 10580.6 1804.7 1896.4 1937.9 1962.4 1983.6 83050.0 85120.0 85800.0 86408.0 87060.0 10168.2 10189.6 10296.5 10335.5 10466.2 14275.3 14309.4 14373.2 14570.8 14608.6 7939.3 7947.5 8006.1 8143.6 8268.9 7932.3 7960.7 8020.7 8081.8 8256.0 4644.1 4669.4 4680.1 4703.0 4742.4 1968.6 1993.3 2004.1 2005.0 2014.9 916.8 972.4 978.4 988.9 1030.6 19281.2 19803.5 19908.2 19915.0 19949.5 1012.3 1016.7 1030.7 1041.7 1062.8 10498.4 10895.3 10940.4 10940.7 11035.4 376252.0 376262.0 382985.0 504111.0 504306.0 94844.5 104818.0 105474.0 105745.0 105884.0 990.8 1020.7 1055.5 1058.2 1059.3 17631.2 17821.0 18407.5 18582.0 18611.4 41187.4 41409.6 42024.8 43014.4 43758.8 57066.4 57894.4 62980.9 63117.7 64020.4 6732.1 7175.7 8645.8 8688.0 8861.3 12869.5 13255.5 13582.9 13639.7 13789.7 11511.4 11551.2 11634.4 11828.3 11837.6 10803.1 11117.3 11162.3 11536.2 11880.9 11924.9 12024.2 12049.9 12113.3 12573.2 8510.0 8584.1 8619.4 8741.4 8781.3 11092.2 11211.6 11713.2 11876.3 11950.2 13:28:26 INFO - PROCESS | 24436 | 13:28:26 INFO - PROCESS | 24436 | [#3] mootools.html Cycles:180 Average:5917.11 Median:4827.18 stddev:3361.50 (69.6%) stddev-sans-first:3353.07 13:28:26 INFO - PROCESS | 24436 | Values: 1305.4 1509.2 1525.0 1676.6 1827.5 8393.6 8707.3 8721.3 8952.5 8981.8 8701.5 8914.2 8915.3 8919.0 8924.8 2333.7 2358.4 2367.3 2368.2 2369.1 2331.3 2355.8 2418.8 2424.7 2426.5 2297.9 2321.3 2333.3 2335.0 2349.2 2303.2 2314.1 2332.4 2332.8 2336.9 2239.2 2280.2 2280.5 2282.8 2283.9 8809.9 8845.4 8882.9 8890.2 9027.4 5266.3 5326.5 5403.5 5410.2 5411.3 3269.6 3334.0 3350.3 3367.1 3373.7 1112.2 1120.4 1133.1 1139.9 1141.9 12306.7 12375.5 12432.3 12433.1 12437.1 4432.1 4514.5 4635.5 4639.1 4648.7 9642.4 9675.6 9699.9 9700.5 9709.8 5304.0 5312.5 5318.2 5318.5 5319.3 4358.2 4754.5 4899.9 4916.4 4980.6 3832.0 3852.7 3857.3 3934.3 3952.4 1166.8 1175.7 1176.6 1189.0 1191.3 762.5 861.9 873.9 1016.0 1025.3 6247.7 6379.8 6412.2 6445.9 6618.2 943.6 998.2 1013.2 1023.6 1053.1 4144.7 4280.2 4293.7 4298.3 4371.3 11104.2 11297.3 11395.0 11428.9 11530.7 10445.3 10707.8 10799.1 10801.9 11282.6 8017.0 8144.4 8178.1 8361.5 8376.4 6108.8 6342.8 6383.0 6450.7 6485.3 9988.9 10341.4 10443.7 10451.9 10455.1 10656.9 10774.9 10776.5 10783.7 10804.9 7556.5 8472.9 8565.2 8612.6 8694.0 8809.4 8846.1 8915.9 8921.7 8924.5 7289.9 7737.3 7738.6 7968.0 8165.4 7818.3 7945.0 7976.4 8011.7 8092.1 7166.9 7297.5 7350.9 7411.7 7418.6 5254.0 5321.6 5379.6 5392.2 5455.1 5334.1 5362.8 5487.6 5569.7 5574.6 13:28:26 INFO - PROCESS | 24436 | 13:28:26 INFO - PROCESS | 24436 | [#4] prototype.html Cycles:180 Average:4639.93 Median:5281.80 stddev:1355.78 (25.7%) stddev-sans-first:1320.36 13:28:26 INFO - PROCESS | 24436 | Values: 326.3 326.6 335.8 336.1 336.6 5287.0 5297.4 5297.7 5319.6 5323.5 5232.3 5240.5 5253.2 5258.0 5258.7 3985.2 4042.9 4150.4 4152.3 4165.2 4066.7 4109.8 4121.3 4124.5 4129.9 3911.7 4132.1 4135.5 4144.8 4155.4 4021.2 4119.9 4125.9 4147.7 4166.2 3648.2 3657.7 3667.9 3668.7 3675.4 5170.9 5205.5 5212.5 5227.5 5243.5 4476.0 4694.5 4699.3 4740.9 4743.3 5454.0 5471.9 5483.5 5489.3 5509.1 3973.8 3977.5 3990.8 3998.8 4006.6 5503.3 5670.4 5701.5 5716.2 5730.8 4002.5 4016.2 4028.9 4034.0 4035.7 4086.3 4098.8 4106.9 4111.8 4121.1 4626.4 4649.9 4702.9 4713.7 4732.8 5495.9 5528.0 5535.6 5541.4 5553.7 1407.1 1412.6 1421.6 1424.1 1427.2 893.6 916.4 921.2 924.2 967.5 5233.2 5257.9 5261.9 5264.2 5276.6 5545.2 5545.9 5582.3 5597.3 5627.0 5080.9 5230.8 5262.7 5274.7 5276.1 2953.7 2967.8 2973.7 2983.0 2993.3 5717.1 5749.9 5754.3 5758.9 5765.3 5454.8 5643.2 5673.7 5683.7 5701.6 5666.2 5675.0 5702.5 5706.2 5754.5 5338.5 5491.3 5497.1 5548.2 5739.5 5653.5 5664.2 5671.0 5675.4 5685.8 5861.9 5875.5 5877.1 5879.6 5895.6 3982.4 4060.2 4077.0 4085.4 4092.4 5426.9 5599.8 5652.3 5681.3 5744.7 5388.4 5479.0 5479.4 5482.5 5516.2 5534.4 5537.3 5547.6 5572.9 5572.9 5332.8 5469.0 5485.4 5504.7 5506.6 5532.5 5570.1 5573.8 5575.5 5583.6 5265.6 5470.1 5486.5 5486.6 5496.4 13:28:26 INFO - PROCESS | 24436 | 13:28:26 INFO - PROCESS | 24436 | [#5] yui.html Cycles:180 Average:19846.39 Median:52070.87 stddev:29303.49 (56.3%) stddev-sans-first:29350.48 13:28:26 INFO - PROCESS | 24436 | Values: 712.3 719.3 791.0 838.1 844.5 13639.1 14063.6 14460.9 14474.6 15338.0 13943.0 14111.4 14112.4 14129.9 14136.6 652.3 755.4 797.3 803.7 815.7 813.4 824.0 827.4 827.8 828.5 868.4 871.4 871.8 872.0 872.3 680.8 805.9 844.7 862.7 863.7 627.4 628.4 628.6 628.8 628.9 14296.3 14307.1 14323.6 14327.2 14342.7 14298.4 14699.5 14771.9 14937.9 15158.0 13231.5 13289.3 13322.9 13490.2 13680.2 4474.6 4534.4 4610.4 4660.7 4696.9 76807.2 77283.6 77333.2 77666.2 77728.6 11532.7 11585.8 11622.9 11630.5 11727.1 18857.6 19246.6 19519.1 19567.7 19574.2 8388.8 8426.5 8553.1 8684.7 8821.4 4525.4 4556.7 4591.4 4680.5 4718.1 3338.2 3467.6 3472.6 3474.0 3474.4 623.0 626.7 628.9 636.1 638.6 578.5 610.5 681.3 712.4 731.4 8580.6 8658.0 8779.5 8828.2 9115.1 627.4 670.7 702.2 731.1 733.2 4048.6 4124.7 4135.2 4270.6 4273.6 68241.3 100861.5 112018.0 112136.0 115242.0 98925.5 99174.0 100024.5 100153.5 100721.5 76637.0 87414.0 88256.0 88411.1 88547.6 7892.9 8062.2 8117.5 8136.6 8161.1 41059.6 50872.0 50971.2 52000.7 52141.0 74300.6 76564.6 77372.6 77381.2 78634.0 10169.5 10306.7 10601.0 10763.7 11132.8 10573.3 10650.4 10849.2 11080.0 11131.2 10787.8 10858.0 10946.1 10946.3 11121.2 10514.8 10592.7 10676.1 10737.0 11232.3 10657.3 10971.8 10997.5 11314.5 11383.7 8492.7 8557.0 8706.3 8837.2 8943.6 9464.5 9656.9 9754.6 9798.4 9839.3 13:28:26 INFO - PROCESS | 24436 | -------- Summary: end -------- 13:28:26 INFO - PROCESS | 24436 | 13:28:27 INFO - TEST-INFO | 24436: exit 0 13:28:27 INFO - TEST-OK | dromaeo_css | took 1113447ms 13:28:27 INFO - TEST-START | kraken 13:28:27 INFO - operating with platform_type : linux_ 13:28:27 INFO - Initialising browser for kraken test... 13:28:27 INFO - TEST-INFO | started process 24632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuaLFfc/profile http://localhost:58019/getInfo.html) 13:28:31 INFO - PROCESS | 24632 | __metrics Screen width/height:1600/1200 13:28:31 INFO - PROCESS | 24632 | colorDepth:24 13:28:31 INFO - PROCESS | 24632 | Browser inner width/height: 1024/697 13:28:31 INFO - PROCESS | 24632 | __metrics 13:28:32 INFO - PROCESS | 24632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:28:32 INFO - PROCESS | 24632 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:28:32 INFO - TEST-INFO | 24632: exit 0 13:28:32 INFO - Browser initialized. 13:28:32 INFO - Running cycle 1/1 for kraken test... 13:28:33 INFO - TEST-INFO | started process 24715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuaLFfc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:44 INFO - PROCESS | 24715 | RSS: Main: 157839360 13:28:44 INFO - PROCESS | 24715 | 13:28:47 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58019/tests/kraken/driver.html?testName=audio-beat-detection) 13:28:48 INFO - PROCESS | 24715 | RSS: Main: 215822336 13:28:48 INFO - PROCESS | 24715 | 13:28:50 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58019/tests/kraken/driver.html?testName=audio-dft) 13:28:51 INFO - PROCESS | 24715 | RSS: Main: 203513856 13:28:51 INFO - PROCESS | 24715 | 13:28:54 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58019/tests/kraken/driver.html?testName=audio-fft) 13:28:55 INFO - PROCESS | 24715 | RSS: Main: 269463552 13:28:55 INFO - PROCESS | 24715 | 13:28:57 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58019/tests/kraken/driver.html?testName=audio-oscillator) 13:28:57 INFO - PROCESS | 24715 | RSS: Main: 180809728 13:28:57 INFO - PROCESS | 24715 | 13:28:59 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58019/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:29:00 INFO - PROCESS | 24715 | RSS: Main: 184778752 13:29:00 INFO - PROCESS | 24715 | 13:29:03 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58019/tests/kraken/driver.html?testName=imaging-darkroom) 13:29:04 INFO - PROCESS | 24715 | RSS: Main: 219578368 13:29:04 INFO - PROCESS | 24715 | 13:29:07 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58019/tests/kraken/driver.html?testName=imaging-desaturate) 13:29:08 INFO - PROCESS | 24715 | RSS: Main: 221421568 13:29:08 INFO - PROCESS | 24715 | 13:29:10 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58019/tests/kraken/driver.html?testName=json-parse-financial) 13:29:11 INFO - PROCESS | 24715 | RSS: Main: 221806592 13:29:11 INFO - PROCESS | 24715 | 13:29:12 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58019/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:29:13 INFO - PROCESS | 24715 | RSS: Main: 209289216 13:29:13 INFO - PROCESS | 24715 | 13:29:15 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58019/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:29:15 INFO - PROCESS | 24715 | RSS: Main: 213807104 13:29:15 INFO - PROCESS | 24715 | 13:29:17 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58019/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:29:18 INFO - PROCESS | 24715 | RSS: Main: 212668416 13:29:18 INFO - PROCESS | 24715 | 13:29:21 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58019/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:29:21 INFO - PROCESS | 24715 | RSS: Main: 223526912 13:29:21 INFO - PROCESS | 24715 | 13:29:24 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58019/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:29:25 INFO - PROCESS | 24715 | RSS: Main: 224698368 13:29:25 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | Cycle 1(1): loaded http://localhost:58019/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58019/tests/kraken/driver.html?testName=ai-astar) 13:29:26 INFO - PROCESS | 24715 | RSS: Main: 267350016 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | __start_tp_report 13:29:26 INFO - PROCESS | 24715 | _x_x_mozilla_page_load 13:29:26 INFO - PROCESS | 24715 | _x_x_mozilla_page_load_details 13:29:26 INFO - PROCESS | 24715 | |i|pagename|runs| 13:29:26 INFO - PROCESS | 24715 | |0;ai-astar;104;111;109;110;114;110;110;108;108;111 13:29:26 INFO - PROCESS | 24715 | |1;audio-beat-detection;148;122;120;168;118;118;150;120;146;124 13:29:26 INFO - PROCESS | 24715 | |2;audio-dft;161;160;160;160;160;160;159;160;161;161 13:29:26 INFO - PROCESS | 24715 | |3;audio-fft;75;74;77;107;76;76;75;74;98;76 13:29:26 INFO - PROCESS | 24715 | |4;audio-oscillator;84;84;112;83;84;84;112;84;84;133 13:29:26 INFO - PROCESS | 24715 | |5;imaging-gaussian-blur;117;117;117;117;118;117;119;117;117;117 13:29:26 INFO - PROCESS | 24715 | |6;imaging-darkroom;146;146;146;146;146;146;153;145;145;146 13:29:26 INFO - PROCESS | 24715 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;94 13:29:26 INFO - PROCESS | 24715 | |8;json-parse-financial;53;53;52;53;54;53;60;54;54;53 13:29:26 INFO - PROCESS | 24715 | |9;json-stringify-tinderbox;62;63;62;62;62;62;63;62;62;62 13:29:26 INFO - PROCESS | 24715 | |10;stanford-crypto-aes;75;75;76;80;74;75;83;75;74;79 13:29:26 INFO - PROCESS | 24715 | |11;stanford-crypto-ccm;135;116;120;132;122;125;127;118;163;120 13:29:26 INFO - PROCESS | 24715 | |12;stanford-crypto-pbkdf2;156;154;156;158;164;155;155;159;153;155 13:29:26 INFO - PROCESS | 24715 | |13;stanford-crypto-sha256-iterative;63;66;65;62;65;62;61;62;60;60 13:29:26 INFO - PROCESS | 24715 | __end_tp_report 13:29:26 INFO - PROCESS | 24715 | __start_cc_report 13:29:26 INFO - PROCESS | 24715 | _x_x_mozilla_cycle_collect,1630 13:29:26 INFO - PROCESS | 24715 | __end_cc_report 13:29:26 INFO - PROCESS | 24715 | __startTimestamp1468614566918__endTimestamp 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | ------- Summary: start ------- 13:29:26 INFO - PROCESS | 24715 | Number of tests: 14 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.59 (2.4%) stddev-sans-first:1.83 13:29:26 INFO - PROCESS | 24715 | Values: 104.0 111.0 109.0 110.0 114.0 110.0 110.0 108.0 108.0 111.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:135.00 stddev:17.94 (13.3%) stddev-sans-first:18.23 13:29:26 INFO - PROCESS | 24715 | Values: 148.0 122.0 120.0 168.0 118.0 118.0 150.0 120.0 146.0 124.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 13:29:26 INFO - PROCESS | 24715 | Values: 161.0 160.0 160.0 160.0 160.0 160.0 159.0 160.0 161.0 161.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:11.67 (15.4%) stddev-sans-first:12.19 13:29:26 INFO - PROCESS | 24715 | Values: 75.0 74.0 77.0 107.0 76.0 76.0 75.0 74.0 98.0 76.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:84.00 stddev:17.91 (21.3%) stddev-sans-first:18.60 13:29:26 INFO - PROCESS | 24715 | Values: 84.0 84.0 112.0 83.0 84.0 84.0 112.0 84.0 84.0 133.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 13:29:26 INFO - PROCESS | 24715 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 119.0 117.0 117.0 117.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:2.32 (1.6%) stddev-sans-first:2.46 13:29:26 INFO - PROCESS | 24715 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 153.0 145.0 145.0 146.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:29:26 INFO - PROCESS | 24715 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:53.50 stddev:2.23 (4.2%) stddev-sans-first:2.35 13:29:26 INFO - PROCESS | 24715 | Values: 53.0 53.0 52.0 53.0 54.0 53.0 60.0 54.0 54.0 53.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 13:29:26 INFO - PROCESS | 24715 | Values: 62.0 63.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 62.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:75.50 stddev:3.03 (4.0%) stddev-sans-first:3.15 13:29:26 INFO - PROCESS | 24715 | Values: 75.0 75.0 76.0 80.0 74.0 75.0 83.0 75.0 74.0 79.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:126.00 stddev:13.77 (10.9%) stddev-sans-first:14.36 13:29:26 INFO - PROCESS | 24715 | Values: 135.0 116.0 120.0 132.0 122.0 125.0 127.0 118.0 163.0 120.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:156.00 stddev:3.17 (2.0%) stddev-sans-first:3.36 13:29:26 INFO - PROCESS | 24715 | Values: 156.0 154.0 156.0 158.0 164.0 155.0 155.0 159.0 153.0 155.0 13:29:26 INFO - PROCESS | 24715 | 13:29:26 INFO - PROCESS | 24715 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:2.12 (3.4%) stddev-sans-first:2.24 13:29:26 INFO - PROCESS | 24715 | Values: 63.0 66.0 65.0 62.0 65.0 62.0 61.0 62.0 60.0 60.0 13:29:26 INFO - PROCESS | 24715 | -------- Summary: end -------- 13:29:26 INFO - PROCESS | 24715 | 13:29:27 INFO - TEST-INFO | 24715: exit 0 13:29:27 INFO - TEST-OK | kraken | took 60466ms 13:29:27 INFO - SUITE-END | took 1173s 13:29:28 INFO - Completed test suite (00:19:34) 13:29:28 INFO - javascript benchmark 13:29:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.694130586941, 3059.281068948795, 3099.876004959801, 3111.8132912025267, 3125.062481255623, 5227.555657769094, 5249.212618107276, 5308.203769434586, 5387.838364849056, 5425.7287135643255, 5298.337707786527, 5311.389190243123, 5338.27933229015, 5338.492843179902, 5379.9731001344935, 4769.117713223048, 4840.201366774478, 4849.199882019462, 4857.635677324197, 4963.0, 4876.4148302203785, 4880.316755654194, 4906.337644417994, 4933.284673722308, 4966.404031516223, 4811.4707382187935, 4812.446568644598, 4816.964352664177, 4869.293952376921, 4873.415190177184, 4791.6166706663735, 4807.567318941277, 4811.350467686888, 4881.731504767236, 4926.334944782444, 4853.102176097434, 4860.781264843091, 4861.173600487926, 4866.391701037371, 4873.244647079673, 5219.399769026572, 5220.1647736362, 5323.707196104213, 5385.3268341457315, 5404.189371594253, 5729.656220626775, 5745.798897038583, 5752.309722833287, 5775.335836378828, 5783.392743761929, 5610.69141197234, 5704.201411802351, 5778.393268706767, 5819.67991760453, 5825.650460972355, 5078.31442755227, 5443.836684899459, 5452.563794896439, 5457.727113644341, 5458.45415458459, 5939.643621382731, 5962.850928726816, 5965.0, 5965.284165900033, 5972.40275972408, 5482.643628164156, 5530.695811730313, 5542.8337149885565, 5727.654001309689, 5729.140628905698, 5667.008273552112, 5668.0647693130995, 5711.885762284731, 5715.371309155989, 5723.771049157987, 5669.262995810601, 5673.035583950738, 5677.233573467612, 5680.77276908919, 5681.9431805681415, 5626.971865140648, 5630.577706672016, 5663.065594176915, 5679.545636349082, 5681.431856814285, 4367.825286988485, 4368.7815609219415, 4371.038371558252, 4375.518692943773, 4416.3596278539435, 3878.4182372644327, 3893.7858417787293, 3903.1413089120347, 3937.2716047530726, 3946.309395855714, 5340.332458442695, 5401.297831281908, 5403.729813509309, 5421.1055175895535, 5461.781528738886, 5803.970980145073, 5837.066069428871, 5840.153177789197, 5845.210896528999, 5885.823425297248, 5458.426865179178, 5496.5053145217125, 5502.504774570228, 5508.697021663847, 5509.118541033416, 4777.928331075037, 4826.131296366688, 4836.564709176191, 4882.048000639912, 4922.581580565692, 5807.912881306784, 5809.041508151107, 5812.680302583483, 5819.330776960619, 5820.359760426434, 5673.035583950821, 5683.261176047087, 5687.516561092353, 5688.516476099578, 5691.089425691869, 5748.6838223898085, 5827.504662103769, 5844.824655260349, 5853.824385268449, 5911.201987731602, 5608.046632072476, 5629.943700562942, 5631.577631677723, 5646.2942132233475, 5646.491815736604, 5687.090065589486, 5688.516476099578, 5691.430856914276, 5750.367459579526, 5763.596548241583, 5610.495055444866, 5613.550915926798, 5620.775168993358, 5622.353429355513, 5622.578306626938, 5545.085060965057, 5606.803761868315, 5612.410696876769, 5612.887742245214, 5619.157126431068, 5465.590080744039, 5479.178123281539, 5511.669299842022, 5514.944850551443, 5599.1041433370465, 5642.23829782974, 5656.773729050957, 5661.207430959586, 5703.7433315500075, 5717.485426311652, 5532.834014979557, 5537.2524709163745, 5546.75039623226, 5551.944480555143, 5557.3331200256225], "value": 5273.010602386995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.1043545117776, 617.9752809887605, 636.5734957578422, 642.4314481683708, 662.6189940784051, 43636.56363436364, 44980.77509612451, 45081.77459112708, 45182.999999999956, 49457.0, 47071.29393059098, 47452.0, 47462.76268618661, 47473.76263118688, 47545.28682069763, 8963.775905602362, 9101.590428430736, 9104.226140778008, 9108.681196158135, 9109.31477676632, 9064.818703625924, 9144.314176436761, 9149.67976120836, 9154.954225228865, 9155.176034156924, 9199.540022998857, 9229.6308147674, 9229.723108306762, 9240.815183696322, 9241.722748317561, 9116.772080697969, 9126.726198214064, 9156.542172891395, 9168.358214924925, 9171.037041110687, 8968.775780605472, 9033.728988130366, 9051.366404351698, 9052.547372631409, 9052.637894484213, 43525.12949741019, 43757.34363984511, 43979.0, 43984.0, 43987.56012439899, 3393.5718014367794, 3879.3792993120965, 3896.2597106549665, 3981.6217459341606, 4065.349544072964, 33324.33351332984, 34270.82864585686, 34396.6560334396, 34813.30373392518, 35118.82440587781, 4293.334533147367, 4329.631981281595, 4331.436913201295, 4369.519352871182, 4398.7580683062415, 366165.0, 366448.0, 368833.9999999973, 368992.0, 369283.0, 59187.11219331714, 59282.703586482654, 59333.70333148393, 59485.702571486865, 59578.999999999134, 62871.6856415715, 63375.36624633787, 63455.36544634494, 63455.365446345866, 63491.41271468158, 14809.33357998871, 16391.754123688155, 16501.422450214184, 16939.407120750715, 16963.491095267163, 13284.601461956157, 13387.196768193939, 13388.93305533466, 13393.129446585941, 13393.397297121654, 17252.0, 17306.0, 17371.56571085733, 17386.21762020712, 17387.56531086733, 5170.922436163461, 6094.695265236809, 6207.534434917399, 6243.250809902841, 6252.154924721354, 918.2103391083663, 991.9057689519484, 1093.868735751715, 1108.5510368300852, 1145.6963904565298, 32832.343353132805, 32909.341813163606, 33104.1723956903, 33208.33583328368, 33404.83297583545, 1088.6298658456162, 1091.3124731419314, 1098.6703988803326, 1117.385438009108, 1204.897583705395, 17047.659046818993, 17293.827061729222, 17304.394346197823, 17358.91320543389, 17477.475675729747, 519213.0, 524493.0, 524621.0, 524718.0, 525924.0, 57813.421865781645, 59060.409395906354, 59095.0, 59159.40840591625, 59190.40809591849, 1236.449779847977, 1346.8922486201081, 1374.4776984745733, 1387.4519564771858, 1396.804447377368, 32055.6794432062, 34451.13872153216, 34503.0, 34521.136971575914, 34864.0, 50349.496505035946, 50848.0, 50911.49088509216, 50967.2354914684, 50989.0, 406433.0, 406829.0, 408337.0, 409279.0, 409943.0, 36422.63577364192, 41810.58189418067, 42730.0, 42988.78505607452, 44981.775091124335, 49523.17465687022, 49670.75164624154, 49934.75032624813, 50417.243741343176, 50659.493405066954, 40796.1840763189, 41634.79182604067, 42453.787731061144, 43043.56956430396, 45954.770226148656, 42261.57738422576, 42824.85258247701, 42913.5708642922, 42941.0, 43328.350074748276, 40452.39321410123, 40740.38889416602, 40792.1841563173, 41248.38127428031, 41509.79245103755, 36791.26417471689, 38108.0, 38154.0, 38624.0, 38868.0, 28745.63334509406, 28995.13014609565, 29019.85490072536, 29078.0, 29176.7082329174], "value": 20697.040793542474, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.17990759128577, 399.8180827723385, 401.63451259353974, 401.64053172410695, 420.03423975793277, 18460.815391846096, 20344.491387715316, 20363.898180509113, 20425.99999999998, 20442.48893777656, 18948.147333369998, 19352.419427417164, 20056.398308050782, 20091.497712557157, 20122.0, 5709.486985948727, 5750.252467179261, 5911.438413350725, 5912.142739302799, 5955.761769529214, 5753.165790960308, 5811.651300921937, 5816.214811000503, 5817.069268916975, 5822.184894114827, 5783.537317014629, 5814.24414826072, 5887.352391236982, 5922.733476993546, 5927.762889484416, 5829.09649004405, 5903.616264942786, 5906.881862362771, 5911.852203694921, 5973.163757074013, 5147.176451767737, 5242.187460943522, 5269.947300527022, 5286.577073834084, 5286.709230992294, 20918.372448826558, 22005.559888802134, 22010.779892201033, 22723.431914202112, 23510.882445587664, 2295.5179412323264, 2373.1931143411152, 2394.317619478458, 2429.866357350345, 2529.178017144417, 9702.805943881154, 10192.694219173436, 10220.386776793417, 10373.636922707745, 10580.576776928914, 1804.6661367647027, 1896.3931541906595, 1937.9229593760565, 1962.4407043992537, 1983.6429442700307, 83050.0, 85120.0, 85799.99999999937, 86408.0, 87060.0, 10168.186545076376, 10189.643362482277, 10296.485175741333, 10335.483225838678, 10466.215033872339, 14275.286235688174, 14309.356078976263, 14373.209473479059, 14570.781438278435, 14608.561743147722, 7939.3251573615735, 7947.483413578215, 8006.119326874039, 8143.552104634184, 8268.917310826935, 7932.325752311002, 7960.721374751856, 8020.679172833138, 8081.797955051054, 8256.0, 4644.140833945731, 4669.369635099286, 4680.087382960358, 4703.035877645075, 4742.4309082909585, 1968.5964377302905, 1993.2624928776156, 2004.1181879972764, 2005.0, 2014.8891810950245, 916.7616419730784, 972.3679608254549, 978.4276198424002, 988.8615593816871, 1030.5723124903232, 19281.22875085009, 19803.50491237702, 19908.203671853254, 19915.0, 19949.506311711037, 1012.3318609717551, 1016.7254841192837, 1030.6907927621683, 1041.6614600254948, 1062.8033813744482, 10498.370097794157, 10895.291806032583, 10940.39827809478, 10940.726481837859, 11035.44822758875, 376252.0, 376262.0, 382985.0, 504111.0, 504306.0, 94844.52577737067, 104818.0, 105474.0, 105745.0, 105884.0, 990.7919336939324, 1020.7090979071078, 1055.488088277185, 1058.1799105693149, 1059.2532264753331, 17631.20659570348, 17821.0, 18407.53981150482, 18582.0, 18611.441656750318, 41187.38218926779, 41409.58590414057, 42024.789876050425, 43014.35478467888, 43758.781206093765, 57066.42933570611, 57894.4210557889, 62980.86486056345, 63117.68441157765, 64020.35979640144, 6732.124823772878, 7175.677094530654, 8645.783855403664, 8688.0, 8861.33539984491, 12869.485220591447, 13255.53605623837, 13582.93208533951, 13639.727205456034, 13789.655258618615, 11511.366874821964, 11551.191416600757, 11634.36011019402, 11828.34944078084, 11837.585684501, 10803.083167544875, 11117.27737697047, 11162.330260184415, 11536.192466527262, 11880.940595296968, 11924.940375298069, 12024.158308918291, 12049.879501204876, 12113.333766642567, 12573.245605263714, 8510.0, 8584.055753867195, 8619.396642234984, 8741.388102832741, 8781.297496200417, 11092.168087393638, 11211.60759373418, 11713.180077394842, 11876.287422754662, 11950.223235489666], "value": 9266.42949123133, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.4060402516857, 1509.2076659753632, 1525.016364444933, 1676.6143786929006, 1827.5431142214454, 8393.580320983958, 8707.25988290996, 8721.345899057564, 8952.462852228871, 8981.775455613613, 8701.477911325324, 8914.153155450222, 8915.286777057836, 8919.01890792014, 8924.776880577989, 2333.6732857399934, 2358.3986083548757, 2367.266147494274, 2368.1829768729763, 2369.123424332999, 2331.288956868163, 2355.7879790818824, 2418.806495480357, 2424.6726691896633, 2426.454047839231, 2297.8851057447146, 2321.303608917318, 2333.346662934381, 2334.9766502335015, 2349.2364981381033, 2303.193882141254, 2314.085936055257, 2332.428555004018, 2332.7550607186254, 2336.906523739048, 2239.1603148819195, 2280.1905323610044, 2280.521090570982, 2282.7717228277206, 2283.892312228568, 8809.867851982226, 8845.380823342368, 8882.866756998586, 8890.155435233642, 9027.4132181408, 5266.315379000744, 5326.520613144797, 5403.486668766461, 5410.215518749798, 5411.269478620376, 3269.640339562646, 3334.0497958082074, 3350.3131857969056, 3367.0740546349707, 3373.713234375081, 1112.227002233448, 1120.3893877836517, 1133.0538999935063, 1139.8632164140356, 1141.8686851012158, 12306.692332691664, 12375.504979800888, 12432.254064756053, 12433.06751993595, 12437.06721995845, 4432.091421258634, 4514.503404625489, 4635.536446355338, 4639.072185562901, 4648.721076735406, 9642.42145471274, 9675.564599592895, 9699.854502182472, 9700.514974251259, 9709.757256068655, 5304.0, 5312.495312945264, 5318.228856815817, 5318.494742999409, 5319.308489896289, 4358.237308471005, 4754.477007529169, 4899.877503062381, 4916.385451818523, 4980.626453016038, 3832.0, 3852.7303088783515, 3857.3442514772555, 3934.3311637021775, 3952.4268980997595, 1166.8016437205695, 1175.735459521618, 1176.6058370445826, 1188.9702757431132, 1191.3209470601846, 762.527233115472, 861.8965724113147, 873.8907636545432, 1015.9796804063877, 1025.251566356549, 6247.718852651642, 6379.808605741835, 6412.198475190601, 6445.871082578416, 6618.172728408949, 943.6461327002374, 998.2164001258977, 1013.2400699475394, 1023.6007956896816, 1053.052252972331, 4144.715138307134, 4280.229558679468, 4293.656507479394, 4298.26929421999, 4371.278739008092, 11104.167187460973, 11297.322160670386, 11395.0, 11428.94285528567, 11530.654080377602, 10445.268831181744, 10707.785844283071, 10799.082078023299, 10801.945990269998, 11282.605108821152, 8016.959915200387, 8144.4298899077685, 8178.059523154794, 8361.540115293596, 8376.371772117116, 6108.786192483241, 6342.841428964312, 6383.0, 6450.741970321134, 6485.254195767358, 9988.900110999088, 10341.37951722899, 10443.738906527398, 10451.947740261554, 10455.111315538265, 10656.946715266684, 10774.892251077388, 10776.461176941279, 10783.730406739895, 10804.891951080388, 7556.508826926232, 8472.915270847212, 8565.186307300797, 8612.569371531274, 8693.956530217562, 8809.383343165917, 8846.071162527842, 8915.910840891767, 8921.687740929296, 8924.464532128093, 7289.854202916018, 7737.264959828807, 7738.574378409242, 7968.0, 8165.428420010542, 7818.296353328228, 7944.960275198587, 7976.441649084509, 8011.679532818622, 8092.069412017693, 7166.928330716834, 7297.525660832029, 7350.852982940418, 7411.7035318588805, 7418.554886706815, 5254.0, 5321.627486075938, 5379.623426360117, 5392.245085687929, 5455.099908515209, 5334.06653835585, 5362.812301569583, 5487.5609951203005, 5569.66582005081, 5574.581906357121], "value": 4712.641684301144, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.3114827713525, 326.55262290661796, 335.8438326178327, 336.10763423111615, 336.6179386396439, 5287.0, 5297.390800057994, 5297.735113244332, 5319.601029922756, 5323.520883120518, 5232.267482552436, 5240.528352448279, 5253.159494480884, 5257.973710131453, 5258.737063146847, 3985.1631157456895, 4042.939355909664, 4150.377443383486, 4152.314868046768, 4165.1669666066755, 4066.715329926906, 4109.835606575748, 4121.259362523918, 4124.546299907008, 4129.876103716878, 3911.6870650347905, 4132.128170921211, 4135.545090040108, 4144.834206631731, 4155.39746736723, 4021.155557332964, 4119.855805046809, 4125.876223713263, 4147.709660323779, 4166.229247589191, 3648.179159689049, 3657.7256705747177, 3667.94498082529, 3668.743187976843, 3675.3751862183226, 5170.896582068338, 5205.453427390107, 5212.50481204285, 5227.529522342969, 5243.528082472596, 4476.015276639134, 4694.530546945312, 4699.318598803155, 4740.881477963044, 4743.312219728155, 5453.972730136364, 5471.945280547223, 5483.479069488392, 5489.313835770528, 5509.063459211943, 3973.841046358142, 3977.5226972763453, 3990.7605543667473, 3998.8400463981407, 4006.639402453764, 5503.257060296849, 5670.376258611549, 5701.486866182022, 5716.228309178249, 5730.799422020251, 4002.4590532645143, 4016.216837716676, 4028.879133625996, 4033.979830100831, 4035.7174997750462, 4086.264472394938, 4098.831832927602, 4106.897327566775, 4111.7944102794745, 4121.1345617420075, 4626.421697287839, 4649.930251046237, 4702.858914232578, 4713.717176969393, 4732.810687572459, 5495.917561236584, 5528.0, 5535.58483113768, 5541.418151094077, 5553.666779993213, 1407.1205496564646, 1412.5903487988369, 1421.5948454690363, 1424.0530047518491, 1427.1651084115701, 893.6023469555985, 916.4404462321813, 921.1985572551923, 924.2236521321987, 967.4823969176598, 5233.215017747369, 5257.8695580450385, 5261.921071183935, 5264.210368444687, 5276.604254680914, 5545.1682247663175, 5545.889082218333, 5582.302212223472, 5597.328320601472, 5626.971865140648, 5080.923786143211, 5230.8169214077325, 5262.71055091966, 5274.683518988873, 5276.129438642658, 2953.74893134086, 2967.8219306841656, 2973.687762784876, 2982.9552556711665, 2993.3414648777234, 5717.084287013653, 5749.885002300014, 5754.280714910637, 5758.88482230353, 5765.3369862465515, 5454.754536045887, 5643.238162847963, 5673.716314184274, 5683.687397193112, 5701.629394089371, 5666.206731057655, 5674.971625141848, 5702.488840457282, 5706.229658996065, 5754.539636829128, 5338.54622357104, 5491.258680078138, 5497.147942068986, 5548.167774833807, 5739.540836733135, 5653.547716182613, 5664.207011018543, 5670.971645141748, 5675.404082571271, 5685.829425117253, 5861.912071318849, 5875.529957603467, 5877.147813566923, 5879.588428809942, 5895.587308888508, 3982.4424580559325, 4060.1879624075896, 4077.0, 4085.4280400744515, 4092.447519584818, 5426.864328391664, 5599.776008959596, 5652.265205523256, 5681.318241811009, 5744.655320680772, 5388.407275199804, 5479.0, 5479.397266300624, 5482.547125011795, 5516.227728118147, 5534.391216966211, 5537.335519737496, 5547.583931205257, 5572.9132819101505, 5572.944270557243, 5332.760025798771, 5469.0, 5485.424030476743, 5504.697241651747, 5506.64206826555, 5532.474414930575, 5570.053090974625, 5573.832785016456, 5575.498205161555, 5583.637063590853, 5265.630935956602, 5470.070088084955, 5486.478784515464, 5486.643368181056, 5496.395396506301], "value": 4206.942409145476, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.2770388056123, 719.2914978745938, 790.9960450197749, 838.1409055717892, 844.4806444036915, 13639.11345762526, 14063.64840878976, 14460.855391446083, 14474.638134046654, 15338.0, 13943.0, 14111.435542578285, 14112.364943577539, 14129.929350353259, 14136.575902722909, 652.2824892618106, 755.4409736794787, 797.3023604346197, 803.7307501986842, 815.7348861619968, 813.3737022492677, 823.983520329593, 827.404268926375, 827.755812035448, 828.5028982610446, 868.3834477520968, 871.372611719561, 871.808202195516, 871.9520426376547, 872.3413822563987, 680.8195828105556, 805.9274665280153, 844.7043534762845, 862.6678728689437, 863.6933888469597, 627.4415769964735, 628.4155735166294, 628.5757113948067, 628.7956414165415, 628.937106289372, 14296.285185740775, 14307.070040447337, 14323.641908952359, 14327.212003339811, 14342.713145737027, 14298.428062877472, 14699.485518006926, 14771.852281477155, 14937.925310373486, 15158.0, 13231.536896208587, 13289.269090200132, 13322.86677133226, 13490.190588564717, 13680.179189248578, 4474.597286244254, 4534.36518887356, 4610.377599024122, 4660.743659098748, 4696.929546056812, 76807.23192768056, 77283.6135819323, 77333.22666773373, 77666.22333776647, 77728.61135694342, 11532.654020379403, 11585.826212606818, 11622.94188529052, 11630.476628551736, 11727.061835053175, 18857.62284754297, 19246.615067698847, 19519.121639526256, 19567.706484402745, 19574.21703131859, 8388.832223355621, 8426.494410335277, 8553.101924297858, 8684.739457816275, 8821.426607270507, 4525.389072475239, 4556.749378784199, 4591.403117594691, 4680.53194680536, 4718.079974404958, 3338.2322065924486, 3467.6358982306997, 3472.600650925176, 3473.9826300868335, 3474.409350410436, 622.953278504114, 626.6866566716642, 628.9495352320871, 636.0999186151636, 638.6327861479667, 578.5062671512242, 610.5359926455836, 681.2506243132614, 712.4264966701751, 731.3522564105142, 8580.570971451403, 8657.95671021641, 8779.452853023373, 8828.249598784047, 9115.088491150831, 627.3945642454962, 670.7193415475045, 702.1749444402807, 731.1040759794201, 733.1743957545673, 4048.5748996355546, 4124.661273463167, 4135.234981528367, 4270.572942705705, 4273.55127711592, 68241.3175868235, 100861.49569252107, 112018.0, 112136.0, 115242.0, 98925.50537247267, 99174.02477925674, 100024.49987750014, 100153.49923250337, 100721.49639251904, 76637.0, 87414.0, 88256.0, 88411.11588884158, 88547.55726221327, 7892.921070789219, 8062.234087761653, 8117.472364296302, 8136.640716986212, 8161.143079976517, 41059.58940410677, 50872.0, 50971.2354314693, 52000.73999629977, 52141.0, 74300.62849685717, 76564.61717691376, 77372.61313693396, 77381.2261877374, 78634.0, 10169.491525423551, 10306.742331441774, 10601.0, 10763.677089687322, 11132.777344453227, 10573.312734672221, 10650.360978341325, 10849.211482015946, 11080.0, 11131.165162612675, 10787.784244315228, 10858.0, 10946.124310055337, 10946.343219406861, 11121.165912556753, 10514.842277365999, 10592.682219533426, 10676.145908327471, 10737.0, 11232.269902456314, 10657.25399222047, 10971.780564388828, 10997.505112269808, 11314.547418103513, 11383.677414557917, 8492.660293588187, 8557.021949497092, 8706.347023973101, 8837.248833849195, 8943.642254309754, 9464.479453629841, 9656.9034309656, 9754.561044752862, 9798.412095274307, 9839.262055345735], "value": 7122.98483823804, "unit": "score"}], "name": "dromaeo_css", "value": 7229.9686370269455, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 109.0, 110.0, 114.0, 110.0, 110.0, 108.0, 108.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 120.0, 168.0, 118.0, 118.0, 150.0, 120.0, 146.0, 124.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 159.0, 160.0, 161.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 107.0, 76.0, 76.0, 75.0, 74.0, 98.0, 76.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 83.0, 84.0, 84.0, 112.0, 84.0, 84.0, 133.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 153.0, 145.0, 145.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 54.0, 53.0, 60.0, 54.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 80.0, 74.0, 75.0, 83.0, 75.0, 74.0, 79.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 116.0, 120.0, 132.0, 122.0, 125.0, 127.0, 118.0, 163.0, 120.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 156.0, 158.0, 164.0, 155.0, 155.0, 159.0, 153.0, 155.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 65.0, 62.0, 65.0, 62.0, 61.0, 62.0, 60.0, 60.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1476.6999999999998, "alertThreshold": 2.0}]} 13:29:28 INFO - Return code: 0 13:29:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:29:28 INFO - # TBPL SUCCESS # 13:29:28 INFO - Running post-action listener: _resource_record_post_action 13:29:28 INFO - ##### 13:29:28 INFO - ##### Finished run-tests step (success) 13:29:28 INFO - ##### 13:29:28 INFO - Running post-run listener: _resource_record_post_run 13:29:28 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 572678144; Read time: 20; Write time: 578072 13:29:28 INFO - TinderboxPrint: CPU usage
13.0% 13:29:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 13:29:28 INFO - TinderboxPrint: I/O write bytes / time
572,678,144 / 578,072 13:29:28 INFO - TinderboxPrint: CPU idle
8,270.6 (87.0%) 13:29:28 INFO - TinderboxPrint: CPU user
1,192.1 (12.5%) 13:29:28 INFO - TinderboxPrint: Swap in / out
0 / 0 13:29:28 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 274812928; Read time: 0; Write time: 315156 13:29:28 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 297865216; Read time: 0; Write time: 262916 13:29:28 INFO - Running post-run listener: _upload_blobber_files 13:29:28 INFO - Blob upload gear active. 13:29:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:29:28 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 13:29:28 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:29:28 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:29:29 INFO - (blobuploader) - INFO - Open directory for files ... 13:29:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:29:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:29:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:30 INFO - (blobuploader) - INFO - Done attempting. 13:29:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:29:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:29:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:31 INFO - (blobuploader) - INFO - Done attempting. 13:29:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:29:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:29:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:36 INFO - (blobuploader) - INFO - Done attempting. 13:29:36 INFO - (blobuploader) - INFO - Iteration through files over. 13:29:36 INFO - Return code: 0 13:29:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:29:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:29:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8efa0c6cc0f11836d073e8776e79c91546a487221136266670ea88aa19bb561861c65a97c7e8016673818d80c5cb5cb7a147cbfb0422e77801bf2ed14ab9cea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9db305c8447547c27d63fcfd1f0df5d689c250c9d6b3857eb792db9c6749aadaf9ba1d831a023e402bb053c5b103d490e382ce6419aac7b2df043d83aa1d2f51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/714c1bce22890f8bc44f7ac8a7ea521b9292c00f1c98c73fd57240e9c2dbb223d5404b6d4c318f40a56ed6f9e7994cc547ddc1eadc3c108232c1589f4a7ca6b1"} 13:29:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:29:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:29:36 INFO - Contents: 13:29:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8efa0c6cc0f11836d073e8776e79c91546a487221136266670ea88aa19bb561861c65a97c7e8016673818d80c5cb5cb7a147cbfb0422e77801bf2ed14ab9cea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9db305c8447547c27d63fcfd1f0df5d689c250c9d6b3857eb792db9c6749aadaf9ba1d831a023e402bb053c5b103d490e382ce6419aac7b2df043d83aa1d2f51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/714c1bce22890f8bc44f7ac8a7ea521b9292c00f1c98c73fd57240e9c2dbb223d5404b6d4c318f40a56ed6f9e7994cc547ddc1eadc3c108232c1589f4a7ca6b1"} 13:29:36 INFO - Running post-run listener: copy_logs_to_upload_dir 13:29:36 INFO - Copying logs to upload dir... 13:29:36 INFO - mkdir: /builds/slave/test/build/upload/logs 13:29:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.762978 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-15 13:29:36.247145) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 13:29:36.250731) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198 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/sha512/b8efa0c6cc0f11836d073e8776e79c91546a487221136266670ea88aa19bb561861c65a97c7e8016673818d80c5cb5cb7a147cbfb0422e77801bf2ed14ab9cea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9db305c8447547c27d63fcfd1f0df5d689c250c9d6b3857eb792db9c6749aadaf9ba1d831a023e402bb053c5b103d490e382ce6419aac7b2df043d83aa1d2f51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/714c1bce22890f8bc44f7ac8a7ea521b9292c00f1c98c73fd57240e9c2dbb223d5404b6d4c318f40a56ed6f9e7994cc547ddc1eadc3c108232c1589f4a7ca6b1"} build_url:https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/XgWzH36cTxGZq_FUgTPxWA/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/sha512/b8efa0c6cc0f11836d073e8776e79c91546a487221136266670ea88aa19bb561861c65a97c7e8016673818d80c5cb5cb7a147cbfb0422e77801bf2ed14ab9cea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9db305c8447547c27d63fcfd1f0df5d689c250c9d6b3857eb792db9c6749aadaf9ba1d831a023e402bb053c5b103d490e382ce6419aac7b2df043d83aa1d2f51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/714c1bce22890f8bc44f7ac8a7ea521b9292c00f1c98c73fd57240e9c2dbb223d5404b6d4c318f40a56ed6f9e7994cc547ddc1eadc3c108232c1589f4a7ca6b1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 13:29:36.275733) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:29:36.276053) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468613341.724229-1202048198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:29:36.358819) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 13:29:36.359123) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 13:29:36.359619) ========= ========= Total master_lag: 0.18 =========