builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1469157862.49 results: success (0) buildid: 20160721173021 builduid: efebc16cf55644959df3d30b9ed88464 revision: 7ba94e0c5daa48d7667519c930eca31d98648512 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:22.492012) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:22.492953) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:22.493291) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:22.509476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:22.509923) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 20:24:22-- 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% 114M=0s 2016-07-21 20:24:22 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201608 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:22.749302) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:22.750131) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019443 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:22.803521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:22.804300) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7ba94e0c5daa48d7667519c930eca31d98648512 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7ba94e0c5daa48d7667519c930eca31d98648512 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 20:24:22,866 truncating revision to first 12 chars 2016-07-21 20:24:22,866 Setting DEBUG logging. 2016-07-21 20:24:22,866 attempt 1/10 2016-07-21 20:24:22,866 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7ba94e0c5daa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 20:24:23,198 unpacking tar archive at: fx-team-7ba94e0c5daa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.729485 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:23.550499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:23.550929) ========= script_repo_revision: 7ba94e0c5daa48d7667519c930eca31d98648512 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:23.551393) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:23.551696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 20:24:23.563096) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-21 20:24:23.563400) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:24:23 INFO - MultiFileLogger online at 20160721 20:24:23 in /builds/slave/test 20:24:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:24:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:24:23 INFO - {'append_to_log': False, 20:24:23 INFO - 'base_work_dir': '/builds/slave/test', 20:24:23 INFO - 'blob_upload_branch': 'Fx-Team', 20:24:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:24:23 INFO - 'branch': 'Fx-Team', 20:24:23 INFO - 'buildbot_json_path': 'buildprops.json', 20:24:23 INFO - 'config_files': ('talos/linux_config.py',), 20:24:23 INFO - 'default_actions': ('clobber', 20:24:23 INFO - 'read-buildbot-config', 20:24:23 INFO - 'download-and-extract', 20:24:23 INFO - 'populate-webroot', 20:24:23 INFO - 'create-virtualenv', 20:24:23 INFO - 'install', 20:24:23 INFO - 'run-tests'), 20:24:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:24:23 INFO - 'download_minidump_stackwalk': True, 20:24:23 INFO - 'download_symbols': 'ondemand', 20:24:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:24:23 INFO - 'tooltool.py': '/tools/tooltool.py', 20:24:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:24:23 INFO - '/tools/misc-python/virtualenv.py')}, 20:24:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:24:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:24:23 INFO - 'installer_path': 'installer.exe', 20:24:23 INFO - 'log_level': 'info', 20:24:23 INFO - 'log_name': 'talos', 20:24:23 INFO - 'log_to_console': True, 20:24:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:24:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:24:23 INFO - 'opt_config_files': (), 20:24:23 INFO - 'pip_index': False, 20:24:23 INFO - 'sps_profile': False, 20:24:23 INFO - 'sps_profile_interval': 0, 20:24:23 INFO - 'suite': 'dromaeojs', 20:24:23 INFO - 'system_bits': '32', 20:24:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:24:23 INFO - 'title': 'talos-linux64-ix-004', 20:24:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:24:23 INFO - 'use_talos_json': True, 20:24:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:24:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:24:23 INFO - 'work_dir': 'build'} 20:24:23 INFO - [mozharness: 2016-07-22 03:24:23.804244Z] Running clobber step. 20:24:23 INFO - Running pre-action listener: _resource_record_pre_action 20:24:23 INFO - Running main action method: clobber 20:24:23 INFO - rmtree: /builds/slave/test/build 20:24:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:24:24 INFO - Running post-action listener: _resource_record_post_action 20:24:24 INFO - [mozharness: 2016-07-22 03:24:24.229148Z] Finished clobber step (success) 20:24:24 INFO - [mozharness: 2016-07-22 03:24:24.229251Z] Running read-buildbot-config step. 20:24:24 INFO - Running pre-action listener: _resource_record_pre_action 20:24:24 INFO - Running main action method: read_buildbot_config 20:24:24 INFO - Using buildbot properties: 20:24:24 INFO - { 20:24:24 INFO - "project": "", 20:24:24 INFO - "product": "firefox", 20:24:24 INFO - "script_repo_revision": "production", 20:24:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:24:24 INFO - "repository": "", 20:24:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:24:24 INFO - "buildid": "20160721173021", 20:24:24 INFO - "pgo_build": "True", 20:24:24 INFO - "basedir": "/builds/slave/test", 20:24:24 INFO - "buildnumber": 924, 20:24:24 INFO - "slavename": "talos-linux64-ix-004", 20:24:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:24:24 INFO - "platform": "ubuntu64_hw", 20:24:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:24:24 INFO - "branch": "fx-team", 20:24:24 INFO - "repo_path": "integration/fx-team", 20:24:24 INFO - "revision": "7ba94e0c5daa48d7667519c930eca31d98648512", 20:24:24 INFO - "stage_platform": "linux64-pgo", 20:24:24 INFO - "builduid": "efebc16cf55644959df3d30b9ed88464", 20:24:24 INFO - "slavebuilddir": "test" 20:24:24 INFO - } 20:24:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:24:24 INFO - Running post-action listener: _resource_record_post_action 20:24:24 INFO - [mozharness: 2016-07-22 03:24:24.231711Z] Finished read-buildbot-config step (success) 20:24:24 INFO - [mozharness: 2016-07-22 03:24:24.231801Z] Running download-and-extract step. 20:24:24 INFO - Running pre-action listener: _resource_record_pre_action 20:24:24 INFO - Running main action method: download_and_extract 20:24:24 INFO - mkdir: /builds/slave/test/build/tests 20:24: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')]} 20:24:24 INFO - https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:24:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:24:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:24:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:24:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:24:24 INFO - Downloaded 1361 bytes. 20:24:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:24:24 INFO - Using the following test package requirements: 20:24:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:24:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:24:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:24:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:24:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:24:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:24:24 INFO - u'jsshell-linux-x86_64.zip'], 20:24:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:24:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:24:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:24:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:24:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:24:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:24:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:24:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:24:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:24:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:24:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:24:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:24: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')]} 20:24:24 INFO - https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:24:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:24:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:24:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:24:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:24:25 INFO - Downloaded 24306931 bytes. 20:24:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:24:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:24:27 INFO - Return code: 0 20:24:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:27 INFO - https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:24:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:24:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:24:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:24:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:24:28 INFO - Downloaded 24306931 bytes. 20:24:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:24:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:24:30 INFO - Return code: 0 20:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:30 INFO - https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:24:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:24:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:24:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:24:30 INFO - Downloaded 14403317 bytes. 20:24:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:24:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:24:31 INFO - Return code: 0 20:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:31 INFO - https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:24:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:24:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:24:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:24:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:24:32 INFO - Downloaded 60876754 bytes. 20:24:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:24:32 INFO - mkdir: /builds/slave/test/properties 20:24:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:24:32 INFO - Writing to file /builds/slave/test/properties/build_url 20:24:32 INFO - Contents: 20:24:32 INFO - build_url:https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:24:33 INFO - Running post-action listener: _resource_record_post_action 20:24:33 INFO - Running post-action listener: set_extra_try_arguments 20:24:33 INFO - [mozharness: 2016-07-22 03:24:33.231568Z] Finished download-and-extract step (success) 20:24:33 INFO - [mozharness: 2016-07-22 03:24:33.231885Z] Running populate-webroot step. 20:24:33 INFO - Running pre-action listener: _resource_record_pre_action 20:24:33 INFO - Running main action method: populate_webroot 20:24:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:24:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:24:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:24:33 INFO - '--tppagecycles', 20:24:33 INFO - '7'], 20:24:33 INFO - 'tests': ['tsvgm']}}, 20:24:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:24:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:24:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:24:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:24:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:24:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:24:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:33 INFO - 'talos_options': ['--disable-e10s'], 20:24:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:24:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:24:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:33 INFO - 'talos_options': ['--disable-e10s'], 20:24:33 INFO - 'tests': ['damp', 'tps']}, 20:24:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:33 INFO - 'tests': ['damp', 'tps']}, 20:24:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:24:33 INFO - 'tests': ['dromaeo_dom']}, 20:24:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:24:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:24:33 INFO - 'tests': ['basic_compositor_video']}, 20:24:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:24:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:24:33 INFO - 'tests': ['a11yr', 20:24:33 INFO - 'ts_paint', 20:24:33 INFO - 'tpaint', 20:24:33 INFO - 'sessionrestore', 20:24:33 INFO - 'sessionrestore_no_auto_restore', 20:24:33 INFO - 'tabpaint']}, 20:24:33 INFO - 'other-e10s': {'tests': ['a11yr', 20:24:33 INFO - 'ts_paint', 20:24:33 INFO - 'tpaint', 20:24:33 INFO - 'sessionrestore', 20:24:33 INFO - 'sessionrestore_no_auto_restore', 20:24:33 INFO - 'tabpaint']}, 20:24:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:24:33 INFO - 'ts_paint', 20:24:33 INFO - 'tpaint', 20:24:33 INFO - 'sessionrestore', 20:24:33 INFO - 'sessionrestore_no_auto_restore', 20:24:33 INFO - 'tabpaint']}, 20:24:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:24:33 INFO - 'ts_paint', 20:24:33 INFO - 'tpaint', 20:24:33 INFO - 'sessionrestore', 20:24:33 INFO - 'sessionrestore_no_auto_restore', 20:24:33 INFO - 'tabpaint']}, 20:24:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:24:33 INFO - 'tests': ['a11yr', 20:24:33 INFO - 'ts_paint', 20:24:33 INFO - 'tpaint', 20:24:33 INFO - 'sessionrestore', 20:24:33 INFO - 'sessionrestore_no_auto_restore', 20:24:33 INFO - 'tabpaint']}, 20:24:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:24:33 INFO - 'tests': ['a11yr', 20:24:33 INFO - 'ts_paint', 20:24:33 INFO - 'tpaint', 20:24:33 INFO - 'sessionrestore', 20:24:33 INFO - 'sessionrestore_no_auto_restore', 20:24:33 INFO - 'tabpaint']}, 20:24:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:24:33 INFO - 'tests': ['tsvgx', 20:24:33 INFO - 'tsvgr_opacity', 20:24:33 INFO - 'tart', 20:24:33 INFO - 'tscrollx', 20:24:33 INFO - 'cart']}, 20:24:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:24:33 INFO - 'tsvgr_opacity', 20:24:33 INFO - 'tart', 20:24:33 INFO - 'tscrollx', 20:24:33 INFO - 'cart']}, 20:24:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:33 INFO - 'talos_options': ['--disable-e10s'], 20:24:33 INFO - 'tests': ['tp5o']}, 20:24:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:33 INFO - 'tests': ['tp5o']}, 20:24:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:33 INFO - 'talos_options': ['--disable-e10s', 20:24:33 INFO - '--xperf_path', 20:24:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:24:33 INFO - 'tests': ['tp5n']}, 20:24:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:33 INFO - 'talos_options': ['--xperf_path', 20:24:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:24:33 INFO - 'tests': ['tp5n']}}, 20:24:33 INFO - 'talos.zip': {'path': '', 20:24:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:24:33 INFO - Running post-action listener: _resource_record_post_action 20:24:33 INFO - [mozharness: 2016-07-22 03:24:33.250377Z] Finished populate-webroot step (success) 20:24:33 INFO - [mozharness: 2016-07-22 03:24:33.250468Z] Running create-virtualenv step. 20:24:33 INFO - Running pre-action listener: _resource_record_pre_action 20:24:33 INFO - Running main action method: create_virtualenv 20:24:33 INFO - Creating virtualenv /builds/slave/test/build/venv 20:24:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:24:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:24:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:24:33 INFO - Using real prefix '/usr' 20:24:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:24:34 INFO - Installing distribute.............................................................................................................................................................................................done. 20:24:36 INFO - Installing pip.................done. 20:24:36 INFO - Return code: 0 20:24:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b3b0>, '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 0x123c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123c740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:24:36 INFO - Using env: {'DISPLAY': ':0', 20:24:36 INFO - 'HOME': '/home/cltbld', 20:24:36 INFO - 'LANG': 'en_US.UTF-8', 20:24:36 INFO - 'LANGUAGE': 'en_US:en', 20:24:36 INFO - 'LOGNAME': 'cltbld', 20:24:36 INFO - 'MAIL': '/var/mail/cltbld', 20:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:36 INFO - 'MOZ_NO_REMOTE': '1', 20:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:36 INFO - 'NO_EM_RESTART': '1', 20:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:36 INFO - 'PWD': '/builds/slave/test', 20:24:36 INFO - 'SHELL': '/bin/bash', 20:24:36 INFO - 'SHLVL': '1', 20:24:36 INFO - 'TERM': 'linux', 20:24:36 INFO - 'TMOUT': '86400', 20:24:36 INFO - 'USER': 'cltbld', 20:24:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 20:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:36 INFO - '_': '/tools/buildbot/bin/python'} 20:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:24:36 INFO - Cleaning up... 20:24:36 INFO - Return code: 0 20:24:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b3b0>, '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 0x123c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123c740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:24:36 INFO - Using env: {'DISPLAY': ':0', 20:24:36 INFO - 'HOME': '/home/cltbld', 20:24:36 INFO - 'LANG': 'en_US.UTF-8', 20:24:36 INFO - 'LANGUAGE': 'en_US:en', 20:24:36 INFO - 'LOGNAME': 'cltbld', 20:24:36 INFO - 'MAIL': '/var/mail/cltbld', 20:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:36 INFO - 'MOZ_NO_REMOTE': '1', 20:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:36 INFO - 'NO_EM_RESTART': '1', 20:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:36 INFO - 'PWD': '/builds/slave/test', 20:24:36 INFO - 'SHELL': '/bin/bash', 20:24:36 INFO - 'SHLVL': '1', 20:24:36 INFO - 'TERM': 'linux', 20:24:36 INFO - 'TMOUT': '86400', 20:24:36 INFO - 'USER': 'cltbld', 20:24:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 20:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:36 INFO - '_': '/tools/buildbot/bin/python'} 20:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:37 INFO - Downloading/unpacking psutil>=3.1.1 20:24: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 20:24: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 20:24: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 20:24: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 20:24: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 20:24: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 20:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:24:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:24:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:24:39 INFO - Installing collected packages: psutil 20:24:39 INFO - Running setup.py install for psutil 20:24:39 INFO - building 'psutil._psutil_linux' extension 20:24:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:24:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:24:45 INFO - building 'psutil._psutil_posix' extension 20:24:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:24:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:24:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:24:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:24:45 INFO - Successfully installed psutil 20:24:45 INFO - Cleaning up... 20:24:45 INFO - Return code: 0 20:24:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:45 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 0xf7c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b3b0>, '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 0x123c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123c740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:24:45 INFO - Using env: {'DISPLAY': ':0', 20:24:45 INFO - 'HOME': '/home/cltbld', 20:24:45 INFO - 'LANG': 'en_US.UTF-8', 20:24:45 INFO - 'LANGUAGE': 'en_US:en', 20:24:45 INFO - 'LOGNAME': 'cltbld', 20:24:45 INFO - 'MAIL': '/var/mail/cltbld', 20:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:45 INFO - 'MOZ_NO_REMOTE': '1', 20:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:45 INFO - 'NO_EM_RESTART': '1', 20:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:45 INFO - 'PWD': '/builds/slave/test', 20:24:45 INFO - 'SHELL': '/bin/bash', 20:24:45 INFO - 'SHLVL': '1', 20:24:45 INFO - 'TERM': 'linux', 20:24:45 INFO - 'TMOUT': '86400', 20:24:45 INFO - 'USER': 'cltbld', 20:24:45 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 20:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:45 INFO - '_': '/tools/buildbot/bin/python'} 20:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:24:47 INFO - Installing collected packages: mozsystemmonitor 20:24:47 INFO - Running setup.py install for mozsystemmonitor 20:24:48 INFO - Successfully installed mozsystemmonitor 20:24:48 INFO - Cleaning up... 20:24:48 INFO - Return code: 0 20:24:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:48 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 0xf7c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b3b0>, '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 0x123c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123c740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:24:48 INFO - Using env: {'DISPLAY': ':0', 20:24:48 INFO - 'HOME': '/home/cltbld', 20:24:48 INFO - 'LANG': 'en_US.UTF-8', 20:24:48 INFO - 'LANGUAGE': 'en_US:en', 20:24:48 INFO - 'LOGNAME': 'cltbld', 20:24:48 INFO - 'MAIL': '/var/mail/cltbld', 20:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:48 INFO - 'MOZ_NO_REMOTE': '1', 20:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:48 INFO - 'NO_EM_RESTART': '1', 20:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:48 INFO - 'PWD': '/builds/slave/test', 20:24:48 INFO - 'SHELL': '/bin/bash', 20:24:48 INFO - 'SHLVL': '1', 20:24:48 INFO - 'TERM': 'linux', 20:24:48 INFO - 'TMOUT': '86400', 20:24:48 INFO - 'USER': 'cltbld', 20:24:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 20:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:48 INFO - '_': '/tools/buildbot/bin/python'} 20:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:48 INFO - Downloading/unpacking jsonschema==2.5.1 20:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:24:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:50 INFO - Downloading functools32-3.2.3-2.tar.gz 20:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:24:50 INFO - warning: no files found matching '*.txt' 20:24:50 INFO - no previously-included directories found matching 'build' 20:24:50 INFO - no previously-included directories found matching 'dist' 20:24:50 INFO - no previously-included directories found matching '.git*' 20:24:50 INFO - Installing collected packages: jsonschema, functools32 20:24:50 INFO - Running setup.py install for functools32 20:24:50 INFO - warning: no files found matching '*.txt' 20:24:50 INFO - no previously-included directories found matching 'build' 20:24:50 INFO - no previously-included directories found matching 'dist' 20:24:50 INFO - no previously-included directories found matching '.git*' 20:24:50 INFO - Successfully installed jsonschema functools32 20:24:50 INFO - Cleaning up... 20:24:50 INFO - Return code: 0 20:24:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf7c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b3b0>, '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 0x123c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123c740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:24:50 INFO - Using env: {'DISPLAY': ':0', 20:24:50 INFO - 'HOME': '/home/cltbld', 20:24:50 INFO - 'LANG': 'en_US.UTF-8', 20:24:50 INFO - 'LANGUAGE': 'en_US:en', 20:24:50 INFO - 'LOGNAME': 'cltbld', 20:24:50 INFO - 'MAIL': '/var/mail/cltbld', 20:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:50 INFO - 'MOZ_NO_REMOTE': '1', 20:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:50 INFO - 'NO_EM_RESTART': '1', 20:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:50 INFO - 'PWD': '/builds/slave/test', 20:24:50 INFO - 'SHELL': '/bin/bash', 20:24:50 INFO - 'SHLVL': '1', 20:24:50 INFO - 'TERM': 'linux', 20:24:50 INFO - 'TMOUT': '86400', 20:24:50 INFO - 'USER': 'cltbld', 20:24:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 20:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:50 INFO - '_': '/tools/buildbot/bin/python'} 20:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:50 INFO - Downloading/unpacking blobuploader==1.2.4 20:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:52 INFO - Downloading blobuploader-1.2.4.tar.gz 20:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:24:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:24:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:53 INFO - Downloading docopt-0.6.1.tar.gz 20:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:24:53 INFO - Installing collected packages: blobuploader, requests, docopt 20:24:53 INFO - Running setup.py install for blobuploader 20:24:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:24:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:24:53 INFO - Running setup.py install for requests 20:24:54 INFO - Running setup.py install for docopt 20:24:54 INFO - Successfully installed blobuploader requests docopt 20:24:54 INFO - Cleaning up... 20:24:54 INFO - Return code: 0 20:24:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:54 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 0xf7c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b3b0>, '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 0x123c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123c740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:24:54 INFO - Using env: {'DISPLAY': ':0', 20:24:54 INFO - 'HOME': '/home/cltbld', 20:24:54 INFO - 'LANG': 'en_US.UTF-8', 20:24:54 INFO - 'LANGUAGE': 'en_US:en', 20:24:54 INFO - 'LOGNAME': 'cltbld', 20:24:54 INFO - 'MAIL': '/var/mail/cltbld', 20:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:54 INFO - 'MOZ_NO_REMOTE': '1', 20:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:54 INFO - 'NO_EM_RESTART': '1', 20:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:54 INFO - 'PWD': '/builds/slave/test', 20:24:54 INFO - 'SHELL': '/bin/bash', 20:24:54 INFO - 'SHLVL': '1', 20:24:54 INFO - 'TERM': 'linux', 20:24:54 INFO - 'TMOUT': '86400', 20:24:54 INFO - 'USER': 'cltbld', 20:24:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 20:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:54 INFO - '_': '/tools/buildbot/bin/python'} 20:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:24:54 INFO - Running setup.py (path:/tmp/pip-wAJ1ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:24:54 INFO - Running setup.py (path:/tmp/pip-IhFQL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:24:54 INFO - Running setup.py (path:/tmp/pip-S7PIGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:24:54 INFO - Running setup.py (path:/tmp/pip-iI9UWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:24:54 INFO - Running setup.py (path:/tmp/pip-ITtuzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:24:54 INFO - Running setup.py (path:/tmp/pip-0_uQku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:24:54 INFO - Running setup.py (path:/tmp/pip-H8euPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:24:54 INFO - Running setup.py (path:/tmp/pip-cuDdAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:24:55 INFO - Running setup.py (path:/tmp/pip-W9oIGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:24:55 INFO - Running setup.py (path:/tmp/pip-PfszSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:24:55 INFO - Running setup.py (path:/tmp/pip-ULtorf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:24:55 INFO - Running setup.py (path:/tmp/pip-avro_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:24:55 INFO - Running setup.py (path:/tmp/pip-YSOeI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:24:55 INFO - Running setup.py (path:/tmp/pip-jCDqOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:55 INFO - Running setup.py (path:/tmp/pip-3xKcya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:24:55 INFO - Running setup.py (path:/tmp/pip-aepxPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:24:55 INFO - Running setup.py (path:/tmp/pip-H59BoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:24:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:24:55 INFO - Running setup.py install for manifestparser 20:24:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:24:55 INFO - Running setup.py install for mozcrash 20:24:55 INFO - Running setup.py install for mozdebug 20:24:55 INFO - Running setup.py install for mozdevice 20:24:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Running setup.py install for mozfile 20:24:56 INFO - Running setup.py install for mozhttpd 20:24:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Running setup.py install for mozinfo 20:24:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Running setup.py install for mozInstall 20:24:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Running setup.py install for mozleak 20:24:56 INFO - Running setup.py install for mozlog 20:24:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Running setup.py install for moznetwork 20:24:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Running setup.py install for mozprocess 20:24:56 INFO - Running setup.py install for mozprofile 20:24:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:24:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:24:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:24:57 INFO - Running setup.py install for mozrunner 20:24:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:24:57 INFO - Running setup.py install for mozscreenshot 20:24:57 INFO - Running setup.py install for moztest 20:24:57 INFO - Running setup.py install for mozversion 20:24:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:24:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:24:57 INFO - Cleaning up... 20:24:57 INFO - Return code: 0 20:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:57 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 0xf7c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b3b0>, '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 0x123c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123c740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:24:57 INFO - Using env: {'DISPLAY': ':0', 20:24:57 INFO - 'HOME': '/home/cltbld', 20:24:57 INFO - 'LANG': 'en_US.UTF-8', 20:24:57 INFO - 'LANGUAGE': 'en_US:en', 20:24:57 INFO - 'LOGNAME': 'cltbld', 20:24:57 INFO - 'MAIL': '/var/mail/cltbld', 20:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:57 INFO - 'MOZ_NO_REMOTE': '1', 20:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:24:57 INFO - 'NO_EM_RESTART': '1', 20:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:57 INFO - 'PWD': '/builds/slave/test', 20:24:57 INFO - 'SHELL': '/bin/bash', 20:24:57 INFO - 'SHLVL': '1', 20:24:57 INFO - 'TERM': 'linux', 20:24:57 INFO - 'TMOUT': '86400', 20:24:57 INFO - 'USER': 'cltbld', 20:24:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 20:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:57 INFO - '_': '/tools/buildbot/bin/python'} 20:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:24:57 INFO - Running setup.py (path:/tmp/pip-OuRiz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:24:57 INFO - Running setup.py (path:/tmp/pip-3YiIZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:24:57 INFO - Running setup.py (path:/tmp/pip-LoPjkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:24:57 INFO - Running setup.py (path:/tmp/pip-HTkD0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:24:58 INFO - Running setup.py (path:/tmp/pip-5PvNSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:24:58 INFO - Running setup.py (path:/tmp/pip-dABq51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:24:58 INFO - Running setup.py (path:/tmp/pip-4PHZZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:24:58 INFO - Running setup.py (path:/tmp/pip-qCG4IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:24:58 INFO - Running setup.py (path:/tmp/pip-1fHB16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:24:58 INFO - Running setup.py (path:/tmp/pip-DvAbGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:24:58 INFO - Running setup.py (path:/tmp/pip-Aww_0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:24:58 INFO - Running setup.py (path:/tmp/pip-D_2rB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:24:58 INFO - Running setup.py (path:/tmp/pip-GfMDk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:24:58 INFO - Running setup.py (path:/tmp/pip-l16za3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:58 INFO - Running setup.py (path:/tmp/pip-Rt3I3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:24:58 INFO - Running setup.py (path:/tmp/pip-R1KbVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:24:58 INFO - Running setup.py (path:/tmp/pip-CRrlWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:24:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:00 INFO - Downloading blessings-1.6.tar.gz 20:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:25:00 INFO - Installing collected packages: blessings 20:25:00 INFO - Running setup.py install for blessings 20:25:01 INFO - Successfully installed blessings 20:25:01 INFO - Cleaning up... 20:25:01 INFO - Return code: 0 20:25:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:25:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:25:01 INFO - Reading from file tmpfile_stdout 20:25:01 INFO - Current package versions: 20:25:01 INFO - argparse == 1.2.1 20:25:01 INFO - blessings == 1.6 20:25:01 INFO - blobuploader == 1.2.4 20:25:01 INFO - docopt == 0.6.1 20:25:01 INFO - functools32 == 3.2.3-2 20:25:01 INFO - jsonschema == 2.5.1 20:25:01 INFO - manifestparser == 1.1 20:25:01 INFO - mozInstall == 1.12 20:25:01 INFO - mozcrash == 0.17 20:25:01 INFO - mozdebug == 0.1 20:25:01 INFO - mozdevice == 0.48 20:25:01 INFO - mozfile == 1.2 20:25:01 INFO - mozhttpd == 0.7 20:25:01 INFO - mozinfo == 0.9 20:25:01 INFO - mozleak == 0.1 20:25:01 INFO - mozlog == 3.3 20:25:01 INFO - moznetwork == 0.27 20:25:01 INFO - mozprocess == 0.23 20:25:01 INFO - mozprofile == 0.28 20:25:01 INFO - mozrunner == 6.12 20:25:01 INFO - mozscreenshot == 0.1 20:25:01 INFO - mozsystemmonitor == 0.3 20:25:01 INFO - moztest == 0.7 20:25:01 INFO - mozversion == 1.4 20:25:01 INFO - psutil == 3.1.1 20:25:01 INFO - requests == 1.2.3 20:25:01 INFO - wsgiref == 0.1.2 20:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:01 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 0xf7c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b3b0>, '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 0x123c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123c740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:25:01 INFO - Using env: {'DISPLAY': ':0', 20:25:01 INFO - 'HOME': '/home/cltbld', 20:25:01 INFO - 'LANG': 'en_US.UTF-8', 20:25:01 INFO - 'LANGUAGE': 'en_US:en', 20:25:01 INFO - 'LOGNAME': 'cltbld', 20:25:01 INFO - 'MAIL': '/var/mail/cltbld', 20:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:01 INFO - 'MOZ_NO_REMOTE': '1', 20:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:25:01 INFO - 'NO_EM_RESTART': '1', 20:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:01 INFO - 'PWD': '/builds/slave/test', 20:25:01 INFO - 'SHELL': '/bin/bash', 20:25:01 INFO - 'SHLVL': '1', 20:25:01 INFO - 'TERM': 'linux', 20:25:01 INFO - 'TMOUT': '86400', 20:25:01 INFO - 'USER': 'cltbld', 20:25:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 20:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:01 INFO - '_': '/tools/buildbot/bin/python'} 20:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:25:01 INFO - Cleaning up... 20:25:01 INFO - Return code: 0 20:25:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:01 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 0xf7c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b3b0>, '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 0x123c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123c740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:25:01 INFO - Using env: {'DISPLAY': ':0', 20:25:01 INFO - 'HOME': '/home/cltbld', 20:25:01 INFO - 'LANG': 'en_US.UTF-8', 20:25:01 INFO - 'LANGUAGE': 'en_US:en', 20:25:01 INFO - 'LOGNAME': 'cltbld', 20:25:01 INFO - 'MAIL': '/var/mail/cltbld', 20:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:01 INFO - 'MOZ_NO_REMOTE': '1', 20:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:25:01 INFO - 'NO_EM_RESTART': '1', 20:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:01 INFO - 'PWD': '/builds/slave/test', 20:25:01 INFO - 'SHELL': '/bin/bash', 20:25:01 INFO - 'SHLVL': '1', 20:25:01 INFO - 'TERM': 'linux', 20:25:01 INFO - 'TMOUT': '86400', 20:25:01 INFO - 'USER': 'cltbld', 20:25:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 20:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:01 INFO - '_': '/tools/buildbot/bin/python'} 20:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:25:01 INFO - Cleaning up... 20:25:01 INFO - Return code: 0 20:25:01 INFO - Running post-action listener: _resource_record_post_action 20:25:01 INFO - Running post-action listener: _start_resource_monitoring 20:25:01 INFO - Starting resource monitoring. 20:25:01 INFO - [mozharness: 2016-07-22 03:25:01.840488Z] Finished create-virtualenv step (success) 20:25:01 INFO - [mozharness: 2016-07-22 03:25:01.840974Z] Running install step. 20:25:01 INFO - Running pre-action listener: _resource_record_pre_action 20:25:01 INFO - Running main action method: install 20:25:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:25:02 INFO - Reading from file tmpfile_stdout 20:25:02 INFO - Detecting whether we're running mozinstall >=1.0... 20:25:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:25:02 INFO - Reading from file tmpfile_stdout 20:25:02 INFO - Output received: 20:25:02 INFO - Usage: mozinstall [options] installer 20:25:02 INFO - Options: 20:25:02 INFO - -h, --help show this help message and exit 20:25:02 INFO - -d DEST, --destination=DEST 20:25:02 INFO - Directory to install application into. [default: 20:25:02 INFO - "/builds/slave/test"] 20:25:02 INFO - --app=APP Application being installed. [default: firefox] 20:25:02 INFO - mkdir: /builds/slave/test/build/application 20:25:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:25:19 INFO - Reading from file tmpfile_stdout 20:25:19 INFO - Output received: 20:25:19 INFO - /builds/slave/test/build/application/firefox/firefox 20:25:19 INFO - Running post-action listener: _resource_record_post_action 20:25:19 INFO - [mozharness: 2016-07-22 03:25:19.353876Z] Finished install step (success) 20:25:19 INFO - [mozharness: 2016-07-22 03:25:19.354164Z] Running run-tests step. 20:25:19 INFO - Running pre-action listener: _resource_record_pre_action 20:25:19 INFO - Running main action method: run_tests 20:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:25:19 INFO - Python 2.7.3 20:25:19 INFO - Return code: 0 20:25:19 INFO - grabbing minidump binary from tooltool 20:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:19 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 0x123b3b0>, '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 0x123c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:25:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:25:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:25:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:25:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:25:19 INFO - Return code: 0 20:25:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:25:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:25:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:25:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:25:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:25:19 INFO - Using env: {'DISPLAY': ':0', 20:25:19 INFO - 'HOME': '/home/cltbld', 20:25:19 INFO - 'LANG': 'en_US.UTF-8', 20:25:19 INFO - 'LANGUAGE': 'en_US:en', 20:25:19 INFO - 'LOGNAME': 'cltbld', 20:25:19 INFO - 'MAIL': '/var/mail/cltbld', 20:25:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:25:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:19 INFO - 'MOZ_NO_REMOTE': '1', 20:25:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:25:19 INFO - 'NO_EM_RESTART': '1', 20:25:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:19 INFO - 'PWD': '/builds/slave/test', 20:25:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:25:19 INFO - 'SHELL': '/bin/bash', 20:25:19 INFO - 'SHLVL': '1', 20:25:19 INFO - 'TERM': 'linux', 20:25:19 INFO - 'TMOUT': '86400', 20:25:19 INFO - 'USER': 'cltbld', 20:25:19 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258', 20:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:19 INFO - '_': '/tools/buildbot/bin/python'} 20:25:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:25:20 INFO - mozversion application_buildid: 20160721173021 20:25:20 INFO - mozversion application_changeset: 7ba94e0c5daa48d7667519c930eca31d98648512 20:25:20 INFO - mozversion application_display_name: Nightly 20:25:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:25:20 INFO - mozversion application_name: Firefox 20:25:20 INFO - mozversion application_remotingname: firefox 20:25:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:25:20 INFO - mozversion application_vendor: Mozilla 20:25:20 INFO - mozversion application_version: 50.0a1 20:25:20 INFO - mozversion platform_buildid: 20160721173021 20:25:20 INFO - mozversion platform_changeset: 7ba94e0c5daa48d7667519c930eca31d98648512 20:25:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:25:20 INFO - mozversion platform_version: 50.0a1 20:25:20 INFO - using testdate: 1469157920 20:25:20 INFO - actual date: 1469157920 20:25:20 INFO - starting webserver on 'localhost:36063' 20:25:20 INFO - SUITE-START | Running 2 tests 20:25:20 INFO - TEST-START | dromaeo_css 20:25:20 INFO - operating with platform_type : linux_ 20:25:20 INFO - Initialising browser for dromaeo_css test... 20:25:20 INFO - TEST-INFO | started process 3301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAeoWxR/profile http://localhost:36063/getInfo.html) 20:25:24 INFO - PROCESS | 3301 | JavaScript error: , line 0: uncaught exception: undefined 20:25:26 INFO - PROCESS | 3301 | __metrics Screen width/height:1600/1200 20:25:26 INFO - PROCESS | 3301 | colorDepth:24 20:25:26 INFO - PROCESS | 3301 | Browser inner width/height: 1024/697 20:25:26 INFO - PROCESS | 3301 | __metrics 20:25:27 INFO - PROCESS | 3301 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:25:27 INFO - PROCESS | 3301 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:25:28 INFO - PROCESS | 3301 | console.error: PushService: 20:25:28 INFO - PROCESS | 3301 | stateChangeProcessEnqueue: Error transitioning state 20:25:28 INFO - PROCESS | 3301 | UnknownError 20:25:28 INFO - TEST-INFO | 3301: exit 0 20:25:28 INFO - Browser initialized. 20:25:28 INFO - Running cycle 1/1 for dromaeo_css test... 20:25:28 INFO - TEST-INFO | started process 3382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAeoWxR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:40 INFO - PROCESS | 3382 | RSS: Main: 157667328 20:25:40 INFO - PROCESS | 3382 | 20:26:32 INFO - PROCESS | 3382 | 1469157992024 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:28:39 INFO - PROCESS | 3382 | Cycle 1(1): loaded http://localhost:36063/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36063/tests/dromaeo/cssquery-ext.html) 20:28:40 INFO - PROCESS | 3382 | RSS: Main: 260083712 20:28:40 INFO - PROCESS | 3382 | 20:31:43 INFO - PROCESS | 3382 | Cycle 1(1): loaded http://localhost:36063/tests/dromaeo/cssquery-ext.html (next: http://localhost:36063/tests/dromaeo/cssquery-jquery.html) 20:31:43 INFO - PROCESS | 3382 | RSS: Main: 236716032 20:31:43 INFO - PROCESS | 3382 | 20:34:45 INFO - PROCESS | 3382 | Cycle 1(1): loaded http://localhost:36063/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36063/tests/dromaeo/cssquery-mootools.html) 20:34:46 INFO - PROCESS | 3382 | RSS: Main: 185778176 20:34:46 INFO - PROCESS | 3382 | 20:37:48 INFO - PROCESS | 3382 | Cycle 1(1): loaded http://localhost:36063/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36063/tests/dromaeo/cssquery-prototype.html) 20:37:49 INFO - PROCESS | 3382 | RSS: Main: 213434368 20:37:49 INFO - PROCESS | 3382 | 20:40:51 INFO - PROCESS | 3382 | Cycle 1(1): loaded http://localhost:36063/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36063/tests/dromaeo/cssquery-yui.html) 20:40:52 INFO - PROCESS | 3382 | RSS: Main: 183160832 20:40:52 INFO - PROCESS | 3382 | 20:43:55 INFO - PROCESS | 3382 | Cycle 1(1): loaded http://localhost:36063/tests/dromaeo/cssquery-yui.html (next: http://localhost:36063/tests/dromaeo/cssquery-dojo.html) 20:43:55 INFO - PROCESS | 3382 | RSS: Main: 276230144 20:43:55 INFO - PROCESS | 3382 | 20:43:55 INFO - PROCESS | 3382 | __start_tp_report 20:43:55 INFO - PROCESS | 3382 | _x_x_mozilla_page_load 20:43:55 INFO - PROCESS | 3382 | _x_x_mozilla_page_load_details 20:43:55 INFO - PROCESS | 3382 | |i|pagename|runs| 20:43:55 INFO - PROCESS | 3382 | |0;dojo.html;3031.4846476099046;3047.268655522675;3051.6948305169485;3073.8309392983406;3088.4286407014706;5164.845054648357;5231.7907283708655;5288.391834938983;5328.626996110269;5349.491798279158;5212.556932660719;5272.288241087452;5275.129603615408;5301.787928482866;5343.679379237239;4694.530546945312;4768.499307572707;4783.760811959405;4791.401074865642;4930.531599498042;4884.535969082949;4884.833372243779;4917.803287868499;4926.679765815228;4933.654644174909;4631.212693842055;4652.534746525371;4704;4752.477227504972;4882.707037577739;4735.100330937111;4752.120857641347;4755.690880092783;4811.59101476375;4829.879253018667;4757.167495688241;4778.37881075458;4786.569208771192;4801.135795556798;4835.05716385305;5085.669431486942;5194.818181363672;5258.211268309746;5262.789488420459;5310.468953104697;5598.4961353477975;5657.4908258256955;5678.403767604384;5692.886142277172;5699.458551437607;5663.603547751659;5666.065099258617;5736.799212027559;5737.942620573825;5739.454751798572;5111.897762044776;5208.869778255574;5271.604629652791;5297.973510132425;5302.257683924254;5769.249997500298;5774.855628609318;5776.884462310731;5822.737976791054;5838.416158384128;5543.501084902378;5591.9720401397735;5592.217089607459;5595.944040559542;5601.719914004283;5459.754311056012;5564.304461942257;5616.747246373923;5657.349404818417;5675.631083979528;5650.4349565043985;5652.547796176296;5655.886882262332;5697.4302569742695;5708.628939118944;5619.8595035124445;5654.293213348332;5659.688717120598;5664.348599910981;5670.603057785916;4182.665386769112;4203.810828512725;4293.248681480728;4368.5194628590825;4410.558944105564;3849.634284742945;3860.1700634363747;3894.8636797711943;3920.6471417571984;3952.6047395260243;5339;5364.624476286623;5370.355557333145;5374.113271310268;5383.919241211385;5362.490563396549;5524.447555244444;5610.214569960209;5663.32040155184;5706.771729130871;5306.257124002643;5361.973190134102;5384.784608615611;5409.675419474844;5411.053065713484;4905.9264111038365;4908.803647854046;4914.606831453475;4914.926276105862;4953.950460495421;5631.662100273915;5842.065269556851;5849.61977471463;5849.970750146222;5853.590248682636;5581.972090139523;5626.071698169756;5639.577031722555;5652.349979752216;5698.088305871041;5788.565857560784;5819.010768169506;5833.125031245348;5836.737346819488;5837.67892765902;5348;5500.202470641654;5534.05920993424;5555.611107222618;5565.471280228372;5575.163725441054;5629.240052592848;5630.23991761107;5641.8589535261945;5721.25623668937;5486.753096110764;5522.116461366162;5525.861853453695;5529.751161197675;5530.253415788817;5317.8404647860625;5528.06022976087;5537.335519737658;5539.41836107219;5587.55299576041;5434.157705555645;5490.286262785812;5502.339719233718;5530.806421775219;5585.804496842591;5586.748596313257;5588.888222235614;5640.746166422603;5642.971785141212;5643.463870932255;5247.1079916415065;5488.506034456758;5493.285872836505;5495.505404513613;5501.312335958005 20:43:55 INFO - PROCESS | 3382 | |1;ext.html;595.3362001368475;612.439617749759;624.045210827434;633.7211626884174;640.1102467570079;43758.78120609396;45383;45458.545414545806;45466;49747;45954.31068533975;46350.30474542876;46442.76778616102;46447.99999999991;46468;9052.36633435658;9119.088091190893;9141.360104792668;9194.954025229865;9238.538073096352;9059.592318345658;9146.542672866364;9149.496777677225;9152.725418237464;9157.130072643122;9158.816823663523;9196.26429885611;9197.724068277928;9201.079892010812;9210.447373157598;9124.31567632427;9155.313351498664;9157;9157.496337701425;9169.312301577374;8949.59726812295;8998.100189981014;9011.369204155711;9011.729648110568;9022.7293181204;44290;44445.55549444779;44727;44844.775776121234;44909.775451122536;3544.805035723034;3611.5846677632144;3661.7802931824176;3686.8156592170285;4044.737092089005;33891.491627625604;34243.486347704806;34381.65618343835;34633.484567640466;36170;3927.626875446828;3942.7240093193486;3946.6645335146545;3959.2675355059405;3975.363941769332;376107;377502.99999999726;379647;380582.6796062152;380987;62435.687821560605;62864.371356285854;62874.37125628777;62944.68527657424;62993;58779.412205877394;58842.7057864708;58921;58964.7051764747;59060;16060;16791.496255112364;16800.41198558069;17309.39417120395;17336.566585835455;12760.489580416865;12895.355232238351;12907.483700651868;12908.741825163632;12910.354482275849;20321.288754893507;20327;20434;20493.692594611093;20537.178512859617;7379.483436159525;7395.149557800814;7417.59203243816;7450.739224127238;7487.737929172453;843.5360551696542;999.205631522941;1116.0680831505783;1122.270524159303;1133.982990255147;33707.66292337095;33723.83138084294;34106.65893341084;34262.43031772627;34612.06143089025;865.6364326982682;1052.652624633869;1131.9547218111184;1176.3823992404057;1188.2514016169757;16627.168641567874;17203.741943870853;17259.39592114295;17290.740638890427;17414.129293535272;587788;589754;591653;591967;594624;62512.37487625157;62999;63112;63216.367836321966;63287.68356158282;1199.3583432863377;1306.8954483641287;1349.595121463557;1363.5363976248123;1374.8762611364825;32968.83515582407;35158.08942987807;35499.29001420009;35609.46585801267;35741.46387804133;53354.19968700395;53963.46036539741;54032.326605705835;54172.18741718798;54177.729111354194;430047;432200;432917;433057;433618;27513.724862751118;28436.807095343942;28696.139115826558;30000.549991750577;30158.69841301559;49533.50466495289;49926.251106234165;50007;50621.746891265306;51116.48883511117;42395.152096957274;42854.142917142104;43181.13637727291;43336;45122.77438612786;42027.36958945679;43193;43553;43900.56099439092;43993;42377.36433953432;43151.568484314754;43204.351934721635;43225.56774432216;43303;35642.64357356393;38098.238035239694;38376.42435363527;38458.23083538369;39467.40798887962;27885.860570697016;28515.572266416435;28678;28874.27814304659;28936 20:43:55 INFO - PROCESS | 3382 | |2;jquery.html;342.6704386978523;359.2491692362961;367.31129132875856;373.47899679946477;389.7252437031893;18295.634087318245;19410.126544305524;19776;20462.89768551155;20615.690764638504;19103.426897193072;19555.884308012195;20002.49993750157;20145.093470793814;20159.798402015975;5537.335519737637;5730.255066841326;5765.567582431314;5776.855578610526;5780.104083866986;5464.23500709899;5564.86087847803;5574.1638754187;5604.075327570946;5604.3835178130375;5563.443655634424;5563.443655634424;5564.721763911808;5567;5569.888602227953;5400.108982017982;5614.045612245928;5637.915431268534;5638.548916086703;5644.717764111778;4954.5540901319055;5004.349434573519;5004.474530174352;5007.349044624212;5008.69947803133;21784.89107554452;22354.441138971655;23251.3024609262;23395;23553.293401197992;2279.9544009119727;2332.9300120996227;2338.754430784777;2345.3784747042046;2819.4079243358715;8905;9071.682491112779;9371.203447706954;9528.904176019707;9553.665621703207;1904.5048287445225;2012.9194832206695;2114.143771772435;2121.968170477444;2194.572058448603;73152;76706.6164669173;92529.53735231348;94327;98502.5074874621;16300.184990750415;17087.829121708623;17428.215730292166;17455.38906138279;17728.379506717203;31666.366672666416;31715.365692686017;31718.36563268722;31845.681543184735;31880;9762.36544624597;9938.751531211778;9954.601815927283;10160.542775575117;10206.081452669147;8276.806455556914;8323.83352332962;8502;8519.531425771642;8651.134886511298;8833;8955.910440895508;8990.415622984616;9052.27581793455;9133.49765762876;3232.854521546536;3304.719098876574;3474.6004209515722;3504.842282097312;3547.113221694576;878.7319867440365;961.0725649748026;978.2467500024941;997.8203923293731;1032.1175395037285;18800.90599547021;20027.09878055491;20174.29389971344;20232.57209134913;20605.793942060387;965.9951700241454;997.8902320744712;1041.1930753665818;1041.953112109957;1057.03281497429;10184.745381365525;11040.944795275973;11143.498542565603;11175.944120279346;11277.492512836778;447418;452795;460013;495901;496363;52412;82189.58905205436;88804;90368;91699;909.2089881802874;955.0783493928393;980.2794945714894;997.5959736306808;1000.1448761309122;17328.740068898725;17668.204930777887;18126.728099078788;18235.45293641193;18429.907850460662;42453.57546424496;42456.1508769829;43023.56976430196;43152;44665;61791;62662.06006909991;62708;63621.681891592096;64601.35398645954;7912.84174316522;7957.681692732226;8013.519188848688;8020.997375328084;8216.055153657167;12178.512859485521;12908.8063679043;13111.213327200017;13180.209187448783;13188.802167967297;11240.447618714434;11322;11433.771324573629;11444.02725768319;11983.820242696542;11285.37930413835;11537.942310288396;11624.186306958432;11681.591144309908;11800.52797888075;11434.82847757301;11562.364069976233;11592.478338474957;12041.33772642513;12055.51777928908;7846.568438735696;8057.153998830038;8074.39442041861;8078.6364613593705;8364.623591938256;10499.737506562396;11163.665090047312;11437.085033197158;11454.599089031844;11854.940725296663 20:43:55 INFO - PROCESS | 3382 | |3;mootools.html;1418.064077708712;1493.7759336099584;1614.9434769783052;1739.3390511605587;1780.5815633326165;8181.140980197076;8710.433821801595;8718.520481373529;8721.476711397321;8721.781955451117;7519.812004699886;7644.197359277266;7654;7858.607069646523;8859.158379953895;2293.2317673579328;2352.729436114843;2356.705411823522;2372.537355215725;2381.0475809676095;2381.6189409694452;2392.605220138675;2411.4574220800355;2413.095089341497;2421.9394515137087;2324.76752324767;2339.6724458575814;2341.098677009355;2342.847714898526;2360.6223004319313;2278.065992942894;2282.8173746100274;2285.6685780561893;2289.118689304613;2289.782470665284;2221.888905554732;2294.3919861236786;2295.173737454515;2295.540891821626;2298.839081264312;8542.10307917672;8563.614637341272;8589.95705021477;8613.61238744258;8617.784555386103;5093.159628661267;5201.037808005531;5207.140821764404;5208.401033881114;5214.270002199657;3405.0976491229844;3442.6041005284465;3509.78941263525;3580.8030558319283;3596.5863925648623;1104.9613263535819;1129.7232178116333;1131.8075927092414;1138.1861968692424;1161.5992482593492;11997.400129993466;12042.63872083839;12083.697907552294;12089.758204835942;12138.211016283913;4501.257292546693;4658.86023419298;4768.165571025057;4833.130036593377;4841.612670986313;10534.631287904887;10542.47287635615;10545.420001899816;10546.736331591772;10550.208734344955;5365.08793505105;5376.354837419534;5379.220013098079;5379.704116273564;5389.541888939406;4641.86074417768;4747.95252047482;4910.238912968495;4911.091448082045;4911.16510193268;3767.3030489359558;3808.6953043756434;3809.1239015026144;3873.6513713765335;3896.6298201670797;1102.1788767368203;1147.6212849759559;1148.4554911458886;1157.0916830288184;1175.44753965636;858.274757829633;859.5959898847532;891.5586784541694;925.1488630459859;933.6685476655825;5481.342238931274;5685.715714214272;5692.31692196939;5750.568707346882;5840.29916410025;937.7186843946789;951.2627713521938;951.6145960885852;956.8469044952774;986.6201512417771;3735.290294843971;3827.904302392407;3880.631340022693;3936.488256526633;3949.8025098744947;10369;10765.084967777826;10810.135189184846;10813.297135686154;10813.729656758644;10635.149188064936;10637.680869573926;10637.787244255227;10644.840327395095;10652.786944261072;7929.365650747926;8008.79978000543;8139.95930020358;8156.836863262702;8210.589470526449;6007.789727359522;6032.547558933185;6138.355472675305;6156.846078848064;6264.248290205204;9812.411255324703;9833.754156146153;9838.458884761407;9846;9948.850767238353;10221.642242521773;10421.374717516974;10472.842907356244;10474.423906685206;10500.212484063879;6874.518783685094;7585.355244804033;7648.158702542604;7783.416243781852;8153.470024448392;8471.830563388574;8473;8558.101399353227;8564;8564.52895090776;7555.357794587521;7583.7724868254045;7596.582187979714;7613.581253030915;7718;7548.131964824115;7561.054868141482;7581.962090189514;7592.202818703957;7633.847323053396;6978;7084.716611335489;7086.39765619928;7088.964555177397;7098.893516597358;4743.430788305425;4803.543663351976;4819.445763737215;5058.595312375075;5123.795048198031;4979.701217926936;5015.097282489187;5160.509751573594;5192.013517431676;5192.558632516128 20:43:55 INFO - PROCESS | 3382 | |4;prototype.html;299.76168945688175;306.6182602659689;313.7395961352078;313.89798315547455;316.1164545096455;5133.3839939207255;5231.947680523203;5318.4681531846845;5334.359876814783;5342.492463215998;5227.242049902762;5236.947630523694;5236.973815130928;5249.86875328116;5306.204069389584;4156.812943417538;4158.521769996444;4160.375943608453;4167.416561681367;4199.3910882921955;3958.8614398496056;4051.6758659307334;4193.832246710143;4197.307444271692;4209.379388935266;4057.052614744924;4070.2266569351727;4074.470318858544;4086.795660216992;4104.733192342503;4050.6354428101317;4061.8375264989513;4076.3070278052655;4086;4092.7953602320063;3446.827658617084;3498.6676265754713;3533.787972721645;3546;3548.556430446194;5095.184770436749;5100.1074811907765;5111.258867464197;5147.433782283946;5170.870728231786;4648.48866624671;4654.930176047362;4658.510856360067;4660.5339466053465;4685.484596694361;5393.379761327458;5412.404635490093;5416.729163541847;5451.918221226645;5511.311086114236;3849.30712471755;3856.151646637735;3896.980515097435;3899.415087736834;3905.8437662493466;5781.768729250825;5800.245968024172;5801.7099145043;5805.593608447411;5817.243758311435;3776.9244615108096;3942.15243722601;3949.2101579684177;3953.6441720245316;3968.6031396860662;3989.4813674222746;3994.422203229708;4005.6595189408645;4035.1526179502634;4035.959640403617;4627.282771170474;4628.606568441653;4637.304404339376;4664.160451118832;4671.182543054952;5397.379301380313;5541.307336582927;5557.5553955683445;5580.302462192226;5581.386047534768;1321.286505287134;1356.3286173344259;1376.779715245576;1384.5915454940816;1385.4388972466168;918.6279556779515;937.9869740680049;943.9575219115156;949.3639261694681;950.4249928793118;5297.629165958346;5304.946950530522;5307.7080760557765;5317.697164194719;5354.143337066051;5600.551955843604;5606.355269144019;5606.971965140148;5628.2683251177905;5639.379668236491;5144.717040562805;5326.36083669962;5347.358317001985;5358.464153584689;5407.729613519308;2984.19426754775;3042.269855234728;3046.2384403899027;3047.9484577820617;3059.3728285701377;5964.957871485573;5976.312724036705;5989;5989.574222439919;5994.100884867217;5632.662040277596;5745.1669507921115;5748.6838223898085;5774.68239246837;5807.593468457168;5878.647281163058;5897.262842144732;5898.587098903035;5910.645361278337;5912.349641539341;5470.699111548903;5667.716614169358;5715.2855893013375;5730.255066841284;5744.971275143597;5650.180723795109;5660.51885589713;5663.518600918803;5670.546356291405;5706.229658995982;5956.51087228193;5957.344692083954;5967.701614919323;5983.581149319506;5985.952458319864;3830.4637350771472;3989.880303590897;4005.379166229239;4013.237484877864;4032.2540330039037;5493.2034854946605;5683.460071293221;5751.568632352507;5785.971070144622;5804.912926306193;5449.591280654046;5560.138178582326;5576.1356989666665;5597.832065037893;5670.347909990239;5574.414686457863;5575.693336866511;5580;5584.46947539983;5593.5879113739775;5285.841424757264;5510.421405752339;5538.667679939216;5541.778328866962;5543.8891222174525;5596.356419011866;5596.62143588965;5602.2717046783655;5618.775248989995;5622.156676498558;5445.829146733471;5460.535854452416;5496;5502.58730595199;5556.499915007668 20:43:55 INFO - PROCESS | 3382 | |5;yui.html;723.3706675192583;730.8209488675276;774.4540099230042;845.4208866926152;847.4025811802679;15288.694226115485;15708.685826283467;16469;16482;16510.91744541277;15603.141827199499;15634.452794152206;15814.130222837739;15827.841721582781;15853.445129420472;807.5235610989515;816.0982114763191;822.1983566023109;822.8189798244376;826.0335407573153;661.22636515277;796.7649543384715;819.610684924659;822.1860358245324;828.3828547731948;870.2037635563452;874.3224001398903;875.3478658399501;876.9912300876973;877.9385443018991;853.1127627267634;854.8375808596378;854.9102344253888;858.1118542308711;860.3203469259278;504.4627471742619;614.5053232148119;627.2786295759867;627.7489004398232;628.745358129958;14530.12819230839;14601.634959126106;14613.123212607277;14663.48677796272;14689.485867994568;13780.862191378059;13873.4450621975;14346.641333966734;14507;14515.564533064025;13208.801867971988;13213;13436.798448023288;13491.730165396637;13499.865001350057;4403;4428.512863585035;4439.422875026258;4447.666425018104;4530.116627257686;75359;75757.62121189413;75809;76424.61787691026;78429.60785196094;11690.824637630443;11707.707307317385;11852.822207666892;12141.15011949155;12285.140040197279;21755.782442175376;21784.237551685615;21784.78215217859;21796.89101554482;21858.344249672537;8533.402661813738;8790.208881200722;8843.0714774949;8888.955555222312;9235.538223088954;4769.689970151999;4787.8563643090765;4805.087033463631;4884.291777692215;4910.533499317559;3417.1798768295926;3435.656434356544;3461.8615255390005;3516.9472457913153;3519.401701710664;571.3087164530881;574.6121368076615;582.670791003082;597.7310210405335;613.4019331152091;624.5596854217765;628.5757113948067;662;670.128832517725;674.231376231097;9171.233420697334;9495.287853410884;9614.278929080347;9823.312368134304;9883.802323953481;683.3712984054681;692.4944790303107;703.89164215057;714.8091100776105;728.3845150847526;4315.438992930899;4810.42274927004;4810.831620893322;4811.879703007453;4831.396075490564;114362.42818785853;114988.42505787418;115772;116233;119373.40313298552;95702;97216;99108;99334;99985;81609.59195203986;87100.99999999873;87689.56155219184;87850;88671.55664221638;9001.594928228114;9229.907700922904;9357.709527532912;9457.668981585612;9500.524973751422;46657.30014049724;46804;51718.48281517137;52760.73619632031;53573;48680;63378.68310658417;73627;76315;78286;12521.812172817234;12625.179363341353;12795.680107997374;12902.935485322514;12944.870551294744;14960.17719025464;14995.100293982396;15304.846951530342;15765.211739412754;15793.447229346917;14081.929590351983;14454.132752034491;14861.777073343692;14912.25438728081;15347.386104556139;13589.660258493617;13616.114952528054;13836;14058.718825623635;14096.013279070366;14025.789613155606;14335.92832035833;14399.78400324017;14506.637334066732;14558;11307.830382544103;11422.885771142515;11859.347735874264;12040.397980101136;12230.449629766505;11140.442977851237;11805.70485737829;11846.289222646668;12047.397630118634;12071.758564828478 20:43:55 INFO - PROCESS | 3382 | __end_tp_report 20:43:55 INFO - PROCESS | 3382 | __start_cc_report 20:43:55 INFO - PROCESS | 3382 | _x_x_mozilla_cycle_collect,933 20:43:55 INFO - PROCESS | 3382 | __end_cc_report 20:43:55 INFO - PROCESS | 3382 | __startTimestamp1469159035437__endTimestamp 20:43:55 INFO - PROCESS | 3382 | 20:43:55 INFO - PROCESS | 3382 | ------- Summary: start ------- 20:43:55 INFO - PROCESS | 3382 | Number of tests: 6 20:43:55 INFO - PROCESS | 3382 | 20:43:55 INFO - PROCESS | 3382 | [#0] dojo.html Cycles:165 Average:5247.63 Median:5488.51 stddev:594.22 (10.8%) stddev-sans-first:570.04 20:43:55 INFO - PROCESS | 3382 | Values: 3031.5 3047.3 3051.7 3073.8 3088.4 5164.8 5231.8 5288.4 5328.6 5349.5 5212.6 5272.3 5275.1 5301.8 5343.7 4694.5 4768.5 4783.8 4791.4 4930.5 4884.5 4884.8 4917.8 4926.7 4933.7 4631.2 4652.5 4704.0 4752.5 4882.7 4735.1 4752.1 4755.7 4811.6 4829.9 4757.2 4778.4 4786.6 4801.1 4835.1 5085.7 5194.8 5258.2 5262.8 5310.5 5598.5 5657.5 5678.4 5692.9 5699.5 5663.6 5666.1 5736.8 5737.9 5739.5 5111.9 5208.9 5271.6 5298.0 5302.3 5769.2 5774.9 5776.9 5822.7 5838.4 5543.5 5592.0 5592.2 5595.9 5601.7 5459.8 5564.3 5616.7 5657.3 5675.6 5650.4 5652.5 5655.9 5697.4 5708.6 5619.9 5654.3 5659.7 5664.3 5670.6 4182.7 4203.8 4293.2 4368.5 4410.6 3849.6 3860.2 3894.9 3920.6 3952.6 5339.0 5364.6 5370.4 5374.1 5383.9 5362.5 5524.4 5610.2 5663.3 5706.8 5306.3 5362.0 5384.8 5409.7 5411.1 4905.9 4908.8 4914.6 4914.9 4954.0 5631.7 5842.1 5849.6 5850.0 5853.6 5582.0 5626.1 5639.6 5652.3 5698.1 5788.6 5819.0 5833.1 5836.7 5837.7 5348.0 5500.2 5534.1 5555.6 5565.5 5575.2 5629.2 5630.2 5641.9 5721.3 5486.8 5522.1 5525.9 5529.8 5530.3 5317.8 5528.1 5537.3 5539.4 5587.6 5434.2 5490.3 5502.3 5530.8 5585.8 5586.7 5588.9 5640.7 5643.0 5643.5 5247.1 5488.5 5493.3 5495.5 5501.3 20:43:55 INFO - PROCESS | 3382 | 20:43:55 INFO - PROCESS | 3382 | [#1] ext.html Cycles:180 Average:63597.82 Median:238196.50 stddev:126345.24 (53.0%) stddev-sans-first:126611.12 20:43:55 INFO - PROCESS | 3382 | Values: 595.3 612.4 624.0 633.7 640.1 43758.8 45383.0 45458.5 45466.0 49747.0 45954.3 46350.3 46442.8 46448.0 46468.0 9052.4 9119.1 9141.4 9195.0 9238.5 9059.6 9146.5 9149.5 9152.7 9157.1 9158.8 9196.3 9197.7 9201.1 9210.4 9124.3 9155.3 9157.0 9157.5 9169.3 8949.6 8998.1 9011.4 9011.7 9022.7 44290.0 44445.6 44727.0 44844.8 44909.8 3544.8 3611.6 3661.8 3686.8 4044.7 33891.5 34243.5 34381.7 34633.5 36170.0 3927.6 3942.7 3946.7 3959.3 3975.4 376107.0 377503.0 379647.0 380582.7 380987.0 62435.7 62864.4 62874.4 62944.7 62993.0 58779.4 58842.7 58921.0 58964.7 59060.0 16060.0 16791.5 16800.4 17309.4 17336.6 12760.5 12895.4 12907.5 12908.7 12910.4 20321.3 20327.0 20434.0 20493.7 20537.2 7379.5 7395.1 7417.6 7450.7 7487.7 843.5 999.2 1116.1 1122.3 1134.0 33707.7 33723.8 34106.7 34262.4 34612.1 865.6 1052.7 1132.0 1176.4 1188.3 16627.2 17203.7 17259.4 17290.7 17414.1 587788.0 589754.0 591653.0 591967.0 594624.0 62512.4 62999.0 63112.0 63216.4 63287.7 1199.4 1306.9 1349.6 1363.5 1374.9 32968.8 35158.1 35499.3 35609.5 35741.5 53354.2 53963.5 54032.3 54172.2 54177.7 430047.0 432200.0 432917.0 433057.0 433618.0 27513.7 28436.8 28696.1 30000.5 30158.7 49533.5 49926.3 50007.0 50621.7 51116.5 42395.2 42854.1 43181.1 43336.0 45122.8 42027.4 43193.0 43553.0 43900.6 43993.0 42377.4 43151.6 43204.4 43225.6 43303.0 35642.6 38098.2 38376.4 38458.2 39467.4 27885.9 28515.6 28678.0 28874.3 28936.0 20:43:55 INFO - PROCESS | 3382 | 20:43:55 INFO - PROCESS | 3382 | [#2] jquery.html Cycles:180 Average:29322.28 Median:381.60 stddev:77671.90 (20354.2%) stddev-sans-first:77859.31 20:43:55 INFO - PROCESS | 3382 | Values: 342.7 359.2 367.3 373.5 389.7 18295.6 19410.1 19776.0 20462.9 20615.7 19103.4 19555.9 20002.5 20145.1 20159.8 5537.3 5730.3 5765.6 5776.9 5780.1 5464.2 5564.9 5574.2 5604.1 5604.4 5563.4 5563.4 5564.7 5567.0 5569.9 5400.1 5614.0 5637.9 5638.5 5644.7 4954.6 5004.3 5004.5 5007.3 5008.7 21784.9 22354.4 23251.3 23395.0 23553.3 2280.0 2332.9 2338.8 2345.4 2819.4 8905.0 9071.7 9371.2 9528.9 9553.7 1904.5 2012.9 2114.1 2122.0 2194.6 73152.0 76706.6 92529.5 94327.0 98502.5 16300.2 17087.8 17428.2 17455.4 17728.4 31666.4 31715.4 31718.4 31845.7 31880.0 9762.4 9938.8 9954.6 10160.5 10206.1 8276.8 8323.8 8502.0 8519.5 8651.1 8833.0 8955.9 8990.4 9052.3 9133.5 3232.9 3304.7 3474.6 3504.8 3547.1 878.7 961.1 978.2 997.8 1032.1 18800.9 20027.1 20174.3 20232.6 20605.8 966.0 997.9 1041.2 1042.0 1057.0 10184.7 11040.9 11143.5 11175.9 11277.5 447418.0 452795.0 460013.0 495901.0 496363.0 52412.0 82189.6 88804.0 90368.0 91699.0 909.2 955.1 980.3 997.6 1000.1 17328.7 17668.2 18126.7 18235.5 18429.9 42453.6 42456.2 43023.6 43152.0 44665.0 61791.0 62662.1 62708.0 63621.7 64601.4 7912.8 7957.7 8013.5 8021.0 8216.1 12178.5 12908.8 13111.2 13180.2 13188.8 11240.4 11322.0 11433.8 11444.0 11983.8 11285.4 11537.9 11624.2 11681.6 11800.5 11434.8 11562.4 11592.5 12041.3 12055.5 7846.6 8057.2 8074.4 8078.6 8364.6 10499.7 11163.7 11437.1 11454.6 11854.9 20:43:55 INFO - PROCESS | 3382 | 20:43:55 INFO - PROCESS | 3382 | [#3] mootools.html Cycles:180 Average:5732.73 Median:4910.67 stddev:3246.72 (66.1%) stddev-sans-first:3239.64 20:43:55 INFO - PROCESS | 3382 | Values: 1418.1 1493.8 1614.9 1739.3 1780.6 8181.1 8710.4 8718.5 8721.5 8721.8 7519.8 7644.2 7654.0 7858.6 8859.2 2293.2 2352.7 2356.7 2372.5 2381.0 2381.6 2392.6 2411.5 2413.1 2421.9 2324.8 2339.7 2341.1 2342.8 2360.6 2278.1 2282.8 2285.7 2289.1 2289.8 2221.9 2294.4 2295.2 2295.5 2298.8 8542.1 8563.6 8590.0 8613.6 8617.8 5093.2 5201.0 5207.1 5208.4 5214.3 3405.1 3442.6 3509.8 3580.8 3596.6 1105.0 1129.7 1131.8 1138.2 1161.6 11997.4 12042.6 12083.7 12089.8 12138.2 4501.3 4658.9 4768.2 4833.1 4841.6 10534.6 10542.5 10545.4 10546.7 10550.2 5365.1 5376.4 5379.2 5379.7 5389.5 4641.9 4748.0 4910.2 4911.1 4911.2 3767.3 3808.7 3809.1 3873.7 3896.6 1102.2 1147.6 1148.5 1157.1 1175.4 858.3 859.6 891.6 925.1 933.7 5481.3 5685.7 5692.3 5750.6 5840.3 937.7 951.3 951.6 956.8 986.6 3735.3 3827.9 3880.6 3936.5 3949.8 10369.0 10765.1 10810.1 10813.3 10813.7 10635.1 10637.7 10637.8 10644.8 10652.8 7929.4 8008.8 8140.0 8156.8 8210.6 6007.8 6032.5 6138.4 6156.8 6264.2 9812.4 9833.8 9838.5 9846.0 9948.9 10221.6 10421.4 10472.8 10474.4 10500.2 6874.5 7585.4 7648.2 7783.4 8153.5 8471.8 8473.0 8558.1 8564.0 8564.5 7555.4 7583.8 7596.6 7613.6 7718.0 7548.1 7561.1 7582.0 7592.2 7633.8 6978.0 7084.7 7086.4 7089.0 7098.9 4743.4 4803.5 4819.4 5058.6 5123.8 4979.7 5015.1 5160.5 5192.0 5192.6 20:43:55 INFO - PROCESS | 3382 | 20:43:55 INFO - PROCESS | 3382 | [#4] prototype.html Cycles:180 Average:4659.45 Median:5338.43 stddev:1393.78 (26.1%) stddev-sans-first:1358.73 20:43:55 INFO - PROCESS | 3382 | Values: 299.8 306.6 313.7 313.9 316.1 5133.4 5231.9 5318.5 5334.4 5342.5 5227.2 5236.9 5237.0 5249.9 5306.2 4156.8 4158.5 4160.4 4167.4 4199.4 3958.9 4051.7 4193.8 4197.3 4209.4 4057.1 4070.2 4074.5 4086.8 4104.7 4050.6 4061.8 4076.3 4086.0 4092.8 3446.8 3498.7 3533.8 3546.0 3548.6 5095.2 5100.1 5111.3 5147.4 5170.9 4648.5 4654.9 4658.5 4660.5 4685.5 5393.4 5412.4 5416.7 5451.9 5511.3 3849.3 3856.2 3897.0 3899.4 3905.8 5781.8 5800.2 5801.7 5805.6 5817.2 3776.9 3942.2 3949.2 3953.6 3968.6 3989.5 3994.4 4005.7 4035.2 4036.0 4627.3 4628.6 4637.3 4664.2 4671.2 5397.4 5541.3 5557.6 5580.3 5581.4 1321.3 1356.3 1376.8 1384.6 1385.4 918.6 938.0 944.0 949.4 950.4 5297.6 5304.9 5307.7 5317.7 5354.1 5600.6 5606.4 5607.0 5628.3 5639.4 5144.7 5326.4 5347.4 5358.5 5407.7 2984.2 3042.3 3046.2 3047.9 3059.4 5965.0 5976.3 5989.0 5989.6 5994.1 5632.7 5745.2 5748.7 5774.7 5807.6 5878.6 5897.3 5898.6 5910.6 5912.3 5470.7 5667.7 5715.3 5730.3 5745.0 5650.2 5660.5 5663.5 5670.5 5706.2 5956.5 5957.3 5967.7 5983.6 5986.0 3830.5 3989.9 4005.4 4013.2 4032.3 5493.2 5683.5 5751.6 5786.0 5804.9 5449.6 5560.1 5576.1 5597.8 5670.3 5574.4 5575.7 5580.0 5584.5 5593.6 5285.8 5510.4 5538.7 5541.8 5543.9 5596.4 5596.6 5602.3 5618.8 5622.2 5445.8 5460.5 5496.0 5502.6 5556.5 20:43:55 INFO - PROCESS | 3382 | 20:43:55 INFO - PROCESS | 3382 | [#5] yui.html Cycles:180 Average:20833.05 Median:4807.75 stddev:29664.98 (617.0%) stddev-sans-first:29709.77 20:43:55 INFO - PROCESS | 3382 | Values: 723.4 730.8 774.5 845.4 847.4 15288.7 15708.7 16469.0 16482.0 16510.9 15603.1 15634.5 15814.1 15827.8 15853.4 807.5 816.1 822.2 822.8 826.0 661.2 796.8 819.6 822.2 828.4 870.2 874.3 875.3 877.0 877.9 853.1 854.8 854.9 858.1 860.3 504.5 614.5 627.3 627.7 628.7 14530.1 14601.6 14613.1 14663.5 14689.5 13780.9 13873.4 14346.6 14507.0 14515.6 13208.8 13213.0 13436.8 13491.7 13499.9 4403.0 4428.5 4439.4 4447.7 4530.1 75359.0 75757.6 75809.0 76424.6 78429.6 11690.8 11707.7 11852.8 12141.2 12285.1 21755.8 21784.2 21784.8 21796.9 21858.3 8533.4 8790.2 8843.1 8889.0 9235.5 4769.7 4787.9 4805.1 4884.3 4910.5 3417.2 3435.7 3461.9 3516.9 3519.4 571.3 574.6 582.7 597.7 613.4 624.6 628.6 662.0 670.1 674.2 9171.2 9495.3 9614.3 9823.3 9883.8 683.4 692.5 703.9 714.8 728.4 4315.4 4810.4 4810.8 4811.9 4831.4 114362.4 114988.4 115772.0 116233.0 119373.4 95702.0 97216.0 99108.0 99334.0 99985.0 81609.6 87101.0 87689.6 87850.0 88671.6 9001.6 9229.9 9357.7 9457.7 9500.5 46657.3 46804.0 51718.5 52760.7 53573.0 48680.0 63378.7 73627.0 76315.0 78286.0 12521.8 12625.2 12795.7 12902.9 12944.9 14960.2 14995.1 15304.8 15765.2 15793.4 14081.9 14454.1 14861.8 14912.3 15347.4 13589.7 13616.1 13836.0 14058.7 14096.0 14025.8 14335.9 14399.8 14506.6 14558.0 11307.8 11422.9 11859.3 12040.4 12230.4 11140.4 11805.7 11846.3 12047.4 12071.8 20:43:55 INFO - PROCESS | 3382 | -------- Summary: end -------- 20:43:55 INFO - PROCESS | 3382 | 20:43:56 INFO - TEST-INFO | 3382: exit 0 20:43:56 INFO - TEST-OK | dromaeo_css | took 1116121ms 20:43:56 INFO - TEST-START | kraken 20:43:56 INFO - operating with platform_type : linux_ 20:43:56 INFO - Initialising browser for kraken test... 20:43:56 INFO - TEST-INFO | started process 3569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6j4wpR/profile http://localhost:36063/getInfo.html) 20:43:59 INFO - PROCESS | 3569 | JavaScript error: , line 0: uncaught exception: undefined 20:44:00 INFO - PROCESS | 3569 | __metrics Screen width/height:1600/1200 20:44:00 INFO - PROCESS | 3569 | colorDepth:24 20:44:00 INFO - PROCESS | 3569 | Browser inner width/height: 1024/697 20:44:00 INFO - PROCESS | 3569 | __metrics 20:44:01 INFO - PROCESS | 3569 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:44:01 INFO - PROCESS | 3569 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:44:02 INFO - TEST-INFO | 3569: exit 0 20:44:02 INFO - Browser initialized. 20:44:02 INFO - Running cycle 1/1 for kraken test... 20:44:02 INFO - TEST-INFO | started process 3649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6j4wpR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:44:13 INFO - PROCESS | 3649 | RSS: Main: 157794304 20:44:13 INFO - PROCESS | 3649 | 20:44:16 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36063/tests/kraken/driver.html?testName=audio-beat-detection) 20:44:17 INFO - PROCESS | 3649 | RSS: Main: 213393408 20:44:17 INFO - PROCESS | 3649 | 20:44:19 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36063/tests/kraken/driver.html?testName=audio-dft) 20:44:20 INFO - PROCESS | 3649 | RSS: Main: 193085440 20:44:20 INFO - PROCESS | 3649 | 20:44:23 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36063/tests/kraken/driver.html?testName=audio-fft) 20:44:24 INFO - PROCESS | 3649 | RSS: Main: 271884288 20:44:24 INFO - PROCESS | 3649 | 20:44:26 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36063/tests/kraken/driver.html?testName=audio-oscillator) 20:44:26 INFO - PROCESS | 3649 | RSS: Main: 181133312 20:44:26 INFO - PROCESS | 3649 | 20:44:29 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36063/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:44:29 INFO - PROCESS | 3649 | RSS: Main: 185942016 20:44:29 INFO - PROCESS | 3649 | 20:44:32 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36063/tests/kraken/driver.html?testName=imaging-darkroom) 20:44:33 INFO - PROCESS | 3649 | RSS: Main: 220708864 20:44:33 INFO - PROCESS | 3649 | 20:44:36 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36063/tests/kraken/driver.html?testName=imaging-desaturate) 20:44:37 INFO - PROCESS | 3649 | RSS: Main: 221147136 20:44:37 INFO - PROCESS | 3649 | 20:44:40 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36063/tests/kraken/driver.html?testName=json-parse-financial) 20:44:40 INFO - PROCESS | 3649 | RSS: Main: 221081600 20:44:40 INFO - PROCESS | 3649 | 20:44:42 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36063/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:44:42 INFO - PROCESS | 3649 | RSS: Main: 185626624 20:44:42 INFO - PROCESS | 3649 | 20:44:44 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36063/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:44:45 INFO - PROCESS | 3649 | RSS: Main: 190803968 20:44:45 INFO - PROCESS | 3649 | 20:44:47 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36063/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:44:47 INFO - PROCESS | 3649 | RSS: Main: 195497984 20:44:47 INFO - PROCESS | 3649 | 20:44:50 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:44:50 INFO - PROCESS | 3649 | RSS: Main: 190226432 20:44:50 INFO - PROCESS | 3649 | 20:44:53 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:44:54 INFO - PROCESS | 3649 | RSS: Main: 193777664 20:44:54 INFO - PROCESS | 3649 | 20:44:55 INFO - PROCESS | 3649 | Cycle 1(1): loaded http://localhost:36063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36063/tests/kraken/driver.html?testName=ai-astar) 20:44:56 INFO - PROCESS | 3649 | RSS: Main: 244695040 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | __start_tp_report 20:44:56 INFO - PROCESS | 3649 | _x_x_mozilla_page_load 20:44:56 INFO - PROCESS | 3649 | _x_x_mozilla_page_load_details 20:44:56 INFO - PROCESS | 3649 | |i|pagename|runs| 20:44:56 INFO - PROCESS | 3649 | |0;ai-astar;103;114;114;112;112;114;112;111;112;112 20:44:56 INFO - PROCESS | 3649 | |1;audio-beat-detection;141;126;119;181;125;117;146;117;148;116 20:44:56 INFO - PROCESS | 3649 | |2;audio-dft;159;160;161;160;161;160;160;162;160;160 20:44:56 INFO - PROCESS | 3649 | |3;audio-fft;74;75;73;110;74;76;73;73;116;76 20:44:56 INFO - PROCESS | 3649 | |4;audio-oscillator;83;83;116;84;83;83;115;84;84;122 20:44:56 INFO - PROCESS | 3649 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;116;116;116 20:44:56 INFO - PROCESS | 3649 | |6;imaging-darkroom;145;146;146;146;145;147;146;145;145;147 20:44:56 INFO - PROCESS | 3649 | |7;imaging-desaturate;95;94;95;94;95;95;94;95;96;95 20:44:56 INFO - PROCESS | 3649 | |8;json-parse-financial;54;52;55;52;52;52;52;53;52;51 20:44:56 INFO - PROCESS | 3649 | |9;json-stringify-tinderbox;63;63;62;64;62;63;63;63;63;63 20:44:56 INFO - PROCESS | 3649 | |10;stanford-crypto-aes;78;74;75;76;76;75;75;75;75;80 20:44:56 INFO - PROCESS | 3649 | |11;stanford-crypto-ccm;121;121;128;128;117;117;128;126;171;137 20:44:56 INFO - PROCESS | 3649 | |12;stanford-crypto-pbkdf2;151;155;151;156;157;158;154;160;154;150 20:44:56 INFO - PROCESS | 3649 | |13;stanford-crypto-sha256-iterative;65;62;64;62;61;64;62;62;62;66 20:44:56 INFO - PROCESS | 3649 | __end_tp_report 20:44:56 INFO - PROCESS | 3649 | __start_cc_report 20:44:56 INFO - PROCESS | 3649 | _x_x_mozilla_cycle_collect,1685 20:44:56 INFO - PROCESS | 3649 | __end_cc_report 20:44:56 INFO - PROCESS | 3649 | __startTimestamp1469159096006__endTimestamp 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | ------- Summary: start ------- 20:44:56 INFO - PROCESS | 3649 | Number of tests: 14 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:3.20 (2.9%) stddev-sans-first:1.13 20:44:56 INFO - PROCESS | 3649 | Values: 103.0 114.0 114.0 112.0 112.0 114.0 112.0 111.0 112.0 112.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:133.50 stddev:20.73 (15.5%) stddev-sans-first:21.82 20:44:56 INFO - PROCESS | 3649 | Values: 141.0 126.0 119.0 181.0 125.0 117.0 146.0 117.0 148.0 116.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 20:44:56 INFO - PROCESS | 3649 | Values: 159.0 160.0 161.0 160.0 161.0 160.0 160.0 162.0 160.0 160.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#3] audio-fft Cycles:10 Average:82.00 Median:74.00 stddev:16.44 (22.2%) stddev-sans-first:17.18 20:44:56 INFO - PROCESS | 3649 | Values: 74.0 75.0 73.0 110.0 74.0 76.0 73.0 73.0 116.0 76.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:83.00 stddev:16.64 (20.0%) stddev-sans-first:17.19 20:44:56 INFO - PROCESS | 3649 | Values: 83.0 83.0 116.0 84.0 83.0 83.0 115.0 84.0 84.0 122.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:44:56 INFO - PROCESS | 3649 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 20:44:56 INFO - PROCESS | 3649 | Values: 145.0 146.0 146.0 146.0 145.0 147.0 146.0 145.0 145.0 147.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 20:44:56 INFO - PROCESS | 3649 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 96.0 95.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.00 stddev:1.18 (2.3%) stddev-sans-first:1.12 20:44:56 INFO - PROCESS | 3649 | Values: 54.0 52.0 55.0 52.0 52.0 52.0 52.0 53.0 52.0 51.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 20:44:56 INFO - PROCESS | 3649 | Values: 63.0 63.0 62.0 64.0 62.0 63.0 63.0 63.0 63.0 63.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.50 stddev:1.79 (2.4%) stddev-sans-first:1.73 20:44:56 INFO - PROCESS | 3649 | Values: 78.0 74.0 75.0 76.0 76.0 75.0 75.0 75.0 75.0 80.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:128.00 stddev:15.83 (12.4%) stddev-sans-first:16.49 20:44:56 INFO - PROCESS | 3649 | Values: 121.0 121.0 128.0 128.0 117.0 117.0 128.0 126.0 171.0 137.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:155.50 stddev:3.27 (2.1%) stddev-sans-first:3.20 20:44:56 INFO - PROCESS | 3649 | Values: 151.0 155.0 151.0 156.0 157.0 158.0 154.0 160.0 154.0 150.0 20:44:56 INFO - PROCESS | 3649 | 20:44:56 INFO - PROCESS | 3649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.63 (2.6%) stddev-sans-first:1.56 20:44:56 INFO - PROCESS | 3649 | Values: 65.0 62.0 64.0 62.0 61.0 64.0 62.0 62.0 62.0 66.0 20:44:56 INFO - PROCESS | 3649 | -------- Summary: end -------- 20:44:56 INFO - PROCESS | 3649 | 20:44:57 INFO - TEST-INFO | 3649: exit 0 20:44:57 INFO - TEST-OK | kraken | took 61232ms 20:44:57 INFO - SUITE-END | took 1177s 20:44:57 INFO - Completed test suite (00:19:37) 20:44:57 INFO - javascript benchmark 20:44:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3031.4846476099046, 3047.268655522675, 3051.6948305169485, 3073.8309392983406, 3088.4286407014706, 5164.845054648357, 5231.7907283708655, 5288.391834938983, 5328.626996110269, 5349.491798279158, 5212.556932660719, 5272.288241087452, 5275.129603615408, 5301.787928482866, 5343.679379237239, 4694.530546945312, 4768.499307572707, 4783.760811959405, 4791.401074865642, 4930.531599498042, 4884.535969082949, 4884.833372243779, 4917.803287868499, 4926.679765815228, 4933.654644174909, 4631.212693842055, 4652.534746525371, 4704.0, 4752.477227504972, 4882.707037577739, 4735.100330937111, 4752.120857641347, 4755.690880092783, 4811.59101476375, 4829.879253018667, 4757.167495688241, 4778.37881075458, 4786.569208771192, 4801.135795556798, 4835.05716385305, 5085.669431486942, 5194.818181363672, 5258.211268309746, 5262.789488420459, 5310.468953104697, 5598.4961353477975, 5657.4908258256955, 5678.403767604384, 5692.886142277172, 5699.458551437607, 5663.603547751659, 5666.065099258617, 5736.799212027559, 5737.942620573825, 5739.454751798572, 5111.897762044776, 5208.869778255574, 5271.604629652791, 5297.973510132425, 5302.257683924254, 5769.249997500298, 5774.855628609318, 5776.884462310731, 5822.737976791054, 5838.416158384128, 5543.501084902378, 5591.9720401397735, 5592.217089607459, 5595.944040559542, 5601.719914004283, 5459.754311056012, 5564.304461942257, 5616.747246373923, 5657.349404818417, 5675.631083979528, 5650.4349565043985, 5652.547796176296, 5655.886882262332, 5697.4302569742695, 5708.628939118944, 5619.8595035124445, 5654.293213348332, 5659.688717120598, 5664.348599910981, 5670.603057785916, 4182.665386769112, 4203.810828512725, 4293.248681480728, 4368.5194628590825, 4410.558944105564, 3849.634284742945, 3860.1700634363747, 3894.8636797711943, 3920.6471417571984, 3952.6047395260243, 5339.0, 5364.624476286623, 5370.355557333145, 5374.113271310268, 5383.919241211385, 5362.490563396549, 5524.447555244444, 5610.214569960209, 5663.32040155184, 5706.771729130871, 5306.257124002643, 5361.973190134102, 5384.784608615611, 5409.675419474844, 5411.053065713484, 4905.9264111038365, 4908.803647854046, 4914.606831453475, 4914.926276105862, 4953.950460495421, 5631.662100273915, 5842.065269556851, 5849.61977471463, 5849.970750146222, 5853.590248682636, 5581.972090139523, 5626.071698169756, 5639.577031722555, 5652.349979752216, 5698.088305871041, 5788.565857560784, 5819.010768169506, 5833.125031245348, 5836.737346819488, 5837.67892765902, 5348.0, 5500.202470641654, 5534.05920993424, 5555.611107222618, 5565.471280228372, 5575.163725441054, 5629.240052592848, 5630.23991761107, 5641.8589535261945, 5721.25623668937, 5486.753096110764, 5522.116461366162, 5525.861853453695, 5529.751161197675, 5530.253415788817, 5317.8404647860625, 5528.06022976087, 5537.335519737658, 5539.41836107219, 5587.55299576041, 5434.157705555645, 5490.286262785812, 5502.339719233718, 5530.806421775219, 5585.804496842591, 5586.748596313257, 5588.888222235614, 5640.746166422603, 5642.971785141212, 5643.463870932255, 5247.1079916415065, 5488.506034456758, 5493.285872836505, 5495.505404513613, 5501.312335958005], "value": 5207.72179021451, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.3362001368475, 612.439617749759, 624.045210827434, 633.7211626884174, 640.1102467570079, 43758.78120609396, 45383.0, 45458.545414545806, 45466.0, 49747.0, 45954.31068533975, 46350.30474542876, 46442.76778616102, 46447.99999999991, 46468.0, 9052.36633435658, 9119.088091190893, 9141.360104792668, 9194.954025229865, 9238.538073096352, 9059.592318345658, 9146.542672866364, 9149.496777677225, 9152.725418237464, 9157.130072643122, 9158.816823663523, 9196.26429885611, 9197.724068277928, 9201.079892010812, 9210.447373157598, 9124.31567632427, 9155.313351498664, 9157.0, 9157.496337701425, 9169.312301577374, 8949.59726812295, 8998.100189981014, 9011.369204155711, 9011.729648110568, 9022.7293181204, 44290.0, 44445.55549444779, 44727.0, 44844.775776121234, 44909.775451122536, 3544.805035723034, 3611.5846677632144, 3661.7802931824176, 3686.8156592170285, 4044.737092089005, 33891.491627625604, 34243.486347704806, 34381.65618343835, 34633.484567640466, 36170.0, 3927.626875446828, 3942.7240093193486, 3946.6645335146545, 3959.2675355059405, 3975.363941769332, 376107.0, 377502.99999999726, 379647.0, 380582.6796062152, 380987.0, 62435.687821560605, 62864.371356285854, 62874.37125628777, 62944.68527657424, 62993.0, 58779.412205877394, 58842.7057864708, 58921.0, 58964.7051764747, 59060.0, 16060.0, 16791.496255112364, 16800.41198558069, 17309.39417120395, 17336.566585835455, 12760.489580416865, 12895.355232238351, 12907.483700651868, 12908.741825163632, 12910.354482275849, 20321.288754893507, 20327.0, 20434.0, 20493.692594611093, 20537.178512859617, 7379.483436159525, 7395.149557800814, 7417.59203243816, 7450.739224127238, 7487.737929172453, 843.5360551696542, 999.205631522941, 1116.0680831505783, 1122.270524159303, 1133.982990255147, 33707.66292337095, 33723.83138084294, 34106.65893341084, 34262.43031772627, 34612.06143089025, 865.6364326982682, 1052.652624633869, 1131.9547218111184, 1176.3823992404057, 1188.2514016169757, 16627.168641567874, 17203.741943870853, 17259.39592114295, 17290.740638890427, 17414.129293535272, 587788.0, 589754.0, 591653.0, 591967.0, 594624.0, 62512.37487625157, 62999.0, 63112.0, 63216.367836321966, 63287.68356158282, 1199.3583432863377, 1306.8954483641287, 1349.595121463557, 1363.5363976248123, 1374.8762611364825, 32968.83515582407, 35158.08942987807, 35499.29001420009, 35609.46585801267, 35741.46387804133, 53354.19968700395, 53963.46036539741, 54032.326605705835, 54172.18741718798, 54177.729111354194, 430047.0, 432200.0, 432917.0, 433057.0, 433618.0, 27513.724862751118, 28436.807095343942, 28696.139115826558, 30000.549991750577, 30158.69841301559, 49533.50466495289, 49926.251106234165, 50007.0, 50621.746891265306, 51116.48883511117, 42395.152096957274, 42854.142917142104, 43181.13637727291, 43336.0, 45122.77438612786, 42027.36958945679, 43193.0, 43553.0, 43900.56099439092, 43993.0, 42377.36433953432, 43151.568484314754, 43204.351934721635, 43225.56774432216, 43303.0, 35642.64357356393, 38098.238035239694, 38376.42435363527, 38458.23083538369, 39467.40798887962, 27885.860570697016, 28515.572266416435, 28678.0, 28874.27814304659, 28936.0], "value": 20832.440961620658, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.6704386978523, 359.2491692362961, 367.31129132875856, 373.47899679946477, 389.7252437031893, 18295.634087318245, 19410.126544305524, 19776.0, 20462.89768551155, 20615.690764638504, 19103.426897193072, 19555.884308012195, 20002.49993750157, 20145.093470793814, 20159.798402015975, 5537.335519737637, 5730.255066841326, 5765.567582431314, 5776.855578610526, 5780.104083866986, 5464.23500709899, 5564.86087847803, 5574.1638754187, 5604.075327570946, 5604.3835178130375, 5563.443655634424, 5563.443655634424, 5564.721763911808, 5567.0, 5569.888602227953, 5400.108982017982, 5614.045612245928, 5637.915431268534, 5638.548916086703, 5644.717764111778, 4954.5540901319055, 5004.349434573519, 5004.474530174352, 5007.349044624212, 5008.69947803133, 21784.89107554452, 22354.441138971655, 23251.3024609262, 23395.0, 23553.293401197992, 2279.9544009119727, 2332.9300120996227, 2338.754430784777, 2345.3784747042046, 2819.4079243358715, 8905.0, 9071.682491112779, 9371.203447706954, 9528.904176019707, 9553.665621703207, 1904.5048287445225, 2012.9194832206695, 2114.143771772435, 2121.968170477444, 2194.572058448603, 73152.0, 76706.6164669173, 92529.53735231348, 94327.0, 98502.5074874621, 16300.184990750415, 17087.829121708623, 17428.215730292166, 17455.38906138279, 17728.379506717203, 31666.366672666416, 31715.365692686017, 31718.36563268722, 31845.681543184735, 31880.0, 9762.36544624597, 9938.751531211778, 9954.601815927283, 10160.542775575117, 10206.081452669147, 8276.806455556914, 8323.83352332962, 8502.0, 8519.531425771642, 8651.134886511298, 8833.0, 8955.910440895508, 8990.415622984616, 9052.27581793455, 9133.49765762876, 3232.854521546536, 3304.719098876574, 3474.6004209515722, 3504.842282097312, 3547.113221694576, 878.7319867440365, 961.0725649748026, 978.2467500024941, 997.8203923293731, 1032.1175395037285, 18800.90599547021, 20027.09878055491, 20174.29389971344, 20232.57209134913, 20605.793942060387, 965.9951700241454, 997.8902320744712, 1041.1930753665818, 1041.953112109957, 1057.03281497429, 10184.745381365525, 11040.944795275973, 11143.498542565603, 11175.944120279346, 11277.492512836778, 447418.0, 452795.0, 460013.0, 495901.0, 496363.0, 52412.0, 82189.58905205436, 88804.0, 90368.0, 91699.0, 909.2089881802874, 955.0783493928393, 980.2794945714894, 997.5959736306808, 1000.1448761309122, 17328.740068898725, 17668.204930777887, 18126.728099078788, 18235.45293641193, 18429.907850460662, 42453.57546424496, 42456.1508769829, 43023.56976430196, 43152.0, 44665.0, 61791.0, 62662.06006909991, 62708.0, 63621.681891592096, 64601.35398645954, 7912.84174316522, 7957.681692732226, 8013.519188848688, 8020.997375328084, 8216.055153657167, 12178.512859485521, 12908.8063679043, 13111.213327200017, 13180.209187448783, 13188.802167967297, 11240.447618714434, 11322.0, 11433.771324573629, 11444.02725768319, 11983.820242696542, 11285.37930413835, 11537.942310288396, 11624.186306958432, 11681.591144309908, 11800.52797888075, 11434.82847757301, 11562.364069976233, 11592.478338474957, 12041.33772642513, 12055.51777928908, 7846.568438735696, 8057.153998830038, 8074.39442041861, 8078.6364613593705, 8364.623591938256, 10499.737506562396, 11163.665090047312, 11437.085033197158, 11454.599089031844, 11854.940725296663], "value": 9830.191781524174, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.064077708712, 1493.7759336099584, 1614.9434769783052, 1739.3390511605587, 1780.5815633326165, 8181.140980197076, 8710.433821801595, 8718.520481373529, 8721.476711397321, 8721.781955451117, 7519.812004699886, 7644.197359277266, 7654.0, 7858.607069646523, 8859.158379953895, 2293.2317673579328, 2352.729436114843, 2356.705411823522, 2372.537355215725, 2381.0475809676095, 2381.6189409694452, 2392.605220138675, 2411.4574220800355, 2413.095089341497, 2421.9394515137087, 2324.76752324767, 2339.6724458575814, 2341.098677009355, 2342.847714898526, 2360.6223004319313, 2278.065992942894, 2282.8173746100274, 2285.6685780561893, 2289.118689304613, 2289.782470665284, 2221.888905554732, 2294.3919861236786, 2295.173737454515, 2295.540891821626, 2298.839081264312, 8542.10307917672, 8563.614637341272, 8589.95705021477, 8613.61238744258, 8617.784555386103, 5093.159628661267, 5201.037808005531, 5207.140821764404, 5208.401033881114, 5214.270002199657, 3405.0976491229844, 3442.6041005284465, 3509.78941263525, 3580.8030558319283, 3596.5863925648623, 1104.9613263535819, 1129.7232178116333, 1131.8075927092414, 1138.1861968692424, 1161.5992482593492, 11997.400129993466, 12042.63872083839, 12083.697907552294, 12089.758204835942, 12138.211016283913, 4501.257292546693, 4658.86023419298, 4768.165571025057, 4833.130036593377, 4841.612670986313, 10534.631287904887, 10542.47287635615, 10545.420001899816, 10546.736331591772, 10550.208734344955, 5365.08793505105, 5376.354837419534, 5379.220013098079, 5379.704116273564, 5389.541888939406, 4641.86074417768, 4747.95252047482, 4910.238912968495, 4911.091448082045, 4911.16510193268, 3767.3030489359558, 3808.6953043756434, 3809.1239015026144, 3873.6513713765335, 3896.6298201670797, 1102.1788767368203, 1147.6212849759559, 1148.4554911458886, 1157.0916830288184, 1175.44753965636, 858.274757829633, 859.5959898847532, 891.5586784541694, 925.1488630459859, 933.6685476655825, 5481.342238931274, 5685.715714214272, 5692.31692196939, 5750.568707346882, 5840.29916410025, 937.7186843946789, 951.2627713521938, 951.6145960885852, 956.8469044952774, 986.6201512417771, 3735.290294843971, 3827.904302392407, 3880.631340022693, 3936.488256526633, 3949.8025098744947, 10369.0, 10765.084967777826, 10810.135189184846, 10813.297135686154, 10813.729656758644, 10635.149188064936, 10637.680869573926, 10637.787244255227, 10644.840327395095, 10652.786944261072, 7929.365650747926, 8008.79978000543, 8139.95930020358, 8156.836863262702, 8210.589470526449, 6007.789727359522, 6032.547558933185, 6138.355472675305, 6156.846078848064, 6264.248290205204, 9812.411255324703, 9833.754156146153, 9838.458884761407, 9846.0, 9948.850767238353, 10221.642242521773, 10421.374717516974, 10472.842907356244, 10474.423906685206, 10500.212484063879, 6874.518783685094, 7585.355244804033, 7648.158702542604, 7783.416243781852, 8153.470024448392, 8471.830563388574, 8473.0, 8558.101399353227, 8564.0, 8564.52895090776, 7555.357794587521, 7583.7724868254045, 7596.582187979714, 7613.581253030915, 7718.0, 7548.131964824115, 7561.054868141482, 7581.962090189514, 7592.202818703957, 7633.847323053396, 6978.0, 7084.716611335489, 7086.39765619928, 7088.964555177397, 7098.893516597358, 4743.430788305425, 4803.543663351976, 4819.445763737215, 5058.595312375075, 5123.795048198031, 4979.701217926936, 5015.097282489187, 5160.509751573594, 5192.013517431676, 5192.558632516128], "value": 4589.194958181599, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.76168945688175, 306.6182602659689, 313.7395961352078, 313.89798315547455, 316.1164545096455, 5133.3839939207255, 5231.947680523203, 5318.4681531846845, 5334.359876814783, 5342.492463215998, 5227.242049902762, 5236.947630523694, 5236.973815130928, 5249.86875328116, 5306.204069389584, 4156.812943417538, 4158.521769996444, 4160.375943608453, 4167.416561681367, 4199.3910882921955, 3958.8614398496056, 4051.6758659307334, 4193.832246710143, 4197.307444271692, 4209.379388935266, 4057.052614744924, 4070.2266569351727, 4074.470318858544, 4086.795660216992, 4104.733192342503, 4050.6354428101317, 4061.8375264989513, 4076.3070278052655, 4086.0, 4092.7953602320063, 3446.827658617084, 3498.6676265754713, 3533.787972721645, 3546.0, 3548.556430446194, 5095.184770436749, 5100.1074811907765, 5111.258867464197, 5147.433782283946, 5170.870728231786, 4648.48866624671, 4654.930176047362, 4658.510856360067, 4660.5339466053465, 4685.484596694361, 5393.379761327458, 5412.404635490093, 5416.729163541847, 5451.918221226645, 5511.311086114236, 3849.30712471755, 3856.151646637735, 3896.980515097435, 3899.415087736834, 3905.8437662493466, 5781.768729250825, 5800.245968024172, 5801.7099145043, 5805.593608447411, 5817.243758311435, 3776.9244615108096, 3942.15243722601, 3949.2101579684177, 3953.6441720245316, 3968.6031396860662, 3989.4813674222746, 3994.422203229708, 4005.6595189408645, 4035.1526179502634, 4035.959640403617, 4627.282771170474, 4628.606568441653, 4637.304404339376, 4664.160451118832, 4671.182543054952, 5397.379301380313, 5541.307336582927, 5557.5553955683445, 5580.302462192226, 5581.386047534768, 1321.286505287134, 1356.3286173344259, 1376.779715245576, 1384.5915454940816, 1385.4388972466168, 918.6279556779515, 937.9869740680049, 943.9575219115156, 949.3639261694681, 950.4249928793118, 5297.629165958346, 5304.946950530522, 5307.7080760557765, 5317.697164194719, 5354.143337066051, 5600.551955843604, 5606.355269144019, 5606.971965140148, 5628.2683251177905, 5639.379668236491, 5144.717040562805, 5326.36083669962, 5347.358317001985, 5358.464153584689, 5407.729613519308, 2984.19426754775, 3042.269855234728, 3046.2384403899027, 3047.9484577820617, 3059.3728285701377, 5964.957871485573, 5976.312724036705, 5989.0, 5989.574222439919, 5994.100884867217, 5632.662040277596, 5745.1669507921115, 5748.6838223898085, 5774.68239246837, 5807.593468457168, 5878.647281163058, 5897.262842144732, 5898.587098903035, 5910.645361278337, 5912.349641539341, 5470.699111548903, 5667.716614169358, 5715.2855893013375, 5730.255066841284, 5744.971275143597, 5650.180723795109, 5660.51885589713, 5663.518600918803, 5670.546356291405, 5706.229658995982, 5956.51087228193, 5957.344692083954, 5967.701614919323, 5983.581149319506, 5985.952458319864, 3830.4637350771472, 3989.880303590897, 4005.379166229239, 4013.237484877864, 4032.2540330039037, 5493.2034854946605, 5683.460071293221, 5751.568632352507, 5785.971070144622, 5804.912926306193, 5449.591280654046, 5560.138178582326, 5576.1356989666665, 5597.832065037893, 5670.347909990239, 5574.414686457863, 5575.693336866511, 5580.0, 5584.46947539983, 5593.5879113739775, 5285.841424757264, 5510.421405752339, 5538.667679939216, 5541.778328866962, 5543.8891222174525, 5596.356419011866, 5596.62143588965, 5602.2717046783655, 5618.775248989995, 5622.156676498558, 5445.829146733471, 5460.535854452416, 5496.0, 5502.58730595199, 5556.499915007668], "value": 4207.715348011543, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.3706675192583, 730.8209488675276, 774.4540099230042, 845.4208866926152, 847.4025811802679, 15288.694226115485, 15708.685826283467, 16469.0, 16482.0, 16510.91744541277, 15603.141827199499, 15634.452794152206, 15814.130222837739, 15827.841721582781, 15853.445129420472, 807.5235610989515, 816.0982114763191, 822.1983566023109, 822.8189798244376, 826.0335407573153, 661.22636515277, 796.7649543384715, 819.610684924659, 822.1860358245324, 828.3828547731948, 870.2037635563452, 874.3224001398903, 875.3478658399501, 876.9912300876973, 877.9385443018991, 853.1127627267634, 854.8375808596378, 854.9102344253888, 858.1118542308711, 860.3203469259278, 504.4627471742619, 614.5053232148119, 627.2786295759867, 627.7489004398232, 628.745358129958, 14530.12819230839, 14601.634959126106, 14613.123212607277, 14663.48677796272, 14689.485867994568, 13780.862191378059, 13873.4450621975, 14346.641333966734, 14507.0, 14515.564533064025, 13208.801867971988, 13213.0, 13436.798448023288, 13491.730165396637, 13499.865001350057, 4403.0, 4428.512863585035, 4439.422875026258, 4447.666425018104, 4530.116627257686, 75359.0, 75757.62121189413, 75809.0, 76424.61787691026, 78429.60785196094, 11690.824637630443, 11707.707307317385, 11852.822207666892, 12141.15011949155, 12285.140040197279, 21755.782442175376, 21784.237551685615, 21784.78215217859, 21796.89101554482, 21858.344249672537, 8533.402661813738, 8790.208881200722, 8843.0714774949, 8888.955555222312, 9235.538223088954, 4769.689970151999, 4787.8563643090765, 4805.087033463631, 4884.291777692215, 4910.533499317559, 3417.1798768295926, 3435.656434356544, 3461.8615255390005, 3516.9472457913153, 3519.401701710664, 571.3087164530881, 574.6121368076615, 582.670791003082, 597.7310210405335, 613.4019331152091, 624.5596854217765, 628.5757113948067, 662.0, 670.128832517725, 674.231376231097, 9171.233420697334, 9495.287853410884, 9614.278929080347, 9823.312368134304, 9883.802323953481, 683.3712984054681, 692.4944790303107, 703.89164215057, 714.8091100776105, 728.3845150847526, 4315.438992930899, 4810.42274927004, 4810.831620893322, 4811.879703007453, 4831.396075490564, 114362.42818785853, 114988.42505787418, 115772.0, 116233.0, 119373.40313298552, 95702.0, 97216.0, 99108.0, 99334.0, 99985.0, 81609.59195203986, 87100.99999999873, 87689.56155219184, 87850.0, 88671.55664221638, 9001.594928228114, 9229.907700922904, 9357.709527532912, 9457.668981585612, 9500.524973751422, 46657.30014049724, 46804.0, 51718.48281517137, 52760.73619632031, 53573.0, 48680.0, 63378.68310658417, 73627.0, 76315.0, 78286.0, 12521.812172817234, 12625.179363341353, 12795.680107997374, 12902.935485322514, 12944.870551294744, 14960.17719025464, 14995.100293982396, 15304.846951530342, 15765.211739412754, 15793.447229346917, 14081.929590351983, 14454.132752034491, 14861.777073343692, 14912.25438728081, 15347.386104556139, 13589.660258493617, 13616.114952528054, 13836.0, 14058.718825623635, 14096.013279070366, 14025.789613155606, 14335.92832035833, 14399.78400324017, 14506.637334066732, 14558.0, 11307.830382544103, 11422.885771142515, 11859.347735874264, 12040.397980101136, 12230.449629766505, 11140.442977851237, 11805.70485737829, 11846.289222646668, 12047.397630118634, 12071.758564828478], "value": 7650.285646913058, "unit": "score"}], "name": "dromaeo_css", "value": 7349.252178894353, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 112.0, 112.0, 114.0, 112.0, 111.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 126.0, 119.0, 181.0, 125.0, 117.0, 146.0, 117.0, 148.0, 116.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 160.0, 161.0, 160.0, 160.0, 162.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 110.0, 74.0, 76.0, 73.0, 73.0, 116.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 116.0, 84.0, 83.0, 83.0, 115.0, 84.0, 84.0, 122.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 145.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 55.0, 52.0, 52.0, 52.0, 52.0, 53.0, 52.0, 51.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 64.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 75.0, 76.0, 76.0, 75.0, 75.0, 75.0, 75.0, 80.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 128.0, 128.0, 117.0, 117.0, 128.0, 126.0, 171.0, 137.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 155.0, 151.0, 156.0, 157.0, 158.0, 154.0, 160.0, 154.0, 150.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 64.0, 62.0, 61.0, 64.0, 62.0, 62.0, 62.0, 66.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1476.5000000000002, "alertThreshold": 2.0}]} 20:44:57 INFO - Return code: 0 20:44:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:44:57 INFO - # TBPL SUCCESS # 20:44:57 INFO - Running post-action listener: _resource_record_post_action 20:44:57 INFO - [mozharness: 2016-07-22 03:44:57.787754Z] Finished run-tests step (success) 20:44:57 INFO - Running post-run listener: _resource_record_post_run 20:44:57 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7712768; Write bytes: 464703488; Read time: 1364; Write time: 457840 20:44:57 INFO - TinderboxPrint: CPU usage
13.0% 20:44:57 INFO - TinderboxPrint: I/O read bytes / time
7,712,768 / 1,364 20:44:57 INFO - TinderboxPrint: I/O write bytes / time
464,703,488 / 457,840 20:44:57 INFO - TinderboxPrint: CPU idle
8,297.8 (87.0%) 20:44:57 INFO - TinderboxPrint: CPU user
1,191.8 (12.5%) 20:44:57 INFO - TinderboxPrint: Swap in / out
0 / 0 20:44:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 4665344; Read time: 0; Write time: 516 20:44:57 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 5931008; Write bytes: 446586880; Read time: 1296; Write time: 414020 20:44:58 INFO - Running post-run listener: _upload_blobber_files 20:44:58 INFO - Blob upload gear active. 20:44:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:44:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:44:58 INFO - (blobuploader) - INFO - Open directory for files ... 20:44:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:44:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:59 INFO - (blobuploader) - INFO - Done attempting. 20:44:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:44:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:45:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:45:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:45:00 INFO - (blobuploader) - INFO - Done attempting. 20:45:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:45:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:45:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:45:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:45:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:45:07 INFO - (blobuploader) - INFO - Done attempting. 20:45:07 INFO - (blobuploader) - INFO - Iteration through files over. 20:45:07 INFO - Return code: 0 20:45:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:45:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:45:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b02017ef5cf39d53242229ef73597d87a417c2c99638f6b6051c9d4ba57f23fa0a163dafc261377e18c5eb4de579dc9ede8bf6a6078ddcf67e533e899a6bcb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e155d0abb10ea1a446c145db76ef7f3751cb4e17e6cdca93f5bf979d13082e0acf6a9329b8a6e294025aee962ebff6ba154208a66bfe29a8bba56fffc5423ed3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10eea1e4bc403ac241ebe70ff62c6c868dce000498cf71810938ddabf5842168758fd571fbfbf7de9185e4c3ae0a5cea27bee0a4e9b956ce19a1005170d18054"} 20:45:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:45:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:45:07 INFO - Contents: 20:45:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b02017ef5cf39d53242229ef73597d87a417c2c99638f6b6051c9d4ba57f23fa0a163dafc261377e18c5eb4de579dc9ede8bf6a6078ddcf67e533e899a6bcb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e155d0abb10ea1a446c145db76ef7f3751cb4e17e6cdca93f5bf979d13082e0acf6a9329b8a6e294025aee962ebff6ba154208a66bfe29a8bba56fffc5423ed3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10eea1e4bc403ac241ebe70ff62c6c868dce000498cf71810938ddabf5842168758fd571fbfbf7de9185e4c3ae0a5cea27bee0a4e9b956ce19a1005170d18054"} 20:45:07 INFO - Running post-run listener: copy_logs_to_upload_dir 20:45:07 INFO - Copying logs to upload dir... 20:45:07 INFO - mkdir: /builds/slave/test/build/upload/logs 20:45:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.485934 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-21 20:45:07.063001) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 20:45:07.068327) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b02017ef5cf39d53242229ef73597d87a417c2c99638f6b6051c9d4ba57f23fa0a163dafc261377e18c5eb4de579dc9ede8bf6a6078ddcf67e533e899a6bcb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e155d0abb10ea1a446c145db76ef7f3751cb4e17e6cdca93f5bf979d13082e0acf6a9329b8a6e294025aee962ebff6ba154208a66bfe29a8bba56fffc5423ed3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10eea1e4bc403ac241ebe70ff62c6c868dce000498cf71810938ddabf5842168758fd571fbfbf7de9185e4c3ae0a5cea27bee0a4e9b956ce19a1005170d18054"} build_url:https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/NAmAStwzRD28O1XvTaVsCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b02017ef5cf39d53242229ef73597d87a417c2c99638f6b6051c9d4ba57f23fa0a163dafc261377e18c5eb4de579dc9ede8bf6a6078ddcf67e533e899a6bcb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e155d0abb10ea1a446c145db76ef7f3751cb4e17e6cdca93f5bf979d13082e0acf6a9329b8a6e294025aee962ebff6ba154208a66bfe29a8bba56fffc5423ed3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10eea1e4bc403ac241ebe70ff62c6c868dce000498cf71810938ddabf5842168758fd571fbfbf7de9185e4c3ae0a5cea27bee0a4e9b956ce19a1005170d18054"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 20:45:07.093065) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:45:07.093373) ========= 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=c6927cf182745ad25b1d38b9000001fe-1469157861.240801-1270223258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 20:45:07.175795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 20:45:07.176113) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 20:45:07.176397) ========= ========= Total master_lag: 0.19 =========