builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1468619822.84 results: success (0) buildid: 20160715141452 builduid: d4b0a68295b04f62aebdcfe41c7c76be revision: 3db372da6fe108ddb0727003447f22c2483fb86d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:02.837658) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:02.838036) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:02.838303) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:02.854129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:02.854389) ========= 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=3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 14:57:03-- 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% 63.3M=0s 2016-07-15 14:57:03 (63.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078398 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:02.985014) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:02.985323) ========= 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=3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014315 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:03.011621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:03.011925) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3db372da6fe108ddb0727003447f22c2483fb86d --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 3db372da6fe108ddb0727003447f22c2483fb86d --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=3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 14:57:03,861 truncating revision to first 12 chars 2016-07-15 14:57:03,861 Setting DEBUG logging. 2016-07-15 14:57:03,861 attempt 1/10 2016-07-15 14:57:03,861 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3db372da6fe1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 14:57:04,433 unpacking tar archive at: fx-team-3db372da6fe1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.938894 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:03.966269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:03.966546) ========= script_repo_revision: 3db372da6fe108ddb0727003447f22c2483fb86d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:03.966887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:03.967142) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:03.981076) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-15 14:57:03.981355) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:57:04 INFO - MultiFileLogger online at 20160715 14:57:04 in /builds/slave/test 14:57:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:57:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:57:04 INFO - {'append_to_log': False, 14:57:04 INFO - 'base_work_dir': '/builds/slave/test', 14:57:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:57:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:57:04 INFO - 'branch': 'Fx-Team-Non-PGO', 14:57:04 INFO - 'buildbot_json_path': 'buildprops.json', 14:57:04 INFO - 'config_files': ('talos/linux_config.py',), 14:57:04 INFO - 'default_actions': ('clobber', 14:57:04 INFO - 'read-buildbot-config', 14:57:04 INFO - 'download-and-extract', 14:57:04 INFO - 'populate-webroot', 14:57:04 INFO - 'create-virtualenv', 14:57:04 INFO - 'install', 14:57:04 INFO - 'run-tests'), 14:57:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:57:04 INFO - 'download_minidump_stackwalk': True, 14:57:04 INFO - 'download_symbols': 'ondemand', 14:57:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:57:04 INFO - 'tooltool.py': '/tools/tooltool.py', 14:57:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:57:04 INFO - '/tools/misc-python/virtualenv.py')}, 14:57:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:57:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:57:04 INFO - 'installer_path': 'installer.exe', 14:57:04 INFO - 'log_level': 'info', 14:57:04 INFO - 'log_name': 'talos', 14:57:04 INFO - 'log_to_console': True, 14:57:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:57:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:57:04 INFO - 'opt_config_files': (), 14:57:04 INFO - 'pip_index': False, 14:57:04 INFO - 'sps_profile': False, 14:57:04 INFO - 'sps_profile_interval': 0, 14:57:04 INFO - 'suite': 'dromaeojs', 14:57:04 INFO - 'system_bits': '32', 14:57:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:57:04 INFO - 'title': 'talos-linux64-ix-059', 14:57:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:57:04 INFO - 'use_talos_json': True, 14:57:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:57:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:57:04 INFO - 'work_dir': 'build'} 14:57:04 INFO - ##### 14:57:04 INFO - ##### Running clobber step. 14:57:04 INFO - ##### 14:57:04 INFO - Running pre-action listener: _resource_record_pre_action 14:57:04 INFO - Running main action method: clobber 14:57:04 INFO - rmtree: /builds/slave/test/build 14:57:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:57:05 INFO - Running post-action listener: _resource_record_post_action 14:57:05 INFO - ##### 14:57:05 INFO - ##### Finished clobber step (success) 14:57:05 INFO - ##### 14:57:05 INFO - ##### 14:57:05 INFO - ##### Running read-buildbot-config step. 14:57:05 INFO - ##### 14:57:05 INFO - Running pre-action listener: _resource_record_pre_action 14:57:05 INFO - Running main action method: read_buildbot_config 14:57:05 INFO - Using buildbot properties: 14:57:05 INFO - { 14:57:05 INFO - "project": "", 14:57:05 INFO - "product": "firefox", 14:57:05 INFO - "script_repo_revision": "production", 14:57:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:57:05 INFO - "repository": "", 14:57:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:57:05 INFO - "buildid": "20160715141452", 14:57:05 INFO - "pgo_build": "False", 14:57:05 INFO - "basedir": "/builds/slave/test", 14:57:05 INFO - "buildnumber": 3162, 14:57:05 INFO - "slavename": "talos-linux64-ix-059", 14:57:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:57:05 INFO - "platform": "ubuntu64_hw", 14:57:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:57:05 INFO - "branch": "fx-team", 14:57:05 INFO - "repo_path": "integration/fx-team", 14:57:05 INFO - "revision": "3db372da6fe108ddb0727003447f22c2483fb86d", 14:57:05 INFO - "stage_platform": "linux64", 14:57:05 INFO - "builduid": "d4b0a68295b04f62aebdcfe41c7c76be", 14:57:05 INFO - "slavebuilddir": "test" 14:57:05 INFO - } 14:57:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:57:05 INFO - Running post-action listener: _resource_record_post_action 14:57:05 INFO - ##### 14:57:05 INFO - ##### Finished read-buildbot-config step (success) 14:57:05 INFO - ##### 14:57:05 INFO - ##### 14:57:05 INFO - ##### Running download-and-extract step. 14:57:05 INFO - ##### 14:57:05 INFO - Running pre-action listener: _resource_record_pre_action 14:57:05 INFO - Running main action method: download_and_extract 14:57:05 INFO - mkdir: /builds/slave/test/build/tests 14:57: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')]} 14:57:05 INFO - https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:57:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:57:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:57:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:06 INFO - Downloaded 1361 bytes. 14:57:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:57:06 INFO - Using the following test package requirements: 14:57:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:57:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:57:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:57:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:06 INFO - u'jsshell-linux-x86_64.zip'], 14:57:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:57:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:57:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:57:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:57:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:57:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:57:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:57: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')]} 14:57:06 INFO - https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:57:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:57:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:57:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:07 INFO - Downloaded 22757261 bytes. 14:57:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:57:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:57:08 INFO - Return code: 0 14:57:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:08 INFO - https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:57:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:57:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:57:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:21 INFO - Downloaded 22757261 bytes. 14:57:21 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'] 14:57:21 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 14:57:23 INFO - Return code: 0 14:57: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')]} 14:57:23 INFO - https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:57:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:57:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:57:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:24 INFO - Downloaded 14403317 bytes. 14:57:24 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'] 14:57:24 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 14:57:24 INFO - Return code: 0 14:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:24 INFO - https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:57:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:57:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:57:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:25 INFO - Downloaded 57080425 bytes. 14:57:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:57:25 INFO - mkdir: /builds/slave/test/properties 14:57:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:57:25 INFO - Writing to file /builds/slave/test/properties/build_url 14:57:25 INFO - Contents: 14:57:25 INFO - build_url:https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:57:26 INFO - Running post-action listener: _resource_record_post_action 14:57:26 INFO - Running post-action listener: set_extra_try_arguments 14:57:26 INFO - ##### 14:57:26 INFO - ##### Finished download-and-extract step (success) 14:57:26 INFO - ##### 14:57:26 INFO - ##### 14:57:26 INFO - ##### Running populate-webroot step. 14:57:26 INFO - ##### 14:57:26 INFO - Running pre-action listener: _resource_record_pre_action 14:57:26 INFO - Running main action method: populate_webroot 14:57:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:57:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:57:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:57:26 INFO - '--tppagecycles', 14:57:26 INFO - '7'], 14:57:26 INFO - 'tests': ['tsvgm']}}, 14:57:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:57:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:57:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:57:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:57:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:57:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:57:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:26 INFO - 'talos_options': ['--disable-e10s'], 14:57:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:26 INFO - 'talos_options': ['--disable-e10s'], 14:57:26 INFO - 'tests': ['damp', 'tps']}, 14:57:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:26 INFO - 'tests': ['damp', 'tps']}, 14:57:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:57:26 INFO - 'tests': ['dromaeo_dom']}, 14:57:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:57:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:57:26 INFO - 'tests': ['basic_compositor_video']}, 14:57:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:57:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:57:26 INFO - 'tests': ['a11yr', 14:57:26 INFO - 'ts_paint', 14:57:26 INFO - 'tpaint', 14:57:26 INFO - 'sessionrestore', 14:57:26 INFO - 'sessionrestore_no_auto_restore', 14:57:26 INFO - 'tabpaint']}, 14:57:26 INFO - 'other-e10s': {'tests': ['a11yr', 14:57:26 INFO - 'ts_paint', 14:57:26 INFO - 'tpaint', 14:57:26 INFO - 'sessionrestore', 14:57:26 INFO - 'sessionrestore_no_auto_restore', 14:57:26 INFO - 'tabpaint']}, 14:57:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:57:26 INFO - 'ts_paint', 14:57:26 INFO - 'tpaint', 14:57:26 INFO - 'sessionrestore', 14:57:26 INFO - 'sessionrestore_no_auto_restore', 14:57:26 INFO - 'tabpaint']}, 14:57:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:57:26 INFO - 'ts_paint', 14:57:26 INFO - 'tpaint', 14:57:26 INFO - 'sessionrestore', 14:57:26 INFO - 'sessionrestore_no_auto_restore', 14:57:26 INFO - 'tabpaint']}, 14:57:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:57:26 INFO - 'tests': ['a11yr', 14:57:26 INFO - 'ts_paint', 14:57:26 INFO - 'tpaint', 14:57:26 INFO - 'sessionrestore', 14:57:26 INFO - 'sessionrestore_no_auto_restore', 14:57:26 INFO - 'tabpaint']}, 14:57:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:57:26 INFO - 'tests': ['a11yr', 14:57:26 INFO - 'ts_paint', 14:57:26 INFO - 'tpaint', 14:57:26 INFO - 'sessionrestore', 14:57:26 INFO - 'sessionrestore_no_auto_restore', 14:57:26 INFO - 'tabpaint']}, 14:57:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:57:26 INFO - 'tests': ['tsvgx', 14:57:26 INFO - 'tsvgr_opacity', 14:57:26 INFO - 'tart', 14:57:26 INFO - 'tscrollx', 14:57:26 INFO - 'cart']}, 14:57:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:57:26 INFO - 'tsvgr_opacity', 14:57:26 INFO - 'tart', 14:57:26 INFO - 'tscrollx', 14:57:26 INFO - 'cart']}, 14:57:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:26 INFO - 'talos_options': ['--disable-e10s'], 14:57:26 INFO - 'tests': ['tp5o']}, 14:57:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:26 INFO - 'tests': ['tp5o']}, 14:57:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:26 INFO - 'talos_options': ['--disable-e10s', 14:57:26 INFO - '--xperf_path', 14:57:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:26 INFO - 'tests': ['tp5n']}, 14:57:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:26 INFO - 'talos_options': ['--xperf_path', 14:57:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:26 INFO - 'tests': ['tp5n']}}, 14:57:26 INFO - 'talos.zip': {'path': '', 14:57:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:57:26 INFO - Running post-action listener: _resource_record_post_action 14:57:26 INFO - ##### 14:57:26 INFO - ##### Finished populate-webroot step (success) 14:57:26 INFO - ##### 14:57:26 INFO - ##### 14:57:26 INFO - ##### Running create-virtualenv step. 14:57:26 INFO - ##### 14:57:26 INFO - Running pre-action listener: _resource_record_pre_action 14:57:26 INFO - Running main action method: create_virtualenv 14:57:26 INFO - Creating virtualenv /builds/slave/test/build/venv 14:57:26 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 14:57:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:57:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:57:26 INFO - Using real prefix '/usr' 14:57:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:57:27 INFO - Installing distribute.............................................................................................................................................................................................done. 14:57:29 INFO - Installing pip.................done. 14:57:29 INFO - Return code: 0 14:57:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:29 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 0x2298030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25573b0>, '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 0x25582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558740>, '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': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', '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 14:57:29 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 14:57:29 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 14:57:29 INFO - Using env: {'DISPLAY': ':0', 14:57:29 INFO - 'HOME': '/home/cltbld', 14:57:29 INFO - 'LANG': 'en_US.UTF-8', 14:57:29 INFO - 'LANGUAGE': 'en_US:en', 14:57:29 INFO - 'LOGNAME': 'cltbld', 14:57:29 INFO - 'MAIL': '/var/mail/cltbld', 14:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:29 INFO - 'MOZ_NO_REMOTE': '1', 14:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:29 INFO - 'NO_EM_RESTART': '1', 14:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:29 INFO - 'PWD': '/builds/slave/test', 14:57:29 INFO - 'SHELL': '/bin/bash', 14:57:29 INFO - 'SHLVL': '1', 14:57:29 INFO - 'TERM': 'linux', 14:57:29 INFO - 'TMOUT': '86400', 14:57:29 INFO - 'USER': 'cltbld', 14:57:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', 14:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:29 INFO - '_': '/tools/buildbot/bin/python'} 14:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:29 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 14:57:29 INFO - Cleaning up... 14:57:29 INFO - Return code: 0 14:57:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:29 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 0x2298030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25573b0>, '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 0x25582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558740>, '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': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', '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 14:57:29 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 14:57:29 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 14:57:29 INFO - Using env: {'DISPLAY': ':0', 14:57:29 INFO - 'HOME': '/home/cltbld', 14:57:29 INFO - 'LANG': 'en_US.UTF-8', 14:57:29 INFO - 'LANGUAGE': 'en_US:en', 14:57:29 INFO - 'LOGNAME': 'cltbld', 14:57:29 INFO - 'MAIL': '/var/mail/cltbld', 14:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:29 INFO - 'MOZ_NO_REMOTE': '1', 14:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:29 INFO - 'NO_EM_RESTART': '1', 14:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:29 INFO - 'PWD': '/builds/slave/test', 14:57:29 INFO - 'SHELL': '/bin/bash', 14:57:29 INFO - 'SHLVL': '1', 14:57:29 INFO - 'TERM': 'linux', 14:57:29 INFO - 'TMOUT': '86400', 14:57:29 INFO - 'USER': 'cltbld', 14:57:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', 14:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:29 INFO - '_': '/tools/buildbot/bin/python'} 14:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:29 INFO - Downloading/unpacking psutil>=3.1.1 14:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:57:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:57:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:57:31 INFO - Installing collected packages: psutil 14:57:31 INFO - Running setup.py install for psutil 14:57:31 INFO - building 'psutil._psutil_linux' extension 14:57:31 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 14:57:31 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 14:57:31 INFO - building 'psutil._psutil_posix' extension 14:57:31 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 14:57:32 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 14:57:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:57:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:57:32 INFO - Successfully installed psutil 14:57:32 INFO - Cleaning up... 14:57:32 INFO - Return code: 0 14:57:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:57:32 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')]} 14:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:32 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')]} 14:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:32 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 0x2298030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25573b0>, '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 0x25582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558740>, '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': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', '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 14:57:32 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 14:57:32 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 14:57:32 INFO - Using env: {'DISPLAY': ':0', 14:57:32 INFO - 'HOME': '/home/cltbld', 14:57:32 INFO - 'LANG': 'en_US.UTF-8', 14:57:32 INFO - 'LANGUAGE': 'en_US:en', 14:57:32 INFO - 'LOGNAME': 'cltbld', 14:57:32 INFO - 'MAIL': '/var/mail/cltbld', 14:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:32 INFO - 'MOZ_NO_REMOTE': '1', 14:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:32 INFO - 'NO_EM_RESTART': '1', 14:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:32 INFO - 'PWD': '/builds/slave/test', 14:57:32 INFO - 'SHELL': '/bin/bash', 14:57:32 INFO - 'SHLVL': '1', 14:57:32 INFO - 'TERM': 'linux', 14:57:32 INFO - 'TMOUT': '86400', 14:57:32 INFO - 'USER': 'cltbld', 14:57:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', 14:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:32 INFO - '_': '/tools/buildbot/bin/python'} 14:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:57:32 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 14:57:32 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 14:57:32 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 14:57:32 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 14:57:32 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 14:57:32 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 14:57:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:57:34 INFO - Installing collected packages: mozsystemmonitor 14:57:34 INFO - Running setup.py install for mozsystemmonitor 14:57:34 INFO - Successfully installed mozsystemmonitor 14:57:34 INFO - Cleaning up... 14:57:34 INFO - Return code: 0 14:57:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:57:34 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')]} 14:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:34 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')]} 14:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:34 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 0x2298030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25573b0>, '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 0x25582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558740>, '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': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', '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 14:57:34 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 14:57:34 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 14:57:34 INFO - Using env: {'DISPLAY': ':0', 14:57:34 INFO - 'HOME': '/home/cltbld', 14:57:34 INFO - 'LANG': 'en_US.UTF-8', 14:57:34 INFO - 'LANGUAGE': 'en_US:en', 14:57:34 INFO - 'LOGNAME': 'cltbld', 14:57:34 INFO - 'MAIL': '/var/mail/cltbld', 14:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:34 INFO - 'MOZ_NO_REMOTE': '1', 14:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:34 INFO - 'NO_EM_RESTART': '1', 14:57:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:34 INFO - 'PWD': '/builds/slave/test', 14:57:34 INFO - 'SHELL': '/bin/bash', 14:57:34 INFO - 'SHLVL': '1', 14:57:34 INFO - 'TERM': 'linux', 14:57:34 INFO - 'TMOUT': '86400', 14:57:34 INFO - 'USER': 'cltbld', 14:57:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', 14:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:34 INFO - '_': '/tools/buildbot/bin/python'} 14:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:34 INFO - Downloading/unpacking jsonschema==2.5.1 14:57:34 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 14:57:34 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 14:57:34 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 14:57:34 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 14:57:34 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 14:57:34 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 14:57:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:57:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:36 INFO - Downloading functools32-3.2.3-2.tar.gz 14:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:57:36 INFO - warning: no files found matching '*.txt' 14:57:36 INFO - no previously-included directories found matching 'build' 14:57:36 INFO - no previously-included directories found matching 'dist' 14:57:36 INFO - no previously-included directories found matching '.git*' 14:57:36 INFO - Installing collected packages: jsonschema, functools32 14:57:37 INFO - Running setup.py install for functools32 14:57:37 INFO - warning: no files found matching '*.txt' 14:57:37 INFO - no previously-included directories found matching 'build' 14:57:37 INFO - no previously-included directories found matching 'dist' 14:57:37 INFO - no previously-included directories found matching '.git*' 14:57:37 INFO - Successfully installed jsonschema functools32 14:57:37 INFO - Cleaning up... 14:57:37 INFO - Return code: 0 14:57:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2298030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25573b0>, '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 0x25582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558740>, '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': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', '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 14:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:57:37 INFO - Using env: {'DISPLAY': ':0', 14:57:37 INFO - 'HOME': '/home/cltbld', 14:57:37 INFO - 'LANG': 'en_US.UTF-8', 14:57:37 INFO - 'LANGUAGE': 'en_US:en', 14:57:37 INFO - 'LOGNAME': 'cltbld', 14:57:37 INFO - 'MAIL': '/var/mail/cltbld', 14:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:37 INFO - 'MOZ_NO_REMOTE': '1', 14:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:37 INFO - 'NO_EM_RESTART': '1', 14:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:37 INFO - 'PWD': '/builds/slave/test', 14:57:37 INFO - 'SHELL': '/bin/bash', 14:57:37 INFO - 'SHLVL': '1', 14:57:37 INFO - 'TERM': 'linux', 14:57:37 INFO - 'TMOUT': '86400', 14:57:37 INFO - 'USER': 'cltbld', 14:57:37 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', 14:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:37 INFO - '_': '/tools/buildbot/bin/python'} 14:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:37 INFO - Downloading/unpacking blobuploader==1.2.4 14:57:37 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 14:57:37 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 14:57:37 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 14:57:37 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 14:57:37 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 14:57:37 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 14:57:39 INFO - Downloading blobuploader-1.2.4.tar.gz 14:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:57:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:57:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:40 INFO - Downloading docopt-0.6.1.tar.gz 14:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:57:40 INFO - Installing collected packages: blobuploader, requests, docopt 14:57:40 INFO - Running setup.py install for blobuploader 14:57:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:57:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:57:40 INFO - Running setup.py install for requests 14:57:40 INFO - Running setup.py install for docopt 14:57:40 INFO - Successfully installed blobuploader requests docopt 14:57:40 INFO - Cleaning up... 14:57:40 INFO - Return code: 0 14:57:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:40 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')]} 14:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:40 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')]} 14:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:40 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 0x2298030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25573b0>, '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 0x25582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558740>, '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': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', '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 14:57:40 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 14:57:40 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 14:57:40 INFO - Using env: {'DISPLAY': ':0', 14:57:40 INFO - 'HOME': '/home/cltbld', 14:57:40 INFO - 'LANG': 'en_US.UTF-8', 14:57:40 INFO - 'LANGUAGE': 'en_US:en', 14:57:40 INFO - 'LOGNAME': 'cltbld', 14:57:40 INFO - 'MAIL': '/var/mail/cltbld', 14:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:40 INFO - 'MOZ_NO_REMOTE': '1', 14:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:40 INFO - 'NO_EM_RESTART': '1', 14:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:40 INFO - 'PWD': '/builds/slave/test', 14:57:40 INFO - 'SHELL': '/bin/bash', 14:57:40 INFO - 'SHLVL': '1', 14:57:40 INFO - 'TERM': 'linux', 14:57:40 INFO - 'TMOUT': '86400', 14:57:40 INFO - 'USER': 'cltbld', 14:57:40 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', 14:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:40 INFO - '_': '/tools/buildbot/bin/python'} 14:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:57:40 INFO - Running setup.py (path:/tmp/pip-bmUfmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:57:41 INFO - Running setup.py (path:/tmp/pip-tmayLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:57:41 INFO - Running setup.py (path:/tmp/pip-hoUw5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:57:41 INFO - Running setup.py (path:/tmp/pip-8ctrUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:57:41 INFO - Running setup.py (path:/tmp/pip-ukHueO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:57:41 INFO - Running setup.py (path:/tmp/pip-57RgUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:57:41 INFO - Running setup.py (path:/tmp/pip-OhCEUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:41 INFO - Running setup.py (path:/tmp/pip-yMBUDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:41 INFO - Running setup.py (path:/tmp/pip-IFXelQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:41 INFO - Running setup.py (path:/tmp/pip-ScUVMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:41 INFO - Running setup.py (path:/tmp/pip-jc7wmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:41 INFO - Running setup.py (path:/tmp/pip-dmmkDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:41 INFO - Running setup.py (path:/tmp/pip-Df1lhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:41 INFO - Running setup.py (path:/tmp/pip-NhsxQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:41 INFO - Running setup.py (path:/tmp/pip-D2UZqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:42 INFO - Running setup.py (path:/tmp/pip-ogen94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:42 INFO - Running setup.py (path:/tmp/pip-AhLQvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:57:42 INFO - Running setup.py install for manifestparser 14:57:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:57:42 INFO - Running setup.py install for mozcrash 14:57:42 INFO - Running setup.py install for mozdebug 14:57:42 INFO - Running setup.py install for mozdevice 14:57:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:57:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:57:42 INFO - Running setup.py install for mozfile 14:57:42 INFO - Running setup.py install for mozhttpd 14:57:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:57:42 INFO - Running setup.py install for mozinfo 14:57:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:57:42 INFO - Running setup.py install for mozInstall 14:57:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:57:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:57:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:57:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:57:42 INFO - Running setup.py install for mozleak 14:57:43 INFO - Running setup.py install for mozlog 14:57:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:57:43 INFO - Running setup.py install for moznetwork 14:57:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:57:43 INFO - Running setup.py install for mozprocess 14:57:43 INFO - Running setup.py install for mozprofile 14:57:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:57:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:57:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:57:43 INFO - Running setup.py install for mozrunner 14:57:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:57:43 INFO - Running setup.py install for mozscreenshot 14:57:43 INFO - Running setup.py install for moztest 14:57:43 INFO - Running setup.py install for mozversion 14:57:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:57:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:57:43 INFO - Cleaning up... 14:57:43 INFO - Return code: 0 14:57:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:43 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 0x2298030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25573b0>, '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 0x25582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558740>, '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': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', '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 14:57:43 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 14:57:43 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 14:57:43 INFO - Using env: {'DISPLAY': ':0', 14:57:43 INFO - 'HOME': '/home/cltbld', 14:57:43 INFO - 'LANG': 'en_US.UTF-8', 14:57:43 INFO - 'LANGUAGE': 'en_US:en', 14:57:43 INFO - 'LOGNAME': 'cltbld', 14:57:43 INFO - 'MAIL': '/var/mail/cltbld', 14:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:43 INFO - 'MOZ_NO_REMOTE': '1', 14:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:43 INFO - 'NO_EM_RESTART': '1', 14:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:43 INFO - 'PWD': '/builds/slave/test', 14:57:43 INFO - 'SHELL': '/bin/bash', 14:57:43 INFO - 'SHLVL': '1', 14:57:43 INFO - 'TERM': 'linux', 14:57:43 INFO - 'TMOUT': '86400', 14:57:43 INFO - 'USER': 'cltbld', 14:57:43 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', 14:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:43 INFO - '_': '/tools/buildbot/bin/python'} 14:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:57:44 INFO - Running setup.py (path:/tmp/pip-_jl4Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:57:44 INFO - Running setup.py (path:/tmp/pip-4J96jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:57:44 INFO - Running setup.py (path:/tmp/pip-eFnM1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:57:44 INFO - Running setup.py (path:/tmp/pip-YxKGhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:57:44 INFO - Running setup.py (path:/tmp/pip-g0OckH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:57:44 INFO - Running setup.py (path:/tmp/pip-xkU4Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:57:44 INFO - Running setup.py (path:/tmp/pip-oRg5aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:44 INFO - Running setup.py (path:/tmp/pip-6WqdV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:44 INFO - Running setup.py (path:/tmp/pip-80X06F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:44 INFO - Running setup.py (path:/tmp/pip-ixmzog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:44 INFO - Running setup.py (path:/tmp/pip-KzFSUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:44 INFO - Running setup.py (path:/tmp/pip-9JblAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:45 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)) 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:45 INFO - Running setup.py (path:/tmp/pip-F1swUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:45 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)) 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:45 INFO - Running setup.py (path:/tmp/pip-S918lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:45 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)) 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:45 INFO - Running setup.py (path:/tmp/pip-33o33N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:45 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)) 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:45 INFO - Running setup.py (path:/tmp/pip-_QVOyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:45 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)) 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:45 INFO - Running setup.py (path:/tmp/pip-59FpP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:45 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)) 14:57:45 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)) 14:57:45 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)) 14:57:45 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)) 14:57:45 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)) 14:57:45 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)) 14:57:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:47 INFO - Downloading blessings-1.6.tar.gz 14:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:57:47 INFO - Installing collected packages: blessings 14:57:47 INFO - Running setup.py install for blessings 14:57:47 INFO - Successfully installed blessings 14:57:47 INFO - Cleaning up... 14:57:47 INFO - Return code: 0 14:57:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:57:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:47 INFO - Reading from file tmpfile_stdout 14:57:47 INFO - Current package versions: 14:57:47 INFO - argparse == 1.2.1 14:57:47 INFO - blessings == 1.6 14:57:47 INFO - blobuploader == 1.2.4 14:57:47 INFO - docopt == 0.6.1 14:57:47 INFO - functools32 == 3.2.3-2 14:57:47 INFO - jsonschema == 2.5.1 14:57:47 INFO - manifestparser == 1.1 14:57:47 INFO - mozInstall == 1.12 14:57:47 INFO - mozcrash == 0.17 14:57:47 INFO - mozdebug == 0.1 14:57:47 INFO - mozdevice == 0.48 14:57:47 INFO - mozfile == 1.2 14:57:47 INFO - mozhttpd == 0.7 14:57:47 INFO - mozinfo == 0.9 14:57:47 INFO - mozleak == 0.1 14:57:47 INFO - mozlog == 3.2 14:57:47 INFO - moznetwork == 0.27 14:57:47 INFO - mozprocess == 0.23 14:57:47 INFO - mozprofile == 0.28 14:57:47 INFO - mozrunner == 6.12 14:57:47 INFO - mozscreenshot == 0.1 14:57:47 INFO - mozsystemmonitor == 0.3 14:57:47 INFO - moztest == 0.7 14:57:47 INFO - mozversion == 1.4 14:57:47 INFO - psutil == 3.1.1 14:57:47 INFO - requests == 1.2.3 14:57:47 INFO - wsgiref == 0.1.2 14:57:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:47 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 0x2298030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25573b0>, '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 0x25582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558740>, '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': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', '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 14:57:47 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 14:57:47 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 14:57:47 INFO - Using env: {'DISPLAY': ':0', 14:57:47 INFO - 'HOME': '/home/cltbld', 14:57:47 INFO - 'LANG': 'en_US.UTF-8', 14:57:47 INFO - 'LANGUAGE': 'en_US:en', 14:57:47 INFO - 'LOGNAME': 'cltbld', 14:57:47 INFO - 'MAIL': '/var/mail/cltbld', 14:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:47 INFO - 'MOZ_NO_REMOTE': '1', 14:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:47 INFO - 'NO_EM_RESTART': '1', 14:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:47 INFO - 'PWD': '/builds/slave/test', 14:57:47 INFO - 'SHELL': '/bin/bash', 14:57:47 INFO - 'SHLVL': '1', 14:57:47 INFO - 'TERM': 'linux', 14:57:47 INFO - 'TMOUT': '86400', 14:57:47 INFO - 'USER': 'cltbld', 14:57:47 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', 14:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:47 INFO - '_': '/tools/buildbot/bin/python'} 14:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 INFO - Cleaning up... 14:57:47 INFO - Return code: 0 14:57:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2298030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25573b0>, '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 0x25582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558740>, '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': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', '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 14:57:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:57:47 INFO - Using env: {'DISPLAY': ':0', 14:57:48 INFO - 'HOME': '/home/cltbld', 14:57:48 INFO - 'LANG': 'en_US.UTF-8', 14:57:48 INFO - 'LANGUAGE': 'en_US:en', 14:57:48 INFO - 'LOGNAME': 'cltbld', 14:57:48 INFO - 'MAIL': '/var/mail/cltbld', 14:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:48 INFO - 'MOZ_NO_REMOTE': '1', 14:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:48 INFO - 'NO_EM_RESTART': '1', 14:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:48 INFO - 'PWD': '/builds/slave/test', 14:57:48 INFO - 'SHELL': '/bin/bash', 14:57:48 INFO - 'SHLVL': '1', 14:57:48 INFO - 'TERM': 'linux', 14:57:48 INFO - 'TMOUT': '86400', 14:57:48 INFO - 'USER': 'cltbld', 14:57:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', 14:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:48 INFO - '_': '/tools/buildbot/bin/python'} 14:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:57:48 INFO - Cleaning up... 14:57:48 INFO - Return code: 0 14:57:48 INFO - Running post-action listener: _resource_record_post_action 14:57:48 INFO - Running post-action listener: _start_resource_monitoring 14:57:48 INFO - Starting resource monitoring. 14:57:48 INFO - ##### 14:57:48 INFO - ##### Finished create-virtualenv step (success) 14:57:48 INFO - ##### 14:57:48 INFO - ##### 14:57:48 INFO - ##### Running install step. 14:57:48 INFO - ##### 14:57:48 INFO - Running pre-action listener: _resource_record_pre_action 14:57:48 INFO - Running main action method: install 14:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:48 INFO - Reading from file tmpfile_stdout 14:57:48 INFO - Detecting whether we're running mozinstall >=1.0... 14:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:57:48 INFO - Reading from file tmpfile_stdout 14:57:48 INFO - Output received: 14:57:48 INFO - Usage: mozinstall [options] installer 14:57:48 INFO - Options: 14:57:48 INFO - -h, --help show this help message and exit 14:57:48 INFO - -d DEST, --destination=DEST 14:57:48 INFO - Directory to install application into. [default: 14:57:48 INFO - "/builds/slave/test"] 14:57:48 INFO - --app=APP Application being installed. [default: firefox] 14:57:48 INFO - mkdir: /builds/slave/test/build/application 14:57:48 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'] 14:57:48 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 14:58:04 INFO - Reading from file tmpfile_stdout 14:58:04 INFO - Output received: 14:58:04 INFO - /builds/slave/test/build/application/firefox/firefox 14:58:04 INFO - Running post-action listener: _resource_record_post_action 14:58:04 INFO - ##### 14:58:04 INFO - ##### Finished install step (success) 14:58:04 INFO - ##### 14:58:04 INFO - ##### 14:58:04 INFO - ##### Running run-tests step. 14:58:04 INFO - ##### 14:58:04 INFO - Running pre-action listener: _resource_record_pre_action 14:58:04 INFO - Running main action method: run_tests 14:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:58:04 INFO - Python 2.7.3 14:58:04 INFO - Return code: 0 14:58:04 INFO - grabbing minidump binary from tooltool 14:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:04 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 0x25573b0>, '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 0x25582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:58:04 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 14:58:04 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 14:58:04 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 14:58:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:58:05 INFO - Return code: 0 14:58:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:58:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:58:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:58:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:58:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 14:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 14:58:05 INFO - Using env: {'DISPLAY': ':0', 14:58:05 INFO - 'HOME': '/home/cltbld', 14:58:05 INFO - 'LANG': 'en_US.UTF-8', 14:58:05 INFO - 'LANGUAGE': 'en_US:en', 14:58:05 INFO - 'LOGNAME': 'cltbld', 14:58:05 INFO - 'MAIL': '/var/mail/cltbld', 14:58:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:58:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:05 INFO - 'MOZ_NO_REMOTE': '1', 14:58:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:05 INFO - 'NO_EM_RESTART': '1', 14:58:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:05 INFO - 'PWD': '/builds/slave/test', 14:58:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:58:05 INFO - 'SHELL': '/bin/bash', 14:58:05 INFO - 'SHLVL': '1', 14:58:05 INFO - 'TERM': 'linux', 14:58:05 INFO - 'TMOUT': '86400', 14:58:05 INFO - 'USER': 'cltbld', 14:58:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344', 14:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:05 INFO - '_': '/tools/buildbot/bin/python'} 14:58:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 14:58:05 INFO - mozversion application_buildid: 20160715141452 14:58:05 INFO - mozversion application_changeset: 3db372da6fe108ddb0727003447f22c2483fb86d 14:58:05 INFO - mozversion application_display_name: Nightly 14:58:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:58:05 INFO - mozversion application_name: Firefox 14:58:05 INFO - mozversion application_remotingname: firefox 14:58:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:58:05 INFO - mozversion application_vendor: Mozilla 14:58:05 INFO - mozversion application_version: 50.0a1 14:58:05 INFO - mozversion platform_buildid: 20160715141452 14:58:05 INFO - mozversion platform_changeset: 3db372da6fe108ddb0727003447f22c2483fb86d 14:58:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:58:05 INFO - mozversion platform_version: 50.0a1 14:58:05 INFO - using testdate: 1468619885 14:58:05 INFO - actual date: 1468619885 14:58:05 INFO - starting webserver on 'localhost:38969' 14:58:05 INFO - SUITE-START | Running 2 tests 14:58:05 INFO - TEST-START | dromaeo_css 14:58:05 INFO - operating with platform_type : linux_ 14:58:05 INFO - Initialising browser for dromaeo_css test... 14:58:05 INFO - TEST-INFO | started process 25720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn0ePi5/profile http://localhost:38969/getInfo.html) 14:58:09 INFO - PROCESS | 25720 | __metrics Screen width/height:1600/1200 14:58:09 INFO - PROCESS | 25720 | colorDepth:24 14:58:09 INFO - PROCESS | 25720 | Browser inner width/height: 1024/697 14:58:09 INFO - PROCESS | 25720 | __metrics 14:58:09 INFO - PROCESS | 25720 | 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" 14:58:09 INFO - PROCESS | 25720 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:58:10 INFO - TEST-INFO | 25720: exit 0 14:58:10 INFO - Browser initialized. 14:58:10 INFO - Running cycle 1/1 for dromaeo_css test... 14:58:10 INFO - TEST-INFO | started process 25803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn0ePi5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:58:22 INFO - PROCESS | 25803 | RSS: Main: 159240192 14:58:22 INFO - PROCESS | 25803 | 14:59:13 INFO - PROCESS | 25803 | 1468619953872 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:01:26 INFO - PROCESS | 25803 | Cycle 1(1): loaded http://localhost:38969/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38969/tests/dromaeo/cssquery-ext.html) 15:01:27 INFO - PROCESS | 25803 | RSS: Main: 270020608 15:01:27 INFO - PROCESS | 25803 | 15:04:30 INFO - PROCESS | 25803 | Cycle 1(1): loaded http://localhost:38969/tests/dromaeo/cssquery-ext.html (next: http://localhost:38969/tests/dromaeo/cssquery-jquery.html) 15:04:31 INFO - PROCESS | 25803 | RSS: Main: 248270848 15:04:31 INFO - PROCESS | 25803 | 15:07:33 INFO - PROCESS | 25803 | Cycle 1(1): loaded http://localhost:38969/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38969/tests/dromaeo/cssquery-mootools.html) 15:07:33 INFO - PROCESS | 25803 | RSS: Main: 244178944 15:07:33 INFO - PROCESS | 25803 | 15:10:36 INFO - PROCESS | 25803 | Cycle 1(1): loaded http://localhost:38969/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38969/tests/dromaeo/cssquery-prototype.html) 15:10:36 INFO - PROCESS | 25803 | RSS: Main: 246190080 15:10:36 INFO - PROCESS | 25803 | 15:13:39 INFO - PROCESS | 25803 | Cycle 1(1): loaded http://localhost:38969/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38969/tests/dromaeo/cssquery-yui.html) 15:13:40 INFO - PROCESS | 25803 | RSS: Main: 216576000 15:13:40 INFO - PROCESS | 25803 | 15:16:43 INFO - PROCESS | 25803 | Cycle 1(1): loaded http://localhost:38969/tests/dromaeo/cssquery-yui.html (next: http://localhost:38969/tests/dromaeo/cssquery-dojo.html) 15:16:43 INFO - PROCESS | 25803 | RSS: Main: 340291584 15:16:43 INFO - PROCESS | 25803 | 15:16:43 INFO - PROCESS | 25803 | __start_tp_report 15:16:43 INFO - PROCESS | 25803 | _x_x_mozilla_page_load 15:16:43 INFO - PROCESS | 25803 | _x_x_mozilla_page_load_details 15:16:43 INFO - PROCESS | 25803 | |i|pagename|runs| 15:16:43 INFO - PROCESS | 25803 | |0;dojo.html;2591.740825917408;2606.4526449445616;2631.5263252614523;2641.5377308970938;2643.709191988882;4557.339185818063;4610.216263235249;4683.531646835315;4688.249880019193;4695.90608187836;4633.258678611414;4691.812327506904;4697.4597921239065;4722.268048452487;4750.76246187691;4260.041490664591;4273.679474039444;4337.154254920292;4368.847090351838;4503.977480112595;4421.624161946254;4440.42274504314;4463.196624607569;4468.687191896569;4492.079123779634;4221.324588065925;4305.698601097924;4309.288967320388;4313.784310784479;4389.802458889326;4301.268784306675;4307.504636966758;4317.892052698676;4366.476022877275;4384.101259241847;4347.434833471629;4373.2565463871215;4374.365716971053;4404.163208990281;4422;4581.198290299218;4637.675362724611;4689.648276379251;4707.929381059287;4722.504137065627;5019.573336266385;5085.949140508585;5090.414602320743;5091.338126043628;5092.490750924915;5093;5106;5121.974390128063;5126.077306084903;5129.256257842592;4523.547645235516;4641.535846415331;4711.387519622427;4713.010267843722;4768.2370820668875;5241.16141417379;5256.159014557652;5256.526912577886;5257.027449921777;5264.868378290496;4963.553280204799;5028.949710502921;5035.118854200574;5036.219385995177;5041.747912604355;4821.590164835958;5029.245613158056;5055;5083.059633967728;5151.356080489939;5037.093323201859;5041.647084704109;5044.041632089965;5047.192449208109;5059.342285502861;5005.074061298671;5007;5009.323741294878;5015.072211640858;5047.29337892688;3888.922221555553;3935.685145188378;3964.4647972523917;4005.899852503711;4011.6991225657607;3536.7170626350344;3537.6816086552335;3570.6429357064603;3578.946315805265;3585.8744943926836;4440.489343725449;4446.466424029137;4446.911061778746;4452.710573812757;4486.910261794746;4864.270359446112;4975.278584605212;5021.598272138293;5024.799008039638;5181.611379146579;4322.157179349996;4336.37122617225;4341.739495630272;4342.5657434256955;4387.100644367897;4530.116627257719;4537.047220083753;4541.341505481687;4541.545845415432;4575.81696732127;4643.141018911512;4771.809127634856;4815.181419158681;4820.927686084641;4899.363082799213;5136.30659860914;5156.381234251914;5167.328247327823;5167.741612919263;5210.97394513025;4821.5178482151505;4843.2735089736825;4843.831273375855;4852.272159176152;4893.143699852582;4893.73084480357;5003.474635163256;5024.572911302434;5069.112905241494;5098.107831129463;5142.820001299937;5144.176931691061;5147.176451767699;5150.871228219325;5157.149070403341;4960.72716000609;4986.750662466789;4988.850334489971;4989.426215985208;5025.924611130763;4750.619950404029;4858.6356023297685;4883.780229889592;4909.361782968192;4926.531979461945;4813.687110337817;4842.4189097308545;4844.709317440965;4895.265710143507;4904.852854414374;4860.73265970375;4916.262560615936;4946.975265123651;4954.133026720381;4956.529129732669;4777.713337199779;4845.127876982177;4859.246816743411;4860.465348811557;4863.294822250825 15:16:43 INFO - PROCESS | 25803 | |1;ext.html;572.2274928846058;579.5566391710342;589.1016200294553;589.9970500147499;593.4421643654962;27564.724352756468;39414.60585394149;40633;40696.79651601738;43928.56071439285;40882.59117408825;41129.38305925406;41283.380749288786;41292.17415651685;41307;7500.137484189307;7816.179301173366;7948.7217947371855;7957.3634109271115;7959;7489.513181643203;7742.187070357616;7742.8838567421535;10119.696409107739;10395.948020259888;10362.948185259102;10427;10432.374057556533;10433.530491127918;10436;10153.187744980383;10243.334183278062;10324.328918620304;10389.480525973671;10396;7376.778696639056;9991.550380232908;10375.84436233457;10382;10746.355218686904;33490.1627459313;33719.494207586904;33735.156621084425;33746.49380259298;33751;3097.473429516965;3184.745220382387;3354.3123659649714;3453.2230248194205;3647.562292524914;29780.851095744383;30232.84883575568;30703.232419189477;30709.846450767825;31307.217319566964;3445.207602251496;3477.3914564951033;3477.878274260414;3513.84187711551;3571.0358203285227;303820;307331;309567;431184;432133;54801.45198547964;55050.44949550453;55357.446425536036;55413.722931385084;55424.722876385356;32880.1779955503;34099.829500852335;34139.82930085383;35844.82077589648;55184.44815551793;14833.406663733545;15238.542843714706;15323.846761532464;15461.613459663598;15608.375664973273;9678.56446459911;10798.082163016075;10840.241183117107;10857.837132443019;10876.347419154717;17977.550561236072;18351.541211469554;18533.351332703292;18972.905135474233;18992.62014759725;6774.796756097325;6935.6878940446795;6994.5453545520395;7062.6821793019435;7201.92798072023;760.0423466432335;841.2386789955101;942.7461476236589;945.7399215215871;981.5288661442405;26832.463350732876;27035.1889443317;27746.445071098464;27885.442291154064;28381;926.9629214831331;928.2481190235931;952.0812416018575;952.9714108576753;976.2092704909046;14568.562943111723;14753.631159220891;14803.595173110245;14839.332230049673;15150.621234469007;119133;119423.40288298676;119497;120029.39985300017;120038;33292.3341533168;33510.16224594356;33531.329373412394;33551.832240839125;33554.66445335515;1062.8883967183335;1140.931544107356;1143.7883991461606;1203.2239205712267;1242.7949388350821;27298.863505683137;27548.311292217055;29429.411411771216;29571.52136938555;29643.40713185767;43020.78489607532;43494.13011739684;43887.34168987404;43893;43905.34141987809;355483;359885;360567;360616;360646;32945.67054329426;38702.80648596739;39028.87768978532;40375.798121009204;40443.59556404516;41938.37092443555;41984.370234445894;42283;42663;42967;37048;37058.25883482369;37111;37508.43737343996;37589;36858;37028;37045.81477092597;37214.255714886094;37326.813365933;33959.32081358408;35849.1037724059;36027.63972360243;36029.27941441209;36493.08767280839;31718.365632687677;33510.832445837616;33513.83243083769;33651.3269734599;33704.325913482084;24554.877225613756;24916.626250605892;25033.74966250387;25195.370115747253;25418.364540886625 15:16:43 INFO - PROCESS | 25803 | |2;jquery.html;369.9223163135741;370.90171104657264;376.2925699684591;384.85183204466273;397.4277041060872;16820.07489588072;17899;18050.63898722025;18724.812751872476;18729.250829966786;17358.826411735878;17868.731969020475;18169.909150454263;18178.27286908522;18204.089795510237;5116.488351164872;5304.124819404794;5320.1753728172;5346.572274218053;5348.786048558053;5253.789848406059;5369.194620806871;5671.120976248688;5684.289463817023;5763.5101016413655;5719.199312096289;5729.226554415142;5733.655980641154;5734.111212762028;5741.081426971686;5493.121100623901;5715.971420142914;5718.71406429679;5720.599558030939;5725.227094342252;4741.122892264908;5511.063119269734;5525.309336332958;5527.5577953764005;5528.115501519737;12685.809712854314;13319.600411987656;13336.933315333457;13349;13527.932360338134;1916.2718167096414;1978.3867001229664;1978.8219060284644;2039.3372154049846;2105.4210092224607;9475.147236748657;9494.477803720793;9896;10603.734906627318;13749.243791591458;1626.6014826367498;1684.139195599309;1712.1182590965664;1801.3245033112582;1816.3915088445387;51045.48954510444;62783.058254126685;63856;69419.30580694179;73525.63237183834;10288.2798204125;10344.586216551405;10543.156547476183;10574.735631609272;10694.572217111385;12558.434870430852;13454.394552245172;14432.855671443362;14572.125672459686;14577.92711036438;7501.887471687929;7544.396448284124;7552.207018263113;7632.160462349138;7742.341900938371;7086.964565177141;7148.213696493382;7289.599072051088;7289.630869967282;7314.122305323395;4472.485664148599;4502.077074199781;4525.818967241339;4563.589276965089;4568.725876447357;1801.4595621313554;1814.3559036541837;1851.1854783895044;1869.242956602578;1902.9619407612047;816.8774683797478;838.7903024243939;843.8312337532395;864.2351518905688;894.3560636341823;16832.495025149266;17453.563660908578;17639.82360176382;17928.731069033976;18199;819.062173810995;836.690424542923;858.9098144694842;870.0646804684862;871.7428358634218;9421.90578094224;9633.566489507848;10026.69919902404;10384.896151038543;10400.115990140923;398896;405004;418692;422797;425087;76962;79354.6032269835;80305.19694803093;82127.9999999988;82778;900.1853322742928;907.732218995398;913.9588718507683;934.8130373925242;942.5051847779833;16227.136009257525;16372.426965056165;16541.917290413472;16570.42003529919;16859;37447.81276093602;39501;39550;40959.59040409677;41930.790346048074;50108;55425;55479;55528.72235638796;55663.44336556583;7757.340626046849;7926.365890728844;8097.838043238984;8150.184981501802;8403.663853445794;8680.652773888974;11240.213185076966;11881.881181188077;12113.515459381526;12373.072019598747;4964.702117872939;5048.697078175322;9264.16622503951;10606.46967651599;10700.250982431155;10405.843912341472;10497.2127090467;10505.894941050492;10806.081483074027;10869.402182879701;10682.252242342962;10682.73573969708;10789.40658263803;10821.947732147162;10993.230473866752;7469.701211951461;7515.023047003854;7615.657295421608;7657.081150261782;7837.529748214897;8997.865032024656;10587.417692027013;10650.254482186172;10670.19973502006;10873.293235939638 15:16:43 INFO - PROCESS | 25803 | |3;mootools.html;1177.9928161421979;1203.7712834561432;1248.4818800197918;1329.7340531893622;1711.863050955923;6793.762218322359;7637.9236207637905;7917.802054948629;7927.603619819015;8150.103488616262;7855.567943763091;7985.16155803641;8000.319972802305;8001.839963200747;8011.5193088414735;1805.711086226204;2065.349414934291;2141.1114387529155;2221.555688862226;2257.683924250606;2220.600291947449;2241.5180736141724;2242.1479837661664;2245.955080898381;2247.6516139998325;2181.6073106840763;2194.9561008779815;2213.7896899794573;2222.9777702223014;2224.8331375146927;1785.4018903667286;2048.1193086972594;2089.101686274901;2118.459792752838;2122.9256976005768;2044.7137400763904;2059.5468996820823;2061.165228082629;2062.3194345865827;2064.225915281769;7968.243016913384;8003.079645840745;8018.398620103516;8027.839443211103;8036.517808931483;4542.6138778203895;4632.027274272406;4663.27719203524;4664.440267167962;4666.626669866437;2747.972520274812;2914.9125526234247;2932.5014747492764;2939.7060293970644;2947.882084716609;925.0564424287256;956.1299217711918;964.4936408385583;974.9122578967856;978.2614126334572;10865.728356791064;10903.727406814893;10909.618163364245;10913.563457461692;10928.344299341985;3988.3020471417385;4129.91740165201;4200.453940987713;4275.315949448135;4286.614204721528;9236.122568355995;9306.90693093074;9307.441553506811;9322.580483878242;9328.813423731623;4533.070720502289;4537.455505339381;4538.092381523708;4538.319252112144;4541.841035563805;3607.9278414431565;4013.257547353749;4149.564295748964;4165.520965088993;4226.556211597799;3606.85572577094;3683.7053035757076;3776.1126135358168;3789.0716774390453;3816.6183381662167;1043.274923927878;1170.607846371458;1177.899878510319;1182.4737991593831;1190.7737529869298;561.6180996922051;690.226945820674;691.8201267670341;753.9019927409402;787.8503084414058;4918.213085906238;5126.79492820283;5137.717425541557;5200.97399513;5234.97382513085;869.6521391443473;873.1617647058767;876.3558784293539;880.4849163239577;881.9470831749987;3541.5218945442552;3646.1431563582537;3667.0832291927018;3673.669369756735;3687.410014397737;9503;9688.12806847387;9898.950505247427;9912.603495860229;9925;9614.51927403627;9706.223502119814;9739.220862330996;9763.218942484584;9853.753656158653;7203.171635262012;7245.985562021321;7321.74373896911;7324.157721862054;7324.597147156957;4927.1131196384995;5043.394792624908;5069.214271787879;5163.509466600667;5204.271402003798;9067;9071.183593476355;9073.90926090757;9168.404053736485;9173.08269173104;8690.174433428814;9073;9091.363604547618;9183.448993060438;9346.53267336644;6081.787137450168;6290.1508296381235;6290.339514350927;6706.329367063255;6811.591304521745;7088.149422069385;7088.220295767358;7146.892796607951;7328.523645963209;7403.370713489414;6871;6943.409810166192;6993.720251190099;7076.540024898365;7146.3568278855155;6813.965930170318;6821.113255276782;6872.140982377203;6873.381395674413;6940.6182659952165;5858.7070646468355;6088.8782224356155;6105.877882442415;6187;6190.7214175363115;4345.934810977901;4364.75993820343;4400.823967041282;4413.249747542861;4476.104779044269;4588.632909367309;4643.767811609474;4652.464966528893;4701.506341834195;4744.003759210466 15:16:43 INFO - PROCESS | 25803 | |4;prototype.html;290.8516656505182;295.88312616516475;298.7669617698195;301.1537579401881;304.5173400160745;4872.220444728844;4898.6815856969315;4899.216125419929;4899.706017638935;4920.458749537548;4770;4789.784459699314;4870.780814863331;4871.780769865356;4880.951190488103;3581.749277550566;3736.5889752127246;3768;3804.239152169577;3823.483829682999;3787.8106094695295;3836.6547010769027;3843.577206507296;3857.4213867919757;3863.1694185750057;3793.924121517568;3794.7343685941996;3813.1229817142075;3815.866444674437;3827.311084004878;3616.7468277220605;3714.331420344337;3800.7339486235974;3806.619338066199;3847.480590120326;3362.0754292569495;3394.1514621344663;3398.048546406985;3400.5409269748516;3406.1654894550747;4706.1293660672545;4708.540352490739;4720.929186062212;4722.976385118052;4724.480307166209;4228.9518262058255;4337.804798784062;4338.761368124752;4349.586789255016;4357.172137293904;4992.750362481861;5014.398272207322;5025.748712564357;5031.32077169581;5032.232272250248;3649.033006253345;3652.6347365263528;3658.0306218852024;3660.3228402745312;3707.9073023174365;5170.819021334235;5328.413874473805;5343.877785664976;5346.973265133688;5353.732313384316;3763.078045878777;3779.111908701453;3783.281176576442;3783.39465685489;3793.6016718244737;3830.0275358190556;3833.8083095845654;3835.3671644178958;3836.3861782114727;3838.7120965927666;4302.569743025672;4334.609885110355;4334.696571240046;4340.175366680321;4358.912821743547;4840.273958906192;5012.398512178562;5036.81634815818;5038.546530812245;5107.387113546398;1307.2744626732065;1310.6461255460972;1316.1576590981779;1321.2336844630092;1323.9271840048889;809.514291425152;833.966641334352;860.3977215948861;868.6785889220903;874.7638137702785;4352.434183556117;4370.562943705604;4386.978065109654;4397.36238245459;4402.097569998143;5166;5202.97398513005;5214.800595862973;5217.947820521822;5241.449647787003;4319.568043195718;4482.417285752831;4482.708623939434;4483.1706134364595;4491;2742.1362270884606;2762.1575419496844;2765.8478783666687;2768.3632764464287;2776.4585905748186;4918.631102667243;4925.532074452921;4933.531314525115;4933.827316043921;4957.975210123998;5088.643794934393;5314.867128321745;5333.093374126408;5356.705381203993;5383.111786555174;4835.975820120947;4883.658143929962;4917.5082491751255;4918.754062296871;4967.950320496749;5245.737713114406;5248.343957005374;5271.156614941591;5283.5773138149625;5308.495692909168;4994.625403094855;5139.126348520836;5177.275181474522;5188.7405629717605;5199.92200116991;4930.285108659153;4938.901221975612;4948.158813001726;4954.126606568254;4956.157453232887;3831.712621553339;3866.922661546697;3867.3232184368185;3869.8065096744485;3889.824957876846;5077.339945807022;5167.30537665571;5177.534021937893;5189.247559103834;5283.4452382499285;5013.899722005613;5036.269740887477;5039.807683657621;5045.8738531537;5047.384836852319;4973;5006.6495345325475;5071.77177027042;5080.618953578422;5087.796488140433;4766.547178018082;4931.9753401232765;4967.552920237052;4986.401631804207;5019.874503137451;4829.589484893683;4870.659053866196;5012.348394708664;5015;5038.546530812245;4908.239222920453;4955.603551715782;5001.549860512571;5003.899142188713;5004.424491183415 15:16:43 INFO - PROCESS | 25803 | |5;yui.html;602.6570347096806;658.0359772932655;661.9371159739823;674.8076798112539;744.7616762635957;12336.198147120442;13258;13280.269585172824;13286.534971276007;13300.068995170343;12819.294938778363;13320.666983325422;13555.390007449663;13666.658333541667;13671.658208544792;781.0510230070463;794.2494342846013;798.2177466083242;799.4963173200904;802.430274505102;613.0926229180815;741.2920660768953;792.5759718550577;794.2613369566301;795.5703919883256;830.4021104804531;832.367400775412;833.5248908122372;834.2575108153748;834.3450391442718;637.2034956304619;826.3100311240122;827.1521690267493;827.6523859978823;827.8509868223687;571.5913122117664;608.8264844519291;609.0590038390653;609.7804790275497;610.2493932463095;12637.49450021998;12643.810342844865;12653.367331633473;12653.620391388273;12700.110992230548;12563.560275390317;12888.548900788428;13059.347032648424;13079.86920130796;13107.803382949263;11548.133889958286;11598.420078996016;11838.822417663741;11906.642800715992;12295.75408491834;4159.667226621863;4231.534531201565;4304.160688665712;4348.4999225089205;4350.695451318409;59567.702161489346;59574;59589.40410595925;59800.40199597992;60218.69890650519;10125.341852779546;10206.438645874548;10404.375737455777;10525.473726313654;10774.299670521392;18987.81012189888;19107.23571057142;19177.32879349244;19229.13468893903;19704.70442943357;5920.674362910081;6250.6874656267;6507.3167317431935;6575.178102737158;6730.192376914703;3616.222512159898;3756.1736417988;3758.4174452959833;3807.9238415232094;3816.7328287020196;2855.5431131018936;2942.985285073561;2969.302213979713;2972.3758010817537;2996.8201907885596;497.572088004316;501.70900877490965;506.55170174395187;514.5471984653481;517.4902720820064;495.8388523729802;531.0785786660142;532.5606374740854;554.2489926150008;556.4491153757832;7637.541747495057;7772.961135194288;7833.451658383972;7939.722109726247;8355.456895301786;521.8669239343943;527.5937528103339;550.4495504495504;555.8026900450362;556.3796367050709;3689.9815500922323;3767.095896984759;3775.6413140751583;3916.823742931575;3952.0672962463227;53923.46076539263;54638.45361546413;77250;80245.59877200576;80555.59722201352;46989.06021879612;47724.522754772705;65147.02279465717;68161.65919170472;68706.65646671834;44402.77798610986;45948.770256149175;72850.27149728646;74066;76317.89456843439;7927.207279272026;8006.759797206093;8113.432059755996;8238.546879921661;8288.171182881664;44352.556474434845;45237.321440177766;45428.545714543754;46730.29904551367;46777;63355;65542;66171.33828661652;66280.6685966567;67575.3242467569;11317.151213659174;11325.15061370384;11671.416429178676;11719.589814356457;12189.329586872807;13251;13362;13568.1859088455;13904.72190556163;14310.713785724436;10618.256722029384;10696;10997.890021100007;11014.118870490182;11035.448227588427;12081.214721043105;12200.288062357326;12231.69420764488;12427.734141382038;12614;11267.887321126684;11455.255408398427;11534.769304614028;11886;11937.28376297425;9972.551235194289;10295.124914382062;10302.639407620698;10319.903026433361;10331.586736530455;8573.571321434029;8908.777280568038;9295.814083718153;9347.859782103138;9387.342885997914 15:16:43 INFO - PROCESS | 25803 | __end_tp_report 15:16:43 INFO - PROCESS | 25803 | __start_cc_report 15:16:43 INFO - PROCESS | 25803 | _x_x_mozilla_cycle_collect,1038 15:16:43 INFO - PROCESS | 25803 | __end_cc_report 15:16:43 INFO - PROCESS | 25803 | __startTimestamp1468621003624__endTimestamp 15:16:43 INFO - PROCESS | 25803 | 15:16:43 INFO - PROCESS | 25803 | ------- Summary: start ------- 15:16:43 INFO - PROCESS | 25803 | Number of tests: 6 15:16:43 INFO - PROCESS | 25803 | 15:16:43 INFO - PROCESS | 25803 | [#0] dojo.html Cycles:165 Average:4667.95 Median:4821.52 stddev:520.67 (10.8%) stddev-sans-first:496.14 15:16:43 INFO - PROCESS | 25803 | Values: 2591.7 2606.5 2631.5 2641.5 2643.7 4557.3 4610.2 4683.5 4688.2 4695.9 4633.3 4691.8 4697.5 4722.3 4750.8 4260.0 4273.7 4337.2 4368.8 4504.0 4421.6 4440.4 4463.2 4468.7 4492.1 4221.3 4305.7 4309.3 4313.8 4389.8 4301.3 4307.5 4317.9 4366.5 4384.1 4347.4 4373.3 4374.4 4404.2 4422.0 4581.2 4637.7 4689.6 4707.9 4722.5 5019.6 5085.9 5090.4 5091.3 5092.5 5093.0 5106.0 5122.0 5126.1 5129.3 4523.5 4641.5 4711.4 4713.0 4768.2 5241.2 5256.2 5256.5 5257.0 5264.9 4963.6 5028.9 5035.1 5036.2 5041.7 4821.6 5029.2 5055.0 5083.1 5151.4 5037.1 5041.6 5044.0 5047.2 5059.3 5005.1 5007.0 5009.3 5015.1 5047.3 3888.9 3935.7 3964.5 4005.9 4011.7 3536.7 3537.7 3570.6 3578.9 3585.9 4440.5 4446.5 4446.9 4452.7 4486.9 4864.3 4975.3 5021.6 5024.8 5181.6 4322.2 4336.4 4341.7 4342.6 4387.1 4530.1 4537.0 4541.3 4541.5 4575.8 4643.1 4771.8 4815.2 4820.9 4899.4 5136.3 5156.4 5167.3 5167.7 5211.0 4821.5 4843.3 4843.8 4852.3 4893.1 4893.7 5003.5 5024.6 5069.1 5098.1 5142.8 5144.2 5147.2 5150.9 5157.1 4960.7 4986.8 4988.9 4989.4 5025.9 4750.6 4858.6 4883.8 4909.4 4926.5 4813.7 4842.4 4844.7 4895.3 4904.9 4860.7 4916.3 4947.0 4954.1 4956.5 4777.7 4845.1 4859.2 4860.5 4863.3 15:16:43 INFO - PROCESS | 25803 | 15:16:43 INFO - PROCESS | 25803 | [#1] ext.html Cycles:180 Average:43873.82 Median:18792.52 stddev:80191.96 (426.7%) stddev-sans-first:80351.01 15:16:43 INFO - PROCESS | 25803 | Values: 572.2 579.6 589.1 590.0 593.4 27564.7 39414.6 40633.0 40696.8 43928.6 40882.6 41129.4 41283.4 41292.2 41307.0 7500.1 7816.2 7948.7 7957.4 7959.0 7489.5 7742.2 7742.9 10119.7 10395.9 10362.9 10427.0 10432.4 10433.5 10436.0 10153.2 10243.3 10324.3 10389.5 10396.0 7376.8 9991.6 10375.8 10382.0 10746.4 33490.2 33719.5 33735.2 33746.5 33751.0 3097.5 3184.7 3354.3 3453.2 3647.6 29780.9 30232.8 30703.2 30709.8 31307.2 3445.2 3477.4 3477.9 3513.8 3571.0 303820.0 307331.0 309567.0 431184.0 432133.0 54801.5 55050.4 55357.4 55413.7 55424.7 32880.2 34099.8 34139.8 35844.8 55184.4 14833.4 15238.5 15323.8 15461.6 15608.4 9678.6 10798.1 10840.2 10857.8 10876.3 17977.6 18351.5 18533.4 18972.9 18992.6 6774.8 6935.7 6994.5 7062.7 7201.9 760.0 841.2 942.7 945.7 981.5 26832.5 27035.2 27746.4 27885.4 28381.0 927.0 928.2 952.1 953.0 976.2 14568.6 14753.6 14803.6 14839.3 15150.6 119133.0 119423.4 119497.0 120029.4 120038.0 33292.3 33510.2 33531.3 33551.8 33554.7 1062.9 1140.9 1143.8 1203.2 1242.8 27298.9 27548.3 29429.4 29571.5 29643.4 43020.8 43494.1 43887.3 43893.0 43905.3 355483.0 359885.0 360567.0 360616.0 360646.0 32945.7 38702.8 39028.9 40375.8 40443.6 41938.4 41984.4 42283.0 42663.0 42967.0 37048.0 37058.3 37111.0 37508.4 37589.0 36858.0 37028.0 37045.8 37214.3 37326.8 33959.3 35849.1 36027.6 36029.3 36493.1 31718.4 33510.8 33513.8 33651.3 33704.3 24554.9 24916.6 25033.7 25195.4 25418.4 15:16:43 INFO - PROCESS | 25803 | 15:16:43 INFO - PROCESS | 25803 | [#2] jquery.html Cycles:180 Average:25100.14 Median:4487.28 stddev:68293.09 (1521.9%) stddev-sans-first:68459.43 15:16:43 INFO - PROCESS | 25803 | Values: 369.9 370.9 376.3 384.9 397.4 16820.1 17899.0 18050.6 18724.8 18729.3 17358.8 17868.7 18169.9 18178.3 18204.1 5116.5 5304.1 5320.2 5346.6 5348.8 5253.8 5369.2 5671.1 5684.3 5763.5 5719.2 5729.2 5733.7 5734.1 5741.1 5493.1 5716.0 5718.7 5720.6 5725.2 4741.1 5511.1 5525.3 5527.6 5528.1 12685.8 13319.6 13336.9 13349.0 13527.9 1916.3 1978.4 1978.8 2039.3 2105.4 9475.1 9494.5 9896.0 10603.7 13749.2 1626.6 1684.1 1712.1 1801.3 1816.4 51045.5 62783.1 63856.0 69419.3 73525.6 10288.3 10344.6 10543.2 10574.7 10694.6 12558.4 13454.4 14432.9 14572.1 14577.9 7501.9 7544.4 7552.2 7632.2 7742.3 7087.0 7148.2 7289.6 7289.6 7314.1 4472.5 4502.1 4525.8 4563.6 4568.7 1801.5 1814.4 1851.2 1869.2 1903.0 816.9 838.8 843.8 864.2 894.4 16832.5 17453.6 17639.8 17928.7 18199.0 819.1 836.7 858.9 870.1 871.7 9421.9 9633.6 10026.7 10384.9 10400.1 398896.0 405004.0 418692.0 422797.0 425087.0 76962.0 79354.6 80305.2 82128.0 82778.0 900.2 907.7 914.0 934.8 942.5 16227.1 16372.4 16541.9 16570.4 16859.0 37447.8 39501.0 39550.0 40959.6 41930.8 50108.0 55425.0 55479.0 55528.7 55663.4 7757.3 7926.4 8097.8 8150.2 8403.7 8680.7 11240.2 11881.9 12113.5 12373.1 4964.7 5048.7 9264.2 10606.5 10700.3 10405.8 10497.2 10505.9 10806.1 10869.4 10682.3 10682.7 10789.4 10821.9 10993.2 7469.7 7515.0 7615.7 7657.1 7837.5 8997.9 10587.4 10650.3 10670.2 10873.3 15:16:43 INFO - PROCESS | 25803 | 15:16:43 INFO - PROCESS | 25803 | [#3] mootools.html Cycles:180 Average:5140.31 Median:5150.61 stddev:2941.54 (57.1%) stddev-sans-first:2934.72 15:16:43 INFO - PROCESS | 25803 | Values: 1178.0 1203.8 1248.5 1329.7 1711.9 6793.8 7637.9 7917.8 7927.6 8150.1 7855.6 7985.2 8000.3 8001.8 8011.5 1805.7 2065.3 2141.1 2221.6 2257.7 2220.6 2241.5 2242.1 2246.0 2247.7 2181.6 2195.0 2213.8 2223.0 2224.8 1785.4 2048.1 2089.1 2118.5 2122.9 2044.7 2059.5 2061.2 2062.3 2064.2 7968.2 8003.1 8018.4 8027.8 8036.5 4542.6 4632.0 4663.3 4664.4 4666.6 2748.0 2914.9 2932.5 2939.7 2947.9 925.1 956.1 964.5 974.9 978.3 10865.7 10903.7 10909.6 10913.6 10928.3 3988.3 4129.9 4200.5 4275.3 4286.6 9236.1 9306.9 9307.4 9322.6 9328.8 4533.1 4537.5 4538.1 4538.3 4541.8 3607.9 4013.3 4149.6 4165.5 4226.6 3606.9 3683.7 3776.1 3789.1 3816.6 1043.3 1170.6 1177.9 1182.5 1190.8 561.6 690.2 691.8 753.9 787.9 4918.2 5126.8 5137.7 5201.0 5235.0 869.7 873.2 876.4 880.5 881.9 3541.5 3646.1 3667.1 3673.7 3687.4 9503.0 9688.1 9899.0 9912.6 9925.0 9614.5 9706.2 9739.2 9763.2 9853.8 7203.2 7246.0 7321.7 7324.2 7324.6 4927.1 5043.4 5069.2 5163.5 5204.3 9067.0 9071.2 9073.9 9168.4 9173.1 8690.2 9073.0 9091.4 9183.4 9346.5 6081.8 6290.2 6290.3 6706.3 6811.6 7088.1 7088.2 7146.9 7328.5 7403.4 6871.0 6943.4 6993.7 7076.5 7146.4 6814.0 6821.1 6872.1 6873.4 6940.6 5858.7 6088.9 6105.9 6187.0 6190.7 4345.9 4364.8 4400.8 4413.2 4476.1 4588.6 4643.8 4652.5 4701.5 4744.0 15:16:43 INFO - PROCESS | 25803 | 15:16:43 INFO - PROCESS | 25803 | [#4] prototype.html Cycles:180 Average:4222.50 Median:4855.47 stddev:1213.35 (25.0%) stddev-sans-first:1180.32 15:16:43 INFO - PROCESS | 25803 | Values: 290.9 295.9 298.8 301.2 304.5 4872.2 4898.7 4899.2 4899.7 4920.5 4770.0 4789.8 4870.8 4871.8 4881.0 3581.7 3736.6 3768.0 3804.2 3823.5 3787.8 3836.7 3843.6 3857.4 3863.2 3793.9 3794.7 3813.1 3815.9 3827.3 3616.7 3714.3 3800.7 3806.6 3847.5 3362.1 3394.2 3398.0 3400.5 3406.2 4706.1 4708.5 4720.9 4723.0 4724.5 4229.0 4337.8 4338.8 4349.6 4357.2 4992.8 5014.4 5025.7 5031.3 5032.2 3649.0 3652.6 3658.0 3660.3 3707.9 5170.8 5328.4 5343.9 5347.0 5353.7 3763.1 3779.1 3783.3 3783.4 3793.6 3830.0 3833.8 3835.4 3836.4 3838.7 4302.6 4334.6 4334.7 4340.2 4358.9 4840.3 5012.4 5036.8 5038.5 5107.4 1307.3 1310.6 1316.2 1321.2 1323.9 809.5 834.0 860.4 868.7 874.8 4352.4 4370.6 4387.0 4397.4 4402.1 5166.0 5203.0 5214.8 5217.9 5241.4 4319.6 4482.4 4482.7 4483.2 4491.0 2742.1 2762.2 2765.8 2768.4 2776.5 4918.6 4925.5 4933.5 4933.8 4958.0 5088.6 5314.9 5333.1 5356.7 5383.1 4836.0 4883.7 4917.5 4918.8 4968.0 5245.7 5248.3 5271.2 5283.6 5308.5 4994.6 5139.1 5177.3 5188.7 5199.9 4930.3 4938.9 4948.2 4954.1 4956.2 3831.7 3866.9 3867.3 3869.8 3889.8 5077.3 5167.3 5177.5 5189.2 5283.4 5013.9 5036.3 5039.8 5045.9 5047.4 4973.0 5006.6 5071.8 5080.6 5087.8 4766.5 4932.0 4967.6 4986.4 5019.9 4829.6 4870.7 5012.3 5015.0 5038.5 4908.2 4955.6 5001.5 5003.9 5004.4 15:16:43 INFO - PROCESS | 25803 | 15:16:43 INFO - PROCESS | 25803 | [#5] yui.html Cycles:180 Average:16080.96 Median:46883.03 stddev:21034.79 (44.9%) stddev-sans-first:21061.69 15:16:43 INFO - PROCESS | 25803 | Values: 602.7 658.0 661.9 674.8 744.8 12336.2 13258.0 13280.3 13286.5 13300.1 12819.3 13320.7 13555.4 13666.7 13671.7 781.1 794.2 798.2 799.5 802.4 613.1 741.3 792.6 794.3 795.6 830.4 832.4 833.5 834.3 834.3 637.2 826.3 827.2 827.7 827.9 571.6 608.8 609.1 609.8 610.2 12637.5 12643.8 12653.4 12653.6 12700.1 12563.6 12888.5 13059.3 13079.9 13107.8 11548.1 11598.4 11838.8 11906.6 12295.8 4159.7 4231.5 4304.2 4348.5 4350.7 59567.7 59574.0 59589.4 59800.4 60218.7 10125.3 10206.4 10404.4 10525.5 10774.3 18987.8 19107.2 19177.3 19229.1 19704.7 5920.7 6250.7 6507.3 6575.2 6730.2 3616.2 3756.2 3758.4 3807.9 3816.7 2855.5 2943.0 2969.3 2972.4 2996.8 497.6 501.7 506.6 514.5 517.5 495.8 531.1 532.6 554.2 556.4 7637.5 7773.0 7833.5 7939.7 8355.5 521.9 527.6 550.4 555.8 556.4 3690.0 3767.1 3775.6 3916.8 3952.1 53923.5 54638.5 77250.0 80245.6 80555.6 46989.1 47724.5 65147.0 68161.7 68706.7 44402.8 45948.8 72850.3 74066.0 76317.9 7927.2 8006.8 8113.4 8238.5 8288.2 44352.6 45237.3 45428.5 46730.3 46777.0 63355.0 65542.0 66171.3 66280.7 67575.3 11317.2 11325.2 11671.4 11719.6 12189.3 13251.0 13362.0 13568.2 13904.7 14310.7 10618.3 10696.0 10997.9 11014.1 11035.4 12081.2 12200.3 12231.7 12427.7 12614.0 11267.9 11455.3 11534.8 11886.0 11937.3 9972.6 10295.1 10302.6 10319.9 10331.6 8573.6 8908.8 9295.8 9347.9 9387.3 15:16:43 INFO - PROCESS | 25803 | -------- Summary: end -------- 15:16:43 INFO - PROCESS | 25803 | 15:16:44 INFO - TEST-INFO | 25803: exit 0 15:16:44 INFO - TEST-OK | dromaeo_css | took 1119220ms 15:16:44 INFO - TEST-START | kraken 15:16:44 INFO - operating with platform_type : linux_ 15:16:44 INFO - Initialising browser for kraken test... 15:16:44 INFO - TEST-INFO | started process 25994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz_b4or/profile http://localhost:38969/getInfo.html) 15:16:48 INFO - PROCESS | 25994 | __metrics Screen width/height:1600/1200 15:16:48 INFO - PROCESS | 25994 | colorDepth:24 15:16:48 INFO - PROCESS | 25994 | Browser inner width/height: 1024/697 15:16:48 INFO - PROCESS | 25994 | __metrics 15:16:49 INFO - PROCESS | 25994 | 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" 15:16:49 INFO - PROCESS | 25994 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:16:50 INFO - TEST-INFO | 25994: exit 0 15:16:50 INFO - Browser initialized. 15:16:50 INFO - Running cycle 1/1 for kraken test... 15:16:50 INFO - TEST-INFO | started process 26075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz_b4or/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:02 INFO - PROCESS | 26075 | RSS: Main: 159072256 15:17:02 INFO - PROCESS | 26075 | 15:17:04 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38969/tests/kraken/driver.html?testName=audio-beat-detection) 15:17:05 INFO - PROCESS | 26075 | RSS: Main: 218181632 15:17:05 INFO - PROCESS | 26075 | 15:17:08 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38969/tests/kraken/driver.html?testName=audio-dft) 15:17:09 INFO - PROCESS | 26075 | RSS: Main: 205402112 15:17:09 INFO - PROCESS | 26075 | 15:17:12 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38969/tests/kraken/driver.html?testName=audio-fft) 15:17:12 INFO - PROCESS | 26075 | RSS: Main: 270831616 15:17:12 INFO - PROCESS | 26075 | 15:17:15 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38969/tests/kraken/driver.html?testName=audio-oscillator) 15:17:15 INFO - PROCESS | 26075 | RSS: Main: 181837824 15:17:15 INFO - PROCESS | 26075 | 15:17:17 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38969/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:17:18 INFO - PROCESS | 26075 | RSS: Main: 186302464 15:17:18 INFO - PROCESS | 26075 | 15:17:21 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38969/tests/kraken/driver.html?testName=imaging-darkroom) 15:17:22 INFO - PROCESS | 26075 | RSS: Main: 221966336 15:17:22 INFO - PROCESS | 26075 | 15:17:25 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38969/tests/kraken/driver.html?testName=imaging-desaturate) 15:17:26 INFO - PROCESS | 26075 | RSS: Main: 222236672 15:17:26 INFO - PROCESS | 26075 | 15:17:29 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38969/tests/kraken/driver.html?testName=json-parse-financial) 15:17:29 INFO - PROCESS | 26075 | RSS: Main: 222523392 15:17:29 INFO - PROCESS | 26075 | 15:17:31 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38969/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:17:32 INFO - PROCESS | 26075 | RSS: Main: 210391040 15:17:32 INFO - PROCESS | 26075 | 15:17:34 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38969/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:17:34 INFO - PROCESS | 26075 | RSS: Main: 212848640 15:17:34 INFO - PROCESS | 26075 | 15:17:36 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38969/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:17:37 INFO - PROCESS | 26075 | RSS: Main: 211058688 15:17:37 INFO - PROCESS | 26075 | 15:17:40 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:17:40 INFO - PROCESS | 26075 | RSS: Main: 224808960 15:17:40 INFO - PROCESS | 26075 | 15:17:43 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:17:44 INFO - PROCESS | 26075 | RSS: Main: 226222080 15:17:44 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | Cycle 1(1): loaded http://localhost:38969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38969/tests/kraken/driver.html?testName=ai-astar) 15:17:46 INFO - PROCESS | 26075 | RSS: Main: 269492224 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | __start_tp_report 15:17:46 INFO - PROCESS | 26075 | _x_x_mozilla_page_load 15:17:46 INFO - PROCESS | 26075 | _x_x_mozilla_page_load_details 15:17:46 INFO - PROCESS | 26075 | |i|pagename|runs| 15:17:46 INFO - PROCESS | 26075 | |0;ai-astar;105;116;114;115;114;114;113;114;114;114 15:17:46 INFO - PROCESS | 26075 | |1;audio-beat-detection;151;124;124;172;122;124;149;121;163;122 15:17:46 INFO - PROCESS | 26075 | |2;audio-dft;161;162;160;160;161;162;161;161;161;162 15:17:46 INFO - PROCESS | 26075 | |3;audio-fft;87;75;77;115;75;77;75;75;104;74 15:17:46 INFO - PROCESS | 26075 | |4;audio-oscillator;85;86;111;85;86;86;122;85;85;129 15:17:46 INFO - PROCESS | 26075 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;118;117 15:17:46 INFO - PROCESS | 26075 | |6;imaging-darkroom;147;147;147;146;147;146;146;146;146;146 15:17:46 INFO - PROCESS | 26075 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 15:17:46 INFO - PROCESS | 26075 | |8;json-parse-financial;65;65;64;64;65;65;64;68;65;64 15:17:46 INFO - PROCESS | 26075 | |9;json-stringify-tinderbox;66;66;65;66;67;65;66;66;66;67 15:17:46 INFO - PROCESS | 26075 | |10;stanford-crypto-aes;79;79;78;83;78;78;78;78;80;81 15:17:46 INFO - PROCESS | 26075 | |11;stanford-crypto-ccm;138;133;130;135;137;138;136;128;220;137 15:17:46 INFO - PROCESS | 26075 | |12;stanford-crypto-pbkdf2;167;163;164;164;163;167;161;162;164;162 15:17:46 INFO - PROCESS | 26075 | |13;stanford-crypto-sha256-iterative;69;70;66;66;66;66;66;67;65;66 15:17:46 INFO - PROCESS | 26075 | __end_tp_report 15:17:46 INFO - PROCESS | 26075 | __start_cc_report 15:17:46 INFO - PROCESS | 26075 | _x_x_mozilla_cycle_collect,1903 15:17:46 INFO - PROCESS | 26075 | __end_cc_report 15:17:46 INFO - PROCESS | 26075 | __startTimestamp1468621066387__endTimestamp 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | ------- Summary: start ------- 15:17:46 INFO - PROCESS | 26075 | Number of tests: 14 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:3.02 (2.6%) stddev-sans-first:0.83 15:17:46 INFO - PROCESS | 26075 | Values: 105.0 116.0 114.0 115.0 114.0 114.0 113.0 114.0 114.0 114.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:136.50 stddev:19.59 (14.4%) stddev-sans-first:20.13 15:17:46 INFO - PROCESS | 26075 | Values: 151.0 124.0 124.0 172.0 122.0 124.0 149.0 121.0 163.0 122.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 15:17:46 INFO - PROCESS | 26075 | Values: 161.0 162.0 160.0 160.0 161.0 162.0 161.0 161.0 161.0 162.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.00 stddev:14.49 (19.3%) stddev-sans-first:15.31 15:17:46 INFO - PROCESS | 26075 | Values: 87.0 75.0 77.0 115.0 75.0 77.0 75.0 75.0 104.0 74.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:85.00 stddev:17.56 (20.7%) stddev-sans-first:18.16 15:17:46 INFO - PROCESS | 26075 | Values: 85.0 86.0 111.0 85.0 86.0 86.0 122.0 85.0 85.0 129.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 15:17:46 INFO - PROCESS | 26075 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:17:46 INFO - PROCESS | 26075 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:17:46 INFO - PROCESS | 26075 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 15:17:46 INFO - PROCESS | 26075 | Values: 65.0 65.0 64.0 64.0 65.0 65.0 64.0 68.0 65.0 64.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 15:17:46 INFO - PROCESS | 26075 | Values: 66.0 66.0 65.0 66.0 67.0 65.0 66.0 66.0 66.0 67.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:1.69 (2.1%) stddev-sans-first:1.79 15:17:46 INFO - PROCESS | 26075 | Values: 79.0 79.0 78.0 83.0 78.0 78.0 78.0 78.0 80.0 81.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:137.00 stddev:27.20 (19.9%) stddev-sans-first:28.78 15:17:46 INFO - PROCESS | 26075 | Values: 138.0 133.0 130.0 135.0 137.0 138.0 136.0 128.0 220.0 137.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:164.00 stddev:2.00 (1.2%) stddev-sans-first:1.73 15:17:46 INFO - PROCESS | 26075 | Values: 167.0 163.0 164.0 164.0 163.0 167.0 161.0 162.0 164.0 162.0 15:17:46 INFO - PROCESS | 26075 | 15:17:46 INFO - PROCESS | 26075 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.00 stddev:1.57 (2.4%) stddev-sans-first:1.42 15:17:46 INFO - PROCESS | 26075 | Values: 69.0 70.0 66.0 66.0 66.0 66.0 66.0 67.0 65.0 66.0 15:17:46 INFO - PROCESS | 26075 | -------- Summary: end -------- 15:17:46 INFO - PROCESS | 26075 | 15:17:47 INFO - TEST-INFO | 26075: exit 0 15:17:47 INFO - TEST-OK | kraken | took 63020ms 15:17:47 INFO - SUITE-END | took 1182s 15:17:47 INFO - Completed test suite (00:19:42) 15:17:47 INFO - javascript benchmark 15:17:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2591.740825917408, 2606.4526449445616, 2631.5263252614523, 2641.5377308970938, 2643.709191988882, 4557.339185818063, 4610.216263235249, 4683.531646835315, 4688.249880019193, 4695.90608187836, 4633.258678611414, 4691.812327506904, 4697.4597921239065, 4722.268048452487, 4750.76246187691, 4260.041490664591, 4273.679474039444, 4337.154254920292, 4368.847090351838, 4503.977480112595, 4421.624161946254, 4440.42274504314, 4463.196624607569, 4468.687191896569, 4492.079123779634, 4221.324588065925, 4305.698601097924, 4309.288967320388, 4313.784310784479, 4389.802458889326, 4301.268784306675, 4307.504636966758, 4317.892052698676, 4366.476022877275, 4384.101259241847, 4347.434833471629, 4373.2565463871215, 4374.365716971053, 4404.163208990281, 4422.0, 4581.198290299218, 4637.675362724611, 4689.648276379251, 4707.929381059287, 4722.504137065627, 5019.573336266385, 5085.949140508585, 5090.414602320743, 5091.338126043628, 5092.490750924915, 5093.0, 5106.0, 5121.974390128063, 5126.077306084903, 5129.256257842592, 4523.547645235516, 4641.535846415331, 4711.387519622427, 4713.010267843722, 4768.2370820668875, 5241.16141417379, 5256.159014557652, 5256.526912577886, 5257.027449921777, 5264.868378290496, 4963.553280204799, 5028.949710502921, 5035.118854200574, 5036.219385995177, 5041.747912604355, 4821.590164835958, 5029.245613158056, 5055.0, 5083.059633967728, 5151.356080489939, 5037.093323201859, 5041.647084704109, 5044.041632089965, 5047.192449208109, 5059.342285502861, 5005.074061298671, 5007.0, 5009.323741294878, 5015.072211640858, 5047.29337892688, 3888.922221555553, 3935.685145188378, 3964.4647972523917, 4005.899852503711, 4011.6991225657607, 3536.7170626350344, 3537.6816086552335, 3570.6429357064603, 3578.946315805265, 3585.8744943926836, 4440.489343725449, 4446.466424029137, 4446.911061778746, 4452.710573812757, 4486.910261794746, 4864.270359446112, 4975.278584605212, 5021.598272138293, 5024.799008039638, 5181.611379146579, 4322.157179349996, 4336.37122617225, 4341.739495630272, 4342.5657434256955, 4387.100644367897, 4530.116627257719, 4537.047220083753, 4541.341505481687, 4541.545845415432, 4575.81696732127, 4643.141018911512, 4771.809127634856, 4815.181419158681, 4820.927686084641, 4899.363082799213, 5136.30659860914, 5156.381234251914, 5167.328247327823, 5167.741612919263, 5210.97394513025, 4821.5178482151505, 4843.2735089736825, 4843.831273375855, 4852.272159176152, 4893.143699852582, 4893.73084480357, 5003.474635163256, 5024.572911302434, 5069.112905241494, 5098.107831129463, 5142.820001299937, 5144.176931691061, 5147.176451767699, 5150.871228219325, 5157.149070403341, 4960.72716000609, 4986.750662466789, 4988.850334489971, 4989.426215985208, 5025.924611130763, 4750.619950404029, 4858.6356023297685, 4883.780229889592, 4909.361782968192, 4926.531979461945, 4813.687110337817, 4842.4189097308545, 4844.709317440965, 4895.265710143507, 4904.852854414374, 4860.73265970375, 4916.262560615936, 4946.975265123651, 4954.133026720381, 4956.529129732669, 4777.713337199779, 4845.127876982177, 4859.246816743411, 4860.465348811557, 4863.294822250825], "value": 4632.849114827867, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.2274928846058, 579.5566391710342, 589.1016200294553, 589.9970500147499, 593.4421643654962, 27564.724352756468, 39414.60585394149, 40633.0, 40696.79651601738, 43928.56071439285, 40882.59117408825, 41129.38305925406, 41283.380749288786, 41292.17415651685, 41307.0, 7500.137484189307, 7816.179301173366, 7948.7217947371855, 7957.3634109271115, 7959.0, 7489.513181643203, 7742.187070357616, 7742.8838567421535, 10119.696409107739, 10395.948020259888, 10362.948185259102, 10427.0, 10432.374057556533, 10433.530491127918, 10436.0, 10153.187744980383, 10243.334183278062, 10324.328918620304, 10389.480525973671, 10396.0, 7376.778696639056, 9991.550380232908, 10375.84436233457, 10382.0, 10746.355218686904, 33490.1627459313, 33719.494207586904, 33735.156621084425, 33746.49380259298, 33751.0, 3097.473429516965, 3184.745220382387, 3354.3123659649714, 3453.2230248194205, 3647.562292524914, 29780.851095744383, 30232.84883575568, 30703.232419189477, 30709.846450767825, 31307.217319566964, 3445.207602251496, 3477.3914564951033, 3477.878274260414, 3513.84187711551, 3571.0358203285227, 303820.0, 307331.0, 309567.0, 431184.0, 432133.0, 54801.45198547964, 55050.44949550453, 55357.446425536036, 55413.722931385084, 55424.722876385356, 32880.1779955503, 34099.829500852335, 34139.82930085383, 35844.82077589648, 55184.44815551793, 14833.406663733545, 15238.542843714706, 15323.846761532464, 15461.613459663598, 15608.375664973273, 9678.56446459911, 10798.082163016075, 10840.241183117107, 10857.837132443019, 10876.347419154717, 17977.550561236072, 18351.541211469554, 18533.351332703292, 18972.905135474233, 18992.62014759725, 6774.796756097325, 6935.6878940446795, 6994.5453545520395, 7062.6821793019435, 7201.92798072023, 760.0423466432335, 841.2386789955101, 942.7461476236589, 945.7399215215871, 981.5288661442405, 26832.463350732876, 27035.1889443317, 27746.445071098464, 27885.442291154064, 28381.0, 926.9629214831331, 928.2481190235931, 952.0812416018575, 952.9714108576753, 976.2092704909046, 14568.562943111723, 14753.631159220891, 14803.595173110245, 14839.332230049673, 15150.621234469007, 119133.0, 119423.40288298676, 119497.0, 120029.39985300017, 120038.0, 33292.3341533168, 33510.16224594356, 33531.329373412394, 33551.832240839125, 33554.66445335515, 1062.8883967183335, 1140.931544107356, 1143.7883991461606, 1203.2239205712267, 1242.7949388350821, 27298.863505683137, 27548.311292217055, 29429.411411771216, 29571.52136938555, 29643.40713185767, 43020.78489607532, 43494.13011739684, 43887.34168987404, 43893.0, 43905.34141987809, 355483.0, 359885.0, 360567.0, 360616.0, 360646.0, 32945.67054329426, 38702.80648596739, 39028.87768978532, 40375.798121009204, 40443.59556404516, 41938.37092443555, 41984.370234445894, 42283.0, 42663.0, 42967.0, 37048.0, 37058.25883482369, 37111.0, 37508.43737343996, 37589.0, 36858.0, 37028.0, 37045.81477092597, 37214.255714886094, 37326.813365933, 33959.32081358408, 35849.1037724059, 36027.63972360243, 36029.27941441209, 36493.08767280839, 31718.365632687677, 33510.832445837616, 33513.83243083769, 33651.3269734599, 33704.325913482084, 24554.877225613756, 24916.626250605892, 25033.74966250387, 25195.370115747253, 25418.364540886625], "value": 17544.377755368743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.9223163135741, 370.90171104657264, 376.2925699684591, 384.85183204466273, 397.4277041060872, 16820.07489588072, 17899.0, 18050.63898722025, 18724.812751872476, 18729.250829966786, 17358.826411735878, 17868.731969020475, 18169.909150454263, 18178.27286908522, 18204.089795510237, 5116.488351164872, 5304.124819404794, 5320.1753728172, 5346.572274218053, 5348.786048558053, 5253.789848406059, 5369.194620806871, 5671.120976248688, 5684.289463817023, 5763.5101016413655, 5719.199312096289, 5729.226554415142, 5733.655980641154, 5734.111212762028, 5741.081426971686, 5493.121100623901, 5715.971420142914, 5718.71406429679, 5720.599558030939, 5725.227094342252, 4741.122892264908, 5511.063119269734, 5525.309336332958, 5527.5577953764005, 5528.115501519737, 12685.809712854314, 13319.600411987656, 13336.933315333457, 13349.0, 13527.932360338134, 1916.2718167096414, 1978.3867001229664, 1978.8219060284644, 2039.3372154049846, 2105.4210092224607, 9475.147236748657, 9494.477803720793, 9896.0, 10603.734906627318, 13749.243791591458, 1626.6014826367498, 1684.139195599309, 1712.1182590965664, 1801.3245033112582, 1816.3915088445387, 51045.48954510444, 62783.058254126685, 63856.0, 69419.30580694179, 73525.63237183834, 10288.2798204125, 10344.586216551405, 10543.156547476183, 10574.735631609272, 10694.572217111385, 12558.434870430852, 13454.394552245172, 14432.855671443362, 14572.125672459686, 14577.92711036438, 7501.887471687929, 7544.396448284124, 7552.207018263113, 7632.160462349138, 7742.341900938371, 7086.964565177141, 7148.213696493382, 7289.599072051088, 7289.630869967282, 7314.122305323395, 4472.485664148599, 4502.077074199781, 4525.818967241339, 4563.589276965089, 4568.725876447357, 1801.4595621313554, 1814.3559036541837, 1851.1854783895044, 1869.242956602578, 1902.9619407612047, 816.8774683797478, 838.7903024243939, 843.8312337532395, 864.2351518905688, 894.3560636341823, 16832.495025149266, 17453.563660908578, 17639.82360176382, 17928.731069033976, 18199.0, 819.062173810995, 836.690424542923, 858.9098144694842, 870.0646804684862, 871.7428358634218, 9421.90578094224, 9633.566489507848, 10026.69919902404, 10384.896151038543, 10400.115990140923, 398896.0, 405004.0, 418692.0, 422797.0, 425087.0, 76962.0, 79354.6032269835, 80305.19694803093, 82127.9999999988, 82778.0, 900.1853322742928, 907.732218995398, 913.9588718507683, 934.8130373925242, 942.5051847779833, 16227.136009257525, 16372.426965056165, 16541.917290413472, 16570.42003529919, 16859.0, 37447.81276093602, 39501.0, 39550.0, 40959.59040409677, 41930.790346048074, 50108.0, 55425.0, 55479.0, 55528.72235638796, 55663.44336556583, 7757.340626046849, 7926.365890728844, 8097.838043238984, 8150.184981501802, 8403.663853445794, 8680.652773888974, 11240.213185076966, 11881.881181188077, 12113.515459381526, 12373.072019598747, 4964.702117872939, 5048.697078175322, 9264.16622503951, 10606.46967651599, 10700.250982431155, 10405.843912341472, 10497.2127090467, 10505.894941050492, 10806.081483074027, 10869.402182879701, 10682.252242342962, 10682.73573969708, 10789.40658263803, 10821.947732147162, 10993.230473866752, 7469.701211951461, 7515.023047003854, 7615.657295421608, 7657.081150261782, 7837.529748214897, 8997.865032024656, 10587.417692027013, 10650.254482186172, 10670.19973502006, 10873.293235939638], "value": 8303.156020618693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1177.9928161421979, 1203.7712834561432, 1248.4818800197918, 1329.7340531893622, 1711.863050955923, 6793.762218322359, 7637.9236207637905, 7917.802054948629, 7927.603619819015, 8150.103488616262, 7855.567943763091, 7985.16155803641, 8000.319972802305, 8001.839963200747, 8011.5193088414735, 1805.711086226204, 2065.349414934291, 2141.1114387529155, 2221.555688862226, 2257.683924250606, 2220.600291947449, 2241.5180736141724, 2242.1479837661664, 2245.955080898381, 2247.6516139998325, 2181.6073106840763, 2194.9561008779815, 2213.7896899794573, 2222.9777702223014, 2224.8331375146927, 1785.4018903667286, 2048.1193086972594, 2089.101686274901, 2118.459792752838, 2122.9256976005768, 2044.7137400763904, 2059.5468996820823, 2061.165228082629, 2062.3194345865827, 2064.225915281769, 7968.243016913384, 8003.079645840745, 8018.398620103516, 8027.839443211103, 8036.517808931483, 4542.6138778203895, 4632.027274272406, 4663.27719203524, 4664.440267167962, 4666.626669866437, 2747.972520274812, 2914.9125526234247, 2932.5014747492764, 2939.7060293970644, 2947.882084716609, 925.0564424287256, 956.1299217711918, 964.4936408385583, 974.9122578967856, 978.2614126334572, 10865.728356791064, 10903.727406814893, 10909.618163364245, 10913.563457461692, 10928.344299341985, 3988.3020471417385, 4129.91740165201, 4200.453940987713, 4275.315949448135, 4286.614204721528, 9236.122568355995, 9306.90693093074, 9307.441553506811, 9322.580483878242, 9328.813423731623, 4533.070720502289, 4537.455505339381, 4538.092381523708, 4538.319252112144, 4541.841035563805, 3607.9278414431565, 4013.257547353749, 4149.564295748964, 4165.520965088993, 4226.556211597799, 3606.85572577094, 3683.7053035757076, 3776.1126135358168, 3789.0716774390453, 3816.6183381662167, 1043.274923927878, 1170.607846371458, 1177.899878510319, 1182.4737991593831, 1190.7737529869298, 561.6180996922051, 690.226945820674, 691.8201267670341, 753.9019927409402, 787.8503084414058, 4918.213085906238, 5126.79492820283, 5137.717425541557, 5200.97399513, 5234.97382513085, 869.6521391443473, 873.1617647058767, 876.3558784293539, 880.4849163239577, 881.9470831749987, 3541.5218945442552, 3646.1431563582537, 3667.0832291927018, 3673.669369756735, 3687.410014397737, 9503.0, 9688.12806847387, 9898.950505247427, 9912.603495860229, 9925.0, 9614.51927403627, 9706.223502119814, 9739.220862330996, 9763.218942484584, 9853.753656158653, 7203.171635262012, 7245.985562021321, 7321.74373896911, 7324.157721862054, 7324.597147156957, 4927.1131196384995, 5043.394792624908, 5069.214271787879, 5163.509466600667, 5204.271402003798, 9067.0, 9071.183593476355, 9073.90926090757, 9168.404053736485, 9173.08269173104, 8690.174433428814, 9073.0, 9091.363604547618, 9183.448993060438, 9346.53267336644, 6081.787137450168, 6290.1508296381235, 6290.339514350927, 6706.329367063255, 6811.591304521745, 7088.149422069385, 7088.220295767358, 7146.892796607951, 7328.523645963209, 7403.370713489414, 6871.0, 6943.409810166192, 6993.720251190099, 7076.540024898365, 7146.3568278855155, 6813.965930170318, 6821.113255276782, 6872.140982377203, 6873.381395674413, 6940.6182659952165, 5858.7070646468355, 6088.8782224356155, 6105.877882442415, 6187.0, 6190.7214175363115, 4345.934810977901, 4364.75993820343, 4400.823967041282, 4413.249747542861, 4476.104779044269, 4588.632909367309, 4643.767811609474, 4652.464966528893, 4701.506341834195, 4744.003759210466], "value": 4098.830925545489, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.8516656505182, 295.88312616516475, 298.7669617698195, 301.1537579401881, 304.5173400160745, 4872.220444728844, 4898.6815856969315, 4899.216125419929, 4899.706017638935, 4920.458749537548, 4770.0, 4789.784459699314, 4870.780814863331, 4871.780769865356, 4880.951190488103, 3581.749277550566, 3736.5889752127246, 3768.0, 3804.239152169577, 3823.483829682999, 3787.8106094695295, 3836.6547010769027, 3843.577206507296, 3857.4213867919757, 3863.1694185750057, 3793.924121517568, 3794.7343685941996, 3813.1229817142075, 3815.866444674437, 3827.311084004878, 3616.7468277220605, 3714.331420344337, 3800.7339486235974, 3806.619338066199, 3847.480590120326, 3362.0754292569495, 3394.1514621344663, 3398.048546406985, 3400.5409269748516, 3406.1654894550747, 4706.1293660672545, 4708.540352490739, 4720.929186062212, 4722.976385118052, 4724.480307166209, 4228.9518262058255, 4337.804798784062, 4338.761368124752, 4349.586789255016, 4357.172137293904, 4992.750362481861, 5014.398272207322, 5025.748712564357, 5031.32077169581, 5032.232272250248, 3649.033006253345, 3652.6347365263528, 3658.0306218852024, 3660.3228402745312, 3707.9073023174365, 5170.819021334235, 5328.413874473805, 5343.877785664976, 5346.973265133688, 5353.732313384316, 3763.078045878777, 3779.111908701453, 3783.281176576442, 3783.39465685489, 3793.6016718244737, 3830.0275358190556, 3833.8083095845654, 3835.3671644178958, 3836.3861782114727, 3838.7120965927666, 4302.569743025672, 4334.609885110355, 4334.696571240046, 4340.175366680321, 4358.912821743547, 4840.273958906192, 5012.398512178562, 5036.81634815818, 5038.546530812245, 5107.387113546398, 1307.2744626732065, 1310.6461255460972, 1316.1576590981779, 1321.2336844630092, 1323.9271840048889, 809.514291425152, 833.966641334352, 860.3977215948861, 868.6785889220903, 874.7638137702785, 4352.434183556117, 4370.562943705604, 4386.978065109654, 4397.36238245459, 4402.097569998143, 5166.0, 5202.97398513005, 5214.800595862973, 5217.947820521822, 5241.449647787003, 4319.568043195718, 4482.417285752831, 4482.708623939434, 4483.1706134364595, 4491.0, 2742.1362270884606, 2762.1575419496844, 2765.8478783666687, 2768.3632764464287, 2776.4585905748186, 4918.631102667243, 4925.532074452921, 4933.531314525115, 4933.827316043921, 4957.975210123998, 5088.643794934393, 5314.867128321745, 5333.093374126408, 5356.705381203993, 5383.111786555174, 4835.975820120947, 4883.658143929962, 4917.5082491751255, 4918.754062296871, 4967.950320496749, 5245.737713114406, 5248.343957005374, 5271.156614941591, 5283.5773138149625, 5308.495692909168, 4994.625403094855, 5139.126348520836, 5177.275181474522, 5188.7405629717605, 5199.92200116991, 4930.285108659153, 4938.901221975612, 4948.158813001726, 4954.126606568254, 4956.157453232887, 3831.712621553339, 3866.922661546697, 3867.3232184368185, 3869.8065096744485, 3889.824957876846, 5077.339945807022, 5167.30537665571, 5177.534021937893, 5189.247559103834, 5283.4452382499285, 5013.899722005613, 5036.269740887477, 5039.807683657621, 5045.8738531537, 5047.384836852319, 4973.0, 5006.6495345325475, 5071.77177027042, 5080.618953578422, 5087.796488140433, 4766.547178018082, 4931.9753401232765, 4967.552920237052, 4986.401631804207, 5019.874503137451, 4829.589484893683, 4870.659053866196, 5012.348394708664, 5015.0, 5038.546530812245, 4908.239222920453, 4955.603551715782, 5001.549860512571, 5003.899142188713, 5004.424491183415], "value": 3834.5235687957615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.6570347096806, 658.0359772932655, 661.9371159739823, 674.8076798112539, 744.7616762635957, 12336.198147120442, 13258.0, 13280.269585172824, 13286.534971276007, 13300.068995170343, 12819.294938778363, 13320.666983325422, 13555.390007449663, 13666.658333541667, 13671.658208544792, 781.0510230070463, 794.2494342846013, 798.2177466083242, 799.4963173200904, 802.430274505102, 613.0926229180815, 741.2920660768953, 792.5759718550577, 794.2613369566301, 795.5703919883256, 830.4021104804531, 832.367400775412, 833.5248908122372, 834.2575108153748, 834.3450391442718, 637.2034956304619, 826.3100311240122, 827.1521690267493, 827.6523859978823, 827.8509868223687, 571.5913122117664, 608.8264844519291, 609.0590038390653, 609.7804790275497, 610.2493932463095, 12637.49450021998, 12643.810342844865, 12653.367331633473, 12653.620391388273, 12700.110992230548, 12563.560275390317, 12888.548900788428, 13059.347032648424, 13079.86920130796, 13107.803382949263, 11548.133889958286, 11598.420078996016, 11838.822417663741, 11906.642800715992, 12295.75408491834, 4159.667226621863, 4231.534531201565, 4304.160688665712, 4348.4999225089205, 4350.695451318409, 59567.702161489346, 59574.0, 59589.40410595925, 59800.40199597992, 60218.69890650519, 10125.341852779546, 10206.438645874548, 10404.375737455777, 10525.473726313654, 10774.299670521392, 18987.81012189888, 19107.23571057142, 19177.32879349244, 19229.13468893903, 19704.70442943357, 5920.674362910081, 6250.6874656267, 6507.3167317431935, 6575.178102737158, 6730.192376914703, 3616.222512159898, 3756.1736417988, 3758.4174452959833, 3807.9238415232094, 3816.7328287020196, 2855.5431131018936, 2942.985285073561, 2969.302213979713, 2972.3758010817537, 2996.8201907885596, 497.572088004316, 501.70900877490965, 506.55170174395187, 514.5471984653481, 517.4902720820064, 495.8388523729802, 531.0785786660142, 532.5606374740854, 554.2489926150008, 556.4491153757832, 7637.541747495057, 7772.961135194288, 7833.451658383972, 7939.722109726247, 8355.456895301786, 521.8669239343943, 527.5937528103339, 550.4495504495504, 555.8026900450362, 556.3796367050709, 3689.9815500922323, 3767.095896984759, 3775.6413140751583, 3916.823742931575, 3952.0672962463227, 53923.46076539263, 54638.45361546413, 77250.0, 80245.59877200576, 80555.59722201352, 46989.06021879612, 47724.522754772705, 65147.02279465717, 68161.65919170472, 68706.65646671834, 44402.77798610986, 45948.770256149175, 72850.27149728646, 74066.0, 76317.89456843439, 7927.207279272026, 8006.759797206093, 8113.432059755996, 8238.546879921661, 8288.171182881664, 44352.556474434845, 45237.321440177766, 45428.545714543754, 46730.29904551367, 46777.0, 63355.0, 65542.0, 66171.33828661652, 66280.6685966567, 67575.3242467569, 11317.151213659174, 11325.15061370384, 11671.416429178676, 11719.589814356457, 12189.329586872807, 13251.0, 13362.0, 13568.1859088455, 13904.72190556163, 14310.713785724436, 10618.256722029384, 10696.0, 10997.890021100007, 11014.118870490182, 11035.448227588427, 12081.214721043105, 12200.288062357326, 12231.69420764488, 12427.734141382038, 12614.0, 11267.887321126684, 11455.255408398427, 11534.769304614028, 11886.0, 11937.28376297425, 9972.551235194289, 10295.124914382062, 10302.639407620698, 10319.903026433361, 10331.586736530455, 8573.571321434029, 8908.777280568038, 9295.814083718153, 9347.859782103138, 9387.342885997914], "value": 6432.620477172792, "unit": "score"}], "name": "dromaeo_css", "value": 6392.534682936362, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 124.0, 172.0, 122.0, 124.0, 149.0, 121.0, 163.0, 122.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 75.0, 77.0, 115.0, 75.0, 77.0, 75.0, 75.0, 104.0, 74.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 111.0, 85.0, 86.0, 86.0, 122.0, 85.0, 85.0, 129.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 68.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 83.0, 78.0, 78.0, 78.0, 78.0, 80.0, 81.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 130.0, 135.0, 137.0, 138.0, 136.0, 128.0, 220.0, 137.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 164.0, 164.0, 163.0, 167.0, 161.0, 162.0, 164.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1533.1000000000001, "alertThreshold": 2.0}]} 15:17:47 INFO - Return code: 0 15:17:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:17:47 INFO - # TBPL SUCCESS # 15:17:47 INFO - Running post-action listener: _resource_record_post_action 15:17:47 INFO - ##### 15:17:47 INFO - ##### Finished run-tests step (success) 15:17:47 INFO - ##### 15:17:47 INFO - Running post-run listener: _resource_record_post_run 15:17:47 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535683072; Read time: 12; Write time: 371528 15:17:47 INFO - TinderboxPrint: CPU usage
13.0% 15:17:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:17:47 INFO - TinderboxPrint: I/O write bytes / time
535,683,072 / 371,528 15:17:47 INFO - TinderboxPrint: CPU idle
8,327.5 (87.0%) 15:17:47 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 15:17:47 INFO - TinderboxPrint: Swap in / out
0 / 0 15:17:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246558720; Read time: 0; Write time: 192904 15:17:47 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288509952; Read time: 12; Write time: 178624 15:17:48 INFO - Running post-run listener: _upload_blobber_files 15:17:48 INFO - Blob upload gear active. 15:17:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:17:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:17:48 INFO - (blobuploader) - INFO - Open directory for files ... 15:17:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:17:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:17:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:56 INFO - (blobuploader) - INFO - Done attempting. 15:17:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:17:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:17:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:56 INFO - (blobuploader) - INFO - Done attempting. 15:17:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:17:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:17:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:57 INFO - (blobuploader) - INFO - Done attempting. 15:17:57 INFO - (blobuploader) - INFO - Iteration through files over. 15:17:57 INFO - Return code: 0 15:17:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:17:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:17:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8acb457be34c733429e75f80277ae598a8d7646891848d5a1173004635e94d51cf809a50b40a916c505e7874f21c66030347ae982808984a86aaa6c9f7d5af73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9434b9095775e6bf1c41d36f6f18334769fff529103388bc28ac38a38ceac3b54a06313adda8b99953be93440d9d15e6092f22ba5718147026499a7217b69e11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0f9c61943d3660f8819fe68ed657750ccd357d65e1d06617aa5336de1bb54d5540316df958a3ce2ef357cd53437dca18d0ee1283fc183553fdf76fa82f500f4"} 15:17:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:17:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:17:57 INFO - Contents: 15:17:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8acb457be34c733429e75f80277ae598a8d7646891848d5a1173004635e94d51cf809a50b40a916c505e7874f21c66030347ae982808984a86aaa6c9f7d5af73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9434b9095775e6bf1c41d36f6f18334769fff529103388bc28ac38a38ceac3b54a06313adda8b99953be93440d9d15e6092f22ba5718147026499a7217b69e11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0f9c61943d3660f8819fe68ed657750ccd357d65e1d06617aa5336de1bb54d5540316df958a3ce2ef357cd53437dca18d0ee1283fc183553fdf76fa82f500f4"} 15:17:57 INFO - Running post-run listener: copy_logs_to_upload_dir 15:17:57 INFO - Copying logs to upload dir... 15:17:57 INFO - mkdir: /builds/slave/test/build/upload/logs 15:17:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.989381 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-15 15:17:57.295995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 15:17:57.299743) ========= 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=3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8acb457be34c733429e75f80277ae598a8d7646891848d5a1173004635e94d51cf809a50b40a916c505e7874f21c66030347ae982808984a86aaa6c9f7d5af73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9434b9095775e6bf1c41d36f6f18334769fff529103388bc28ac38a38ceac3b54a06313adda8b99953be93440d9d15e6092f22ba5718147026499a7217b69e11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0f9c61943d3660f8819fe68ed657750ccd357d65e1d06617aa5336de1bb54d5540316df958a3ce2ef357cd53437dca18d0ee1283fc183553fdf76fa82f500f4"} build_url:https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009889 build_url: 'https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8acb457be34c733429e75f80277ae598a8d7646891848d5a1173004635e94d51cf809a50b40a916c505e7874f21c66030347ae982808984a86aaa6c9f7d5af73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9434b9095775e6bf1c41d36f6f18334769fff529103388bc28ac38a38ceac3b54a06313adda8b99953be93440d9d15e6092f22ba5718147026499a7217b69e11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0f9c61943d3660f8819fe68ed657750ccd357d65e1d06617aa5336de1bb54d5540316df958a3ce2ef357cd53437dca18d0ee1283fc183553fdf76fa82f500f4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 15:17:57.321783) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:17:57.322062) ========= 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=3a3620fb28aea1604ab609ef000001d2-1468616074.609434-1136798344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:17:57.371117) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 15:17:57.371448) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 15:17:57.371755) ========= ========= Total master_lag: 0.46 =========