builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1474941248.05 results: success (0) buildid: 20160926041252 builduid: 557bab29aaeb4c3b9de51a813111fc0c revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:08.049764) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:08.050132) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:08.050396) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:08.128886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:08.129185) ========= 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=6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 18:54:10-- 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% 50.6M=0s 2016-09-26 18:54:10 (50.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.436798 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:08.580555) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:08.583923) ========= 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=6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017427 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:08.640248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:08.640584) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --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 c55bcb7c777ea09431b4d16903ed079ae5632648 --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=6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 18:54:10,662 truncating revision to first 12 chars 2016-09-26 18:54:10,662 Setting DEBUG logging. 2016-09-26 18:54:10,663 attempt 1/10 2016-09-26 18:54:10,663 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c55bcb7c777e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 18:54:10,997 unpacking tar archive at: fx-team-c55bcb7c777e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677571 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:09.342162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:09.342428) ========= script_repo_revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:09.342788) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:09.343047) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 18:54:09.357834) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-26 18:54:09.358760) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:54:11 INFO - MultiFileLogger online at 20160926 18:54:11 in /builds/slave/test 18:54:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:54:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:54:11 INFO - {'append_to_log': False, 18:54:11 INFO - 'base_work_dir': '/builds/slave/test', 18:54:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:54:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:54:11 INFO - 'branch': 'Fx-Team-Non-PGO', 18:54:11 INFO - 'buildbot_json_path': 'buildprops.json', 18:54:11 INFO - 'config_files': ('talos/linux_config.py',), 18:54:11 INFO - 'default_actions': ('clobber', 18:54:11 INFO - 'read-buildbot-config', 18:54:11 INFO - 'download-and-extract', 18:54:11 INFO - 'populate-webroot', 18:54:11 INFO - 'create-virtualenv', 18:54:11 INFO - 'install', 18:54:11 INFO - 'run-tests'), 18:54:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:54:11 INFO - 'download_minidump_stackwalk': True, 18:54:11 INFO - 'download_symbols': 'ondemand', 18:54:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:54:11 INFO - 'tooltool.py': '/tools/tooltool.py', 18:54:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:54:11 INFO - '/tools/misc-python/virtualenv.py')}, 18:54:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:54:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:54:11 INFO - 'installer_path': 'installer.exe', 18:54:11 INFO - 'log_level': 'info', 18:54:11 INFO - 'log_name': 'talos', 18:54:11 INFO - 'log_to_console': True, 18:54:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:54:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:54:11 INFO - 'opt_config_files': (), 18:54:11 INFO - 'pip_index': False, 18:54:11 INFO - 'sps_profile': False, 18:54:11 INFO - 'sps_profile_interval': 0, 18:54:11 INFO - 'suite': 'dromaeojs', 18:54:11 INFO - 'system_bits': '32', 18:54:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:54:11 INFO - 'title': 'talos-linux64-ix-023', 18:54:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:54:11 INFO - 'use_talos_json': True, 18:54:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:54:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:54:11 INFO - 'work_dir': 'build'} 18:54:11 INFO - [mozharness: 2016-09-27 01:54:11.483887Z] Running clobber step. 18:54:11 INFO - Running pre-action listener: _resource_record_pre_action 18:54:11 INFO - Running main action method: clobber 18:54:11 INFO - rmtree: /builds/slave/test/build 18:54:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:54:11 INFO - Running post-action listener: _resource_record_post_action 18:54:11 INFO - [mozharness: 2016-09-27 01:54:11.943735Z] Finished clobber step (success) 18:54:11 INFO - [mozharness: 2016-09-27 01:54:11.943836Z] Running read-buildbot-config step. 18:54:11 INFO - Running pre-action listener: _resource_record_pre_action 18:54:11 INFO - Running main action method: read_buildbot_config 18:54:11 INFO - Using buildbot properties: 18:54:11 INFO - { 18:54:11 INFO - "project": "", 18:54:11 INFO - "product": "firefox", 18:54:11 INFO - "script_repo_revision": "production", 18:54:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:54:11 INFO - "repository": "", 18:54:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:54:11 INFO - "buildid": "20160926041252", 18:54:11 INFO - "pgo_build": "False", 18:54:11 INFO - "basedir": "/builds/slave/test", 18:54:11 INFO - "buildnumber": 1953, 18:54:11 INFO - "slavename": "talos-linux64-ix-023", 18:54:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:54:11 INFO - "platform": "ubuntu64_hw", 18:54:11 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:54:11 INFO - "branch": "fx-team", 18:54:11 INFO - "repo_path": "integration/fx-team", 18:54:11 INFO - "revision": "c55bcb7c777ea09431b4d16903ed079ae5632648", 18:54:11 INFO - "stage_platform": "linux64", 18:54:11 INFO - "builduid": "557bab29aaeb4c3b9de51a813111fc0c", 18:54:11 INFO - "slavebuilddir": "test" 18:54:11 INFO - } 18:54:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:54:11 INFO - Running post-action listener: _resource_record_post_action 18:54:11 INFO - [mozharness: 2016-09-27 01:54:11.946251Z] Finished read-buildbot-config step (success) 18:54:11 INFO - [mozharness: 2016-09-27 01:54:11.946355Z] Running download-and-extract step. 18:54:11 INFO - Running pre-action listener: _resource_record_pre_action 18:54:11 INFO - Running main action method: download_and_extract 18:54:11 INFO - mkdir: /builds/slave/test/build/tests 18:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:11 INFO - trying https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:54:11 INFO - Downloading https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:54:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:54:12 INFO - Downloaded 1361 bytes. 18:54:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:54:12 INFO - Using the following test package requirements: 18:54:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:54:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:54:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:54:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:12 INFO - u'jsshell-linux-x86_64.zip'], 18:54:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:54:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:54:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:54:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:54:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:54:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:54:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:54:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:54:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:54:12 INFO - Fetch https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:54:13 INFO - Expected file size: 20410618 18:54:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:54:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:54:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:54:18 INFO - Fetch https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:54:18 INFO - Expected file size: 20410618 18:54:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:54:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:54:23 INFO - Fetch https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:54:23 INFO - Expected file size: 14414057 18:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:24 INFO - trying https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:54:24 INFO - Downloading https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:54:25 INFO - Downloaded 55743729 bytes. 18:54:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:54:25 INFO - mkdir: /builds/slave/test/properties 18:54:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:54:25 INFO - Writing to file /builds/slave/test/properties/build_url 18:54:25 INFO - Contents: 18:54:25 INFO - build_url:https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:54:26 INFO - Running post-action listener: _resource_record_post_action 18:54:26 INFO - Running post-action listener: set_extra_try_arguments 18:54:26 INFO - [mozharness: 2016-09-27 01:54:26.169891Z] Finished download-and-extract step (success) 18:54:26 INFO - [mozharness: 2016-09-27 01:54:26.170117Z] Running populate-webroot step. 18:54:26 INFO - Running pre-action listener: _resource_record_pre_action 18:54:26 INFO - Running main action method: populate_webroot 18:54:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:54:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:54:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:54:26 INFO - '--tppagecycles', 18:54:26 INFO - '7'], 18:54:26 INFO - 'tests': ['tsvgm']}}, 18:54:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:54:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:54:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:54:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:54:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:54:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:54:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:26 INFO - 'talos_options': ['--disable-e10s'], 18:54:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:54:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:54:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:26 INFO - 'talos_options': ['--disable-e10s'], 18:54:26 INFO - 'tests': ['damp', 'tps']}, 18:54:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:26 INFO - 'tests': ['damp', 'tps']}, 18:54:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:54:26 INFO - 'tests': ['dromaeo_dom']}, 18:54:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:54:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:54:26 INFO - 'tests': ['basic_compositor_video']}, 18:54:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:54:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:54:26 INFO - 'tests': ['a11yr', 18:54:26 INFO - 'ts_paint', 18:54:26 INFO - 'tpaint', 18:54:26 INFO - 'sessionrestore', 18:54:26 INFO - 'sessionrestore_no_auto_restore', 18:54:26 INFO - 'tabpaint']}, 18:54:26 INFO - 'other-e10s': {'tests': ['a11yr', 18:54:26 INFO - 'ts_paint', 18:54:26 INFO - 'tpaint', 18:54:26 INFO - 'sessionrestore', 18:54:26 INFO - 'sessionrestore_no_auto_restore', 18:54:26 INFO - 'tabpaint']}, 18:54:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:54:26 INFO - 'ts_paint', 18:54:26 INFO - 'tpaint', 18:54:26 INFO - 'sessionrestore', 18:54:26 INFO - 'sessionrestore_no_auto_restore', 18:54:26 INFO - 'tabpaint']}, 18:54:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:54:26 INFO - 'ts_paint', 18:54:26 INFO - 'tpaint', 18:54:26 INFO - 'sessionrestore', 18:54:26 INFO - 'sessionrestore_no_auto_restore', 18:54:26 INFO - 'tabpaint']}, 18:54:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:54:26 INFO - 'tests': ['a11yr', 18:54:26 INFO - 'ts_paint', 18:54:26 INFO - 'tpaint', 18:54:26 INFO - 'sessionrestore', 18:54:26 INFO - 'sessionrestore_no_auto_restore', 18:54:26 INFO - 'tabpaint']}, 18:54:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:54:26 INFO - 'tests': ['a11yr', 18:54:26 INFO - 'ts_paint', 18:54:26 INFO - 'tpaint', 18:54:26 INFO - 'sessionrestore', 18:54:26 INFO - 'sessionrestore_no_auto_restore', 18:54:26 INFO - 'tabpaint']}, 18:54:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:54:26 INFO - 'tests': ['tsvgx', 18:54:26 INFO - 'tsvgr_opacity', 18:54:26 INFO - 'tart', 18:54:26 INFO - 'tscrollx', 18:54:26 INFO - 'cart']}, 18:54:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:54:26 INFO - 'tsvgr_opacity', 18:54:26 INFO - 'tart', 18:54:26 INFO - 'tscrollx', 18:54:26 INFO - 'cart']}, 18:54:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:26 INFO - 'talos_options': ['--disable-e10s'], 18:54:26 INFO - 'tests': ['tp5o']}, 18:54:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:26 INFO - 'tests': ['tp5o']}, 18:54:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:26 INFO - 'talos_options': ['--disable-e10s', 18:54:26 INFO - '--xperf_path', 18:54:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:54:26 INFO - 'tests': ['tp5n']}, 18:54:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:26 INFO - 'talos_options': ['--xperf_path', 18:54:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:54:26 INFO - 'tests': ['tp5n']}}, 18:54:26 INFO - 'talos.zip': {'path': '', 18:54:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:54:26 INFO - Running post-action listener: _resource_record_post_action 18:54:26 INFO - [mozharness: 2016-09-27 01:54:26.188742Z] Finished populate-webroot step (success) 18:54:26 INFO - [mozharness: 2016-09-27 01:54:26.188831Z] Running create-virtualenv step. 18:54:26 INFO - Running pre-action listener: _resource_record_pre_action 18:54:26 INFO - Running main action method: create_virtualenv 18:54:26 INFO - Creating virtualenv /builds/slave/test/build/venv 18:54:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:54:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:54:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:54:26 INFO - Using real prefix '/usr' 18:54:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:54:26 INFO - Installing distribute.............................................................................................................................................................................................done. 18:54:28 INFO - Installing pip.................done. 18:54:28 INFO - Return code: 0 18:54:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:54:28 INFO - Reading from file tmpfile_stdout 18:54:28 INFO - Output received: 18:54:28 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:54:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:28 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 0x7fe148ba6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139df60>, '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 0x139ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139f1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', '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 18:54:28 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 18:54:28 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 18:54:28 INFO - Using env: {'DISPLAY': ':0', 18:54:28 INFO - 'HOME': '/home/cltbld', 18:54:28 INFO - 'LANG': 'en_US.UTF-8', 18:54:28 INFO - 'LANGUAGE': 'en_US:en', 18:54:28 INFO - 'LOGNAME': 'cltbld', 18:54:28 INFO - 'MAIL': '/var/mail/cltbld', 18:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:28 INFO - 'MOZ_NO_REMOTE': '1', 18:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:28 INFO - 'NO_EM_RESTART': '1', 18:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:28 INFO - 'PWD': '/builds/slave/test', 18:54:28 INFO - 'SHELL': '/bin/bash', 18:54:28 INFO - 'SHLVL': '1', 18:54:28 INFO - 'TERM': 'linux', 18:54:28 INFO - 'TMOUT': '86400', 18:54:28 INFO - 'USER': 'cltbld', 18:54:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', 18:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:28 INFO - '_': '/tools/buildbot/bin/python'} 18:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:54:29 INFO - Cleaning up... 18:54:29 INFO - Return code: 0 18:54:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe148ba6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139df60>, '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 0x139ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139f1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', '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 18:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:54:29 INFO - Using env: {'DISPLAY': ':0', 18:54:29 INFO - 'HOME': '/home/cltbld', 18:54:29 INFO - 'LANG': 'en_US.UTF-8', 18:54:29 INFO - 'LANGUAGE': 'en_US:en', 18:54:29 INFO - 'LOGNAME': 'cltbld', 18:54:29 INFO - 'MAIL': '/var/mail/cltbld', 18:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:29 INFO - 'MOZ_NO_REMOTE': '1', 18:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:29 INFO - 'NO_EM_RESTART': '1', 18:54:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:29 INFO - 'PWD': '/builds/slave/test', 18:54:29 INFO - 'SHELL': '/bin/bash', 18:54:29 INFO - 'SHLVL': '1', 18:54:29 INFO - 'TERM': 'linux', 18:54:29 INFO - 'TMOUT': '86400', 18:54:29 INFO - 'USER': 'cltbld', 18:54:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', 18:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:29 INFO - '_': '/tools/buildbot/bin/python'} 18:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:29 INFO - Downloading/unpacking psutil>=3.1.1 18:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:54:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:54:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:54:31 INFO - Installing collected packages: psutil 18:54:31 INFO - Running setup.py install for psutil 18:54:31 INFO - building 'psutil._psutil_linux' extension 18:54:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:54:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:54:31 INFO - building 'psutil._psutil_posix' extension 18:54:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:54:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:54:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:54:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:54:31 INFO - Successfully installed psutil 18:54:31 INFO - Cleaning up... 18:54:31 INFO - Return code: 0 18:54:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe148ba6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139df60>, '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 0x139ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139f1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', '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 18:54:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:54:31 INFO - Using env: {'DISPLAY': ':0', 18:54:31 INFO - 'HOME': '/home/cltbld', 18:54:31 INFO - 'LANG': 'en_US.UTF-8', 18:54:31 INFO - 'LANGUAGE': 'en_US:en', 18:54:31 INFO - 'LOGNAME': 'cltbld', 18:54:31 INFO - 'MAIL': '/var/mail/cltbld', 18:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:31 INFO - 'MOZ_NO_REMOTE': '1', 18:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:31 INFO - 'NO_EM_RESTART': '1', 18:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:31 INFO - 'PWD': '/builds/slave/test', 18:54:31 INFO - 'SHELL': '/bin/bash', 18:54:31 INFO - 'SHLVL': '1', 18:54:31 INFO - 'TERM': 'linux', 18:54:31 INFO - 'TMOUT': '86400', 18:54:31 INFO - 'USER': 'cltbld', 18:54:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', 18:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:31 INFO - '_': '/tools/buildbot/bin/python'} 18:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:54:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:54:34 INFO - Installing collected packages: mozsystemmonitor 18:54:34 INFO - Running setup.py install for mozsystemmonitor 18:54:34 INFO - Successfully installed mozsystemmonitor 18:54:34 INFO - Cleaning up... 18:54:34 INFO - Return code: 0 18:54:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe148ba6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139df60>, '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 0x139ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139f1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', '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 18:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:54:34 INFO - Using env: {'DISPLAY': ':0', 18:54:34 INFO - 'HOME': '/home/cltbld', 18:54:34 INFO - 'LANG': 'en_US.UTF-8', 18:54:34 INFO - 'LANGUAGE': 'en_US:en', 18:54:34 INFO - 'LOGNAME': 'cltbld', 18:54:34 INFO - 'MAIL': '/var/mail/cltbld', 18:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:34 INFO - 'MOZ_NO_REMOTE': '1', 18:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:34 INFO - 'NO_EM_RESTART': '1', 18:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:34 INFO - 'PWD': '/builds/slave/test', 18:54:34 INFO - 'SHELL': '/bin/bash', 18:54:34 INFO - 'SHLVL': '1', 18:54:34 INFO - 'TERM': 'linux', 18:54:34 INFO - 'TMOUT': '86400', 18:54:34 INFO - 'USER': 'cltbld', 18:54:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', 18:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:34 INFO - '_': '/tools/buildbot/bin/python'} 18:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:34 INFO - Downloading/unpacking jsonschema==2.5.1 18:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:54:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:36 INFO - Downloading functools32-3.2.3-2.tar.gz 18:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:54:36 INFO - warning: no files found matching '*.txt' 18:54:36 INFO - no previously-included directories found matching 'build' 18:54:36 INFO - no previously-included directories found matching 'dist' 18:54:36 INFO - no previously-included directories found matching '.git*' 18:54:36 INFO - Installing collected packages: jsonschema, functools32 18:54:36 INFO - Running setup.py install for functools32 18:54:36 INFO - warning: no files found matching '*.txt' 18:54:36 INFO - no previously-included directories found matching 'build' 18:54:36 INFO - no previously-included directories found matching 'dist' 18:54:36 INFO - no previously-included directories found matching '.git*' 18:54:36 INFO - Successfully installed jsonschema functools32 18:54:36 INFO - Cleaning up... 18:54:36 INFO - Return code: 0 18:54:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe148ba6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139df60>, '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 0x139ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139f1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', '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 18:54: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:54: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 functools32==3.2.3-2 18:54:36 INFO - Using env: {'DISPLAY': ':0', 18:54:36 INFO - 'HOME': '/home/cltbld', 18:54:36 INFO - 'LANG': 'en_US.UTF-8', 18:54:36 INFO - 'LANGUAGE': 'en_US:en', 18:54:36 INFO - 'LOGNAME': 'cltbld', 18:54:36 INFO - 'MAIL': '/var/mail/cltbld', 18:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:36 INFO - 'MOZ_NO_REMOTE': '1', 18:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:36 INFO - 'NO_EM_RESTART': '1', 18:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:36 INFO - 'PWD': '/builds/slave/test', 18:54:36 INFO - 'SHELL': '/bin/bash', 18:54:36 INFO - 'SHLVL': '1', 18:54:36 INFO - 'TERM': 'linux', 18:54:36 INFO - 'TMOUT': '86400', 18:54:36 INFO - 'USER': 'cltbld', 18:54:36 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', 18:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:36 INFO - '_': '/tools/buildbot/bin/python'} 18:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:54:37 INFO - Cleaning up... 18:54:37 INFO - Return code: 0 18:54:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe148ba6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139df60>, '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 0x139ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139f1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', '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 18:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:54:37 INFO - Using env: {'DISPLAY': ':0', 18:54:37 INFO - 'HOME': '/home/cltbld', 18:54:37 INFO - 'LANG': 'en_US.UTF-8', 18:54:37 INFO - 'LANGUAGE': 'en_US:en', 18:54:37 INFO - 'LOGNAME': 'cltbld', 18:54:37 INFO - 'MAIL': '/var/mail/cltbld', 18:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:37 INFO - 'MOZ_NO_REMOTE': '1', 18:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:37 INFO - 'NO_EM_RESTART': '1', 18:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:37 INFO - 'PWD': '/builds/slave/test', 18:54:37 INFO - 'SHELL': '/bin/bash', 18:54:37 INFO - 'SHLVL': '1', 18:54:37 INFO - 'TERM': 'linux', 18:54:37 INFO - 'TMOUT': '86400', 18:54:37 INFO - 'USER': 'cltbld', 18:54:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', 18:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:37 INFO - '_': '/tools/buildbot/bin/python'} 18:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:37 INFO - Downloading/unpacking blobuploader==1.2.4 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:39 INFO - Downloading blobuploader-1.2.4.tar.gz 18:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:54:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:54:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:39 INFO - Downloading docopt-0.6.1.tar.gz 18:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:54:39 INFO - Installing collected packages: blobuploader, requests, docopt 18:54:39 INFO - Running setup.py install for blobuploader 18:54:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:54:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:54:39 INFO - Running setup.py install for requests 18:54:40 INFO - Running setup.py install for docopt 18:54:40 INFO - Successfully installed blobuploader requests docopt 18:54:40 INFO - Cleaning up... 18:54:40 INFO - Return code: 0 18:54:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe148ba6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139df60>, '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 0x139ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139f1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', '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 18:54:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:54:40 INFO - Using env: {'DISPLAY': ':0', 18:54:40 INFO - 'HOME': '/home/cltbld', 18:54:40 INFO - 'LANG': 'en_US.UTF-8', 18:54:40 INFO - 'LANGUAGE': 'en_US:en', 18:54:40 INFO - 'LOGNAME': 'cltbld', 18:54:40 INFO - 'MAIL': '/var/mail/cltbld', 18:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:40 INFO - 'MOZ_NO_REMOTE': '1', 18:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:40 INFO - 'NO_EM_RESTART': '1', 18:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:40 INFO - 'PWD': '/builds/slave/test', 18:54:40 INFO - 'SHELL': '/bin/bash', 18:54:40 INFO - 'SHLVL': '1', 18:54:40 INFO - 'TERM': 'linux', 18:54:40 INFO - 'TMOUT': '86400', 18:54:40 INFO - 'USER': 'cltbld', 18:54:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', 18:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:40 INFO - '_': '/tools/buildbot/bin/python'} 18:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:54:40 INFO - Running setup.py (path:/tmp/pip-vL9ASR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:54:40 INFO - Running setup.py (path:/tmp/pip-vZ0W5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:54:40 INFO - Running setup.py (path:/tmp/pip-hbfJUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:54:40 INFO - Running setup.py (path:/tmp/pip-BvGTsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:54:41 INFO - Running setup.py (path:/tmp/pip-HBhQhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:54:41 INFO - Running setup.py (path:/tmp/pip-bLA5Ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:54:41 INFO - Running setup.py (path:/tmp/pip-iJlFvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:54:41 INFO - Running setup.py (path:/tmp/pip-mPBj85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:54:41 INFO - Running setup.py (path:/tmp/pip-PmolMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:54:41 INFO - Running setup.py (path:/tmp/pip-M9OIGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:54:41 INFO - Running setup.py (path:/tmp/pip-nCqMxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:54:41 INFO - Running setup.py (path:/tmp/pip-L2on6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:54:41 INFO - Running setup.py (path:/tmp/pip-V63K9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:54:41 INFO - Running setup.py (path:/tmp/pip-kENumC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:41 INFO - Running setup.py (path:/tmp/pip-n8A1k9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:54:41 INFO - Running setup.py (path:/tmp/pip-yzQHBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:54:41 INFO - Running setup.py (path:/tmp/pip-qyP5Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:54:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:54:41 INFO - Running setup.py install for manifestparser 18:54:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:54:42 INFO - Running setup.py install for mozcrash 18:54:42 INFO - Running setup.py install for mozdebug 18:54:42 INFO - Running setup.py install for mozdevice 18:54:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:54:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:54:42 INFO - Running setup.py install for mozfile 18:54:42 INFO - Running setup.py install for mozhttpd 18:54:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:54:42 INFO - Running setup.py install for mozinfo 18:54:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:54:42 INFO - Running setup.py install for mozInstall 18:54:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:54:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:54:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:54:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:54:42 INFO - Running setup.py install for mozleak 18:54:42 INFO - Running setup.py install for mozlog 18:54:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:54:43 INFO - Running setup.py install for moznetwork 18:54:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:54:43 INFO - Running setup.py install for mozprocess 18:54:43 INFO - Running setup.py install for mozprofile 18:54:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:54:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:54:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:54:43 INFO - Running setup.py install for mozrunner 18:54:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:54:43 INFO - Running setup.py install for mozscreenshot 18:54:43 INFO - Running setup.py install for moztest 18:54:43 INFO - Running setup.py install for mozversion 18:54:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:54:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:54:43 INFO - Cleaning up... 18:54:43 INFO - Return code: 0 18:54:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe148ba6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139df60>, '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 0x139ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139f1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', '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 18:54:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:54:43 INFO - Using env: {'DISPLAY': ':0', 18:54:43 INFO - 'HOME': '/home/cltbld', 18:54:43 INFO - 'LANG': 'en_US.UTF-8', 18:54:43 INFO - 'LANGUAGE': 'en_US:en', 18:54:43 INFO - 'LOGNAME': 'cltbld', 18:54:43 INFO - 'MAIL': '/var/mail/cltbld', 18:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:43 INFO - 'MOZ_NO_REMOTE': '1', 18:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:43 INFO - 'NO_EM_RESTART': '1', 18:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:43 INFO - 'PWD': '/builds/slave/test', 18:54:43 INFO - 'SHELL': '/bin/bash', 18:54:43 INFO - 'SHLVL': '1', 18:54:43 INFO - 'TERM': 'linux', 18:54:43 INFO - 'TMOUT': '86400', 18:54:43 INFO - 'USER': 'cltbld', 18:54:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', 18:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:43 INFO - '_': '/tools/buildbot/bin/python'} 18:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:54:43 INFO - Running setup.py (path:/tmp/pip-aLQLbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:54:44 INFO - Running setup.py (path:/tmp/pip-TsQp00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:54:44 INFO - Running setup.py (path:/tmp/pip-9u3t5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:54:44 INFO - Running setup.py (path:/tmp/pip-kGqjsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:54:44 INFO - Running setup.py (path:/tmp/pip-vF0KnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:54:44 INFO - Running setup.py (path:/tmp/pip-7fhaLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:54:44 INFO - Running setup.py (path:/tmp/pip-WgrY0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:54:44 INFO - Running setup.py (path:/tmp/pip-ohbco0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:54:44 INFO - Running setup.py (path:/tmp/pip-uOmbti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:54:44 INFO - Running setup.py (path:/tmp/pip-YBpVUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:54:44 INFO - Running setup.py (path:/tmp/pip-Kn4yu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:54:44 INFO - Running setup.py (path:/tmp/pip-pjBSDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:54:44 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)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:54:44 INFO - Running setup.py (path:/tmp/pip-q_Hjcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:54:44 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)) 18:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:54:44 INFO - Running setup.py (path:/tmp/pip-f7XORi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:45 INFO - Running setup.py (path:/tmp/pip-Z3mWoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:54:45 INFO - Running setup.py (path:/tmp/pip-Hpy_Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:54:45 INFO - Running setup.py (path:/tmp/pip-kDFzyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:54:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:47 INFO - Downloading blessings-1.6.tar.gz 18:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:54:47 INFO - Installing collected packages: blessings 18:54:47 INFO - Running setup.py install for blessings 18:54:47 INFO - Successfully installed blessings 18:54:47 INFO - Cleaning up... 18:54:47 INFO - Return code: 0 18:54:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:54:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:54:47 INFO - Reading from file tmpfile_stdout 18:54:47 INFO - Current package versions: 18:54:47 INFO - argparse == 1.2.1 18:54:47 INFO - blessings == 1.6 18:54:47 INFO - blobuploader == 1.2.4 18:54:47 INFO - docopt == 0.6.1 18:54:47 INFO - functools32 == 3.2.3-2 18:54:47 INFO - jsonschema == 2.5.1 18:54:47 INFO - manifestparser == 1.1 18:54:47 INFO - mozInstall == 1.12 18:54:47 INFO - mozcrash == 0.17 18:54:47 INFO - mozdebug == 0.1 18:54:47 INFO - mozdevice == 0.48 18:54:47 INFO - mozfile == 1.2 18:54:47 INFO - mozhttpd == 0.7 18:54:47 INFO - mozinfo == 0.9 18:54:47 INFO - mozleak == 0.1 18:54:47 INFO - mozlog == 3.4 18:54:47 INFO - moznetwork == 0.27 18:54:47 INFO - mozprocess == 0.23 18:54:47 INFO - mozprofile == 0.28 18:54:47 INFO - mozrunner == 6.12 18:54:47 INFO - mozscreenshot == 0.1 18:54:47 INFO - mozsystemmonitor == 0.3 18:54:47 INFO - moztest == 0.7 18:54:47 INFO - mozversion == 1.4 18:54:47 INFO - psutil == 3.1.1 18:54:47 INFO - requests == 1.2.3 18:54:47 INFO - wsgiref == 0.1.2 18:54:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe148ba6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139df60>, '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 0x139ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139f1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', '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 18:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:54:47 INFO - Using env: {'DISPLAY': ':0', 18:54:47 INFO - 'HOME': '/home/cltbld', 18:54:47 INFO - 'LANG': 'en_US.UTF-8', 18:54:47 INFO - 'LANGUAGE': 'en_US:en', 18:54:47 INFO - 'LOGNAME': 'cltbld', 18:54:47 INFO - 'MAIL': '/var/mail/cltbld', 18:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:47 INFO - 'MOZ_NO_REMOTE': '1', 18:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:47 INFO - 'NO_EM_RESTART': '1', 18:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:47 INFO - 'PWD': '/builds/slave/test', 18:54:47 INFO - 'SHELL': '/bin/bash', 18:54:47 INFO - 'SHLVL': '1', 18:54:47 INFO - 'TERM': 'linux', 18:54:47 INFO - 'TMOUT': '86400', 18:54:47 INFO - 'USER': 'cltbld', 18:54:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', 18:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:47 INFO - '_': '/tools/buildbot/bin/python'} 18:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:54:47 INFO - Cleaning up... 18:54:47 INFO - Return code: 0 18:54:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe148ba6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139df60>, '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 0x139ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139f1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', '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 18:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:54:47 INFO - Using env: {'DISPLAY': ':0', 18:54:47 INFO - 'HOME': '/home/cltbld', 18:54:47 INFO - 'LANG': 'en_US.UTF-8', 18:54:47 INFO - 'LANGUAGE': 'en_US:en', 18:54:47 INFO - 'LOGNAME': 'cltbld', 18:54:47 INFO - 'MAIL': '/var/mail/cltbld', 18:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:47 INFO - 'MOZ_NO_REMOTE': '1', 18:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:47 INFO - 'NO_EM_RESTART': '1', 18:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:47 INFO - 'PWD': '/builds/slave/test', 18:54:47 INFO - 'SHELL': '/bin/bash', 18:54:47 INFO - 'SHLVL': '1', 18:54:47 INFO - 'TERM': 'linux', 18:54:47 INFO - 'TMOUT': '86400', 18:54:47 INFO - 'USER': 'cltbld', 18:54:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', 18:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:47 INFO - '_': '/tools/buildbot/bin/python'} 18:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:54:48 INFO - Cleaning up... 18:54:48 INFO - Return code: 0 18:54:48 INFO - Running post-action listener: _resource_record_post_action 18:54:48 INFO - Running post-action listener: _start_resource_monitoring 18:54:48 INFO - Starting resource monitoring. 18:54:48 INFO - [mozharness: 2016-09-27 01:54:48.110359Z] Finished create-virtualenv step (success) 18:54:48 INFO - [mozharness: 2016-09-27 01:54:48.110924Z] Running install step. 18:54:48 INFO - Running pre-action listener: _resource_record_pre_action 18:54:48 INFO - Running main action method: install 18:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:54:48 INFO - Reading from file tmpfile_stdout 18:54:48 INFO - Detecting whether we're running mozinstall >=1.0... 18:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:54:48 INFO - Reading from file tmpfile_stdout 18:54:48 INFO - Output received: 18:54:48 INFO - Usage: mozinstall [options] installer 18:54:48 INFO - Options: 18:54:48 INFO - -h, --help show this help message and exit 18:54:48 INFO - -d DEST, --destination=DEST 18:54:48 INFO - Directory to install application into. [default: 18:54:48 INFO - "/builds/slave/test"] 18:54:48 INFO - --app=APP Application being installed. [default: firefox] 18:54:48 INFO - mkdir: /builds/slave/test/build/application 18:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:55:04 INFO - Reading from file tmpfile_stdout 18:55:04 INFO - Output received: 18:55:04 INFO - /builds/slave/test/build/application/firefox/firefox 18:55:04 INFO - Running post-action listener: _resource_record_post_action 18:55:04 INFO - [mozharness: 2016-09-27 01:55:04.497583Z] Finished install step (success) 18:55:04 INFO - [mozharness: 2016-09-27 01:55:04.497830Z] Running run-tests step. 18:55:04 INFO - Running pre-action listener: _resource_record_pre_action 18:55:04 INFO - Running main action method: run_tests 18:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:55:04 INFO - Python 2.7.3 18:55:04 INFO - Return code: 0 18:55:04 INFO - grabbing minidump binary from tooltool 18:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:55:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139df60>, '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 0x139ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:55:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:55:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:55:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:55:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:55:04 INFO - Return code: 0 18:55:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:55:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:55:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:55:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:55:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 18:55:04 INFO - Using env: {'DISPLAY': ':0', 18:55:04 INFO - 'HOME': '/home/cltbld', 18:55:04 INFO - 'LANG': 'en_US.UTF-8', 18:55:04 INFO - 'LANGUAGE': 'en_US:en', 18:55:04 INFO - 'LOGNAME': 'cltbld', 18:55:04 INFO - 'MAIL': '/var/mail/cltbld', 18:55:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:55:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:04 INFO - 'MOZ_NO_REMOTE': '1', 18:55:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:04 INFO - 'NO_EM_RESTART': '1', 18:55:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:04 INFO - 'PWD': '/builds/slave/test', 18:55:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:55:04 INFO - 'SHELL': '/bin/bash', 18:55:04 INFO - 'SHLVL': '1', 18:55:04 INFO - 'TERM': 'linux', 18:55:04 INFO - 'TMOUT': '86400', 18:55:04 INFO - 'USER': 'cltbld', 18:55:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586', 18:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:04 INFO - '_': '/tools/buildbot/bin/python'} 18:55:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:55:04 INFO - mozversion application_buildid: 20160926041252 18:55:04 INFO - mozversion application_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 18:55:04 INFO - mozversion application_display_name: Nightly 18:55:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:55:04 INFO - mozversion application_name: Firefox 18:55:04 INFO - mozversion application_remotingname: firefox 18:55:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:55:04 INFO - mozversion application_vendor: Mozilla 18:55:04 INFO - mozversion application_version: 52.0a1 18:55:04 INFO - mozversion platform_buildid: 20160926041252 18:55:04 INFO - mozversion platform_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 18:55:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:55:04 INFO - mozversion platform_version: 52.0a1 18:55:04 INFO - using testdate: 1474941304 18:55:04 INFO - actual date: 1474941304 18:55:04 INFO - starting webserver on 'localhost:58848' 18:55:04 INFO - SUITE-START | Running 2 tests 18:55:04 INFO - TEST-START | dromaeo_css 18:55:04 INFO - operating with platform_type : linux_ 18:55:04 INFO - Initialising browser for dromaeo_css test... 18:55:04 INFO - TEST-INFO | started process 8559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRnFTK0/profile http://localhost:58848/getInfo.html) 18:55:09 INFO - PROCESS | 8559 | __metrics Screen width/height:1600/1200 18:55:09 INFO - PROCESS | 8559 | colorDepth:24 18:55:09 INFO - PROCESS | 8559 | Browser inner width/height: 1024/697 18:55:09 INFO - PROCESS | 8559 | __metrics 18:55:09 INFO - PROCESS | 8559 | 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" 18:55:09 INFO - PROCESS | 8559 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:55:10 INFO - PROCESS | 8559 | console.error: PushService: 18:55:10 INFO - PROCESS | 8559 | stateChangeProcessEnqueue: Error transitioning state 18:55:10 INFO - PROCESS | 8559 | UnknownError 18:55:11 INFO - TEST-INFO | 8559: exit 0 18:55:11 INFO - Browser initialized. 18:55:11 INFO - Running cycle 1/1 for dromaeo_css test... 18:55:11 INFO - TEST-INFO | started process 8640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRnFTK0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:55:23 INFO - PROCESS | 8640 | RSS: Main: 175099904 18:55:23 INFO - PROCESS | 8640 | 18:56:14 INFO - PROCESS | 8640 | 1474941374167 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] 18:58:27 INFO - PROCESS | 8640 | Cycle 1(1): loaded http://localhost:58848/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58848/tests/dromaeo/cssquery-ext.html) 18:58:28 INFO - PROCESS | 8640 | RSS: Main: 281698304 18:58:28 INFO - PROCESS | 8640 | 19:01:31 INFO - PROCESS | 8640 | Cycle 1(1): loaded http://localhost:58848/tests/dromaeo/cssquery-ext.html (next: http://localhost:58848/tests/dromaeo/cssquery-jquery.html) 19:01:31 INFO - PROCESS | 8640 | RSS: Main: 282198016 19:01:31 INFO - PROCESS | 8640 | 19:04:33 INFO - PROCESS | 8640 | Cycle 1(1): loaded http://localhost:58848/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58848/tests/dromaeo/cssquery-mootools.html) 19:04:34 INFO - PROCESS | 8640 | RSS: Main: 255533056 19:04:34 INFO - PROCESS | 8640 | 19:07:36 INFO - PROCESS | 8640 | Cycle 1(1): loaded http://localhost:58848/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58848/tests/dromaeo/cssquery-prototype.html) 19:07:37 INFO - PROCESS | 8640 | RSS: Main: 220721152 19:07:37 INFO - PROCESS | 8640 | 19:10:40 INFO - PROCESS | 8640 | Cycle 1(1): loaded http://localhost:58848/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58848/tests/dromaeo/cssquery-yui.html) 19:10:41 INFO - PROCESS | 8640 | RSS: Main: 219136000 19:10:41 INFO - PROCESS | 8640 | 19:13:43 INFO - PROCESS | 8640 | Cycle 1(1): loaded http://localhost:58848/tests/dromaeo/cssquery-yui.html (next: http://localhost:58848/tests/dromaeo/cssquery-dojo.html) 19:13:44 INFO - PROCESS | 8640 | RSS: Main: 311652352 19:13:44 INFO - PROCESS | 8640 | 19:13:44 INFO - PROCESS | 8640 | __start_tp_report 19:13:44 INFO - PROCESS | 8640 | _x_x_mozilla_page_load 19:13:44 INFO - PROCESS | 8640 | _x_x_mozilla_page_load_details 19:13:44 INFO - PROCESS | 8640 | |i|pagename|runs| 19:13:44 INFO - PROCESS | 8640 | |0;dojo.html;2560.5647040003196;2583.1862963166614;2615.6338112664225;2621.92134235973;2640.353113487196;4538.841140560081;4625.745583992879;4680.391549098613;4685.226937555303;4685.508021657728;4631.004334068175;4634.443866735996;4636.397268355117;4640.09518143962;4651.5348465153465;4227.788610569474;4251.8724438266745;4282.22919874424;4325.848595299165;4357.847475338363;4308.2029824482415;4311.741295522263;4316.136772645467;4391.802368893392;4440.267355886275;4290.356446533014;4347.891302717441;4354.172707185625;4360.149770794696;4409.823607055714;4331.870043898688;4466.932996005063;4501.527339629324;4503.864884053483;4505.211587972091;4152.667786577066;4184.958150418487;4286.992556749162;4328.7402755834755;4332.458442694663;4598.310253461974;4607.884802879921;4627.1439783640135;4650.813967441299;4675.392199014141;4901.779419926112;4905.754712264373;4905.975470122627;4970.229614409773;5031.044101620717;4868.415790105175;4952.579030782352;5001.649884508086;5009.474005229471;5013.9972005598665;4579.931301030487;4634.420697412824;4663.650226233046;4689.882752931136;4695.037517308943;5128.743562821844;5131.87170320745;5135.178371460623;5140.691558506427;5182.0413223553005;4747.8575642730775;4910.90178196434;4932.8766780830765;4934.3338649282605;4997.875053123628;4864.70811751289;4920.6801557898625;4960.181570040975;4964.503549645006;5013.824516141991;4931.926021109686;4940.209566469348;4942.135126352874;4943.431505376856;5000.349954505891;4913.385826771653;4926.162552366106;4926.433460152129;4926.8768280793265;4988.72562009093;4091.263572556909;4131.5248746393945;4136.110736191733;4209.200251952119;4246.915061698749;3726.347889119393;3726.925461490809;3772.962270377261;3773.2830762155104;3790.431435284674;4322.524522302544;4326.848560300375;4327.588879056485;4377.693561450732;4380.846670366522;4782.282657601388;4846.660733748674;4901.142300097468;5030.496950305013;5034.320366750442;4266.530681625019;4277.123189746095;4277.337012763027;4312.266914624522;4322.783860806947;4465.799039043251;4466.665000124939;4484.260097083945;4518.051209246029;4539.523350048197;4559.133764584718;4566.54334566554;4697.976510117427;4711.939813541926;4717.127331443694;4931.9753401232765;5004.1492946198505;5015.122353588181;5016.849494515171;5052.343195384577;4737.123632128068;4739.573438390561;4749.881252968704;4754.120487709784;4807.927881081717;4770.165221086366;4959.231319145538;4959.355283813081;4960.280759289955;5024.6985180887805;4877.731724755173;4936.234883593049;4995;5007.524285192901;5071.822486212965;4831;4831.299461578122;4851.078295123915;4853.587445067209;4904.239842824368;4857;4871.244957031666;4874.53691899269;4881.974785294986;4937.679050861682;4641.164590373765;4697.107549565571;4775.21209000511;4836.153673107263;4840.685355451885;4939.629527785359;4945.1346014448045;4949.901001979868;4954.677945933647;4991.775370108427;4658.627309815139;4713.08094921487;4815.446223684181;4900.558949694545;4918.631102667243 19:13:44 INFO - PROCESS | 8640 | |1;ext.html;553.1757681055228;569.3196630027116;569.9287589051369;572.5963195946855;582.4786815799856;28771.280717982034;36756.44865327019;37986.05034874129;38081.80959095204;40400.59599404005;40473;40814.59185408145;40843;40889.795551022275;40929.59070409295;7629.313361797451;7750.031246094239;7773.8056548586455;7775.105862825791;7783.182765809594;7612.352949999229;7683.846323073535;7686.538807671557;7698.769036928901;7700.614969251515;7674.501157424749;7715.922840771605;7717.575533345664;7719.305262526372;7720.382369410434;7635;7680.155182929873;7690.115636701795;7692.846143077107;7706.152323244439;7672.73145439907;7727.49771264866;7740.458167928247;7741.8451630967065;7745.419093568005;38040.80979595112;38341.42487862684;38384.80807595972;38388.808055959824;38402.23195536074;2990.8953186638364;2999.565063065865;3002.8498575071376;3057.8318192499405;3109.6112985876766;26235;26450.86774566134;26818.463630727278;27342.453150937068;27997.160085197476;3340.1148695595684;3393.2025973896116;3412.8805491807666;3431.55389799327;3444.810535420551;245054;245511;245544;245592;246366;51028.74485627548;51238.23142652863;51337.229941550904;51351.486485135414;51368.74315628398;32342.514862277083;33050.66949330524;33148.1712957178;53987.46012539824;54393;13613.251271179983;13950.511732089328;14033.71932561343;14035.578932632037;14070.366833492313;9887.159591434809;9893.604255829687;9963.551640176209;9965.601375944882;9970.351927124713;17442.47672569825;17567.20947557363;17644.470665880042;17644.558886027695;17717.519547263393;6554.14796076507;6640.900386494206;6647.734090636321;6769.830754231085;6786.355296246848;794.6821271491334;861.2722249698994;875.7898104454885;918.8437965545739;967.3567077893263;26363.472730545283;27651.86174069117;27711.72288277132;28045.859770701423;28266.15201543957;771.7028943856656;892.3441270666056;910.2444970674325;921.1985572551923;968.7239136846106;14371.13773173592;14611.561653150422;14661.120332780067;14892.62768430798;14917.552473425814;347605;349629;350579;350834;351330;46667.533324667;47022.94655801589;47023;47054;47149.292760608616;1076.983845242322;1118.7147277444199;1127.8421021057059;1165.4464129538571;1178.2400351773058;26705.33236669099;28242.85878570594;28667.426651466438;29142;29144;40166.59833401746;40718.38922416225;40788.59211407848;40803;40822.1835563293;240419;241599;241688;242607;242977;22001.22995695143;22295.331140065824;22620.886895565418;22640.73592640723;22681.88659056694;40554.39168412417;40651.390229147175;40658.39012414757;40791;42007.57992420159;34330.82834585811;34347.313053739286;34374.82812585921;34453.483197752554;34484;34083;34228.657713422544;34492.82753586216;34514.82742586271;34656.48015279722;34567.827160864035;34620.48069279013;34914.82542587271;35116.29767404586;35858.64141358553;28192.85903570551;30156.24609384783;30325.965940578666;30536.84731576328;30679.386412272077;23661;23848.284551463483;23902.641460378458;24513.754862451147;24574.754252457962 19:13:44 INFO - PROCESS | 8640 | |2;jquery.html;348.3642352706312;357.6548630571498;367.90986208378945;375.1764876096967;381.3764495050593;12389.814152787703;16101.758473622891;16557.917210413932;16830.40111189435;17925.193366298514;16862.494125176232;17049.82950170498;17209.225584848682;17209.56976075599;17338.133093345346;4935.876603084916;4957.628177886655;5105.744712764347;5132.692038477703;5141.485851414866;3759.398496240602;3948.624880636335;5006.499350065001;5114.514121158484;5613.214150019001;5799.65202087874;5929.140274660172;5937.85155371117;5938.435848594377;5938.792142275021;5765.999999999979;5906.084556893688;5967.7016149192805;5996.610220335664;5997.640141591519;5281.973590132063;5283.445238250005;5290.418054014055;5290.894182116374;5291.1534154535475;20297.289594864258;20661.17355305786;20790.792092079188;20873.582528349347;21018.474538136517;1802.7025540785755;2309.226409152936;2341.1922886604093;2346.5189636124555;2422.6123820188686;12572.4342404592;12674.36628168588;12814.80777788334;13033.413496392684;13534.526291579847;1679.26112510495;1712.1353716373276;1721.2684609041107;1760.1639221369876;1761.8238176182278;64608;66268.66865665738;66992.3300766991;67454.66272668654;69342.30657693409;9374.625014999323;9767.365121267096;9781.951090244645;10226.846597301046;10291.33106348085;13224;13368.532101376406;13368.598942031755;13399.866001339862;13407.128536645281;6928.861422771516;7029.22678505364;7111.573305601681;7285.198628150899;7312.634368281565;6762.69567869447;6789.15135608049;6868.965655171693;6915.89626155608;7052.541584796972;6035.758569657252;6039.516838652898;6040.214772079602;6069.726862291208;6194.752209911643;1724.6809340272089;1740.4256595323513;1742.1968262847893;1755.2803350626182;1774.6184570317444;823.9835203295901;827.8137419080779;832.1636755061124;875.1423604867266;882.9072947340437;16592;16864.83135168657;17406.129693515275;17556.385526506765;17784.822151778575;823.2302796884932;890.7372325163963;890.973270801877;898.0435835834814;905.3029167541089;9637.22902167825;9949.751256218653;10059.899401005896;10243.590256389662;10246.614966461391;333692;334544;336399;336620;337605;64952.35047649557;65585.67207163933;68269.65865170742;68713.65643171752;70290.2970970294;874.9650013999496;893.4594570284884;913.1553313185277;916.637928018429;919.384012711485;14201.928990354982;14529.094181163598;15171.241437927838;15589.142597157264;16001.759094066332;38817.417738734504;39107.413388798625;39709.40435893406;40113.734034259476;40153.1969360617;50267.24599131089;50811.491885082156;51229.48770512396;52322;53095.46904530905;7712.305892469704;7718.15100338951;7736.806579835324;7888.092869320101;8074.354051675734;9294.395864269072;12179.939100304797;12236.632901012983;12353.567625133077;12556.058295627681;10028.498575071071;10207.795844083224;10349.689509314732;11128.38793866345;11202.49588768491;9825.052484254553;10310.43292618913;10380.169586433218;10438.63464778729;10624.20318476102;10654.520546575268;10693.9465302673;10931.398773067558;11021.016217080682;11299.943500282447;7720.53676779395;7775.416843736855;7980.561069141253;7980.600969951363;8033.156518565466;10343.896561034293;10518.474076296001;10763.892361076289;10765.73085672833;11143.2199746017 19:13:44 INFO - PROCESS | 8640 | |3;mootools.html;1217.689489180259;1346.5085243885978;1377.5729523847608;1415.7805540141276;1663.680956491799;6507.51193660475;7042.929570704291;7104.396126329269;7384.593847338394;7384.704611815534;7428.814279643012;7510.66202020909;7511.812204694886;7513.985611942386;7527.435442341833;2102.8843413612285;2125.8405619578593;2130.7336582927132;2134.8398870084807;2135.4341099608614;2050.794920507945;2109.367189843041;2129.4569884679463;2132.040581738216;2134.2743467221144;2101.726775519188;2107.957840843182;2115.9471013224716;2121.7984291492285;2136.594047131048;2076.0761461149796;2078.7609424916177;2091.874487530753;2096.2139197800825;2099.6640537514077;2028.9391318260475;2068.803463670949;2073.0878413498012;2074.4917495213617;2090.4773806548365;7498.100227972678;7557.69769209231;7652.923470765277;7655.387568994523;7667.3099421052375;4272.081502476951;4420.491643461011;4420.602145806861;4438.467383913919;4470.75410852403;2723.128598848369;2837.2764944939113;2877.2806798300426;2892.0311695582004;2896.840673762942;942.236788201559;945.4847108325979;947.6683160893701;951.8952915179325;979.1774909076339;10009.099181073738;10052.195824334109;10075.496225188785;10102.595896164145;10144.94927525365;3915.257710318938;4157.958420415757;4187.5184353799705;4193.6645068394455;4290.678199135077;8466.492010479267;8801.91198088011;8824.073472285447;8839.204471597586;8842.646294148291;4588.609968152745;4624.167649822997;4625.4911959684405;4628.583427491542;4630.814767409333;3651.1967367179177;3768;4069.613386728256;4198.076423186894;4210.494740631083;3479.251960828434;3669.43123815809;3677.963220367762;3713.33160031197;3832.8083595820653;1164.2490593567102;1184.1178322150054;1186.7626474705094;1194.4684615346262;1202.2546021466746;738.7008261654039;757.4205732614554;777.7355699062346;778.8636988526985;813.7436707437139;4985.526374994442;4995.225740010304;5082.415522214918;5139.820106296262;5297.443768404262;401.0715194325128;404.22389013094926;408.9754614723067;411.3849794557156;415.991680166395;3349.648286929886;3475.3570589441033;3496.17839807645;3519.102628829632;3680.5583330000572;8900.955495222612;9052.456852588866;9079.45523268606;9111.863322050174;9116.042815504408;9057.365984381162;9062.275017998545;9062.592183351764;9069.138431848964;9111.179993800457;6932.272111428329;6986.895196572055;7032.578045317297;7046.718131274794;7059.505834591632;4837.959838634711;4878.878028049186;4933.97533012347;5002.849914502571;5199.584033277404;8242.340612750846;8470.322374209925;8537.87193192115;8542.82914341722;8656.22094011542;8239.917600823916;8459.196376344238;8481.57592120404;8491.06598274177;8522.403431759718;5506.834794956158;5767.740451679769;6128.387161284014;6164.630122192682;6184.938150618436;7011.8247043822275;7235.891461628185;7284.053073100675;7284.344409003215;7289.671964761705;6023.819285421444;6377.298497165215;6489.091527186103;6570.901436478361;6573.112629794917;6494.4804415645685;6499.935000649933;6515.934840651533;6519.185101862267;6530.314316996647;6029.427204415573;6184.6598437086395;6184.752609895734;6184.845378865564;6187.907181392193;4345.934810977901;4365.563443655609;4391.880070582109;4492.73043617384;4538.115067561926;4351.10802285537;4428.933565996577;4430.822767089409;4492.797824097989;4533.957189846288 19:13:44 INFO - PROCESS | 8640 | |4;prototype.html;287.2388171345933;289.4413781401895;296.12790332470877;301.42879243832925;301.6591251885369;4815.229563269878;4838.709677419349;4849.830255941043;4867.172580661288;4893.434101087653;4744.169770290194;4770.4275486941615;4802.879928001802;4807.831725889595;4829.396325459317;3789.6210378962023;3808.257389808988;3810.3712887373617;3813.836779782165;3848.9615103849023;3468.3756923753713;3793.336166170909;3795.240951809635;3798.3542797724317;3802.1065049713297;3665.303592317451;3672.5042119313953;3673.669369756721;3681.8711345102924;3685.2076803487244;3631.6018332941744;3643.1620727232885;3658.7987660678787;3660.5790334111653;3669.5229620149344;3053.4809082456036;3152.1331633800887;3153.1801731549963;3160.604924384452;3161.541576471399;4532.4334458192725;4642.79107440166;4643.419572553431;4712.175369310391;4729.929051064237;4260.339647354634;4271.829126834923;4273.658107351435;4275.978620106911;4279.422277992493;4740.127649578397;4768.570828625406;5007.749612519359;5060.696358218519;5066.544011038987;3274.96725032749;3513.6310687377713;3513.9648603513892;3520.929581408383;3527.8236088195486;5175.948240517584;5222.503862133091;5229.921551176735;5283.445238249967;5290.285811415448;3659.176685245852;3664.6518580734787;3665.706743460517;3670.871519496805;3672.2373260834947;3535.310614430213;3713.9442908356395;3730.962690373116;3735.458358537997;3739.0278527583023;4272.594103560157;4280.324797001874;4287.292596721506;4289.63538099265;4305.31115021595;5007.098722230034;5007.723030627167;5010.323606313101;5020.497950205024;5022.271770593244;1201.381288636353;1222.2971791219907;1242.4843689868603;1254.9184303020456;1260.3950103950156;800.9799755006171;802.9558374289353;817.0481389181656;826.9090400055989;829.8630725930275;3964.623360780721;3976.622220889011;3986.3223252047223;4013.0970531630733;4083.387491876183;4493.236149854532;4521.773911304422;4547.295169248771;4552.6797228803935;4574.4446888057555;3934.488516492838;3944.8224829882724;3962.2075584883137;3970.8014599269923;3977.463042489227;2414.2274472168738;2424.1030818597233;2539.362111438149;2744.1218809980614;2757.9172624821285;4732.313814496879;4830.203016502238;4876.097921884463;4900.779464924087;4906.865513501567;5169.689818610896;5275.525202731696;5299.470052994747;5305.65513241638;5325.174597937326;4908.907388345391;4920.163572192736;4934.432540257916;4946.653734238569;4946.727929963887;4951.3810773653295;5113.517080046745;5154.8969020620125;5201;5204.713740744295;5036.471170527042;5061.7469126544265;5083.822066227813;5086.338775959101;5099.3370861787735;4863.7324947128245;4873.658843880894;4895.632827537877;4900.411950565955;4911.140550403594;3493;3604.9459258110624;3632.5480300797385;3642.3625865472904;3647.8176091195865;5157.329547158845;5171.586273098218;5178.663386879841;5180.948190518197;5202.739863006759;4944.678595891256;4952.820758866087;4965.702057876539;5023.321851549994;5041.395032596112;4839.661223714306;4907.190313598359;4910.7544622768;4959.950400496094;4973.825916093064;4927.088488629615;4930.802767889244;4939.357883475269;4951.653384263067;4961.181405068123;5058.367704036996;5059.5952323814745;5063.670861393997;5066.898662026665;5067.290579318825;4682.274247491644;4930.235813448921;4951.084049450863;4955.281484184701;4971.577415919687 19:13:44 INFO - PROCESS | 8640 | |5;yui.html;654.1724718231437;681.6693903456822;689.6827459368693;735.3345222573573;774.9728759493419;13376.59870203893;14507.709845803103;14509.419623215084;14527.636809079766;14527.636809079779;12815.167014144074;13333.866661333408;14332.426702931896;14385.424583016693;14391.856081439182;759.8366351234483;777.0519965641907;790.0756115345031;790.2650535002446;790.3479629305817;629.965351905645;653.6045692356128;783.4280974888335;785.7092875636023;787.397640804782;795.2762985683;817.2522142239843;820.6061090676479;822.284612387224;822.461287856452;807.7374853172713;807.858624740668;808.296781799832;808.3735105293385;808.5270116981602;485.50478511918;498.0860121676728;593.3236110833653;593.4747748242836;593.8485686150048;12882.549110781172;13358.131721438076;13358.666033349147;13924.37340319678;13944.233067181302;13377.464901403931;13719.382627781773;13770.380332885044;14331.140131592034;14389.352479138464;10503.264771466;10654.254202205848;11046.171537134667;11324;11772.882271177265;3119.393512341146;3138.73320767735;3194.632617249023;3295.3574053059665;3299.6040475143136;60635.112039025575;61541.69229153825;62035.68982155105;62221;62336.37663623397;9967.40195588267;10128.34165779222;10136.442495662663;10148.543315550818;10400.791984160274;18788.812111878706;18911.52721181954;18916.243350265835;18929.148188331557;18952.715709264372;6678.165229346332;6738.797836064926;6789.15135608049;6908.5509441886115;6970.930290697028;3656.8902932912056;3672.8347224374966;3686.668199862025;3720.330340538729;3732.0669832541867;2914.0674984004913;3048.2074660587964;3049.0547930141283;3054.1906394805396;3056.9694303056685;527.741406710709;547.8466029511743;556.2990631803956;557.4230671255232;557.8438037349549;483.3957553058677;510.7088959293167;553.914143307788;571.9971400143056;574.6092656993285;7510.1738808731;7575.431842611826;7788.8052798679355;7994.960025199837;8026.117127116013;476.55918275594934;525.7818005527739;549.8240563019796;569.7236840132532;577.2178697864417;3664.5052917855746;3754.5494540655295;3757.887263382103;3764.6447278979545;3800.6199380062326;104434.47782761038;104844.47577762062;105617;106446.93553064525;107017.46491267494;89217;90955;91755;91760;95899.52050239705;61812.69093654593;67622.32377676161;72599.63700181466;79239;80668;7295;7357.448191385561;7695.615219238904;7870.645820937957;8118.959405202936;41722.374164388166;41863.7906810464;42456.99459589133;43395.13209735851;43838.34242486302;34898.64459637751;60692.69653651703;61399.386006139364;61556.69221653863;62365.37634623596;10949.671509854717;11027.724306892393;11187.496562654864;11214.83177752318;11637.127215459044;10895.836562451412;11162.776744465227;11166.944165279121;11771.293722376684;11884.524619015143;10474.895251047697;10985.83521247166;11430;11790.764184716087;11885.76228475443;9152.908470915205;9277.721668349961;9289.303302252223;9327.906720932704;9954.253430992849;9703.320767546204;10016.899831001889;10293.639722609672;10308.536115874953;10612.363258204532;8258.463199891989;8493.660253590035;8504.23461888433;8612.956935215283;8915.153060459246;8636.438631488933;9295.256379489489;9353.859692104488;9502.667406640734;9507.286953478379 19:13:44 INFO - PROCESS | 8640 | __end_tp_report 19:13:44 INFO - PROCESS | 8640 | __start_cc_report 19:13:44 INFO - PROCESS | 8640 | _x_x_mozilla_cycle_collect,941 19:13:44 INFO - PROCESS | 8640 | __end_cc_report 19:13:44 INFO - PROCESS | 8640 | __startTimestamp1474942424241__endTimestamp 19:13:44 INFO - PROCESS | 8640 | 19:13:44 INFO - PROCESS | 8640 | ------- Summary: start ------- 19:13:44 INFO - PROCESS | 8640 | Number of tests: 6 19:13:44 INFO - PROCESS | 8640 | 19:13:44 INFO - PROCESS | 8640 | [#0] dojo.html Cycles:165 Average:4613.05 Median:4713.08 stddev:474.55 (10.1%) stddev-sans-first:447.85 19:13:44 INFO - PROCESS | 8640 | Values: 2560.6 2583.2 2615.6 2621.9 2640.4 4538.8 4625.7 4680.4 4685.2 4685.5 4631.0 4634.4 4636.4 4640.1 4651.5 4227.8 4251.9 4282.2 4325.8 4357.8 4308.2 4311.7 4316.1 4391.8 4440.3 4290.4 4347.9 4354.2 4360.1 4409.8 4331.9 4466.9 4501.5 4503.9 4505.2 4152.7 4185.0 4287.0 4328.7 4332.5 4598.3 4607.9 4627.1 4650.8 4675.4 4901.8 4905.8 4906.0 4970.2 5031.0 4868.4 4952.6 5001.6 5009.5 5014.0 4579.9 4634.4 4663.7 4689.9 4695.0 5128.7 5131.9 5135.2 5140.7 5182.0 4747.9 4910.9 4932.9 4934.3 4997.9 4864.7 4920.7 4960.2 4964.5 5013.8 4931.9 4940.2 4942.1 4943.4 5000.3 4913.4 4926.2 4926.4 4926.9 4988.7 4091.3 4131.5 4136.1 4209.2 4246.9 3726.3 3726.9 3773.0 3773.3 3790.4 4322.5 4326.8 4327.6 4377.7 4380.8 4782.3 4846.7 4901.1 5030.5 5034.3 4266.5 4277.1 4277.3 4312.3 4322.8 4465.8 4466.7 4484.3 4518.1 4539.5 4559.1 4566.5 4698.0 4711.9 4717.1 4932.0 5004.1 5015.1 5016.8 5052.3 4737.1 4739.6 4749.9 4754.1 4807.9 4770.2 4959.2 4959.4 4960.3 5024.7 4877.7 4936.2 4995.0 5007.5 5071.8 4831.0 4831.3 4851.1 4853.6 4904.2 4857.0 4871.2 4874.5 4882.0 4937.7 4641.2 4697.1 4775.2 4836.2 4840.7 4939.6 4945.1 4949.9 4954.7 4991.8 4658.6 4713.1 4815.4 4900.6 4918.6 19:13:44 INFO - PROCESS | 8640 | 19:13:44 INFO - PROCESS | 8640 | [#1] ext.html Cycles:180 Average:43021.83 Median:192975.15 stddev:74407.61 (38.6%) stddev-sans-first:74548.02 19:13:44 INFO - PROCESS | 8640 | Values: 553.2 569.3 569.9 572.6 582.5 28771.3 36756.4 37986.1 38081.8 40400.6 40473.0 40814.6 40843.0 40889.8 40929.6 7629.3 7750.0 7773.8 7775.1 7783.2 7612.4 7683.8 7686.5 7698.8 7700.6 7674.5 7715.9 7717.6 7719.3 7720.4 7635.0 7680.2 7690.1 7692.8 7706.2 7672.7 7727.5 7740.5 7741.8 7745.4 38040.8 38341.4 38384.8 38388.8 38402.2 2990.9 2999.6 3002.8 3057.8 3109.6 26235.0 26450.9 26818.5 27342.5 27997.2 3340.1 3393.2 3412.9 3431.6 3444.8 245054.0 245511.0 245544.0 245592.0 246366.0 51028.7 51238.2 51337.2 51351.5 51368.7 32342.5 33050.7 33148.2 53987.5 54393.0 13613.3 13950.5 14033.7 14035.6 14070.4 9887.2 9893.6 9963.6 9965.6 9970.4 17442.5 17567.2 17644.5 17644.6 17717.5 6554.1 6640.9 6647.7 6769.8 6786.4 794.7 861.3 875.8 918.8 967.4 26363.5 27651.9 27711.7 28045.9 28266.2 771.7 892.3 910.2 921.2 968.7 14371.1 14611.6 14661.1 14892.6 14917.6 347605.0 349629.0 350579.0 350834.0 351330.0 46667.5 47022.9 47023.0 47054.0 47149.3 1077.0 1118.7 1127.8 1165.4 1178.2 26705.3 28242.9 28667.4 29142.0 29144.0 40166.6 40718.4 40788.6 40803.0 40822.2 240419.0 241599.0 241688.0 242607.0 242977.0 22001.2 22295.3 22620.9 22640.7 22681.9 40554.4 40651.4 40658.4 40791.0 42007.6 34330.8 34347.3 34374.8 34453.5 34484.0 34083.0 34228.7 34492.8 34514.8 34656.5 34567.8 34620.5 34914.8 35116.3 35858.6 28192.9 30156.2 30326.0 30536.8 30679.4 23661.0 23848.3 23902.6 24513.8 24574.8 19:13:44 INFO - PROCESS | 8640 | 19:13:44 INFO - PROCESS | 8640 | [#2] jquery.html Cycles:180 Average:22761.04 Median:21528.02 stddev:55540.04 (258.0%) stddev-sans-first:55670.35 19:13:44 INFO - PROCESS | 8640 | Values: 348.4 357.7 367.9 375.2 381.4 12389.8 16101.8 16557.9 16830.4 17925.2 16862.5 17049.8 17209.2 17209.6 17338.1 4935.9 4957.6 5105.7 5132.7 5141.5 3759.4 3948.6 5006.5 5114.5 5613.2 5799.7 5929.1 5937.9 5938.4 5938.8 5766.0 5906.1 5967.7 5996.6 5997.6 5282.0 5283.4 5290.4 5290.9 5291.2 20297.3 20661.2 20790.8 20873.6 21018.5 1802.7 2309.2 2341.2 2346.5 2422.6 12572.4 12674.4 12814.8 13033.4 13534.5 1679.3 1712.1 1721.3 1760.2 1761.8 64608.0 66268.7 66992.3 67454.7 69342.3 9374.6 9767.4 9782.0 10226.8 10291.3 13224.0 13368.5 13368.6 13399.9 13407.1 6928.9 7029.2 7111.6 7285.2 7312.6 6762.7 6789.2 6869.0 6915.9 7052.5 6035.8 6039.5 6040.2 6069.7 6194.8 1724.7 1740.4 1742.2 1755.3 1774.6 824.0 827.8 832.2 875.1 882.9 16592.0 16864.8 17406.1 17556.4 17784.8 823.2 890.7 891.0 898.0 905.3 9637.2 9949.8 10059.9 10243.6 10246.6 333692.0 334544.0 336399.0 336620.0 337605.0 64952.4 65585.7 68269.7 68713.7 70290.3 875.0 893.5 913.2 916.6 919.4 14201.9 14529.1 15171.2 15589.1 16001.8 38817.4 39107.4 39709.4 40113.7 40153.2 50267.2 50811.5 51229.5 52322.0 53095.5 7712.3 7718.2 7736.8 7888.1 8074.4 9294.4 12179.9 12236.6 12353.6 12556.1 10028.5 10207.8 10349.7 11128.4 11202.5 9825.1 10310.4 10380.2 10438.6 10624.2 10654.5 10693.9 10931.4 11021.0 11299.9 7720.5 7775.4 7980.6 7980.6 8033.2 10343.9 10518.5 10763.9 10765.7 11143.2 19:13:44 INFO - PROCESS | 8640 | 19:13:44 INFO - PROCESS | 8640 | [#3] mootools.html Cycles:180 Average:4908.00 Median:4858.42 stddev:2727.10 (56.1%) stddev-sans-first:2720.64 19:13:44 INFO - PROCESS | 8640 | Values: 1217.7 1346.5 1377.6 1415.8 1663.7 6507.5 7042.9 7104.4 7384.6 7384.7 7428.8 7510.7 7511.8 7514.0 7527.4 2102.9 2125.8 2130.7 2134.8 2135.4 2050.8 2109.4 2129.5 2132.0 2134.3 2101.7 2108.0 2115.9 2121.8 2136.6 2076.1 2078.8 2091.9 2096.2 2099.7 2028.9 2068.8 2073.1 2074.5 2090.5 7498.1 7557.7 7652.9 7655.4 7667.3 4272.1 4420.5 4420.6 4438.5 4470.8 2723.1 2837.3 2877.3 2892.0 2896.8 942.2 945.5 947.7 951.9 979.2 10009.1 10052.2 10075.5 10102.6 10144.9 3915.3 4158.0 4187.5 4193.7 4290.7 8466.5 8801.9 8824.1 8839.2 8842.6 4588.6 4624.2 4625.5 4628.6 4630.8 3651.2 3768.0 4069.6 4198.1 4210.5 3479.3 3669.4 3678.0 3713.3 3832.8 1164.2 1184.1 1186.8 1194.5 1202.3 738.7 757.4 777.7 778.9 813.7 4985.5 4995.2 5082.4 5139.8 5297.4 401.1 404.2 409.0 411.4 416.0 3349.6 3475.4 3496.2 3519.1 3680.6 8901.0 9052.5 9079.5 9111.9 9116.0 9057.4 9062.3 9062.6 9069.1 9111.2 6932.3 6986.9 7032.6 7046.7 7059.5 4838.0 4878.9 4934.0 5002.8 5199.6 8242.3 8470.3 8537.9 8542.8 8656.2 8239.9 8459.2 8481.6 8491.1 8522.4 5506.8 5767.7 6128.4 6164.6 6184.9 7011.8 7235.9 7284.1 7284.3 7289.7 6023.8 6377.3 6489.1 6570.9 6573.1 6494.5 6499.9 6515.9 6519.2 6530.3 6029.4 6184.7 6184.8 6184.8 6187.9 4345.9 4365.6 4391.9 4492.7 4538.1 4351.1 4428.9 4430.8 4492.8 4534.0 19:13:44 INFO - PROCESS | 8640 | 19:13:44 INFO - PROCESS | 8640 | [#4] prototype.html Cycles:180 Average:4112.01 Median:4731.12 stddev:1217.13 (25.7%) stddev-sans-first:1186.21 19:13:44 INFO - PROCESS | 8640 | Values: 287.2 289.4 296.1 301.4 301.7 4815.2 4838.7 4849.8 4867.2 4893.4 4744.2 4770.4 4802.9 4807.8 4829.4 3789.6 3808.3 3810.4 3813.8 3849.0 3468.4 3793.3 3795.2 3798.4 3802.1 3665.3 3672.5 3673.7 3681.9 3685.2 3631.6 3643.2 3658.8 3660.6 3669.5 3053.5 3152.1 3153.2 3160.6 3161.5 4532.4 4642.8 4643.4 4712.2 4729.9 4260.3 4271.8 4273.7 4276.0 4279.4 4740.1 4768.6 5007.7 5060.7 5066.5 3275.0 3513.6 3514.0 3520.9 3527.8 5175.9 5222.5 5229.9 5283.4 5290.3 3659.2 3664.7 3665.7 3670.9 3672.2 3535.3 3713.9 3731.0 3735.5 3739.0 4272.6 4280.3 4287.3 4289.6 4305.3 5007.1 5007.7 5010.3 5020.5 5022.3 1201.4 1222.3 1242.5 1254.9 1260.4 801.0 803.0 817.0 826.9 829.9 3964.6 3976.6 3986.3 4013.1 4083.4 4493.2 4521.8 4547.3 4552.7 4574.4 3934.5 3944.8 3962.2 3970.8 3977.5 2414.2 2424.1 2539.4 2744.1 2757.9 4732.3 4830.2 4876.1 4900.8 4906.9 5169.7 5275.5 5299.5 5305.7 5325.2 4908.9 4920.2 4934.4 4946.7 4946.7 4951.4 5113.5 5154.9 5201.0 5204.7 5036.5 5061.7 5083.8 5086.3 5099.3 4863.7 4873.7 4895.6 4900.4 4911.1 3493.0 3604.9 3632.5 3642.4 3647.8 5157.3 5171.6 5178.7 5180.9 5202.7 4944.7 4952.8 4965.7 5023.3 5041.4 4839.7 4907.2 4910.8 4960.0 4973.8 4927.1 4930.8 4939.4 4951.7 4961.2 5058.4 5059.6 5063.7 5066.9 5067.3 4682.3 4930.2 4951.1 4955.3 4971.6 19:13:44 INFO - PROCESS | 8640 | 19:13:44 INFO - PROCESS | 8640 | [#5] yui.html Cycles:180 Average:17763.79 Median:537.79 stddev:26300.39 (4890.4%) stddev-sans-first:26342.80 19:13:44 INFO - PROCESS | 8640 | Values: 654.2 681.7 689.7 735.3 775.0 13376.6 14507.7 14509.4 14527.6 14527.6 12815.2 13333.9 14332.4 14385.4 14391.9 759.8 777.1 790.1 790.3 790.3 630.0 653.6 783.4 785.7 787.4 795.3 817.3 820.6 822.3 822.5 807.7 807.9 808.3 808.4 808.5 485.5 498.1 593.3 593.5 593.8 12882.5 13358.1 13358.7 13924.4 13944.2 13377.5 13719.4 13770.4 14331.1 14389.4 10503.3 10654.3 11046.2 11324.0 11772.9 3119.4 3138.7 3194.6 3295.4 3299.6 60635.1 61541.7 62035.7 62221.0 62336.4 9967.4 10128.3 10136.4 10148.5 10400.8 18788.8 18911.5 18916.2 18929.1 18952.7 6678.2 6738.8 6789.2 6908.6 6970.9 3656.9 3672.8 3686.7 3720.3 3732.1 2914.1 3048.2 3049.1 3054.2 3057.0 527.7 547.8 556.3 557.4 557.8 483.4 510.7 553.9 572.0 574.6 7510.2 7575.4 7788.8 7995.0 8026.1 476.6 525.8 549.8 569.7 577.2 3664.5 3754.5 3757.9 3764.6 3800.6 104434.5 104844.5 105617.0 106446.9 107017.5 89217.0 90955.0 91755.0 91760.0 95899.5 61812.7 67622.3 72599.6 79239.0 80668.0 7295.0 7357.4 7695.6 7870.6 8119.0 41722.4 41863.8 42457.0 43395.1 43838.3 34898.6 60692.7 61399.4 61556.7 62365.4 10949.7 11027.7 11187.5 11214.8 11637.1 10895.8 11162.8 11166.9 11771.3 11884.5 10474.9 10985.8 11430.0 11790.8 11885.8 9152.9 9277.7 9289.3 9327.9 9954.3 9703.3 10016.9 10293.6 10308.5 10612.4 8258.5 8493.7 8504.2 8613.0 8915.2 8636.4 9295.3 9353.9 9502.7 9507.3 19:13:44 INFO - PROCESS | 8640 | -------- Summary: end -------- 19:13:44 INFO - PROCESS | 8640 | 19:13:45 INFO - TEST-INFO | 8640: exit 0 19:13:45 INFO - TEST-OK | dromaeo_css | took 1120476ms 19:13:45 INFO - TEST-START | kraken 19:13:45 INFO - operating with platform_type : linux_ 19:13:45 INFO - Initialising browser for kraken test... 19:13:45 INFO - TEST-INFO | started process 8941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCqt8vn/profile http://localhost:58848/getInfo.html) 19:13:49 INFO - PROCESS | 8941 | __metrics Screen width/height:1600/1200 19:13:49 INFO - PROCESS | 8941 | colorDepth:24 19:13:49 INFO - PROCESS | 8941 | Browser inner width/height: 1024/697 19:13:49 INFO - PROCESS | 8941 | __metrics 19:13:50 INFO - PROCESS | 8941 | 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" 19:13:50 INFO - PROCESS | 8941 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:13:50 INFO - PROCESS | 8941 | console.error: PushService: 19:13:50 INFO - PROCESS | 8941 | stateChangeProcessEnqueue: Error transitioning state 19:13:50 INFO - PROCESS | 8941 | UnknownError 19:13:51 INFO - TEST-INFO | 8941: exit 0 19:13:51 INFO - Browser initialized. 19:13:51 INFO - Running cycle 1/1 for kraken test... 19:13:51 INFO - TEST-INFO | started process 9023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCqt8vn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:14:03 INFO - PROCESS | 9023 | RSS: Main: 174637056 19:14:03 INFO - PROCESS | 9023 | 19:14:06 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58848/tests/kraken/driver.html?testName=audio-beat-detection) 19:14:07 INFO - PROCESS | 9023 | RSS: Main: 233758720 19:14:07 INFO - PROCESS | 9023 | 19:14:10 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58848/tests/kraken/driver.html?testName=audio-dft) 19:14:10 INFO - PROCESS | 9023 | RSS: Main: 218439680 19:14:10 INFO - PROCESS | 9023 | 19:14:13 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58848/tests/kraken/driver.html?testName=audio-fft) 19:14:14 INFO - PROCESS | 9023 | RSS: Main: 300138496 19:14:14 INFO - PROCESS | 9023 | 19:14:16 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58848/tests/kraken/driver.html?testName=audio-oscillator) 19:14:17 INFO - PROCESS | 9023 | RSS: Main: 210001920 19:14:17 INFO - PROCESS | 9023 | 19:14:19 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58848/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:14:20 INFO - PROCESS | 9023 | RSS: Main: 214372352 19:14:20 INFO - PROCESS | 9023 | 19:14:23 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58848/tests/kraken/driver.html?testName=imaging-darkroom) 19:14:24 INFO - PROCESS | 9023 | RSS: Main: 250040320 19:14:24 INFO - PROCESS | 9023 | 19:14:27 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58848/tests/kraken/driver.html?testName=imaging-desaturate) 19:14:28 INFO - PROCESS | 9023 | RSS: Main: 244846592 19:14:28 INFO - PROCESS | 9023 | 19:14:31 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58848/tests/kraken/driver.html?testName=json-parse-financial) 19:14:31 INFO - PROCESS | 9023 | RSS: Main: 247091200 19:14:31 INFO - PROCESS | 9023 | 19:14:33 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58848/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:14:33 INFO - PROCESS | 9023 | RSS: Main: 210927616 19:14:33 INFO - PROCESS | 9023 | 19:14:35 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58848/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:14:36 INFO - PROCESS | 9023 | RSS: Main: 217956352 19:14:36 INFO - PROCESS | 9023 | 19:14:38 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58848/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:14:39 INFO - PROCESS | 9023 | RSS: Main: 222617600 19:14:39 INFO - PROCESS | 9023 | 19:14:42 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:14:42 INFO - PROCESS | 9023 | RSS: Main: 223682560 19:14:42 INFO - PROCESS | 9023 | 19:14:45 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:14:46 INFO - PROCESS | 9023 | RSS: Main: 221515776 19:14:46 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | Cycle 1(1): loaded http://localhost:58848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58848/tests/kraken/driver.html?testName=ai-astar) 19:14:48 INFO - PROCESS | 9023 | RSS: Main: 272318464 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | __start_tp_report 19:14:48 INFO - PROCESS | 9023 | _x_x_mozilla_page_load 19:14:48 INFO - PROCESS | 9023 | _x_x_mozilla_page_load_details 19:14:48 INFO - PROCESS | 9023 | |i|pagename|runs| 19:14:48 INFO - PROCESS | 9023 | |0;ai-astar;113;116;115;115;116;117;114;115;113;115 19:14:48 INFO - PROCESS | 9023 | |1;audio-beat-detection;149;123;125;175;122;123;129;121;158;123 19:14:48 INFO - PROCESS | 9023 | |2;audio-dft;160;160;165;161;162;162;161;162;161;160 19:14:48 INFO - PROCESS | 9023 | |3;audio-fft;76;77;77;117;79;76;76;77;96;86 19:14:48 INFO - PROCESS | 9023 | |4;audio-oscillator;84;84;128;85;84;86;104;84;85;128 19:14:48 INFO - PROCESS | 9023 | |5;imaging-gaussian-blur;117;117;116;117;118;117;117;117;117;118 19:14:48 INFO - PROCESS | 9023 | |6;imaging-darkroom;147;147;147;147;148;148;148;147;147;148 19:14:48 INFO - PROCESS | 9023 | |7;imaging-desaturate;96;95;95;95;96;95;95;95;95;95 19:14:48 INFO - PROCESS | 9023 | |8;json-parse-financial;65;62;63;63;65;63;71;64;64;64 19:14:48 INFO - PROCESS | 9023 | |9;json-stringify-tinderbox;65;66;66;67;67;67;66;66;66;66 19:14:48 INFO - PROCESS | 9023 | |10;stanford-crypto-aes;82;81;81;82;83;82;84;82;88;85 19:14:48 INFO - PROCESS | 9023 | |11;stanford-crypto-ccm;144;144;133;133;134;133;134;133;167;144 19:14:48 INFO - PROCESS | 9023 | |12;stanford-crypto-pbkdf2;179;183;180;177;174;180;176;176;179;176 19:14:48 INFO - PROCESS | 9023 | |13;stanford-crypto-sha256-iterative;70;70;70;73;74;69;70;69;68;67 19:14:48 INFO - PROCESS | 9023 | __end_tp_report 19:14:48 INFO - PROCESS | 9023 | __start_cc_report 19:14:48 INFO - PROCESS | 9023 | _x_x_mozilla_cycle_collect,1927 19:14:48 INFO - PROCESS | 9023 | __end_cc_report 19:14:48 INFO - PROCESS | 9023 | __startTimestamp1474942488457__endTimestamp 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | ------- Summary: start ------- 19:14:48 INFO - PROCESS | 9023 | Number of tests: 14 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:1.29 (1.1%) stddev-sans-first:1.17 19:14:48 INFO - PROCESS | 9023 | Values: 113.0 116.0 115.0 115.0 116.0 117.0 114.0 115.0 113.0 115.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:127.00 stddev:19.03 (15.0%) stddev-sans-first:19.47 19:14:48 INFO - PROCESS | 9023 | Values: 149.0 123.0 125.0 175.0 122.0 123.0 129.0 121.0 158.0 123.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.51 (0.9%) stddev-sans-first:1.51 19:14:48 INFO - PROCESS | 9023 | Values: 160.0 160.0 165.0 161.0 162.0 162.0 161.0 162.0 161.0 160.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#3] audio-fft Cycles:10 Average:83.70 Median:77.00 stddev:13.33 (17.3%) stddev-sans-first:13.85 19:14:48 INFO - PROCESS | 9023 | Values: 76.0 77.0 77.0 117.0 79.0 76.0 76.0 77.0 96.0 86.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:84.00 stddev:18.33 (21.8%) stddev-sans-first:18.99 19:14:48 INFO - PROCESS | 9023 | Values: 84.0 84.0 128.0 85.0 84.0 86.0 104.0 84.0 85.0 128.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 19:14:48 INFO - PROCESS | 9023 | Values: 117.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:14:48 INFO - PROCESS | 9023 | Values: 147.0 147.0 147.0 147.0 148.0 148.0 148.0 147.0 147.0 148.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 19:14:48 INFO - PROCESS | 9023 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.00 stddev:2.50 (3.9%) stddev-sans-first:2.65 19:14:48 INFO - PROCESS | 9023 | Values: 65.0 62.0 63.0 63.0 65.0 63.0 71.0 64.0 64.0 64.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 19:14:48 INFO - PROCESS | 9023 | Values: 65.0 66.0 66.0 67.0 67.0 67.0 66.0 66.0 66.0 66.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:82.50 stddev:2.16 (2.6%) stddev-sans-first:2.26 19:14:48 INFO - PROCESS | 9023 | Values: 82.0 81.0 81.0 82.0 83.0 82.0 84.0 82.0 88.0 85.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:139.00 stddev:10.77 (7.8%) stddev-sans-first:11.33 19:14:48 INFO - PROCESS | 9023 | Values: 144.0 144.0 133.0 133.0 134.0 133.0 134.0 133.0 167.0 144.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:179.00 stddev:2.67 (1.5%) stddev-sans-first:2.80 19:14:48 INFO - PROCESS | 9023 | Values: 179.0 183.0 180.0 177.0 174.0 180.0 176.0 176.0 179.0 176.0 19:14:48 INFO - PROCESS | 9023 | 19:14:48 INFO - PROCESS | 9023 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:2.11 (3.0%) stddev-sans-first:2.24 19:14:48 INFO - PROCESS | 9023 | Values: 70.0 70.0 70.0 73.0 74.0 69.0 70.0 69.0 68.0 67.0 19:14:48 INFO - PROCESS | 9023 | -------- Summary: end -------- 19:14:48 INFO - PROCESS | 9023 | 19:14:49 INFO - TEST-INFO | 9023: exit 0 19:14:49 INFO - TEST-OK | kraken | took 64715ms 19:14:49 INFO - SUITE-END | took 1185s 19:14:50 INFO - Completed test suite (00:19:45) 19:14:50 INFO - javascript benchmark 19:14:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2560.5647040003196, 2583.1862963166614, 2615.6338112664225, 2621.92134235973, 2640.353113487196, 4538.841140560081, 4625.745583992879, 4680.391549098613, 4685.226937555303, 4685.508021657728, 4631.004334068175, 4634.443866735996, 4636.397268355117, 4640.09518143962, 4651.5348465153465, 4227.788610569474, 4251.8724438266745, 4282.22919874424, 4325.848595299165, 4357.847475338363, 4308.2029824482415, 4311.741295522263, 4316.136772645467, 4391.802368893392, 4440.267355886275, 4290.356446533014, 4347.891302717441, 4354.172707185625, 4360.149770794696, 4409.823607055714, 4331.870043898688, 4466.932996005063, 4501.527339629324, 4503.864884053483, 4505.211587972091, 4152.667786577066, 4184.958150418487, 4286.992556749162, 4328.7402755834755, 4332.458442694663, 4598.310253461974, 4607.884802879921, 4627.1439783640135, 4650.813967441299, 4675.392199014141, 4901.779419926112, 4905.754712264373, 4905.975470122627, 4970.229614409773, 5031.044101620717, 4868.415790105175, 4952.579030782352, 5001.649884508086, 5009.474005229471, 5013.9972005598665, 4579.931301030487, 4634.420697412824, 4663.650226233046, 4689.882752931136, 4695.037517308943, 5128.743562821844, 5131.87170320745, 5135.178371460623, 5140.691558506427, 5182.0413223553005, 4747.8575642730775, 4910.90178196434, 4932.8766780830765, 4934.3338649282605, 4997.875053123628, 4864.70811751289, 4920.6801557898625, 4960.181570040975, 4964.503549645006, 5013.824516141991, 4931.926021109686, 4940.209566469348, 4942.135126352874, 4943.431505376856, 5000.349954505891, 4913.385826771653, 4926.162552366106, 4926.433460152129, 4926.8768280793265, 4988.72562009093, 4091.263572556909, 4131.5248746393945, 4136.110736191733, 4209.200251952119, 4246.915061698749, 3726.347889119393, 3726.925461490809, 3772.962270377261, 3773.2830762155104, 3790.431435284674, 4322.524522302544, 4326.848560300375, 4327.588879056485, 4377.693561450732, 4380.846670366522, 4782.282657601388, 4846.660733748674, 4901.142300097468, 5030.496950305013, 5034.320366750442, 4266.530681625019, 4277.123189746095, 4277.337012763027, 4312.266914624522, 4322.783860806947, 4465.799039043251, 4466.665000124939, 4484.260097083945, 4518.051209246029, 4539.523350048197, 4559.133764584718, 4566.54334566554, 4697.976510117427, 4711.939813541926, 4717.127331443694, 4931.9753401232765, 5004.1492946198505, 5015.122353588181, 5016.849494515171, 5052.343195384577, 4737.123632128068, 4739.573438390561, 4749.881252968704, 4754.120487709784, 4807.927881081717, 4770.165221086366, 4959.231319145538, 4959.355283813081, 4960.280759289955, 5024.6985180887805, 4877.731724755173, 4936.234883593049, 4995.0, 5007.524285192901, 5071.822486212965, 4831.0, 4831.299461578122, 4851.078295123915, 4853.587445067209, 4904.239842824368, 4857.0, 4871.244957031666, 4874.53691899269, 4881.974785294986, 4937.679050861682, 4641.164590373765, 4697.107549565571, 4775.21209000511, 4836.153673107263, 4840.685355451885, 4939.629527785359, 4945.1346014448045, 4949.901001979868, 4954.677945933647, 4991.775370108427, 4658.627309815139, 4713.08094921487, 4815.446223684181, 4900.558949694545, 4918.631102667243], "value": 4583.201163944711, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.1757681055228, 569.3196630027116, 569.9287589051369, 572.5963195946855, 582.4786815799856, 28771.280717982034, 36756.44865327019, 37986.05034874129, 38081.80959095204, 40400.59599404005, 40473.0, 40814.59185408145, 40843.0, 40889.795551022275, 40929.59070409295, 7629.313361797451, 7750.031246094239, 7773.8056548586455, 7775.105862825791, 7783.182765809594, 7612.352949999229, 7683.846323073535, 7686.538807671557, 7698.769036928901, 7700.614969251515, 7674.501157424749, 7715.922840771605, 7717.575533345664, 7719.305262526372, 7720.382369410434, 7635.0, 7680.155182929873, 7690.115636701795, 7692.846143077107, 7706.152323244439, 7672.73145439907, 7727.49771264866, 7740.458167928247, 7741.8451630967065, 7745.419093568005, 38040.80979595112, 38341.42487862684, 38384.80807595972, 38388.808055959824, 38402.23195536074, 2990.8953186638364, 2999.565063065865, 3002.8498575071376, 3057.8318192499405, 3109.6112985876766, 26235.0, 26450.86774566134, 26818.463630727278, 27342.453150937068, 27997.160085197476, 3340.1148695595684, 3393.2025973896116, 3412.8805491807666, 3431.55389799327, 3444.810535420551, 245054.0, 245511.0, 245544.0, 245592.0, 246366.0, 51028.74485627548, 51238.23142652863, 51337.229941550904, 51351.486485135414, 51368.74315628398, 32342.514862277083, 33050.66949330524, 33148.1712957178, 53987.46012539824, 54393.0, 13613.251271179983, 13950.511732089328, 14033.71932561343, 14035.578932632037, 14070.366833492313, 9887.159591434809, 9893.604255829687, 9963.551640176209, 9965.601375944882, 9970.351927124713, 17442.47672569825, 17567.20947557363, 17644.470665880042, 17644.558886027695, 17717.519547263393, 6554.14796076507, 6640.900386494206, 6647.734090636321, 6769.830754231085, 6786.355296246848, 794.6821271491334, 861.2722249698994, 875.7898104454885, 918.8437965545739, 967.3567077893263, 26363.472730545283, 27651.86174069117, 27711.72288277132, 28045.859770701423, 28266.15201543957, 771.7028943856656, 892.3441270666056, 910.2444970674325, 921.1985572551923, 968.7239136846106, 14371.13773173592, 14611.561653150422, 14661.120332780067, 14892.62768430798, 14917.552473425814, 347605.0, 349629.0, 350579.0, 350834.0, 351330.0, 46667.533324667, 47022.94655801589, 47023.0, 47054.0, 47149.292760608616, 1076.983845242322, 1118.7147277444199, 1127.8421021057059, 1165.4464129538571, 1178.2400351773058, 26705.33236669099, 28242.85878570594, 28667.426651466438, 29142.0, 29144.0, 40166.59833401746, 40718.38922416225, 40788.59211407848, 40803.0, 40822.1835563293, 240419.0, 241599.0, 241688.0, 242607.0, 242977.0, 22001.22995695143, 22295.331140065824, 22620.886895565418, 22640.73592640723, 22681.88659056694, 40554.39168412417, 40651.390229147175, 40658.39012414757, 40791.0, 42007.57992420159, 34330.82834585811, 34347.313053739286, 34374.82812585921, 34453.483197752554, 34484.0, 34083.0, 34228.657713422544, 34492.82753586216, 34514.82742586271, 34656.48015279722, 34567.827160864035, 34620.48069279013, 34914.82542587271, 35116.29767404586, 35858.64141358553, 28192.85903570551, 30156.24609384783, 30325.965940578666, 30536.84731576328, 30679.386412272077, 23661.0, 23848.284551463483, 23902.641460378458, 24513.754862451147, 24574.754252457962], "value": 16660.82062281765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.3642352706312, 357.6548630571498, 367.90986208378945, 375.1764876096967, 381.3764495050593, 12389.814152787703, 16101.758473622891, 16557.917210413932, 16830.40111189435, 17925.193366298514, 16862.494125176232, 17049.82950170498, 17209.225584848682, 17209.56976075599, 17338.133093345346, 4935.876603084916, 4957.628177886655, 5105.744712764347, 5132.692038477703, 5141.485851414866, 3759.398496240602, 3948.624880636335, 5006.499350065001, 5114.514121158484, 5613.214150019001, 5799.65202087874, 5929.140274660172, 5937.85155371117, 5938.435848594377, 5938.792142275021, 5765.999999999979, 5906.084556893688, 5967.7016149192805, 5996.610220335664, 5997.640141591519, 5281.973590132063, 5283.445238250005, 5290.418054014055, 5290.894182116374, 5291.1534154535475, 20297.289594864258, 20661.17355305786, 20790.792092079188, 20873.582528349347, 21018.474538136517, 1802.7025540785755, 2309.226409152936, 2341.1922886604093, 2346.5189636124555, 2422.6123820188686, 12572.4342404592, 12674.36628168588, 12814.80777788334, 13033.413496392684, 13534.526291579847, 1679.26112510495, 1712.1353716373276, 1721.2684609041107, 1760.1639221369876, 1761.8238176182278, 64608.0, 66268.66865665738, 66992.3300766991, 67454.66272668654, 69342.30657693409, 9374.625014999323, 9767.365121267096, 9781.951090244645, 10226.846597301046, 10291.33106348085, 13224.0, 13368.532101376406, 13368.598942031755, 13399.866001339862, 13407.128536645281, 6928.861422771516, 7029.22678505364, 7111.573305601681, 7285.198628150899, 7312.634368281565, 6762.69567869447, 6789.15135608049, 6868.965655171693, 6915.89626155608, 7052.541584796972, 6035.758569657252, 6039.516838652898, 6040.214772079602, 6069.726862291208, 6194.752209911643, 1724.6809340272089, 1740.4256595323513, 1742.1968262847893, 1755.2803350626182, 1774.6184570317444, 823.9835203295901, 827.8137419080779, 832.1636755061124, 875.1423604867266, 882.9072947340437, 16592.0, 16864.83135168657, 17406.129693515275, 17556.385526506765, 17784.822151778575, 823.2302796884932, 890.7372325163963, 890.973270801877, 898.0435835834814, 905.3029167541089, 9637.22902167825, 9949.751256218653, 10059.899401005896, 10243.590256389662, 10246.614966461391, 333692.0, 334544.0, 336399.0, 336620.0, 337605.0, 64952.35047649557, 65585.67207163933, 68269.65865170742, 68713.65643171752, 70290.2970970294, 874.9650013999496, 893.4594570284884, 913.1553313185277, 916.637928018429, 919.384012711485, 14201.928990354982, 14529.094181163598, 15171.241437927838, 15589.142597157264, 16001.759094066332, 38817.417738734504, 39107.413388798625, 39709.40435893406, 40113.734034259476, 40153.1969360617, 50267.24599131089, 50811.491885082156, 51229.48770512396, 52322.0, 53095.46904530905, 7712.305892469704, 7718.15100338951, 7736.806579835324, 7888.092869320101, 8074.354051675734, 9294.395864269072, 12179.939100304797, 12236.632901012983, 12353.567625133077, 12556.058295627681, 10028.498575071071, 10207.795844083224, 10349.689509314732, 11128.38793866345, 11202.49588768491, 9825.052484254553, 10310.43292618913, 10380.169586433218, 10438.63464778729, 10624.20318476102, 10654.520546575268, 10693.9465302673, 10931.398773067558, 11021.016217080682, 11299.943500282447, 7720.53676779395, 7775.416843736855, 7980.561069141253, 7980.600969951363, 8033.156518565466, 10343.896561034293, 10518.474076296001, 10763.892361076289, 10765.73085672833, 11143.2199746017], "value": 8362.007656172773, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.689489180259, 1346.5085243885978, 1377.5729523847608, 1415.7805540141276, 1663.680956491799, 6507.51193660475, 7042.929570704291, 7104.396126329269, 7384.593847338394, 7384.704611815534, 7428.814279643012, 7510.66202020909, 7511.812204694886, 7513.985611942386, 7527.435442341833, 2102.8843413612285, 2125.8405619578593, 2130.7336582927132, 2134.8398870084807, 2135.4341099608614, 2050.794920507945, 2109.367189843041, 2129.4569884679463, 2132.040581738216, 2134.2743467221144, 2101.726775519188, 2107.957840843182, 2115.9471013224716, 2121.7984291492285, 2136.594047131048, 2076.0761461149796, 2078.7609424916177, 2091.874487530753, 2096.2139197800825, 2099.6640537514077, 2028.9391318260475, 2068.803463670949, 2073.0878413498012, 2074.4917495213617, 2090.4773806548365, 7498.100227972678, 7557.69769209231, 7652.923470765277, 7655.387568994523, 7667.3099421052375, 4272.081502476951, 4420.491643461011, 4420.602145806861, 4438.467383913919, 4470.75410852403, 2723.128598848369, 2837.2764944939113, 2877.2806798300426, 2892.0311695582004, 2896.840673762942, 942.236788201559, 945.4847108325979, 947.6683160893701, 951.8952915179325, 979.1774909076339, 10009.099181073738, 10052.195824334109, 10075.496225188785, 10102.595896164145, 10144.94927525365, 3915.257710318938, 4157.958420415757, 4187.5184353799705, 4193.6645068394455, 4290.678199135077, 8466.492010479267, 8801.91198088011, 8824.073472285447, 8839.204471597586, 8842.646294148291, 4588.609968152745, 4624.167649822997, 4625.4911959684405, 4628.583427491542, 4630.814767409333, 3651.1967367179177, 3768.0, 4069.613386728256, 4198.076423186894, 4210.494740631083, 3479.251960828434, 3669.43123815809, 3677.963220367762, 3713.33160031197, 3832.8083595820653, 1164.2490593567102, 1184.1178322150054, 1186.7626474705094, 1194.4684615346262, 1202.2546021466746, 738.7008261654039, 757.4205732614554, 777.7355699062346, 778.8636988526985, 813.7436707437139, 4985.526374994442, 4995.225740010304, 5082.415522214918, 5139.820106296262, 5297.443768404262, 401.0715194325128, 404.22389013094926, 408.9754614723067, 411.3849794557156, 415.991680166395, 3349.648286929886, 3475.3570589441033, 3496.17839807645, 3519.102628829632, 3680.5583330000572, 8900.955495222612, 9052.456852588866, 9079.45523268606, 9111.863322050174, 9116.042815504408, 9057.365984381162, 9062.275017998545, 9062.592183351764, 9069.138431848964, 9111.179993800457, 6932.272111428329, 6986.895196572055, 7032.578045317297, 7046.718131274794, 7059.505834591632, 4837.959838634711, 4878.878028049186, 4933.97533012347, 5002.849914502571, 5199.584033277404, 8242.340612750846, 8470.322374209925, 8537.87193192115, 8542.82914341722, 8656.22094011542, 8239.917600823916, 8459.196376344238, 8481.57592120404, 8491.06598274177, 8522.403431759718, 5506.834794956158, 5767.740451679769, 6128.387161284014, 6164.630122192682, 6184.938150618436, 7011.8247043822275, 7235.891461628185, 7284.053073100675, 7284.344409003215, 7289.671964761705, 6023.819285421444, 6377.298497165215, 6489.091527186103, 6570.901436478361, 6573.112629794917, 6494.4804415645685, 6499.935000649933, 6515.934840651533, 6519.185101862267, 6530.314316996647, 6029.427204415573, 6184.6598437086395, 6184.752609895734, 6184.845378865564, 6187.907181392193, 4345.934810977901, 4365.563443655609, 4391.880070582109, 4492.73043617384, 4538.115067561926, 4351.10802285537, 4428.933565996577, 4430.822767089409, 4492.797824097989, 4533.957189846288], "value": 3908.8241600843003, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.2388171345933, 289.4413781401895, 296.12790332470877, 301.42879243832925, 301.6591251885369, 4815.229563269878, 4838.709677419349, 4849.830255941043, 4867.172580661288, 4893.434101087653, 4744.169770290194, 4770.4275486941615, 4802.879928001802, 4807.831725889595, 4829.396325459317, 3789.6210378962023, 3808.257389808988, 3810.3712887373617, 3813.836779782165, 3848.9615103849023, 3468.3756923753713, 3793.336166170909, 3795.240951809635, 3798.3542797724317, 3802.1065049713297, 3665.303592317451, 3672.5042119313953, 3673.669369756721, 3681.8711345102924, 3685.2076803487244, 3631.6018332941744, 3643.1620727232885, 3658.7987660678787, 3660.5790334111653, 3669.5229620149344, 3053.4809082456036, 3152.1331633800887, 3153.1801731549963, 3160.604924384452, 3161.541576471399, 4532.4334458192725, 4642.79107440166, 4643.419572553431, 4712.175369310391, 4729.929051064237, 4260.339647354634, 4271.829126834923, 4273.658107351435, 4275.978620106911, 4279.422277992493, 4740.127649578397, 4768.570828625406, 5007.749612519359, 5060.696358218519, 5066.544011038987, 3274.96725032749, 3513.6310687377713, 3513.9648603513892, 3520.929581408383, 3527.8236088195486, 5175.948240517584, 5222.503862133091, 5229.921551176735, 5283.445238249967, 5290.285811415448, 3659.176685245852, 3664.6518580734787, 3665.706743460517, 3670.871519496805, 3672.2373260834947, 3535.310614430213, 3713.9442908356395, 3730.962690373116, 3735.458358537997, 3739.0278527583023, 4272.594103560157, 4280.324797001874, 4287.292596721506, 4289.63538099265, 4305.31115021595, 5007.098722230034, 5007.723030627167, 5010.323606313101, 5020.497950205024, 5022.271770593244, 1201.381288636353, 1222.2971791219907, 1242.4843689868603, 1254.9184303020456, 1260.3950103950156, 800.9799755006171, 802.9558374289353, 817.0481389181656, 826.9090400055989, 829.8630725930275, 3964.623360780721, 3976.622220889011, 3986.3223252047223, 4013.0970531630733, 4083.387491876183, 4493.236149854532, 4521.773911304422, 4547.295169248771, 4552.6797228803935, 4574.4446888057555, 3934.488516492838, 3944.8224829882724, 3962.2075584883137, 3970.8014599269923, 3977.463042489227, 2414.2274472168738, 2424.1030818597233, 2539.362111438149, 2744.1218809980614, 2757.9172624821285, 4732.313814496879, 4830.203016502238, 4876.097921884463, 4900.779464924087, 4906.865513501567, 5169.689818610896, 5275.525202731696, 5299.470052994747, 5305.65513241638, 5325.174597937326, 4908.907388345391, 4920.163572192736, 4934.432540257916, 4946.653734238569, 4946.727929963887, 4951.3810773653295, 5113.517080046745, 5154.8969020620125, 5201.0, 5204.713740744295, 5036.471170527042, 5061.7469126544265, 5083.822066227813, 5086.338775959101, 5099.3370861787735, 4863.7324947128245, 4873.658843880894, 4895.632827537877, 4900.411950565955, 4911.140550403594, 3493.0, 3604.9459258110624, 3632.5480300797385, 3642.3625865472904, 3647.8176091195865, 5157.329547158845, 5171.586273098218, 5178.663386879841, 5180.948190518197, 5202.739863006759, 4944.678595891256, 4952.820758866087, 4965.702057876539, 5023.321851549994, 5041.395032596112, 4839.661223714306, 4907.190313598359, 4910.7544622768, 4959.950400496094, 4973.825916093064, 4927.088488629615, 4930.802767889244, 4939.357883475269, 4951.653384263067, 4961.181405068123, 5058.367704036996, 5059.5952323814745, 5063.670861393997, 5066.898662026665, 5067.290579318825, 4682.274247491644, 4930.235813448921, 4951.084049450863, 4955.281484184701, 4971.577415919687], "value": 3723.799488878354, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.1724718231437, 681.6693903456822, 689.6827459368693, 735.3345222573573, 774.9728759493419, 13376.59870203893, 14507.709845803103, 14509.419623215084, 14527.636809079766, 14527.636809079779, 12815.167014144074, 13333.866661333408, 14332.426702931896, 14385.424583016693, 14391.856081439182, 759.8366351234483, 777.0519965641907, 790.0756115345031, 790.2650535002446, 790.3479629305817, 629.965351905645, 653.6045692356128, 783.4280974888335, 785.7092875636023, 787.397640804782, 795.2762985683, 817.2522142239843, 820.6061090676479, 822.284612387224, 822.461287856452, 807.7374853172713, 807.858624740668, 808.296781799832, 808.3735105293385, 808.5270116981602, 485.50478511918, 498.0860121676728, 593.3236110833653, 593.4747748242836, 593.8485686150048, 12882.549110781172, 13358.131721438076, 13358.666033349147, 13924.37340319678, 13944.233067181302, 13377.464901403931, 13719.382627781773, 13770.380332885044, 14331.140131592034, 14389.352479138464, 10503.264771466, 10654.254202205848, 11046.171537134667, 11324.0, 11772.882271177265, 3119.393512341146, 3138.73320767735, 3194.632617249023, 3295.3574053059665, 3299.6040475143136, 60635.112039025575, 61541.69229153825, 62035.68982155105, 62221.0, 62336.37663623397, 9967.40195588267, 10128.34165779222, 10136.442495662663, 10148.543315550818, 10400.791984160274, 18788.812111878706, 18911.52721181954, 18916.243350265835, 18929.148188331557, 18952.715709264372, 6678.165229346332, 6738.797836064926, 6789.15135608049, 6908.5509441886115, 6970.930290697028, 3656.8902932912056, 3672.8347224374966, 3686.668199862025, 3720.330340538729, 3732.0669832541867, 2914.0674984004913, 3048.2074660587964, 3049.0547930141283, 3054.1906394805396, 3056.9694303056685, 527.741406710709, 547.8466029511743, 556.2990631803956, 557.4230671255232, 557.8438037349549, 483.3957553058677, 510.7088959293167, 553.914143307788, 571.9971400143056, 574.6092656993285, 7510.1738808731, 7575.431842611826, 7788.8052798679355, 7994.960025199837, 8026.117127116013, 476.55918275594934, 525.7818005527739, 549.8240563019796, 569.7236840132532, 577.2178697864417, 3664.5052917855746, 3754.5494540655295, 3757.887263382103, 3764.6447278979545, 3800.6199380062326, 104434.47782761038, 104844.47577762062, 105617.0, 106446.93553064525, 107017.46491267494, 89217.0, 90955.0, 91755.0, 91760.0, 95899.52050239705, 61812.69093654593, 67622.32377676161, 72599.63700181466, 79239.0, 80668.0, 7295.0, 7357.448191385561, 7695.615219238904, 7870.645820937957, 8118.959405202936, 41722.374164388166, 41863.7906810464, 42456.99459589133, 43395.13209735851, 43838.34242486302, 34898.64459637751, 60692.69653651703, 61399.386006139364, 61556.69221653863, 62365.37634623596, 10949.671509854717, 11027.724306892393, 11187.496562654864, 11214.83177752318, 11637.127215459044, 10895.836562451412, 11162.776744465227, 11166.944165279121, 11771.293722376684, 11884.524619015143, 10474.895251047697, 10985.83521247166, 11430.0, 11790.764184716087, 11885.76228475443, 9152.908470915205, 9277.721668349961, 9289.303302252223, 9327.906720932704, 9954.253430992849, 9703.320767546204, 10016.899831001889, 10293.639722609672, 10308.536115874953, 10612.363258204532, 8258.463199891989, 8493.660253590035, 8504.23461888433, 8612.956935215283, 8915.153060459246, 8636.438631488933, 9295.256379489489, 9353.859692104488, 9502.667406640734, 9507.286953478379], "value": 6417.742207399422, "unit": "score"}], "name": "dromaeo_css", "value": 6250.867701210059, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 115.0, 115.0, 116.0, 117.0, 114.0, 115.0, 113.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 125.0, 175.0, 122.0, 123.0, 129.0, 121.0, 158.0, 123.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 165.0, 161.0, 162.0, 162.0, 161.0, 162.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 117.0, 79.0, 76.0, 76.0, 77.0, 96.0, 86.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 128.0, 85.0, 84.0, 86.0, 104.0, 84.0, 85.0, 128.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 63.0, 65.0, 63.0, 71.0, 64.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 82.0, 83.0, 82.0, 84.0, 82.0, 88.0, 85.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 133.0, 133.0, 134.0, 133.0, 134.0, 133.0, 167.0, 144.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 183.0, 180.0, 177.0, 174.0, 180.0, 176.0, 176.0, 179.0, 176.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 73.0, 74.0, 69.0, 70.0, 69.0, 68.0, 67.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1551.2, "alertThreshold": 2.0}]} 19:14:50 INFO - Return code: 0 19:14:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:14:50 INFO - # TBPL SUCCESS # 19:14:50 INFO - Running post-action listener: _resource_record_post_action 19:14:50 INFO - [mozharness: 2016-09-27 02:14:50.245556Z] Finished run-tests step (success) 19:14:50 INFO - Running post-run listener: _resource_record_post_run 19:14:50 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 403443712; Read time: 308; Write time: 272624 19:14:50 INFO - TinderboxPrint: CPU usage
13.0% 19:14:50 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 308 19:14:50 INFO - TinderboxPrint: I/O write bytes / time
403,443,712 / 272,624 19:14:50 INFO - TinderboxPrint: CPU idle
8,340.9 (87.0%) 19:14:50 INFO - TinderboxPrint: CPU user
1,202.0 (12.5%) 19:14:50 INFO - TinderboxPrint: Swap in / out
0 / 0 19:14:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110477312; Read time: 208; Write time: 65104 19:14:50 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292446208; Read time: 100; Write time: 207488 19:14:50 INFO - Running post-run listener: _upload_blobber_files 19:14:50 INFO - Blob upload gear active. 19:14:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:14:50 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 19:14:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:14:51 INFO - (blobuploader) - INFO - Open directory for files ... 19:14:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:14:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:14:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:14:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:52 INFO - (blobuploader) - INFO - Done attempting. 19:14:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:14:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:14:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:14:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:53 INFO - (blobuploader) - INFO - Done attempting. 19:14:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:14:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:14:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:14:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:57 INFO - (blobuploader) - INFO - Done attempting. 19:14:57 INFO - (blobuploader) - INFO - Iteration through files over. 19:14:57 INFO - Return code: 0 19:14:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:14:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:14:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/197d4158915fe6fbeff20036280b423342ff813be3a00c90c06dbb6914d67c8083ebf6fcff356016bc7dda70c5d5b9baa3826106c035a826d8f7d28471f6b593", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75c57875e99bf7d30b9d2e49147fc76afa91620929dc14b9a083762b9ac574aa36b9f962ad23366e8ad250e74d86da204af1ff26c5f9206923836028a972f144", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0fffce4094ff4e8eba87bae44294b965f65786f7e8c1018ac366d0383d7609c3c17803cd27e333f39ad825ab63c597667b7e9ab79c17bd6b37fe5a9c2fe7f8f"} 19:14:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:14:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:14:57 INFO - Contents: 19:14:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/197d4158915fe6fbeff20036280b423342ff813be3a00c90c06dbb6914d67c8083ebf6fcff356016bc7dda70c5d5b9baa3826106c035a826d8f7d28471f6b593", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75c57875e99bf7d30b9d2e49147fc76afa91620929dc14b9a083762b9ac574aa36b9f962ad23366e8ad250e74d86da204af1ff26c5f9206923836028a972f144", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0fffce4094ff4e8eba87bae44294b965f65786f7e8c1018ac366d0383d7609c3c17803cd27e333f39ad825ab63c597667b7e9ab79c17bd6b37fe5a9c2fe7f8f"} 19:14:57 INFO - Running post-run listener: copy_logs_to_upload_dir 19:14:57 INFO - Copying logs to upload dir... 19:14:57 INFO - mkdir: /builds/slave/test/build/upload/logs 19:14:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.067001 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-26 19:14:55.432117) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 19:14:55.436185) ========= 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=6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/197d4158915fe6fbeff20036280b423342ff813be3a00c90c06dbb6914d67c8083ebf6fcff356016bc7dda70c5d5b9baa3826106c035a826d8f7d28471f6b593", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75c57875e99bf7d30b9d2e49147fc76afa91620929dc14b9a083762b9ac574aa36b9f962ad23366e8ad250e74d86da204af1ff26c5f9206923836028a972f144", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0fffce4094ff4e8eba87bae44294b965f65786f7e8c1018ac366d0383d7609c3c17803cd27e333f39ad825ab63c597667b7e9ab79c17bd6b37fe5a9c2fe7f8f"} build_url:https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/YH4pAcQfRP2Yn4V5piyXeA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/197d4158915fe6fbeff20036280b423342ff813be3a00c90c06dbb6914d67c8083ebf6fcff356016bc7dda70c5d5b9baa3826106c035a826d8f7d28471f6b593", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75c57875e99bf7d30b9d2e49147fc76afa91620929dc14b9a083762b9ac574aa36b9f962ad23366e8ad250e74d86da204af1ff26c5f9206923836028a972f144", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0fffce4094ff4e8eba87bae44294b965f65786f7e8c1018ac366d0383d7609c3c17803cd27e333f39ad825ab63c597667b7e9ab79c17bd6b37fe5a9c2fe7f8f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 19:14:55.461378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:14:55.461771) ========= 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=6d15e502d8e29d5d2676d664000001c3-1474940157.101591-97257586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:14:55.545903) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 19:14:55.546317) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 19:14:55.546716) ========= ========= Total master_lag: 0.18 =========