builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1469157596.07 results: success (0) buildid: 20160721173021 builduid: efebc16cf55644959df3d30b9ed88464 revision: 7ba94e0c5daa48d7667519c930eca31d98648512 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 20:19:56.068726) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 20:19:56.069785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 20:19:56.070478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 20:19:56.088824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:19:56.089454) ========= 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=826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 20:19:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 89.8M=0s 2016-07-21 20:19:57 (89.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:19:56.217690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:19:56.218421) ========= 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=826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019318 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:19:56.270372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 20:19:56.271170) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7ba94e0c5daa48d7667519c930eca31d98648512 --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 7ba94e0c5daa48d7667519c930eca31d98648512 --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=826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 20:19:57,246 truncating revision to first 12 chars 2016-07-21 20:19:57,246 Setting DEBUG logging. 2016-07-21 20:19:57,246 attempt 1/10 2016-07-21 20:19:57,246 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7ba94e0c5daa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 20:19:58,430 unpacking tar archive at: fx-team-7ba94e0c5daa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.519907 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 20:19:57.806947) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 20:19:57.807355) ========= script_repo_revision: 7ba94e0c5daa48d7667519c930eca31d98648512 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 20:19:57.807798) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 20:19:57.808119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 20:19:57.819451) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-21 20:19:57.819758) ========= /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=826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:19:58 INFO - MultiFileLogger online at 20160721 20:19:58 in /builds/slave/test 20:19:58 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 20:19:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:19:58 INFO - {'append_to_log': False, 20:19:58 INFO - 'base_work_dir': '/builds/slave/test', 20:19:58 INFO - 'blob_upload_branch': 'Fx-Team', 20:19:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:19:58 INFO - 'branch': 'Fx-Team', 20:19:58 INFO - 'buildbot_json_path': 'buildprops.json', 20:19:58 INFO - 'config_files': ('talos/linux_config.py',), 20:19:58 INFO - 'default_actions': ('clobber', 20:19:58 INFO - 'read-buildbot-config', 20:19:58 INFO - 'download-and-extract', 20:19:58 INFO - 'populate-webroot', 20:19:58 INFO - 'create-virtualenv', 20:19:58 INFO - 'install', 20:19:58 INFO - 'run-tests'), 20:19:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:19:58 INFO - 'download_minidump_stackwalk': True, 20:19:58 INFO - 'download_symbols': 'ondemand', 20:19:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:19:58 INFO - 'tooltool.py': '/tools/tooltool.py', 20:19:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:19:58 INFO - '/tools/misc-python/virtualenv.py')}, 20:19:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:19:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:19:58 INFO - 'installer_path': 'installer.exe', 20:19:58 INFO - 'log_level': 'info', 20:19:58 INFO - 'log_name': 'talos', 20:19:58 INFO - 'log_to_console': True, 20:19:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:19:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:19:58 INFO - 'opt_config_files': (), 20:19:58 INFO - 'pip_index': False, 20:19:58 INFO - 'sps_profile': False, 20:19:58 INFO - 'sps_profile_interval': 0, 20:19:58 INFO - 'suite': 'dromaeojs', 20:19:58 INFO - 'system_bits': '32', 20:19:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:19:58 INFO - 'title': 'talos-linux64-ix-052', 20:19:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:19:58 INFO - 'use_talos_json': True, 20:19:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:19:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:19:58 INFO - 'work_dir': 'build'} 20:19:58 INFO - [mozharness: 2016-07-22 03:19:58.882102Z] Running clobber step. 20:19:58 INFO - Running pre-action listener: _resource_record_pre_action 20:19:58 INFO - Running main action method: clobber 20:19:58 INFO - rmtree: /builds/slave/test/build 20:19:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:19:59 INFO - Running post-action listener: _resource_record_post_action 20:19:59 INFO - [mozharness: 2016-07-22 03:19:59.360961Z] Finished clobber step (success) 20:19:59 INFO - [mozharness: 2016-07-22 03:19:59.361062Z] Running read-buildbot-config step. 20:19:59 INFO - Running pre-action listener: _resource_record_pre_action 20:19:59 INFO - Running main action method: read_buildbot_config 20:19:59 INFO - Using buildbot properties: 20:19:59 INFO - { 20:19:59 INFO - "project": "", 20:19:59 INFO - "product": "firefox", 20:19:59 INFO - "script_repo_revision": "production", 20:19:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:19:59 INFO - "repository": "", 20:19:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:19:59 INFO - "buildid": "20160721173021", 20:19:59 INFO - "pgo_build": "True", 20:19:59 INFO - "basedir": "/builds/slave/test", 20:19:59 INFO - "buildnumber": 923, 20:19:59 INFO - "slavename": "talos-linux64-ix-052", 20:19:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:19:59 INFO - "platform": "ubuntu64_hw", 20:19:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:19:59 INFO - "branch": "fx-team", 20:19:59 INFO - "repo_path": "integration/fx-team", 20:19:59 INFO - "revision": "7ba94e0c5daa48d7667519c930eca31d98648512", 20:19:59 INFO - "stage_platform": "linux64-pgo", 20:19:59 INFO - "builduid": "efebc16cf55644959df3d30b9ed88464", 20:19:59 INFO - "slavebuilddir": "test" 20:19:59 INFO - } 20:19:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:19:59 INFO - Running post-action listener: _resource_record_post_action 20:19:59 INFO - [mozharness: 2016-07-22 03:19:59.363522Z] Finished read-buildbot-config step (success) 20:19:59 INFO - [mozharness: 2016-07-22 03:19:59.363612Z] Running download-and-extract step. 20:19:59 INFO - Running pre-action listener: _resource_record_pre_action 20:19:59 INFO - Running main action method: download_and_extract 20:19:59 INFO - mkdir: /builds/slave/test/build/tests 20:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:59 INFO - https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:19:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:19:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:19:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/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 20:19:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/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 20:20:00 INFO - Downloaded 1361 bytes. 20:20:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:20:00 INFO - Using the following test package requirements: 20:20:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:20:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:20:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:20:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:00 INFO - u'jsshell-linux-x86_64.zip'], 20:20:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:20:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:20:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:20:00 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:20:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:20:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:20:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:00 INFO - https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:20:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/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 20:20:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/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 20:20:01 INFO - Downloaded 24306931 bytes. 20:20:01 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'] 20:20:01 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 20:20:02 INFO - Return code: 0 20:20:02 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 20:20:02 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')]} 20:20:02 INFO - https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:20:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/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 20:20:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/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 20:20:03 INFO - Downloaded 24306931 bytes. 20:20:03 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'] 20:20:03 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 20:20:05 INFO - Return code: 0 20:20: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')]} 20:20:05 INFO - https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:20:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:20:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:20:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/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 20:20:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/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 20:20:05 INFO - Downloaded 14403317 bytes. 20:20:05 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'] 20:20:05 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 20:20:06 INFO - Return code: 0 20:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:06 INFO - https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:20:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/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 20:20:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/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 20:20:08 INFO - Downloaded 60876754 bytes. 20:20:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:08 INFO - mkdir: /builds/slave/test/properties 20:20:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:20:08 INFO - Writing to file /builds/slave/test/properties/build_url 20:20:08 INFO - Contents: 20:20:08 INFO - build_url:https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:09 INFO - Running post-action listener: _resource_record_post_action 20:20:09 INFO - Running post-action listener: set_extra_try_arguments 20:20:09 INFO - [mozharness: 2016-07-22 03:20:09.705427Z] Finished download-and-extract step (success) 20:20:09 INFO - [mozharness: 2016-07-22 03:20:09.705667Z] Running populate-webroot step. 20:20:09 INFO - Running pre-action listener: _resource_record_pre_action 20:20:09 INFO - Running main action method: populate_webroot 20:20:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:20:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:20:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:20:09 INFO - '--tppagecycles', 20:20:09 INFO - '7'], 20:20:09 INFO - 'tests': ['tsvgm']}}, 20:20:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:20:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:20:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:20:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:20:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:20:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:20:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:09 INFO - 'talos_options': ['--disable-e10s'], 20:20:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:09 INFO - 'talos_options': ['--disable-e10s'], 20:20:09 INFO - 'tests': ['damp', 'tps']}, 20:20:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:09 INFO - 'tests': ['damp', 'tps']}, 20:20:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:20:09 INFO - 'tests': ['dromaeo_dom']}, 20:20:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:20:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:20:09 INFO - 'tests': ['basic_compositor_video']}, 20:20:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:20:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:20:09 INFO - 'tests': ['a11yr', 20:20:09 INFO - 'ts_paint', 20:20:09 INFO - 'tpaint', 20:20:09 INFO - 'sessionrestore', 20:20:09 INFO - 'sessionrestore_no_auto_restore', 20:20:09 INFO - 'tabpaint']}, 20:20:09 INFO - 'other-e10s': {'tests': ['a11yr', 20:20:09 INFO - 'ts_paint', 20:20:09 INFO - 'tpaint', 20:20:09 INFO - 'sessionrestore', 20:20:09 INFO - 'sessionrestore_no_auto_restore', 20:20:09 INFO - 'tabpaint']}, 20:20:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:20:09 INFO - 'ts_paint', 20:20:09 INFO - 'tpaint', 20:20:09 INFO - 'sessionrestore', 20:20:09 INFO - 'sessionrestore_no_auto_restore', 20:20:09 INFO - 'tabpaint']}, 20:20:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:20:09 INFO - 'ts_paint', 20:20:09 INFO - 'tpaint', 20:20:09 INFO - 'sessionrestore', 20:20:09 INFO - 'sessionrestore_no_auto_restore', 20:20:09 INFO - 'tabpaint']}, 20:20:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:20:09 INFO - 'tests': ['a11yr', 20:20:09 INFO - 'ts_paint', 20:20:09 INFO - 'tpaint', 20:20:09 INFO - 'sessionrestore', 20:20:09 INFO - 'sessionrestore_no_auto_restore', 20:20:09 INFO - 'tabpaint']}, 20:20:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:20:09 INFO - 'tests': ['a11yr', 20:20:09 INFO - 'ts_paint', 20:20:09 INFO - 'tpaint', 20:20:09 INFO - 'sessionrestore', 20:20:09 INFO - 'sessionrestore_no_auto_restore', 20:20:09 INFO - 'tabpaint']}, 20:20:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:20:09 INFO - 'tests': ['tsvgx', 20:20:09 INFO - 'tsvgr_opacity', 20:20:09 INFO - 'tart', 20:20:09 INFO - 'tscrollx', 20:20:09 INFO - 'cart']}, 20:20:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:20:09 INFO - 'tsvgr_opacity', 20:20:09 INFO - 'tart', 20:20:09 INFO - 'tscrollx', 20:20:09 INFO - 'cart']}, 20:20:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:09 INFO - 'talos_options': ['--disable-e10s'], 20:20:09 INFO - 'tests': ['tp5o']}, 20:20:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:09 INFO - 'tests': ['tp5o']}, 20:20:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:09 INFO - 'talos_options': ['--disable-e10s', 20:20:09 INFO - '--xperf_path', 20:20:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:09 INFO - 'tests': ['tp5n']}, 20:20:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:09 INFO - 'talos_options': ['--xperf_path', 20:20:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:09 INFO - 'tests': ['tp5n']}}, 20:20:09 INFO - 'talos.zip': {'path': '', 20:20:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:20:09 INFO - Running post-action listener: _resource_record_post_action 20:20:09 INFO - [mozharness: 2016-07-22 03:20:09.726470Z] Finished populate-webroot step (success) 20:20:09 INFO - [mozharness: 2016-07-22 03:20:09.726560Z] Running create-virtualenv step. 20:20:09 INFO - Running pre-action listener: _resource_record_pre_action 20:20:09 INFO - Running main action method: create_virtualenv 20:20:09 INFO - Creating virtualenv /builds/slave/test/build/venv 20:20:09 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 20:20:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:20:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:20:09 INFO - Using real prefix '/usr' 20:20:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:20:10 INFO - Installing distribute.............................................................................................................................................................................................done. 20:20:12 INFO - Installing pip.................done. 20:20:12 INFO - Return code: 0 20:20:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f43b0>, '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 0x11f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5740>, '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': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', '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 20:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:20:12 INFO - Using env: {'DISPLAY': ':0', 20:20:12 INFO - 'HOME': '/home/cltbld', 20:20:12 INFO - 'LANG': 'en_US.UTF-8', 20:20:12 INFO - 'LANGUAGE': 'en_US:en', 20:20:12 INFO - 'LOGNAME': 'cltbld', 20:20:12 INFO - 'MAIL': '/var/mail/cltbld', 20:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:12 INFO - 'MOZ_NO_REMOTE': '1', 20:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:12 INFO - 'NO_EM_RESTART': '1', 20:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:12 INFO - 'PWD': '/builds/slave/test', 20:20:12 INFO - 'SHELL': '/bin/bash', 20:20:12 INFO - 'SHLVL': '1', 20:20:12 INFO - 'TERM': 'linux', 20:20:12 INFO - 'TMOUT': '86400', 20:20:12 INFO - 'USER': 'cltbld', 20:20:12 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', 20:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:12 INFO - '_': '/tools/buildbot/bin/python'} 20:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:12 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 20:20:12 INFO - Cleaning up... 20:20:12 INFO - Return code: 0 20:20:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f43b0>, '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 0x11f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5740>, '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': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', '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 20:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:20:12 INFO - Using env: {'DISPLAY': ':0', 20:20:12 INFO - 'HOME': '/home/cltbld', 20:20:12 INFO - 'LANG': 'en_US.UTF-8', 20:20:12 INFO - 'LANGUAGE': 'en_US:en', 20:20:12 INFO - 'LOGNAME': 'cltbld', 20:20:12 INFO - 'MAIL': '/var/mail/cltbld', 20:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:12 INFO - 'MOZ_NO_REMOTE': '1', 20:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:12 INFO - 'NO_EM_RESTART': '1', 20:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:12 INFO - 'PWD': '/builds/slave/test', 20:20:12 INFO - 'SHELL': '/bin/bash', 20:20:12 INFO - 'SHLVL': '1', 20:20:12 INFO - 'TERM': 'linux', 20:20:12 INFO - 'TMOUT': '86400', 20:20:12 INFO - 'USER': 'cltbld', 20:20:12 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', 20:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:12 INFO - '_': '/tools/buildbot/bin/python'} 20:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:12 INFO - Downloading/unpacking psutil>=3.1.1 20:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:20:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:14 INFO - Installing collected packages: psutil 20:20:14 INFO - Running setup.py install for psutil 20:20:14 INFO - building 'psutil._psutil_linux' extension 20:20:14 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 20:20:14 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 20:20:15 INFO - building 'psutil._psutil_posix' extension 20:20:15 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 20:20:15 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 20:20:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:15 INFO - Successfully installed psutil 20:20:15 INFO - Cleaning up... 20:20:15 INFO - Return code: 0 20:20:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:20:15 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')]} 20:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:15 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')]} 20:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:15 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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f43b0>, '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 0x11f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5740>, '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': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', '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 20:20:15 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 20:20:15 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 20:20:15 INFO - Using env: {'DISPLAY': ':0', 20:20:15 INFO - 'HOME': '/home/cltbld', 20:20:15 INFO - 'LANG': 'en_US.UTF-8', 20:20:15 INFO - 'LANGUAGE': 'en_US:en', 20:20:15 INFO - 'LOGNAME': 'cltbld', 20:20:15 INFO - 'MAIL': '/var/mail/cltbld', 20:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:15 INFO - 'MOZ_NO_REMOTE': '1', 20:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:15 INFO - 'NO_EM_RESTART': '1', 20:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:15 INFO - 'PWD': '/builds/slave/test', 20:20:15 INFO - 'SHELL': '/bin/bash', 20:20:15 INFO - 'SHLVL': '1', 20:20:15 INFO - 'TERM': 'linux', 20:20:15 INFO - 'TMOUT': '86400', 20:20:15 INFO - 'USER': 'cltbld', 20:20:15 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', 20:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:15 INFO - '_': '/tools/buildbot/bin/python'} 20:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:20:17 INFO - Installing collected packages: mozsystemmonitor 20:20:17 INFO - Running setup.py install for mozsystemmonitor 20:20:17 INFO - Successfully installed mozsystemmonitor 20:20:17 INFO - Cleaning up... 20:20:17 INFO - Return code: 0 20:20:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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', '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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f43b0>, '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 0x11f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5740>, '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': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', '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 20:20: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:20: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 jsonschema==2.5.1 20:20:17 INFO - Using env: {'DISPLAY': ':0', 20:20:17 INFO - 'HOME': '/home/cltbld', 20:20:17 INFO - 'LANG': 'en_US.UTF-8', 20:20:17 INFO - 'LANGUAGE': 'en_US:en', 20:20:17 INFO - 'LOGNAME': 'cltbld', 20:20:17 INFO - 'MAIL': '/var/mail/cltbld', 20:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:17 INFO - 'MOZ_NO_REMOTE': '1', 20:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:17 INFO - 'NO_EM_RESTART': '1', 20:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:17 INFO - 'PWD': '/builds/slave/test', 20:20:17 INFO - 'SHELL': '/bin/bash', 20:20:17 INFO - 'SHLVL': '1', 20:20:17 INFO - 'TERM': 'linux', 20:20:17 INFO - 'TMOUT': '86400', 20:20:17 INFO - 'USER': 'cltbld', 20:20:17 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', 20:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:17 INFO - '_': '/tools/buildbot/bin/python'} 20:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:17 INFO - Downloading/unpacking jsonschema==2.5.1 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:20:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:20 INFO - Downloading functools32-3.2.3-2.tar.gz 20:20:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:20:20 INFO - warning: no files found matching '*.txt' 20:20:20 INFO - no previously-included directories found matching 'build' 20:20:20 INFO - no previously-included directories found matching 'dist' 20:20:20 INFO - no previously-included directories found matching '.git*' 20:20:20 INFO - Installing collected packages: jsonschema, functools32 20:20:20 INFO - Running setup.py install for functools32 20:20:20 INFO - warning: no files found matching '*.txt' 20:20:20 INFO - no previously-included directories found matching 'build' 20:20:20 INFO - no previously-included directories found matching 'dist' 20:20:20 INFO - no previously-included directories found matching '.git*' 20:20:20 INFO - Successfully installed jsonschema functools32 20:20:20 INFO - Cleaning up... 20:20:20 INFO - Return code: 0 20:20:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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', '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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f43b0>, '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 0x11f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5740>, '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': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', '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 20:20: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:20: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 blobuploader==1.2.4 20:20:20 INFO - Using env: {'DISPLAY': ':0', 20:20:20 INFO - 'HOME': '/home/cltbld', 20:20:20 INFO - 'LANG': 'en_US.UTF-8', 20:20:20 INFO - 'LANGUAGE': 'en_US:en', 20:20:20 INFO - 'LOGNAME': 'cltbld', 20:20:20 INFO - 'MAIL': '/var/mail/cltbld', 20:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:20 INFO - 'MOZ_NO_REMOTE': '1', 20:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:20 INFO - 'NO_EM_RESTART': '1', 20:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:20 INFO - 'PWD': '/builds/slave/test', 20:20:20 INFO - 'SHELL': '/bin/bash', 20:20:20 INFO - 'SHLVL': '1', 20:20:20 INFO - 'TERM': 'linux', 20:20:20 INFO - 'TMOUT': '86400', 20:20:20 INFO - 'USER': 'cltbld', 20:20:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', 20:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:20 INFO - '_': '/tools/buildbot/bin/python'} 20:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:20 INFO - Downloading/unpacking blobuploader==1.2.4 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:22 INFO - Downloading blobuploader-1.2.4.tar.gz 20:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:20:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:20:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:23 INFO - Downloading docopt-0.6.1.tar.gz 20:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:20:23 INFO - Installing collected packages: blobuploader, requests, docopt 20:20:23 INFO - Running setup.py install for blobuploader 20:20:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:20:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:20:23 INFO - Running setup.py install for requests 20:20:23 INFO - Running setup.py install for docopt 20:20:23 INFO - Successfully installed blobuploader requests docopt 20:20:23 INFO - Cleaning up... 20:20:23 INFO - Return code: 0 20:20:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:23 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')]} 20:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:23 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')]} 20:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:23 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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f43b0>, '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 0x11f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5740>, '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': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', '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 20:20:23 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 20:20:23 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 20:20:23 INFO - Using env: {'DISPLAY': ':0', 20:20:23 INFO - 'HOME': '/home/cltbld', 20:20:23 INFO - 'LANG': 'en_US.UTF-8', 20:20:23 INFO - 'LANGUAGE': 'en_US:en', 20:20:23 INFO - 'LOGNAME': 'cltbld', 20:20:23 INFO - 'MAIL': '/var/mail/cltbld', 20:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:23 INFO - 'MOZ_NO_REMOTE': '1', 20:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:23 INFO - 'NO_EM_RESTART': '1', 20:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:23 INFO - 'PWD': '/builds/slave/test', 20:20:23 INFO - 'SHELL': '/bin/bash', 20:20:23 INFO - 'SHLVL': '1', 20:20:23 INFO - 'TERM': 'linux', 20:20:23 INFO - 'TMOUT': '86400', 20:20:23 INFO - 'USER': 'cltbld', 20:20:23 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', 20:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:23 INFO - '_': '/tools/buildbot/bin/python'} 20:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:24 INFO - Running setup.py (path:/tmp/pip-MbkDW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:24 INFO - Running setup.py (path:/tmp/pip-DngJdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:24 INFO - Running setup.py (path:/tmp/pip-KyZhri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:24 INFO - Running setup.py (path:/tmp/pip-62jmwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:24 INFO - Running setup.py (path:/tmp/pip-0Rm2Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:24 INFO - Running setup.py (path:/tmp/pip-NX5JHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:24 INFO - Running setup.py (path:/tmp/pip-23g9gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:24 INFO - Running setup.py (path:/tmp/pip-gQMBtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:24 INFO - Running setup.py (path:/tmp/pip-BJZubV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:24 INFO - Running setup.py (path:/tmp/pip-uy_DtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:24 INFO - Running setup.py (path:/tmp/pip-3NI61G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:24 INFO - Running setup.py (path:/tmp/pip-Xosz4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:24 INFO - Running setup.py (path:/tmp/pip-4xNUKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:25 INFO - Running setup.py (path:/tmp/pip-ziB9sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:25 INFO - Running setup.py (path:/tmp/pip-fbrEH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:25 INFO - Running setup.py (path:/tmp/pip-V7RMyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:25 INFO - Running setup.py (path:/tmp/pip-rvqKSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:20:25 INFO - Running setup.py install for manifestparser 20:20:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Running setup.py install for mozcrash 20:20:25 INFO - Running setup.py install for mozdebug 20:20:25 INFO - Running setup.py install for mozdevice 20:20:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Running setup.py install for mozfile 20:20:25 INFO - Running setup.py install for mozhttpd 20:20:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:20:25 INFO - Running setup.py install for mozinfo 20:20:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:20:26 INFO - Running setup.py install for mozInstall 20:20:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:20:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:20:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:20:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:20:26 INFO - Running setup.py install for mozleak 20:20:26 INFO - Running setup.py install for mozlog 20:20:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:20:26 INFO - Running setup.py install for moznetwork 20:20:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:20:26 INFO - Running setup.py install for mozprocess 20:20:26 INFO - Running setup.py install for mozprofile 20:20:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:20:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:20:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:20:26 INFO - Running setup.py install for mozrunner 20:20:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:20:26 INFO - Running setup.py install for mozscreenshot 20:20:26 INFO - Running setup.py install for moztest 20:20:26 INFO - Running setup.py install for mozversion 20:20:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:20:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:20:27 INFO - Cleaning up... 20:20:27 INFO - Return code: 0 20:20:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:27 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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f43b0>, '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 0x11f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5740>, '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': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', '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 20:20:27 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 20:20:27 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 20:20:27 INFO - Using env: {'DISPLAY': ':0', 20:20:27 INFO - 'HOME': '/home/cltbld', 20:20:27 INFO - 'LANG': 'en_US.UTF-8', 20:20:27 INFO - 'LANGUAGE': 'en_US:en', 20:20:27 INFO - 'LOGNAME': 'cltbld', 20:20:27 INFO - 'MAIL': '/var/mail/cltbld', 20:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:27 INFO - 'MOZ_NO_REMOTE': '1', 20:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:27 INFO - 'NO_EM_RESTART': '1', 20:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:27 INFO - 'PWD': '/builds/slave/test', 20:20:27 INFO - 'SHELL': '/bin/bash', 20:20:27 INFO - 'SHLVL': '1', 20:20:27 INFO - 'TERM': 'linux', 20:20:27 INFO - 'TMOUT': '86400', 20:20:27 INFO - 'USER': 'cltbld', 20:20:27 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', 20:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:27 INFO - '_': '/tools/buildbot/bin/python'} 20:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:27 INFO - Running setup.py (path:/tmp/pip-fIh6FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:27 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)) 20:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:27 INFO - Running setup.py (path:/tmp/pip-_cAdZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:27 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)) 20:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:27 INFO - Running setup.py (path:/tmp/pip-BQm7wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:27 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)) 20:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:27 INFO - Running setup.py (path:/tmp/pip-D7dAO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:27 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)) 20:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:27 INFO - Running setup.py (path:/tmp/pip-rDBWyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:27 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)) 20:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:27 INFO - Running setup.py (path:/tmp/pip-qpeDNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:27 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)) 20:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:27 INFO - Running setup.py (path:/tmp/pip-TVGEUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:27 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)) 20:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:27 INFO - Running setup.py (path:/tmp/pip-hsGOkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:27 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)) 20:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:27 INFO - Running setup.py (path:/tmp/pip-IO_ZpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:27 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)) 20:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:27 INFO - Running setup.py (path:/tmp/pip-RH9LvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 20:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:28 INFO - Running setup.py (path:/tmp/pip-94W_Zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:28 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)) 20:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:28 INFO - Running setup.py (path:/tmp/pip-D43OpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:28 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)) 20:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:28 INFO - Running setup.py (path:/tmp/pip-5hWAMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:28 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)) 20:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:28 INFO - Running setup.py (path:/tmp/pip-jxtPaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:28 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)) 20:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:28 INFO - Running setup.py (path:/tmp/pip-_KeDXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:28 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)) 20:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:28 INFO - Running setup.py (path:/tmp/pip-jzxPQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:28 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)) 20:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:28 INFO - Running setup.py (path:/tmp/pip-Ykn1yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:28 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)) 20:20:28 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)) 20:20:28 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)) 20:20:28 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)) 20:20:28 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)) 20:20:28 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)) 20:20:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:20:28 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 20:20:28 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 20:20:28 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 20:20:28 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 20:20:28 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 20:20:28 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 20:20:30 INFO - Downloading blessings-1.6.tar.gz 20:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:20:30 INFO - Installing collected packages: blessings 20:20:30 INFO - Running setup.py install for blessings 20:20:30 INFO - Successfully installed blessings 20:20:30 INFO - Cleaning up... 20:20:30 INFO - Return code: 0 20:20:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:20:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:20:30 INFO - Reading from file tmpfile_stdout 20:20:30 INFO - Current package versions: 20:20:30 INFO - argparse == 1.2.1 20:20:30 INFO - blessings == 1.6 20:20:30 INFO - blobuploader == 1.2.4 20:20:30 INFO - docopt == 0.6.1 20:20:30 INFO - functools32 == 3.2.3-2 20:20:30 INFO - jsonschema == 2.5.1 20:20:30 INFO - manifestparser == 1.1 20:20:30 INFO - mozInstall == 1.12 20:20:30 INFO - mozcrash == 0.17 20:20:30 INFO - mozdebug == 0.1 20:20:30 INFO - mozdevice == 0.48 20:20:30 INFO - mozfile == 1.2 20:20:30 INFO - mozhttpd == 0.7 20:20:30 INFO - mozinfo == 0.9 20:20:30 INFO - mozleak == 0.1 20:20:30 INFO - mozlog == 3.3 20:20:30 INFO - moznetwork == 0.27 20:20:30 INFO - mozprocess == 0.23 20:20:30 INFO - mozprofile == 0.28 20:20:30 INFO - mozrunner == 6.12 20:20:30 INFO - mozscreenshot == 0.1 20:20:30 INFO - mozsystemmonitor == 0.3 20:20:30 INFO - moztest == 0.7 20:20:30 INFO - mozversion == 1.4 20:20:30 INFO - psutil == 3.1.1 20:20:30 INFO - requests == 1.2.3 20:20:30 INFO - wsgiref == 0.1.2 20:20:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:30 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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f43b0>, '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 0x11f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5740>, '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': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', '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 20:20:30 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 20:20:30 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 20:20:30 INFO - Using env: {'DISPLAY': ':0', 20:20:30 INFO - 'HOME': '/home/cltbld', 20:20:30 INFO - 'LANG': 'en_US.UTF-8', 20:20:30 INFO - 'LANGUAGE': 'en_US:en', 20:20:30 INFO - 'LOGNAME': 'cltbld', 20:20:30 INFO - 'MAIL': '/var/mail/cltbld', 20:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:30 INFO - 'MOZ_NO_REMOTE': '1', 20:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:30 INFO - 'NO_EM_RESTART': '1', 20:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:30 INFO - 'PWD': '/builds/slave/test', 20:20:30 INFO - 'SHELL': '/bin/bash', 20:20:30 INFO - 'SHLVL': '1', 20:20:30 INFO - 'TERM': 'linux', 20:20:30 INFO - 'TMOUT': '86400', 20:20:30 INFO - 'USER': 'cltbld', 20:20:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', 20:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:30 INFO - '_': '/tools/buildbot/bin/python'} 20:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 INFO - Cleaning up... 20:20:31 INFO - Return code: 0 20:20:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:31 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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f43b0>, '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 0x11f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5740>, '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': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', '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 20:20:31 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 20:20:31 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 20:20:31 INFO - Using env: {'DISPLAY': ':0', 20:20:31 INFO - 'HOME': '/home/cltbld', 20:20:31 INFO - 'LANG': 'en_US.UTF-8', 20:20:31 INFO - 'LANGUAGE': 'en_US:en', 20:20:31 INFO - 'LOGNAME': 'cltbld', 20:20:31 INFO - 'MAIL': '/var/mail/cltbld', 20:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:31 INFO - 'MOZ_NO_REMOTE': '1', 20:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:31 INFO - 'NO_EM_RESTART': '1', 20:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:31 INFO - 'PWD': '/builds/slave/test', 20:20:31 INFO - 'SHELL': '/bin/bash', 20:20:31 INFO - 'SHLVL': '1', 20:20:31 INFO - 'TERM': 'linux', 20:20:31 INFO - 'TMOUT': '86400', 20:20:31 INFO - 'USER': 'cltbld', 20:20:31 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', 20:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:31 INFO - '_': '/tools/buildbot/bin/python'} 20:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:20:31 INFO - Cleaning up... 20:20:31 INFO - Return code: 0 20:20:31 INFO - Running post-action listener: _resource_record_post_action 20:20:31 INFO - Running post-action listener: _start_resource_monitoring 20:20:31 INFO - Starting resource monitoring. 20:20:31 INFO - [mozharness: 2016-07-22 03:20:31.370862Z] Finished create-virtualenv step (success) 20:20:31 INFO - [mozharness: 2016-07-22 03:20:31.371340Z] Running install step. 20:20:31 INFO - Running pre-action listener: _resource_record_pre_action 20:20:31 INFO - Running main action method: install 20:20:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:20:31 INFO - Reading from file tmpfile_stdout 20:20:31 INFO - Detecting whether we're running mozinstall >=1.0... 20:20:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:20:31 INFO - Reading from file tmpfile_stdout 20:20:31 INFO - Output received: 20:20:31 INFO - Usage: mozinstall [options] installer 20:20:31 INFO - Options: 20:20:31 INFO - -h, --help show this help message and exit 20:20:31 INFO - -d DEST, --destination=DEST 20:20:31 INFO - Directory to install application into. [default: 20:20:31 INFO - "/builds/slave/test"] 20:20:31 INFO - --app=APP Application being installed. [default: firefox] 20:20:31 INFO - mkdir: /builds/slave/test/build/application 20:20:31 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'] 20:20:31 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 20:20:48 INFO - Reading from file tmpfile_stdout 20:20:48 INFO - Output received: 20:20:48 INFO - /builds/slave/test/build/application/firefox/firefox 20:20:48 INFO - Running post-action listener: _resource_record_post_action 20:20:48 INFO - [mozharness: 2016-07-22 03:20:48.934997Z] Finished install step (success) 20:20:48 INFO - [mozharness: 2016-07-22 03:20:48.935273Z] Running run-tests step. 20:20:48 INFO - Running pre-action listener: _resource_record_pre_action 20:20:48 INFO - Running main action method: run_tests 20:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:20:48 INFO - Python 2.7.3 20:20:48 INFO - Return code: 0 20:20:48 INFO - grabbing minidump binary from tooltool 20:20:48 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')]} 20:20:48 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 0x11f43b0>, '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 0x11f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:20:48 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 20:20:48 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 20:20:48 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 20:20:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:20:49 INFO - Return code: 0 20:20:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:20:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:20:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:20:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:20:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:20:49 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/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 20:20:49 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/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 20:20:49 INFO - Using env: {'DISPLAY': ':0', 20:20:49 INFO - 'HOME': '/home/cltbld', 20:20:49 INFO - 'LANG': 'en_US.UTF-8', 20:20:49 INFO - 'LANGUAGE': 'en_US:en', 20:20:49 INFO - 'LOGNAME': 'cltbld', 20:20:49 INFO - 'MAIL': '/var/mail/cltbld', 20:20:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:20:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:49 INFO - 'MOZ_NO_REMOTE': '1', 20:20:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:49 INFO - 'NO_EM_RESTART': '1', 20:20:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:49 INFO - 'PWD': '/builds/slave/test', 20:20:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:20:49 INFO - 'SHELL': '/bin/bash', 20:20:49 INFO - 'SHLVL': '1', 20:20:49 INFO - 'TERM': 'linux', 20:20:49 INFO - 'TMOUT': '86400', 20:20:49 INFO - 'USER': 'cltbld', 20:20:49 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484', 20:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:49 INFO - '_': '/tools/buildbot/bin/python'} 20:20:49 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/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 20:20:49 INFO - mozversion application_buildid: 20160721173021 20:20:49 INFO - mozversion application_changeset: 7ba94e0c5daa48d7667519c930eca31d98648512 20:20:49 INFO - mozversion application_display_name: Nightly 20:20:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:20:49 INFO - mozversion application_name: Firefox 20:20:49 INFO - mozversion application_remotingname: firefox 20:20:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:20:49 INFO - mozversion application_vendor: Mozilla 20:20:49 INFO - mozversion application_version: 50.0a1 20:20:49 INFO - mozversion platform_buildid: 20160721173021 20:20:49 INFO - mozversion platform_changeset: 7ba94e0c5daa48d7667519c930eca31d98648512 20:20:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:20:49 INFO - mozversion platform_version: 50.0a1 20:20:49 INFO - using testdate: 1469157649 20:20:49 INFO - actual date: 1469157649 20:20:49 INFO - starting webserver on 'localhost:56002' 20:20:49 INFO - SUITE-START | Running 2 tests 20:20:49 INFO - TEST-START | dromaeo_css 20:20:49 INFO - operating with platform_type : linux_ 20:20:49 INFO - Initialising browser for dromaeo_css test... 20:20:49 INFO - TEST-INFO | started process 14685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplPCmOO/profile http://localhost:56002/getInfo.html) 20:20:52 INFO - PROCESS | 14685 | JavaScript error: , line 0: uncaught exception: undefined 20:20:53 INFO - PROCESS | 14685 | __metrics Screen width/height:1600/1200 20:20:53 INFO - PROCESS | 14685 | colorDepth:24 20:20:53 INFO - PROCESS | 14685 | Browser inner width/height: 1024/697 20:20:53 INFO - PROCESS | 14685 | __metrics 20:20:54 INFO - PROCESS | 14685 | 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" 20:20:54 INFO - PROCESS | 14685 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:20:55 INFO - TEST-INFO | 14685: exit 0 20:20:55 INFO - Browser initialized. 20:20:55 INFO - Running cycle 1/1 for dromaeo_css test... 20:20:55 INFO - TEST-INFO | started process 14767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplPCmOO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:07 INFO - PROCESS | 14767 | RSS: Main: 157659136 20:21:07 INFO - PROCESS | 14767 | 20:21:58 INFO - PROCESS | 14767 | 1469157718664 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] 20:24:06 INFO - PROCESS | 14767 | Cycle 1(1): loaded http://localhost:56002/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56002/tests/dromaeo/cssquery-ext.html) 20:24:07 INFO - PROCESS | 14767 | RSS: Main: 243064832 20:24:07 INFO - PROCESS | 14767 | 20:27:09 INFO - PROCESS | 14767 | Cycle 1(1): loaded http://localhost:56002/tests/dromaeo/cssquery-ext.html (next: http://localhost:56002/tests/dromaeo/cssquery-jquery.html) 20:27:10 INFO - PROCESS | 14767 | RSS: Main: 247394304 20:27:10 INFO - PROCESS | 14767 | 20:30:12 INFO - PROCESS | 14767 | Cycle 1(1): loaded http://localhost:56002/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56002/tests/dromaeo/cssquery-mootools.html) 20:30:13 INFO - PROCESS | 14767 | RSS: Main: 190984192 20:30:13 INFO - PROCESS | 14767 | 20:33:14 INFO - PROCESS | 14767 | Cycle 1(1): loaded http://localhost:56002/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56002/tests/dromaeo/cssquery-prototype.html) 20:33:15 INFO - PROCESS | 14767 | RSS: Main: 223412224 20:33:15 INFO - PROCESS | 14767 | 20:36:18 INFO - PROCESS | 14767 | Cycle 1(1): loaded http://localhost:56002/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56002/tests/dromaeo/cssquery-yui.html) 20:36:18 INFO - PROCESS | 14767 | RSS: Main: 191295488 20:36:18 INFO - PROCESS | 14767 | 20:39:21 INFO - PROCESS | 14767 | Cycle 1(1): loaded http://localhost:56002/tests/dromaeo/cssquery-yui.html (next: http://localhost:56002/tests/dromaeo/cssquery-dojo.html) 20:39:21 INFO - PROCESS | 14767 | RSS: Main: 281645056 20:39:21 INFO - PROCESS | 14767 | 20:39:21 INFO - PROCESS | 14767 | __start_tp_report 20:39:21 INFO - PROCESS | 14767 | _x_x_mozilla_page_load 20:39:21 INFO - PROCESS | 14767 | _x_x_mozilla_page_load_details 20:39:21 INFO - PROCESS | 14767 | |i|pagename|runs| 20:39:21 INFO - PROCESS | 14767 | |0;dojo.html;2996.3557835065462;3034.059441573114;3057.25097351149;3059.2810689487965;3069.324748555317;5005.949940500594;5122.948770512294;5182.2226666000115;5276.314079169707;5364.490373414525;5160.870978225546;5229.163333866582;5299.973500132503;5304.098303288441;5368.946310536893;4697.271922851964;4728.503507131753;4759.690620109682;4818.734969576672;4841.927371089428;4763.118823017736;4824.324594556765;4990.725510096943;4992.525710057539;4992.525710057539;4893.7063776173545;4932.975335123319;4939.407271127469;4943.307936888838;4975.4029516457895;4683.508231635663;4707.7881495332795;4711.858644240679;4745.810167593292;4831.710097394168;4705.600023997964;4721.716696998191;4735.786889589976;4788.61691064714;4801.495842936476;5243.737813109329;5263.710495922723;5300.151975683911;5312.2297266896085;5319.521243088102;5339.199120131972;5541.251930989305;5648;5654.067078931971;5658.292713410824;5500.22996780447;5668.461496157858;5671.234383358235;5723.570732195102;5725.026745453283;5271.894562108736;5320.866978325535;5326.014687282865;5326.307580014573;5329.493698098674;5581.6930068845795;5697.287839020122;5748.856278592985;5778.393268706725;5780.682062486603;5456.236126942152;5503.834884953458;5512.531434828004;5512.751926163332;5515.61390702655;5556.055470570012;5592.5805564582815;5596.244506991504;5600.60795744294;5603.075492543685;5396.64921780083;5485.424030476743;5545.611807173459;5567.944320556823;5585.972070139624;5609.0184217761725;5616.887662246732;5627.746751396197;5666.716664166775;5668.26312579362;4269;4293.763842988603;4301.612854843079;4303.289957157034;4342.913141737211;3770.3401904666575;3843.865464708722;3857.363535016747;3875.186210895687;3895.6104389561383;5202.92195617066;5274.4198138204765;5277.23480095384;5303.787848486095;5324.254604355393;5532.5020748132865;5535.418781027934;5536.390996990328;5542.196381524656;5575.581831362664;5180.766865491062;5219.634625576249;5250.264962905197;5261.605379596545;5276.498732620395;4820.060088282751;4862.51374862518;4870.561649451566;4913;4927.039227350704;5787.102999035156;5789.102689083199;5796.333421656479;5798.101294299306;5800.970995145081;5462.781488740565;5507.862303442285;5595.580331475075;5598.972005139948;5633.605647604629;5741.885162296814;5789.421057894177;5792.21805056312;5812.73842677089;5834.124881267844;5473.644213126134;5476.91784623223;5477.45225477465;5483.150111732688;5488;5447.291852059207;5589.720513974366;5590.748416321194;5599.048161812583;5601;5477.726113694379;5538.529225015919;5540.944590554042;5589.664620122806;5591.748371323219;5523;5528.143137813645;5533.170024496358;5537.916931246115;5539.224508568885;5287.920681189862;5297.073012222922;5464.909191028845;5469.288992430958;5469.972650136724;5355.25026496283;5417.864553386039;5441.29263195782;5467.480589344006;5477.096279113902;5306.97346513265;5307.389650190277;5317.042932272228;5317.973410132925;5319.255304257485 20:39:21 INFO - PROCESS | 14767 | |1;ext.html;588.1002066837739;608.5527137553897;612;619.5074915442223;620.1163342237311;30567.38865222697;33306.167345816364;33311.666883331156;43648.34527482082;44911.326330105076;46494.30258546124;46967.530324696745;47018.52981470184;47085.29372059422;47097.764511177484;8986.82026359474;9152.542372881362;9154.633814647439;9155.084491550859;9155.72532824013;8104;8969.14793094655;9070.229030532413;10417.374957502536;10672.146228301717;10479.84280235797;10573.841392379121;10584.3649381037;10584.735381615445;10594.152467802596;10888.074513666308;10946.39794811285;10947.50736216872;10958.726031849228;10966.342019478778;8018.198180181994;10253.487325633689;10589.947050264776;10596.735081622945;10722;43723;44038.55961440376;44055.77972110151;44084.779576101915;44188;3550.5916819565823;3565.322588708137;3613.5121758562523;3652.0687224757517;3715.702743780518;29881.551776723365;30178.54732179019;30182.54726179087;30206.24484387886;30307.242318942204;4379.386885835986;4438.977805110953;4479.238529450001;4482.282834746457;4531.161735079021;367796;369117;374184;374629;375369;58782.11826822601;59142;59233.70383148057;59250;59261.70369148213;61108.69445652743;61917.380826192064;62192.37807621956;62201.68899155475;62377;16740.49778506647;17070.914645426943;17108.82891171097;17122;17133.400330988356;12729.299888506035;12967.870321296667;12972.481100756053;13065;13139.408726607326;13982.650433739034;15279.847201527842;15709.371625135094;15721.764173537405;16237.188140592923;5621.297337832771;5720.221055979717;5825.912611310834;5846.356900740915;5875.529957603381;969.3263182088381;1045.1743122932799;1070.7002039428817;1119.7928383248961;1128.3568366031448;32976.67023329784;33332.83335083309;33334.49998250028;33348.49977250343;33525;1083.7399024234128;1157.6295585412756;1158.924669896471;1185.2947496239724;1227.1961864978452;16938.15309234558;17060.31758729637;17290.481285561455;17336.219870105622;17364.565885852702;577128;584550;587340;592134;592522;58489.12266316009;58955;58960.115598266064;58965;59003;1294.210531575738;1339.8861096806882;1352.6280272924828;1354.6951935814363;1359.1709057474932;30226.25788909158;32636.347273053932;32653.673463266012;33063.850849694696;33283.83655062413;51619.2257116136;55476.44523554713;57124.71437642785;57167.14249286347;61220;506821;508020;509639;510131;511268;24030.27909162728;26386;27908.44183116367;28225.43549128965;28346.433071338044;43619.345709813744;48210.27684584664;48319.5168048315;48477.27284090812;49202.50797491979;40143.39784903287;40469.797651012734;41241.58758412377;41316.1736765269;42417.575824242595;40274.59725402708;41222.79388603038;41381.37927931023;41934;42235.155296893274;40527.392089119276;40891.47965024684;41052.384214237405;41721.58278417177;42002.57997419986;35691.46462803112;37168.2736798113;37195.6280437203;37455.25089498249;37478;27980.720192797813;28355;28532.286692832844;28561.428771424038;28705.42589148247 20:39:21 INFO - PROCESS | 14767 | |2;jquery.html;341.39743352981975;365.4244564810423;369.96670299673025;373.4957806960603;386.5149237706678;14340.4980825671;18580.721289180656;19383.90308048461;20346.389608311736;20612.484687882774;19132.234710611592;19485.97967315065;19935.202591896308;20004.899975500102;20109.497262568442;5575;5824.126381042835;5831.183634291203;5832.970835145839;5838.795642152526;5546.584006199531;5714.771409143629;5720.3135623725;5741.655500669973;5747.913781293284;5688.800891968782;5702.087665973445;5710.057840456319;5711.914321285184;5712.942870571283;5697.6866272355;6167.444929956303;6393.136926514931;6425.261094974091;6546.476281897437;5631.521320687746;5640.900024495225;5742.626729262584;5756.453136951983;5761.942380576183;11942.641720748305;12125.151239413244;12182;12205.145639805218;12216.450259738243;2216.556688662258;2259.2318611672113;2278.065992942902;2295.070496448941;2835.432913417304;8951.328650351184;9399.013103624158;9411.341206115574;12908.548200812926;13061.020423468279;1810.1582764014665;1870.1771220662865;1891.5176629959271;1954.3355259211794;1982.0387112250546;70522.64738676324;81768;81836;83141.58429207875;83987.5800620993;10242.385456872611;10280.794384112276;10283.794324113625;10533.9473302633;10740.462976851282;14412.351444185037;14414.783778243334;14428.567142985727;14441.49454769078;14489.492867749577;7775.222477752292;8074.677012919417;8095.83808323842;8144.104148543655;8265.421420500628;7758.262965018314;7841.215878412113;7871.803204919808;8071.434999549975;8088.191180881865;3864.1885204107452;3893.124047089439;3970.4838371011583;3980.3034468968394;4455.688101832905;1612.475945317753;1722.7415887616958;1753.097154965194;1775.343123044456;1783.6967715488397;768.2624680306856;900.2572877376191;980.1032055669126;1003.3127307794184;1095.5562996986234;19302.806971930102;19517.316893908646;19601.411957641292;19617;19755;957.4159762544842;978.3396207559869;988;1012.1599072769584;1117.0560876059717;10243.79578003704;10903.945480272549;10917.454127293762;10953.780924381468;11023.503942322615;498469;502503;502822;504385;514191;87908.56045719731;89680.5515972416;90412;90941.54529227312;92109.53945230231;1021.6934919524113;1030.3817709374316;1031.9432431216205;1043.88517263101;1058.8200005999;16617.667646646758;17075.80869220103;17323.220455079805;17433.389831355842;17580.648387032445;30649.54025689661;31747.84126079355;40293.79853100833;40952.385714214906;42188.82705008952;55643.721781390836;57295.42704572901;57417;57852;58037.41962580489;7318.377937875341;7695.2304769524835;7705.961470192838;7756.806079848049;8178.67285308581;10191.643292484727;12194.939025304817;12305.323207223688;12549;12639.304838233986;10804.67585972422;11060.778784424427;11133.220674552704;11329.150313726668;11547.94226028898;10591.576336946744;10944.288621239593;11038.889611103787;11291.209615326849;11406.258593191416;11053.28153670009;11069.169812263952;11091.833622495831;11111.777764444505;11212;7619.733309334369;7782.922170778446;7812.765617031499;7833.09919359281;8362.707305244287;7880.527168369917;10835.295705779099;10950.233483656068;10970.506327215135;11291 20:39:21 INFO - PROCESS | 14767 | |3;mootools.html;1415.5045733993104;1495.1253516692736;1596.984030159698;1745.7119575270065;1784.2506147418082;8192.631331590077;8667.263282620977;8672.956635216815;8676.696315628955;8681.826363472735;7498.137714162873;8085.71699990499;8351.164883511647;8383.958080209606;8487.151284871525;2350.5651454480976;2378.6550950112223;2380;2382.3686723018413;2382.833201675883;2338.4270853640796;2350.059976009593;2386.713594368678;2387.200287903546;2391.497785465054;2355.95288094238;2361.929142125739;2372.406898275431;2403.6875206223167;2403.795677367426;2301.505176387068;2317.2237300504353;2321.1991862807304;2322.907083716658;2323.744388117297;2297.218945558501;2305.13557415969;2307.9307620771237;2308.515211805523;2311.9884400578057;8571.914280857236;8610.569471526462;8618.956905215497;8636.913630863673;8643.481391116553;5001.524855138756;5240.213967904845;5242.030224408497;5243.082460569423;5250.737463126867;3200.3279311344645;3382.3404436134965;3427.2631384252504;3443.9827800860835;3464.1512829356716;1118.2395970739894;1121.7307846116955;1188.8751681073536;1189.7679952409283;1200.5017917564287;11778.941105294418;11797.351145686984;11844.526218951232;11844.585439509576;11850.525978960832;4346.565343465628;4481.641468682563;4653.697509661861;4659.161350956792;4665.883352916204;9921.80156396868;9942.80114397708;10001.34991225568;10022.047905448972;10029.598816047423;5244.895102097937;5244.921326180111;5248.160294352885;5249;5255;4200.936985945214;4572.222722137245;4736.313234580966;4782.234842425195;4814.5907597853875;3813.504244448204;3840.327942610088;3952.446657467957;4000.2199571083943;4012.9799351003644;1238.6965193527644;1243.5274595653593;1247.114548670436;1256.2713626096843;1274.4519856461625;867.3191544637556;868.491932219646;934.7195841247599;973.0075323170327;980.54404701814;5519.39286678465;5714.285714285715;5807.796727114531;5933.762649494059;6026.126211699367;948.9952550237205;982.7543114221445;998.1565577087349;1008.8839783424853;1022.943738094412;3852.749571277914;3899.5710471848074;3947.250022495774;4023.376376661622;4075.551689314173;10197;10590.417527035934;10663.200259980378;10674.893251067546;10676.839847402296;10349.63776267827;10604.628837990633;10674.199435042403;10675.57297708083;10685.145188384911;7912.0505539335645;7931;7995.120536740954;8024.358051355995;8035.236652518119;5607.214989901336;5609.354924183771;5647.661140331593;5662.546996240373;5836.387179346278;9627.374220675634;9682.951585242028;9707.077827606367;9730.075642813921;9798.706038818562;9863.309568330147;10042.14641755459;10061.597536098474;10143.847842282225;10166;6219.191505104308;7045.048918395951;7160.391366733677;7284.235155308616;7423.146338171179;8103.230193131643;8306.792330191794;8348.666053357798;8352.58237088131;8353.33173346143;7371.152317483558;7543.849123017619;7544.321011109027;7566.659500322608;7609.429292803173;7294.562326260229;7361.153467351323;7444.106707195171;7447.851042979219;7551.282628150317;6850.862982740417;6937.236903940663;6963.09479767627;6965.094537710065;7015.438764898694;4905.313256144214;5019.096562618618;5106.821261255986;5186.09243382399;5268.762905669178;5096.261042148942;5209.661372010807;5241.191788832846;5276.630635855453;5546.584006199632 20:39:21 INFO - PROCESS | 14767 | |4;prototype.html;303.13455085730254;307.5218035954091;316.389368518759;316.5394351218976;317.4381345019316;5277.947220527793;5304.973475132619;5306.151015837467;5308.044551980647;5343.145096784515;4964.156093464111;5059.6458247922565;5222.529972302492;5257.579393648509;5258.368995720519;4110.856120035799;4133.090720041601;4134.73124246923;4139.337705967046;4159;4125.711200215986;4126.195391898581;4127.793610319487;4134.8139333729905;4140.668746500272;3861.382178851384;3924.274009308273;4095.0990782027907;4099.6720262379085;4113.341865301552;4088.5281298732434;4094.5905409459115;4108.6918481114035;4108.917821643566;4121.958780412202;3621.4024685926793;3626.38351480249;3629.219717760694;3630.3828349180703;3637.8181090945345;5048.112803876886;5067.9746601267125;5078.771455284521;5157.524388293603;5166.844994650167;4605.332226827091;4624.167649823031;4647.60495357895;4652.441706995149;4687.250039993619;5431.34823821144;5437.429069947678;5445.237666726662;5492.725363731797;5506.146547285177;3683.7421380503374;3849.3648547989546;3926.823292951824;3975.2248311579256;3991.8004099794894;5639.774409023634;5675.886482270373;5689.345725241609;5696.430356964312;5698.145278208261;3961.771850726284;3967.2263908537557;3978.6220309071173;3979.9801000994808;4006.318925782624;3881.7865017423746;4027.9798601006805;4029.576894426043;4032.1129351542613;4033.8184781684895;4539.978504836451;4562.977185114053;4563.612092972068;4568.748718820497;4588.747618880927;5467.343918729698;5489.890202195934;5491.450854914477;5512.39363670004;5520;1368.8152099466645;1370.5751217122724;1374.182361494909;1386.1336664584635;1390.4994202087241;939.220447028978;972.4554249620236;975.9316847820585;984.2568860510269;986.8865080515833;5293.497117773805;5300.946990530122;5343.5457986071615;5346.4118946915805;5383.703896285742;5463.3717122530625;5513.373554801343;5546.805861794818;5593.804216852391;5617.775288988395;5242.423333433319;5266.183741520071;5345.358556973188;5361.678299302054;5374.435684253175;2969.1389497045616;2970.50986587215;2972.301509145349;2987.536931775535;3009.864556094981;5601.5238704710555;5731.799387021434;5826.76692932278;5838.620489668158;5856.238688970492;5661.235733176051;5666.631668941505;5669.299210236995;5684.261046063985;5694.981659720354;5732.111522713986;5768.163616275617;5789.407912823923;5841.028100891434;5852.765889364463;5386;5572.192032155396;5602.1036634138345;5616.85957851057;5632.436756324335;5547.306586676666;5551.278333816578;5554.861128471821;5559.527440167631;5571.749271282721;5584.654445132973;5813.3895940925595;5827.621204621686;5831.1544826000845;5837.620554663933;3914.6672532835028;3944.230874979466;3973.264945985002;3974.4634474345594;3978.104926391539;5428.83713488596;5550.361708403585;5667.4615911488345;5676.829695108988;5678.176664383724;5525.668459892419;5529.474699903502;5536.252605898152;5540.944590554204;5540.97491963988;5471.2887324647545;5496.790706044664;5507.642003269774;5516.393196748274;5531.280933478622;5259.763310650953;5467.4532546745;5522.337319521683;5523.337199536081;5533.418991005887;5593.8321850344555;5599.244102046172;5600.35595906476;5610.803621873215;5616.269884914935;5180.792768289226;5422.48486393792;5481.479259470344;5504.614676972574;5507.642003269774 20:39:21 INFO - PROCESS | 14767 | |5;yui.html;760.5880692650123;819.2263748983451;834.9332053435726;859.2438653984497;890.6214858685059;15653.452129175466;16763.497095087136;16873.325066997306;16916.15419229038;16960.57598560035;14679.339429725662;14777.704445911102;14891.627709307246;14988.175650339226;15026.699466010701;807.676929228309;823.2672921100226;826.2481142160635;826.7395770332326;826.7891687619649;676.2459857259146;794.0590400375545;826.2893911236332;831.0359982420393;833.1668331668332;870.8737233101197;873.9344549158839;874.0254616103031;876.4390789894472;877.9604917778684;860.191420065143;861.3496809908511;861.3970220845371;862.3273846399818;867.5532100968006;501.8670052436107;606.6633018674634;625.9374062593704;632.34552238433;634.8984162534018;15161.241937903062;15265.923670381577;15267.160306183156;15277.770833437507;15283.617909552238;14366.41404547181;14564.417423303055;15010.474633387888;15213.31540080688;15260.31328590216;13466.528671496451;13487.797683034762;13650.590482285548;13665.248411337372;13733.45066197351;3769.6984241260634;4101.815418306153;4459.866204013885;4548.476925153616;4588.403507543998;73611;74739.62630186869;74806.62596687036;75531.24468755297;75532;11569.88430115705;11613;11635.360055196876;11779.88220117805;11934.4766009238;20465.79534204639;20504.282350117675;20509.718445048722;20540.17839286412;20570.79429205689;8373.1626837317;8418.579071046423;8532.8720069199;8573.871391929126;8733.868991965126;4751.904961900743;4760.95239047612;4782.593479554277;4822.517748225149;5001.224810154432;3234;3306.7850589711593;3308.239105005814;3309.1065412338535;3316.2538428853795;605.5639939243738;616.5468380740152;628.522323034497;629.3014753623474;629.85513331933;662.2913482573696;689.069755829636;698.5983059740568;722.158495835617;734.6657270941708;9754.317197796086;10217.74455638615;10237.48812559369;10440.164786817037;10491.790164196826;689.334791925784;712.6686090967725;717.6089031477857;718.7556230881526;724.822418507469;4536.206163921301;4654.301854721751;4893.192623217129;4925.927942464876;4941.678790878582;64245.67877160678;65191.67404163044;104117;115756;123900;60425.39574604198;61269;64040.35959640344;98357.50821245847;101538;87254;89295;89577;90861.54569227244;92981;9055.68305109318;9377.249820014518;9400.670976516063;9453.33826632129;9482.905170948203;52405;52497.21254181114;52781.20828187657;53789;54387.640308992595;64600.35399645943;64871;74993.25006749862;75697.24302756901;78917;11665.533378664759;11743.94657389102;12016.399180040788;12239.32683702405;12404.503819847467;15092.471763488225;15257.923710381821;16032.27854746516;16131.11278879626;16168.434104806276;14290.28548572588;14374;14678;14695.853041469449;14948.85051149518;13969.231692256617;14336.949610554793;14511;14592.927035364755;15074.547763566672;14054.578362649137;14559.708805823613;14601.488947886774;14653;14971.550853474413;11906.107041971714;12024.398780061138;12238.449269782703;12363.443645036175;12570.434330455335;10586.928475719365;12028.63914082579;12293;12450.564230251897;12999.545015924397 20:39:21 INFO - PROCESS | 14767 | __end_tp_report 20:39:21 INFO - PROCESS | 14767 | __start_cc_report 20:39:21 INFO - PROCESS | 14767 | _x_x_mozilla_cycle_collect,939 20:39:21 INFO - PROCESS | 14767 | __end_cc_report 20:39:21 INFO - PROCESS | 14767 | __startTimestamp1469158761900__endTimestamp 20:39:21 INFO - PROCESS | 14767 | 20:39:21 INFO - PROCESS | 14767 | ------- Summary: start ------- 20:39:21 INFO - PROCESS | 14767 | Number of tests: 6 20:39:21 INFO - PROCESS | 14767 | 20:39:21 INFO - PROCESS | 14767 | [#0] dojo.html Cycles:165 Average:5209.29 Median:5364.49 stddev:577.06 (10.8%) stddev-sans-first:552.10 20:39:21 INFO - PROCESS | 14767 | Values: 2996.4 3034.1 3057.3 3059.3 3069.3 5005.9 5122.9 5182.2 5276.3 5364.5 5160.9 5229.2 5300.0 5304.1 5368.9 4697.3 4728.5 4759.7 4818.7 4841.9 4763.1 4824.3 4990.7 4992.5 4992.5 4893.7 4933.0 4939.4 4943.3 4975.4 4683.5 4707.8 4711.9 4745.8 4831.7 4705.6 4721.7 4735.8 4788.6 4801.5 5243.7 5263.7 5300.2 5312.2 5319.5 5339.2 5541.3 5648.0 5654.1 5658.3 5500.2 5668.5 5671.2 5723.6 5725.0 5271.9 5320.9 5326.0 5326.3 5329.5 5581.7 5697.3 5748.9 5778.4 5780.7 5456.2 5503.8 5512.5 5512.8 5515.6 5556.1 5592.6 5596.2 5600.6 5603.1 5396.6 5485.4 5545.6 5567.9 5586.0 5609.0 5616.9 5627.7 5666.7 5668.3 4269.0 4293.8 4301.6 4303.3 4342.9 3770.3 3843.9 3857.4 3875.2 3895.6 5202.9 5274.4 5277.2 5303.8 5324.3 5532.5 5535.4 5536.4 5542.2 5575.6 5180.8 5219.6 5250.3 5261.6 5276.5 4820.1 4862.5 4870.6 4913.0 4927.0 5787.1 5789.1 5796.3 5798.1 5801.0 5462.8 5507.9 5595.6 5599.0 5633.6 5741.9 5789.4 5792.2 5812.7 5834.1 5473.6 5476.9 5477.5 5483.2 5488.0 5447.3 5589.7 5590.7 5599.0 5601.0 5477.7 5538.5 5540.9 5589.7 5591.7 5523.0 5528.1 5533.2 5537.9 5539.2 5287.9 5297.1 5464.9 5469.3 5470.0 5355.3 5417.9 5441.3 5467.5 5477.1 5307.0 5307.4 5317.0 5318.0 5319.3 20:39:21 INFO - PROCESS | 14767 | 20:39:21 INFO - PROCESS | 14767 | [#1] ext.html Cycles:180 Average:64528.42 Median:206053.50 stddev:132307.47 (64.2%) stddev-sans-first:132591.53 20:39:21 INFO - PROCESS | 14767 | Values: 588.1 608.6 612.0 619.5 620.1 30567.4 33306.2 33311.7 43648.3 44911.3 46494.3 46967.5 47018.5 47085.3 47097.8 8986.8 9152.5 9154.6 9155.1 9155.7 8104.0 8969.1 9070.2 10417.4 10672.1 10479.8 10573.8 10584.4 10584.7 10594.2 10888.1 10946.4 10947.5 10958.7 10966.3 8018.2 10253.5 10589.9 10596.7 10722.0 43723.0 44038.6 44055.8 44084.8 44188.0 3550.6 3565.3 3613.5 3652.1 3715.7 29881.6 30178.5 30182.5 30206.2 30307.2 4379.4 4439.0 4479.2 4482.3 4531.2 367796.0 369117.0 374184.0 374629.0 375369.0 58782.1 59142.0 59233.7 59250.0 59261.7 61108.7 61917.4 62192.4 62201.7 62377.0 16740.5 17070.9 17108.8 17122.0 17133.4 12729.3 12967.9 12972.5 13065.0 13139.4 13982.7 15279.8 15709.4 15721.8 16237.2 5621.3 5720.2 5825.9 5846.4 5875.5 969.3 1045.2 1070.7 1119.8 1128.4 32976.7 33332.8 33334.5 33348.5 33525.0 1083.7 1157.6 1158.9 1185.3 1227.2 16938.2 17060.3 17290.5 17336.2 17364.6 577128.0 584550.0 587340.0 592134.0 592522.0 58489.1 58955.0 58960.1 58965.0 59003.0 1294.2 1339.9 1352.6 1354.7 1359.2 30226.3 32636.3 32653.7 33063.9 33283.8 51619.2 55476.4 57124.7 57167.1 61220.0 506821.0 508020.0 509639.0 510131.0 511268.0 24030.3 26386.0 27908.4 28225.4 28346.4 43619.3 48210.3 48319.5 48477.3 49202.5 40143.4 40469.8 41241.6 41316.2 42417.6 40274.6 41222.8 41381.4 41934.0 42235.2 40527.4 40891.5 41052.4 41721.6 42002.6 35691.5 37168.3 37195.6 37455.3 37478.0 27980.7 28355.0 28532.3 28561.4 28705.4 20:39:21 INFO - PROCESS | 14767 | 20:39:21 INFO - PROCESS | 14767 | [#2] jquery.html Cycles:180 Average:28691.45 Median:31198.69 stddev:83125.41 (266.4%) stddev-sans-first:83331.34 20:39:21 INFO - PROCESS | 14767 | Values: 341.4 365.4 370.0 373.5 386.5 14340.5 18580.7 19383.9 20346.4 20612.5 19132.2 19486.0 19935.2 20004.9 20109.5 5575.0 5824.1 5831.2 5833.0 5838.8 5546.6 5714.8 5720.3 5741.7 5747.9 5688.8 5702.1 5710.1 5711.9 5712.9 5697.7 6167.4 6393.1 6425.3 6546.5 5631.5 5640.9 5742.6 5756.5 5761.9 11942.6 12125.2 12182.0 12205.1 12216.5 2216.6 2259.2 2278.1 2295.1 2835.4 8951.3 9399.0 9411.3 12908.5 13061.0 1810.2 1870.2 1891.5 1954.3 1982.0 70522.6 81768.0 81836.0 83141.6 83987.6 10242.4 10280.8 10283.8 10533.9 10740.5 14412.4 14414.8 14428.6 14441.5 14489.5 7775.2 8074.7 8095.8 8144.1 8265.4 7758.3 7841.2 7871.8 8071.4 8088.2 3864.2 3893.1 3970.5 3980.3 4455.7 1612.5 1722.7 1753.1 1775.3 1783.7 768.3 900.3 980.1 1003.3 1095.6 19302.8 19517.3 19601.4 19617.0 19755.0 957.4 978.3 988.0 1012.2 1117.1 10243.8 10903.9 10917.5 10953.8 11023.5 498469.0 502503.0 502822.0 504385.0 514191.0 87908.6 89680.6 90412.0 90941.5 92109.5 1021.7 1030.4 1031.9 1043.9 1058.8 16617.7 17075.8 17323.2 17433.4 17580.6 30649.5 31747.8 40293.8 40952.4 42188.8 55643.7 57295.4 57417.0 57852.0 58037.4 7318.4 7695.2 7706.0 7756.8 8178.7 10191.6 12194.9 12305.3 12549.0 12639.3 10804.7 11060.8 11133.2 11329.2 11547.9 10591.6 10944.3 11038.9 11291.2 11406.3 11053.3 11069.2 11091.8 11111.8 11212.0 7619.7 7782.9 7812.8 7833.1 8362.7 7880.5 10835.3 10950.2 10970.5 11291.0 20:39:21 INFO - PROCESS | 14767 | 20:39:21 INFO - PROCESS | 14767 | [#3] mootools.html Cycles:180 Average:5658.47 Median:5010.31 stddev:3156.43 (63.0%) stddev-sans-first:3149.18 20:39:21 INFO - PROCESS | 14767 | Values: 1415.5 1495.1 1597.0 1745.7 1784.3 8192.6 8667.3 8673.0 8676.7 8681.8 7498.1 8085.7 8351.2 8384.0 8487.2 2350.6 2378.7 2380.0 2382.4 2382.8 2338.4 2350.1 2386.7 2387.2 2391.5 2356.0 2361.9 2372.4 2403.7 2403.8 2301.5 2317.2 2321.2 2322.9 2323.7 2297.2 2305.1 2307.9 2308.5 2312.0 8571.9 8610.6 8619.0 8636.9 8643.5 5001.5 5240.2 5242.0 5243.1 5250.7 3200.3 3382.3 3427.3 3444.0 3464.2 1118.2 1121.7 1188.9 1189.8 1200.5 11778.9 11797.4 11844.5 11844.6 11850.5 4346.6 4481.6 4653.7 4659.2 4665.9 9921.8 9942.8 10001.3 10022.0 10029.6 5244.9 5244.9 5248.2 5249.0 5255.0 4200.9 4572.2 4736.3 4782.2 4814.6 3813.5 3840.3 3952.4 4000.2 4013.0 1238.7 1243.5 1247.1 1256.3 1274.5 867.3 868.5 934.7 973.0 980.5 5519.4 5714.3 5807.8 5933.8 6026.1 949.0 982.8 998.2 1008.9 1022.9 3852.7 3899.6 3947.3 4023.4 4075.6 10197.0 10590.4 10663.2 10674.9 10676.8 10349.6 10604.6 10674.2 10675.6 10685.1 7912.1 7931.0 7995.1 8024.4 8035.2 5607.2 5609.4 5647.7 5662.5 5836.4 9627.4 9683.0 9707.1 9730.1 9798.7 9863.3 10042.1 10061.6 10143.8 10166.0 6219.2 7045.0 7160.4 7284.2 7423.1 8103.2 8306.8 8348.7 8352.6 8353.3 7371.2 7543.8 7544.3 7566.7 7609.4 7294.6 7361.2 7444.1 7447.9 7551.3 6850.9 6937.2 6963.1 6965.1 7015.4 4905.3 5019.1 5106.8 5186.1 5268.8 5096.3 5209.7 5241.2 5276.6 5546.6 20:39:21 INFO - PROCESS | 14767 | 20:39:21 INFO - PROCESS | 14767 | [#4] prototype.html Cycles:180 Average:4621.11 Median:5343.35 stddev:1361.03 (25.5%) stddev-sans-first:1325.70 20:39:21 INFO - PROCESS | 14767 | Values: 303.1 307.5 316.4 316.5 317.4 5277.9 5305.0 5306.2 5308.0 5343.1 4964.2 5059.6 5222.5 5257.6 5258.4 4110.9 4133.1 4134.7 4139.3 4159.0 4125.7 4126.2 4127.8 4134.8 4140.7 3861.4 3924.3 4095.1 4099.7 4113.3 4088.5 4094.6 4108.7 4108.9 4122.0 3621.4 3626.4 3629.2 3630.4 3637.8 5048.1 5068.0 5078.8 5157.5 5166.8 4605.3 4624.2 4647.6 4652.4 4687.3 5431.3 5437.4 5445.2 5492.7 5506.1 3683.7 3849.4 3926.8 3975.2 3991.8 5639.8 5675.9 5689.3 5696.4 5698.1 3961.8 3967.2 3978.6 3980.0 4006.3 3881.8 4028.0 4029.6 4032.1 4033.8 4540.0 4563.0 4563.6 4568.7 4588.7 5467.3 5489.9 5491.5 5512.4 5520.0 1368.8 1370.6 1374.2 1386.1 1390.5 939.2 972.5 975.9 984.3 986.9 5293.5 5300.9 5343.5 5346.4 5383.7 5463.4 5513.4 5546.8 5593.8 5617.8 5242.4 5266.2 5345.4 5361.7 5374.4 2969.1 2970.5 2972.3 2987.5 3009.9 5601.5 5731.8 5826.8 5838.6 5856.2 5661.2 5666.6 5669.3 5684.3 5695.0 5732.1 5768.2 5789.4 5841.0 5852.8 5386.0 5572.2 5602.1 5616.9 5632.4 5547.3 5551.3 5554.9 5559.5 5571.7 5584.7 5813.4 5827.6 5831.2 5837.6 3914.7 3944.2 3973.3 3974.5 3978.1 5428.8 5550.4 5667.5 5676.8 5678.2 5525.7 5529.5 5536.3 5540.9 5541.0 5471.3 5496.8 5507.6 5516.4 5531.3 5259.8 5467.5 5522.3 5523.3 5533.4 5593.8 5599.2 5600.4 5610.8 5616.3 5180.8 5422.5 5481.5 5504.6 5507.6 20:39:21 INFO - PROCESS | 14767 | 20:39:21 INFO - PROCESS | 14767 | [#5] yui.html Cycles:180 Average:19913.79 Median:4756.43 stddev:27312.49 (574.2%) stddev-sans-first:27351.24 20:39:21 INFO - PROCESS | 14767 | Values: 760.6 819.2 834.9 859.2 890.6 15653.5 16763.5 16873.3 16916.2 16960.6 14679.3 14777.7 14891.6 14988.2 15026.7 807.7 823.3 826.2 826.7 826.8 676.2 794.1 826.3 831.0 833.2 870.9 873.9 874.0 876.4 878.0 860.2 861.3 861.4 862.3 867.6 501.9 606.7 625.9 632.3 634.9 15161.2 15265.9 15267.2 15277.8 15283.6 14366.4 14564.4 15010.5 15213.3 15260.3 13466.5 13487.8 13650.6 13665.2 13733.5 3769.7 4101.8 4459.9 4548.5 4588.4 73611.0 74739.6 74806.6 75531.2 75532.0 11569.9 11613.0 11635.4 11779.9 11934.5 20465.8 20504.3 20509.7 20540.2 20570.8 8373.2 8418.6 8532.9 8573.9 8733.9 4751.9 4761.0 4782.6 4822.5 5001.2 3234.0 3306.8 3308.2 3309.1 3316.3 605.6 616.5 628.5 629.3 629.9 662.3 689.1 698.6 722.2 734.7 9754.3 10217.7 10237.5 10440.2 10491.8 689.3 712.7 717.6 718.8 724.8 4536.2 4654.3 4893.2 4925.9 4941.7 64245.7 65191.7 104117.0 115756.0 123900.0 60425.4 61269.0 64040.4 98357.5 101538.0 87254.0 89295.0 89577.0 90861.5 92981.0 9055.7 9377.2 9400.7 9453.3 9482.9 52405.0 52497.2 52781.2 53789.0 54387.6 64600.4 64871.0 74993.3 75697.2 78917.0 11665.5 11743.9 12016.4 12239.3 12404.5 15092.5 15257.9 16032.3 16131.1 16168.4 14290.3 14374.0 14678.0 14695.9 14948.9 13969.2 14336.9 14511.0 14592.9 15074.5 14054.6 14559.7 14601.5 14653.0 14971.6 11906.1 12024.4 12238.4 12363.4 12570.4 10586.9 12028.6 12293.0 12450.6 12999.5 20:39:21 INFO - PROCESS | 14767 | -------- Summary: end -------- 20:39:21 INFO - PROCESS | 14767 | 20:39:22 INFO - TEST-INFO | 14767: exit 0 20:39:22 INFO - TEST-OK | dromaeo_css | took 1113436ms 20:39:22 INFO - TEST-START | kraken 20:39:22 INFO - operating with platform_type : linux_ 20:39:22 INFO - Initialising browser for kraken test... 20:39:22 INFO - TEST-INFO | started process 14949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXyYayB/profile http://localhost:56002/getInfo.html) 20:39:25 INFO - PROCESS | 14949 | JavaScript error: , line 0: uncaught exception: undefined 20:39:26 INFO - PROCESS | 14949 | __metrics Screen width/height:1600/1200 20:39:26 INFO - PROCESS | 14949 | colorDepth:24 20:39:26 INFO - PROCESS | 14949 | Browser inner width/height: 1024/697 20:39:26 INFO - PROCESS | 14949 | __metrics 20:39:27 INFO - PROCESS | 14949 | 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" 20:39:27 INFO - PROCESS | 14949 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:39:27 INFO - PROCESS | 14949 | console.error: PushService: 20:39:27 INFO - PROCESS | 14949 | stateChangeProcessEnqueue: Error transitioning state 20:39:27 INFO - PROCESS | 14949 | UnknownError 20:39:28 INFO - TEST-INFO | 14949: exit 0 20:39:28 INFO - Browser initialized. 20:39:28 INFO - Running cycle 1/1 for kraken test... 20:39:28 INFO - TEST-INFO | started process 15030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXyYayB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:39:40 INFO - PROCESS | 15030 | RSS: Main: 158322688 20:39:40 INFO - PROCESS | 15030 | 20:39:42 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56002/tests/kraken/driver.html?testName=audio-beat-detection) 20:39:43 INFO - PROCESS | 15030 | RSS: Main: 214753280 20:39:43 INFO - PROCESS | 15030 | 20:39:46 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56002/tests/kraken/driver.html?testName=audio-dft) 20:39:46 INFO - PROCESS | 15030 | RSS: Main: 192425984 20:39:46 INFO - PROCESS | 15030 | 20:39:49 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56002/tests/kraken/driver.html?testName=audio-fft) 20:39:50 INFO - PROCESS | 15030 | RSS: Main: 271380480 20:39:50 INFO - PROCESS | 15030 | 20:39:52 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56002/tests/kraken/driver.html?testName=audio-oscillator) 20:39:53 INFO - PROCESS | 15030 | RSS: Main: 180097024 20:39:53 INFO - PROCESS | 15030 | 20:39:55 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56002/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:39:56 INFO - PROCESS | 15030 | RSS: Main: 185257984 20:39:56 INFO - PROCESS | 15030 | 20:39:59 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56002/tests/kraken/driver.html?testName=imaging-darkroom) 20:39:59 INFO - PROCESS | 15030 | RSS: Main: 220033024 20:39:59 INFO - PROCESS | 15030 | 20:40:03 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56002/tests/kraken/driver.html?testName=imaging-desaturate) 20:40:03 INFO - PROCESS | 15030 | RSS: Main: 220590080 20:40:03 INFO - PROCESS | 15030 | 20:40:06 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56002/tests/kraken/driver.html?testName=json-parse-financial) 20:40:07 INFO - PROCESS | 15030 | RSS: Main: 220995584 20:40:07 INFO - PROCESS | 15030 | 20:40:08 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56002/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:40:09 INFO - PROCESS | 15030 | RSS: Main: 185122816 20:40:09 INFO - PROCESS | 15030 | 20:40:10 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56002/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:40:11 INFO - PROCESS | 15030 | RSS: Main: 190173184 20:40:11 INFO - PROCESS | 15030 | 20:40:13 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56002/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:40:14 INFO - PROCESS | 15030 | RSS: Main: 195272704 20:40:14 INFO - PROCESS | 15030 | 20:40:16 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56002/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:40:17 INFO - PROCESS | 15030 | RSS: Main: 190279680 20:40:17 INFO - PROCESS | 15030 | 20:40:19 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56002/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:40:20 INFO - PROCESS | 15030 | RSS: Main: 193585152 20:40:20 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | Cycle 1(1): loaded http://localhost:56002/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56002/tests/kraken/driver.html?testName=ai-astar) 20:40:22 INFO - PROCESS | 15030 | RSS: Main: 244690944 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | __start_tp_report 20:40:22 INFO - PROCESS | 15030 | _x_x_mozilla_page_load 20:40:22 INFO - PROCESS | 15030 | _x_x_mozilla_page_load_details 20:40:22 INFO - PROCESS | 15030 | |i|pagename|runs| 20:40:22 INFO - PROCESS | 15030 | |0;ai-astar;103;113;112;112;111;111;111;113;114;112 20:40:22 INFO - PROCESS | 15030 | |1;audio-beat-detection;142;117;119;185;122;118;142;118;155;117 20:40:22 INFO - PROCESS | 15030 | |2;audio-dft;160;161;160;160;160;160;163;161;161;161 20:40:22 INFO - PROCESS | 15030 | |3;audio-fft;73;75;76;110;75;75;74;75;109;74 20:40:22 INFO - PROCESS | 15030 | |4;audio-oscillator;83;82;126;83;83;83;118;83;83;129 20:40:22 INFO - PROCESS | 15030 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;116;117;116 20:40:22 INFO - PROCESS | 15030 | |6;imaging-darkroom;145;147;145;146;146;146;145;146;148;146 20:40:22 INFO - PROCESS | 15030 | |7;imaging-desaturate;94;94;95;95;95;96;95;95;95;95 20:40:22 INFO - PROCESS | 15030 | |8;json-parse-financial;53;54;51;51;52;53;51;52;52;52 20:40:22 INFO - PROCESS | 15030 | |9;json-stringify-tinderbox;63;63;61;63;62;62;63;63;64;64 20:40:22 INFO - PROCESS | 15030 | |10;stanford-crypto-aes;76;76;75;76;75;75;75;75;78;79 20:40:22 INFO - PROCESS | 15030 | |11;stanford-crypto-ccm;121;130;121;128;120;119;120;118;163;129 20:40:22 INFO - PROCESS | 15030 | |12;stanford-crypto-pbkdf2;157;159;153;151;159;158;152;155;157;154 20:40:22 INFO - PROCESS | 15030 | |13;stanford-crypto-sha256-iterative;62;61;64;62;63;63;63;60;64;63 20:40:22 INFO - PROCESS | 15030 | __end_tp_report 20:40:22 INFO - PROCESS | 15030 | __start_cc_report 20:40:22 INFO - PROCESS | 15030 | _x_x_mozilla_cycle_collect,1672 20:40:22 INFO - PROCESS | 15030 | __end_cc_report 20:40:22 INFO - PROCESS | 15030 | __startTimestamp1469158822396__endTimestamp 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | ------- Summary: start ------- 20:40:22 INFO - PROCESS | 15030 | Number of tests: 14 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.05 (2.7%) stddev-sans-first:1.05 20:40:22 INFO - PROCESS | 15030 | Values: 103.0 113.0 112.0 112.0 111.0 111.0 111.0 113.0 114.0 112.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:132.00 stddev:22.67 (17.2%) stddev-sans-first:23.84 20:40:22 INFO - PROCESS | 15030 | Values: 142.0 117.0 119.0 185.0 122.0 118.0 142.0 118.0 155.0 117.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 20:40:22 INFO - PROCESS | 15030 | Values: 160.0 161.0 160.0 160.0 160.0 160.0 163.0 161.0 161.0 161.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:14.73 (19.6%) stddev-sans-first:15.29 20:40:22 INFO - PROCESS | 15030 | Values: 73.0 75.0 76.0 110.0 75.0 75.0 74.0 75.0 109.0 74.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:83.00 stddev:20.22 (24.4%) stddev-sans-first:20.95 20:40:22 INFO - PROCESS | 15030 | Values: 83.0 82.0 126.0 83.0 83.0 83.0 118.0 83.0 83.0 129.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 20:40:22 INFO - PROCESS | 15030 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 20:40:22 INFO - PROCESS | 15030 | Values: 145.0 147.0 145.0 146.0 146.0 146.0 145.0 146.0 148.0 146.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 20:40:22 INFO - PROCESS | 15030 | Values: 94.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.99 (1.9%) stddev-sans-first:1.00 20:40:22 INFO - PROCESS | 15030 | Values: 53.0 54.0 51.0 51.0 52.0 53.0 51.0 52.0 52.0 52.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 20:40:22 INFO - PROCESS | 15030 | Values: 63.0 63.0 61.0 63.0 62.0 62.0 63.0 63.0 64.0 64.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:1.41 (1.9%) stddev-sans-first:1.50 20:40:22 INFO - PROCESS | 15030 | Values: 76.0 76.0 75.0 76.0 75.0 75.0 75.0 75.0 78.0 79.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:124.50 stddev:13.44 (10.8%) stddev-sans-first:14.08 20:40:22 INFO - PROCESS | 15030 | Values: 121.0 130.0 121.0 128.0 120.0 119.0 120.0 118.0 163.0 129.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:157.00 stddev:2.92 (1.9%) stddev-sans-first:3.04 20:40:22 INFO - PROCESS | 15030 | Values: 157.0 159.0 153.0 151.0 159.0 158.0 152.0 155.0 157.0 154.0 20:40:22 INFO - PROCESS | 15030 | 20:40:22 INFO - PROCESS | 15030 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.27 (2.0%) stddev-sans-first:1.33 20:40:22 INFO - PROCESS | 15030 | Values: 62.0 61.0 64.0 62.0 63.0 63.0 63.0 60.0 64.0 63.0 20:40:22 INFO - PROCESS | 15030 | -------- Summary: end -------- 20:40:22 INFO - PROCESS | 15030 | 20:40:23 INFO - TEST-INFO | 15030: exit 0 20:40:23 INFO - TEST-OK | kraken | took 60772ms 20:40:23 INFO - SUITE-END | took 1174s 20:40:23 INFO - Completed test suite (00:19:34) 20:40:23 INFO - javascript benchmark 20:40:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2996.3557835065462, 3034.059441573114, 3057.25097351149, 3059.2810689487965, 3069.324748555317, 5005.949940500594, 5122.948770512294, 5182.2226666000115, 5276.314079169707, 5364.490373414525, 5160.870978225546, 5229.163333866582, 5299.973500132503, 5304.098303288441, 5368.946310536893, 4697.271922851964, 4728.503507131753, 4759.690620109682, 4818.734969576672, 4841.927371089428, 4763.118823017736, 4824.324594556765, 4990.725510096943, 4992.525710057539, 4992.525710057539, 4893.7063776173545, 4932.975335123319, 4939.407271127469, 4943.307936888838, 4975.4029516457895, 4683.508231635663, 4707.7881495332795, 4711.858644240679, 4745.810167593292, 4831.710097394168, 4705.600023997964, 4721.716696998191, 4735.786889589976, 4788.61691064714, 4801.495842936476, 5243.737813109329, 5263.710495922723, 5300.151975683911, 5312.2297266896085, 5319.521243088102, 5339.199120131972, 5541.251930989305, 5648.0, 5654.067078931971, 5658.292713410824, 5500.22996780447, 5668.461496157858, 5671.234383358235, 5723.570732195102, 5725.026745453283, 5271.894562108736, 5320.866978325535, 5326.014687282865, 5326.307580014573, 5329.493698098674, 5581.6930068845795, 5697.287839020122, 5748.856278592985, 5778.393268706725, 5780.682062486603, 5456.236126942152, 5503.834884953458, 5512.531434828004, 5512.751926163332, 5515.61390702655, 5556.055470570012, 5592.5805564582815, 5596.244506991504, 5600.60795744294, 5603.075492543685, 5396.64921780083, 5485.424030476743, 5545.611807173459, 5567.944320556823, 5585.972070139624, 5609.0184217761725, 5616.887662246732, 5627.746751396197, 5666.716664166775, 5668.26312579362, 4269.0, 4293.763842988603, 4301.612854843079, 4303.289957157034, 4342.913141737211, 3770.3401904666575, 3843.865464708722, 3857.363535016747, 3875.186210895687, 3895.6104389561383, 5202.92195617066, 5274.4198138204765, 5277.23480095384, 5303.787848486095, 5324.254604355393, 5532.5020748132865, 5535.418781027934, 5536.390996990328, 5542.196381524656, 5575.581831362664, 5180.766865491062, 5219.634625576249, 5250.264962905197, 5261.605379596545, 5276.498732620395, 4820.060088282751, 4862.51374862518, 4870.561649451566, 4913.0, 4927.039227350704, 5787.102999035156, 5789.102689083199, 5796.333421656479, 5798.101294299306, 5800.970995145081, 5462.781488740565, 5507.862303442285, 5595.580331475075, 5598.972005139948, 5633.605647604629, 5741.885162296814, 5789.421057894177, 5792.21805056312, 5812.73842677089, 5834.124881267844, 5473.644213126134, 5476.91784623223, 5477.45225477465, 5483.150111732688, 5488.0, 5447.291852059207, 5589.720513974366, 5590.748416321194, 5599.048161812583, 5601.0, 5477.726113694379, 5538.529225015919, 5540.944590554042, 5589.664620122806, 5591.748371323219, 5523.0, 5528.143137813645, 5533.170024496358, 5537.916931246115, 5539.224508568885, 5287.920681189862, 5297.073012222922, 5464.909191028845, 5469.288992430958, 5469.972650136724, 5355.25026496283, 5417.864553386039, 5441.29263195782, 5467.480589344006, 5477.096279113902, 5306.97346513265, 5307.389650190277, 5317.042932272228, 5317.973410132925, 5319.255304257485], "value": 5171.142561519843, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.1002066837739, 608.5527137553897, 612.0, 619.5074915442223, 620.1163342237311, 30567.38865222697, 33306.167345816364, 33311.666883331156, 43648.34527482082, 44911.326330105076, 46494.30258546124, 46967.530324696745, 47018.52981470184, 47085.29372059422, 47097.764511177484, 8986.82026359474, 9152.542372881362, 9154.633814647439, 9155.084491550859, 9155.72532824013, 8104.0, 8969.14793094655, 9070.229030532413, 10417.374957502536, 10672.146228301717, 10479.84280235797, 10573.841392379121, 10584.3649381037, 10584.735381615445, 10594.152467802596, 10888.074513666308, 10946.39794811285, 10947.50736216872, 10958.726031849228, 10966.342019478778, 8018.198180181994, 10253.487325633689, 10589.947050264776, 10596.735081622945, 10722.0, 43723.0, 44038.55961440376, 44055.77972110151, 44084.779576101915, 44188.0, 3550.5916819565823, 3565.322588708137, 3613.5121758562523, 3652.0687224757517, 3715.702743780518, 29881.551776723365, 30178.54732179019, 30182.54726179087, 30206.24484387886, 30307.242318942204, 4379.386885835986, 4438.977805110953, 4479.238529450001, 4482.282834746457, 4531.161735079021, 367796.0, 369117.0, 374184.0, 374629.0, 375369.0, 58782.11826822601, 59142.0, 59233.70383148057, 59250.0, 59261.70369148213, 61108.69445652743, 61917.380826192064, 62192.37807621956, 62201.68899155475, 62377.0, 16740.49778506647, 17070.914645426943, 17108.82891171097, 17122.0, 17133.400330988356, 12729.299888506035, 12967.870321296667, 12972.481100756053, 13065.0, 13139.408726607326, 13982.650433739034, 15279.847201527842, 15709.371625135094, 15721.764173537405, 16237.188140592923, 5621.297337832771, 5720.221055979717, 5825.912611310834, 5846.356900740915, 5875.529957603381, 969.3263182088381, 1045.1743122932799, 1070.7002039428817, 1119.7928383248961, 1128.3568366031448, 32976.67023329784, 33332.83335083309, 33334.49998250028, 33348.49977250343, 33525.0, 1083.7399024234128, 1157.6295585412756, 1158.924669896471, 1185.2947496239724, 1227.1961864978452, 16938.15309234558, 17060.31758729637, 17290.481285561455, 17336.219870105622, 17364.565885852702, 577128.0, 584550.0, 587340.0, 592134.0, 592522.0, 58489.12266316009, 58955.0, 58960.115598266064, 58965.0, 59003.0, 1294.210531575738, 1339.8861096806882, 1352.6280272924828, 1354.6951935814363, 1359.1709057474932, 30226.25788909158, 32636.347273053932, 32653.673463266012, 33063.850849694696, 33283.83655062413, 51619.2257116136, 55476.44523554713, 57124.71437642785, 57167.14249286347, 61220.0, 506821.0, 508020.0, 509639.0, 510131.0, 511268.0, 24030.27909162728, 26386.0, 27908.44183116367, 28225.43549128965, 28346.433071338044, 43619.345709813744, 48210.27684584664, 48319.5168048315, 48477.27284090812, 49202.50797491979, 40143.39784903287, 40469.797651012734, 41241.58758412377, 41316.1736765269, 42417.575824242595, 40274.59725402708, 41222.79388603038, 41381.37927931023, 41934.0, 42235.155296893274, 40527.392089119276, 40891.47965024684, 41052.384214237405, 41721.58278417177, 42002.57997419986, 35691.46462803112, 37168.2736798113, 37195.6280437203, 37455.25089498249, 37478.0, 27980.720192797813, 28355.0, 28532.286692832844, 28561.428771424038, 28705.42589148247], "value": 20535.506311927336, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.39743352981975, 365.4244564810423, 369.96670299673025, 373.4957806960603, 386.5149237706678, 14340.4980825671, 18580.721289180656, 19383.90308048461, 20346.389608311736, 20612.484687882774, 19132.234710611592, 19485.97967315065, 19935.202591896308, 20004.899975500102, 20109.497262568442, 5575.0, 5824.126381042835, 5831.183634291203, 5832.970835145839, 5838.795642152526, 5546.584006199531, 5714.771409143629, 5720.3135623725, 5741.655500669973, 5747.913781293284, 5688.800891968782, 5702.087665973445, 5710.057840456319, 5711.914321285184, 5712.942870571283, 5697.6866272355, 6167.444929956303, 6393.136926514931, 6425.261094974091, 6546.476281897437, 5631.521320687746, 5640.900024495225, 5742.626729262584, 5756.453136951983, 5761.942380576183, 11942.641720748305, 12125.151239413244, 12182.0, 12205.145639805218, 12216.450259738243, 2216.556688662258, 2259.2318611672113, 2278.065992942902, 2295.070496448941, 2835.432913417304, 8951.328650351184, 9399.013103624158, 9411.341206115574, 12908.548200812926, 13061.020423468279, 1810.1582764014665, 1870.1771220662865, 1891.5176629959271, 1954.3355259211794, 1982.0387112250546, 70522.64738676324, 81768.0, 81836.0, 83141.58429207875, 83987.5800620993, 10242.385456872611, 10280.794384112276, 10283.794324113625, 10533.9473302633, 10740.462976851282, 14412.351444185037, 14414.783778243334, 14428.567142985727, 14441.49454769078, 14489.492867749577, 7775.222477752292, 8074.677012919417, 8095.83808323842, 8144.104148543655, 8265.421420500628, 7758.262965018314, 7841.215878412113, 7871.803204919808, 8071.434999549975, 8088.191180881865, 3864.1885204107452, 3893.124047089439, 3970.4838371011583, 3980.3034468968394, 4455.688101832905, 1612.475945317753, 1722.7415887616958, 1753.097154965194, 1775.343123044456, 1783.6967715488397, 768.2624680306856, 900.2572877376191, 980.1032055669126, 1003.3127307794184, 1095.5562996986234, 19302.806971930102, 19517.316893908646, 19601.411957641292, 19617.0, 19755.0, 957.4159762544842, 978.3396207559869, 988.0, 1012.1599072769584, 1117.0560876059717, 10243.79578003704, 10903.945480272549, 10917.454127293762, 10953.780924381468, 11023.503942322615, 498469.0, 502503.0, 502822.0, 504385.0, 514191.0, 87908.56045719731, 89680.5515972416, 90412.0, 90941.54529227312, 92109.53945230231, 1021.6934919524113, 1030.3817709374316, 1031.9432431216205, 1043.88517263101, 1058.8200005999, 16617.667646646758, 17075.80869220103, 17323.220455079805, 17433.389831355842, 17580.648387032445, 30649.54025689661, 31747.84126079355, 40293.79853100833, 40952.385714214906, 42188.82705008952, 55643.721781390836, 57295.42704572901, 57417.0, 57852.0, 58037.41962580489, 7318.377937875341, 7695.2304769524835, 7705.961470192838, 7756.806079848049, 8178.67285308581, 10191.643292484727, 12194.939025304817, 12305.323207223688, 12549.0, 12639.304838233986, 10804.67585972422, 11060.778784424427, 11133.220674552704, 11329.150313726668, 11547.94226028898, 10591.576336946744, 10944.288621239593, 11038.889611103787, 11291.209615326849, 11406.258593191416, 11053.28153670009, 11069.169812263952, 11091.833622495831, 11111.777764444505, 11212.0, 7619.733309334369, 7782.922170778446, 7812.765617031499, 7833.09919359281, 8362.707305244287, 7880.527168369917, 10835.295705779099, 10950.233483656068, 10970.506327215135, 11291.0], "value": 8811.996794740766, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.5045733993104, 1495.1253516692736, 1596.984030159698, 1745.7119575270065, 1784.2506147418082, 8192.631331590077, 8667.263282620977, 8672.956635216815, 8676.696315628955, 8681.826363472735, 7498.137714162873, 8085.71699990499, 8351.164883511647, 8383.958080209606, 8487.151284871525, 2350.5651454480976, 2378.6550950112223, 2380.0, 2382.3686723018413, 2382.833201675883, 2338.4270853640796, 2350.059976009593, 2386.713594368678, 2387.200287903546, 2391.497785465054, 2355.95288094238, 2361.929142125739, 2372.406898275431, 2403.6875206223167, 2403.795677367426, 2301.505176387068, 2317.2237300504353, 2321.1991862807304, 2322.907083716658, 2323.744388117297, 2297.218945558501, 2305.13557415969, 2307.9307620771237, 2308.515211805523, 2311.9884400578057, 8571.914280857236, 8610.569471526462, 8618.956905215497, 8636.913630863673, 8643.481391116553, 5001.524855138756, 5240.213967904845, 5242.030224408497, 5243.082460569423, 5250.737463126867, 3200.3279311344645, 3382.3404436134965, 3427.2631384252504, 3443.9827800860835, 3464.1512829356716, 1118.2395970739894, 1121.7307846116955, 1188.8751681073536, 1189.7679952409283, 1200.5017917564287, 11778.941105294418, 11797.351145686984, 11844.526218951232, 11844.585439509576, 11850.525978960832, 4346.565343465628, 4481.641468682563, 4653.697509661861, 4659.161350956792, 4665.883352916204, 9921.80156396868, 9942.80114397708, 10001.34991225568, 10022.047905448972, 10029.598816047423, 5244.895102097937, 5244.921326180111, 5248.160294352885, 5249.0, 5255.0, 4200.936985945214, 4572.222722137245, 4736.313234580966, 4782.234842425195, 4814.5907597853875, 3813.504244448204, 3840.327942610088, 3952.446657467957, 4000.2199571083943, 4012.9799351003644, 1238.6965193527644, 1243.5274595653593, 1247.114548670436, 1256.2713626096843, 1274.4519856461625, 867.3191544637556, 868.491932219646, 934.7195841247599, 973.0075323170327, 980.54404701814, 5519.39286678465, 5714.285714285715, 5807.796727114531, 5933.762649494059, 6026.126211699367, 948.9952550237205, 982.7543114221445, 998.1565577087349, 1008.8839783424853, 1022.943738094412, 3852.749571277914, 3899.5710471848074, 3947.250022495774, 4023.376376661622, 4075.551689314173, 10197.0, 10590.417527035934, 10663.200259980378, 10674.893251067546, 10676.839847402296, 10349.63776267827, 10604.628837990633, 10674.199435042403, 10675.57297708083, 10685.145188384911, 7912.0505539335645, 7931.0, 7995.120536740954, 8024.358051355995, 8035.236652518119, 5607.214989901336, 5609.354924183771, 5647.661140331593, 5662.546996240373, 5836.387179346278, 9627.374220675634, 9682.951585242028, 9707.077827606367, 9730.075642813921, 9798.706038818562, 9863.309568330147, 10042.14641755459, 10061.597536098474, 10143.847842282225, 10166.0, 6219.191505104308, 7045.048918395951, 7160.391366733677, 7284.235155308616, 7423.146338171179, 8103.230193131643, 8306.792330191794, 8348.666053357798, 8352.58237088131, 8353.33173346143, 7371.152317483558, 7543.849123017619, 7544.321011109027, 7566.659500322608, 7609.429292803173, 7294.562326260229, 7361.153467351323, 7444.106707195171, 7447.851042979219, 7551.282628150317, 6850.862982740417, 6937.236903940663, 6963.09479767627, 6965.094537710065, 7015.438764898694, 4905.313256144214, 5019.096562618618, 5106.821261255986, 5186.09243382399, 5268.762905669178, 5096.261042148942, 5209.661372010807, 5241.191788832846, 5276.630635855453, 5546.584006199632], "value": 4571.645074972691, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.13455085730254, 307.5218035954091, 316.389368518759, 316.5394351218976, 317.4381345019316, 5277.947220527793, 5304.973475132619, 5306.151015837467, 5308.044551980647, 5343.145096784515, 4964.156093464111, 5059.6458247922565, 5222.529972302492, 5257.579393648509, 5258.368995720519, 4110.856120035799, 4133.090720041601, 4134.73124246923, 4139.337705967046, 4159.0, 4125.711200215986, 4126.195391898581, 4127.793610319487, 4134.8139333729905, 4140.668746500272, 3861.382178851384, 3924.274009308273, 4095.0990782027907, 4099.6720262379085, 4113.341865301552, 4088.5281298732434, 4094.5905409459115, 4108.6918481114035, 4108.917821643566, 4121.958780412202, 3621.4024685926793, 3626.38351480249, 3629.219717760694, 3630.3828349180703, 3637.8181090945345, 5048.112803876886, 5067.9746601267125, 5078.771455284521, 5157.524388293603, 5166.844994650167, 4605.332226827091, 4624.167649823031, 4647.60495357895, 4652.441706995149, 4687.250039993619, 5431.34823821144, 5437.429069947678, 5445.237666726662, 5492.725363731797, 5506.146547285177, 3683.7421380503374, 3849.3648547989546, 3926.823292951824, 3975.2248311579256, 3991.8004099794894, 5639.774409023634, 5675.886482270373, 5689.345725241609, 5696.430356964312, 5698.145278208261, 3961.771850726284, 3967.2263908537557, 3978.6220309071173, 3979.9801000994808, 4006.318925782624, 3881.7865017423746, 4027.9798601006805, 4029.576894426043, 4032.1129351542613, 4033.8184781684895, 4539.978504836451, 4562.977185114053, 4563.612092972068, 4568.748718820497, 4588.747618880927, 5467.343918729698, 5489.890202195934, 5491.450854914477, 5512.39363670004, 5520.0, 1368.8152099466645, 1370.5751217122724, 1374.182361494909, 1386.1336664584635, 1390.4994202087241, 939.220447028978, 972.4554249620236, 975.9316847820585, 984.2568860510269, 986.8865080515833, 5293.497117773805, 5300.946990530122, 5343.5457986071615, 5346.4118946915805, 5383.703896285742, 5463.3717122530625, 5513.373554801343, 5546.805861794818, 5593.804216852391, 5617.775288988395, 5242.423333433319, 5266.183741520071, 5345.358556973188, 5361.678299302054, 5374.435684253175, 2969.1389497045616, 2970.50986587215, 2972.301509145349, 2987.536931775535, 3009.864556094981, 5601.5238704710555, 5731.799387021434, 5826.76692932278, 5838.620489668158, 5856.238688970492, 5661.235733176051, 5666.631668941505, 5669.299210236995, 5684.261046063985, 5694.981659720354, 5732.111522713986, 5768.163616275617, 5789.407912823923, 5841.028100891434, 5852.765889364463, 5386.0, 5572.192032155396, 5602.1036634138345, 5616.85957851057, 5632.436756324335, 5547.306586676666, 5551.278333816578, 5554.861128471821, 5559.527440167631, 5571.749271282721, 5584.654445132973, 5813.3895940925595, 5827.621204621686, 5831.1544826000845, 5837.620554663933, 3914.6672532835028, 3944.230874979466, 3973.264945985002, 3974.4634474345594, 3978.104926391539, 5428.83713488596, 5550.361708403585, 5667.4615911488345, 5676.829695108988, 5678.176664383724, 5525.668459892419, 5529.474699903502, 5536.252605898152, 5540.944590554204, 5540.97491963988, 5471.2887324647545, 5496.790706044664, 5507.642003269774, 5516.393196748274, 5531.280933478622, 5259.763310650953, 5467.4532546745, 5522.337319521683, 5523.337199536081, 5533.418991005887, 5593.8321850344555, 5599.244102046172, 5600.35595906476, 5610.803621873215, 5616.269884914935, 5180.792768289226, 5422.48486393792, 5481.479259470344, 5504.614676972574, 5507.642003269774], "value": 4184.033724366664, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.5880692650123, 819.2263748983451, 834.9332053435726, 859.2438653984497, 890.6214858685059, 15653.452129175466, 16763.497095087136, 16873.325066997306, 16916.15419229038, 16960.57598560035, 14679.339429725662, 14777.704445911102, 14891.627709307246, 14988.175650339226, 15026.699466010701, 807.676929228309, 823.2672921100226, 826.2481142160635, 826.7395770332326, 826.7891687619649, 676.2459857259146, 794.0590400375545, 826.2893911236332, 831.0359982420393, 833.1668331668332, 870.8737233101197, 873.9344549158839, 874.0254616103031, 876.4390789894472, 877.9604917778684, 860.191420065143, 861.3496809908511, 861.3970220845371, 862.3273846399818, 867.5532100968006, 501.8670052436107, 606.6633018674634, 625.9374062593704, 632.34552238433, 634.8984162534018, 15161.241937903062, 15265.923670381577, 15267.160306183156, 15277.770833437507, 15283.617909552238, 14366.41404547181, 14564.417423303055, 15010.474633387888, 15213.31540080688, 15260.31328590216, 13466.528671496451, 13487.797683034762, 13650.590482285548, 13665.248411337372, 13733.45066197351, 3769.6984241260634, 4101.815418306153, 4459.866204013885, 4548.476925153616, 4588.403507543998, 73611.0, 74739.62630186869, 74806.62596687036, 75531.24468755297, 75532.0, 11569.88430115705, 11613.0, 11635.360055196876, 11779.88220117805, 11934.4766009238, 20465.79534204639, 20504.282350117675, 20509.718445048722, 20540.17839286412, 20570.79429205689, 8373.1626837317, 8418.579071046423, 8532.8720069199, 8573.871391929126, 8733.868991965126, 4751.904961900743, 4760.95239047612, 4782.593479554277, 4822.517748225149, 5001.224810154432, 3234.0, 3306.7850589711593, 3308.239105005814, 3309.1065412338535, 3316.2538428853795, 605.5639939243738, 616.5468380740152, 628.522323034497, 629.3014753623474, 629.85513331933, 662.2913482573696, 689.069755829636, 698.5983059740568, 722.158495835617, 734.6657270941708, 9754.317197796086, 10217.74455638615, 10237.48812559369, 10440.164786817037, 10491.790164196826, 689.334791925784, 712.6686090967725, 717.6089031477857, 718.7556230881526, 724.822418507469, 4536.206163921301, 4654.301854721751, 4893.192623217129, 4925.927942464876, 4941.678790878582, 64245.67877160678, 65191.67404163044, 104117.0, 115756.0, 123900.0, 60425.39574604198, 61269.0, 64040.35959640344, 98357.50821245847, 101538.0, 87254.0, 89295.0, 89577.0, 90861.54569227244, 92981.0, 9055.68305109318, 9377.249820014518, 9400.670976516063, 9453.33826632129, 9482.905170948203, 52405.0, 52497.21254181114, 52781.20828187657, 53789.0, 54387.640308992595, 64600.35399645943, 64871.0, 74993.25006749862, 75697.24302756901, 78917.0, 11665.533378664759, 11743.94657389102, 12016.399180040788, 12239.32683702405, 12404.503819847467, 15092.471763488225, 15257.923710381821, 16032.27854746516, 16131.11278879626, 16168.434104806276, 14290.28548572588, 14374.0, 14678.0, 14695.853041469449, 14948.85051149518, 13969.231692256617, 14336.949610554793, 14511.0, 14592.927035364755, 15074.547763566672, 14054.578362649137, 14559.708805823613, 14601.488947886774, 14653.0, 14971.550853474413, 11906.107041971714, 12024.398780061138, 12238.449269782703, 12363.443645036175, 12570.434330455335, 10586.928475719365, 12028.63914082579, 12293.0, 12450.564230251897, 12999.545015924397], "value": 7636.703812122053, "unit": "score"}], "name": "dromaeo_css", "value": 7177.355926909794, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 112.0, 111.0, 111.0, 111.0, 113.0, 114.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 119.0, 185.0, 122.0, 118.0, 142.0, 118.0, 155.0, 117.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 160.0, 163.0, 161.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 110.0, 75.0, 75.0, 74.0, 75.0, 109.0, 74.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 126.0, 83.0, 83.0, 83.0, 118.0, 83.0, 83.0, 129.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 148.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 51.0, 51.0, 52.0, 53.0, 51.0, 52.0, 52.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 61.0, 63.0, 62.0, 62.0, 63.0, 63.0, 64.0, 64.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 76.0, 75.0, 75.0, 75.0, 75.0, 78.0, 79.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 130.0, 121.0, 128.0, 120.0, 119.0, 120.0, 118.0, 163.0, 129.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 153.0, 151.0, 159.0, 158.0, 152.0, 155.0, 157.0, 154.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 64.0, 62.0, 63.0, 63.0, 63.0, 60.0, 64.0, 63.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1475.6000000000001, "alertThreshold": 2.0}]} 20:40:23 INFO - Return code: 0 20:40:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:40:23 INFO - # TBPL SUCCESS # 20:40:23 INFO - Running post-action listener: _resource_record_post_action 20:40:23 INFO - [mozharness: 2016-07-22 03:40:23.710242Z] Finished run-tests step (success) 20:40:23 INFO - Running post-run listener: _resource_record_post_run 20:40:23 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 554377216; Read time: 0; Write time: 463420 20:40:23 INFO - TinderboxPrint: CPU usage
13.0% 20:40:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:40:23 INFO - TinderboxPrint: I/O write bytes / time
554,377,216 / 463,420 20:40:23 INFO - TinderboxPrint: CPU idle
8,275.6 (87.0%) 20:40:23 INFO - TinderboxPrint: CPU user
1,193.5 (12.5%) 20:40:23 INFO - TinderboxPrint: Swap in / out
0 / 0 20:40:23 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257089536; Read time: 0; Write time: 237900 20:40:23 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 297287680; Read time: 0; Write time: 225520 20:40:24 INFO - Running post-run listener: _upload_blobber_files 20:40:24 INFO - Blob upload gear active. 20:40:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:40:24 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 20:40:24 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'] 20:40:24 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 20:40:24 INFO - (blobuploader) - INFO - Open directory for files ... 20:40:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:40:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:40:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:25 INFO - (blobuploader) - INFO - Done attempting. 20:40:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:40:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:40:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:52 INFO - (blobuploader) - INFO - Done attempting. 20:40:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:40:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:40:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:52 INFO - (blobuploader) - INFO - Done attempting. 20:40:52 INFO - (blobuploader) - INFO - Iteration through files over. 20:40:52 INFO - Return code: 0 20:40:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:40:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:40:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7866af8c9c4e315a446c428bb1717a5eb4596f6b469c6a30ddb6cdcbb23494c5f23a0bd076f35374466f648075d8b2d2bc056a260dee83fe914af81ad3572460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00fd5adc8f3272a773cfca0922c07564f5a3a91b7ea6ce21df7e34cade11640f9542b6a38c5a4397bf868c8bae0eb5347f03e63376fdd7a4166faf6e99f84be4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e74fc4618f3c69cae36ed961e790a813e2afacc705c9d7627520651ca9b987001de3d8a3d2dba9094e3e586967c6df792cb80827798d59cc751dcd7783309ec5"} 20:40:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:40:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:40:52 INFO - Contents: 20:40:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7866af8c9c4e315a446c428bb1717a5eb4596f6b469c6a30ddb6cdcbb23494c5f23a0bd076f35374466f648075d8b2d2bc056a260dee83fe914af81ad3572460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00fd5adc8f3272a773cfca0922c07564f5a3a91b7ea6ce21df7e34cade11640f9542b6a38c5a4397bf868c8bae0eb5347f03e63376fdd7a4166faf6e99f84be4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e74fc4618f3c69cae36ed961e790a813e2afacc705c9d7627520651ca9b987001de3d8a3d2dba9094e3e586967c6df792cb80827798d59cc751dcd7783309ec5"} 20:40:52 INFO - Running post-run listener: copy_logs_to_upload_dir 20:40:52 INFO - Copying logs to upload dir... 20:40:52 INFO - mkdir: /builds/slave/test/build/upload/logs 20:40:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.230404 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-21 20:40:52.054418) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 20:40:52.058362) ========= 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=826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484 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/7866af8c9c4e315a446c428bb1717a5eb4596f6b469c6a30ddb6cdcbb23494c5f23a0bd076f35374466f648075d8b2d2bc056a260dee83fe914af81ad3572460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00fd5adc8f3272a773cfca0922c07564f5a3a91b7ea6ce21df7e34cade11640f9542b6a38c5a4397bf868c8bae0eb5347f03e63376fdd7a4166faf6e99f84be4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e74fc4618f3c69cae36ed961e790a813e2afacc705c9d7627520651ca9b987001de3d8a3d2dba9094e3e586967c6df792cb80827798d59cc751dcd7783309ec5"} build_url:https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011467 build_url: 'https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/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/7866af8c9c4e315a446c428bb1717a5eb4596f6b469c6a30ddb6cdcbb23494c5f23a0bd076f35374466f648075d8b2d2bc056a260dee83fe914af81ad3572460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00fd5adc8f3272a773cfca0922c07564f5a3a91b7ea6ce21df7e34cade11640f9542b6a38c5a4397bf868c8bae0eb5347f03e63376fdd7a4166faf6e99f84be4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e74fc4618f3c69cae36ed961e790a813e2afacc705c9d7627520651ca9b987001de3d8a3d2dba9094e3e586967c6df792cb80827798d59cc751dcd7783309ec5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 20:40:52.084224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:40:52.084690) ========= 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=826874ccc97bd7bf541b4875000001d5-1469157596.223999-1709790484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:40:52.136435) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 20:40:52.136767) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 20:40:52.137107) ========= ========= Total master_lag: 0.13 =========