builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1472138570.99 results: success (0) buildid: 20160825054326 builduid: 7e29b840d0b84dbe8217f7fde66c11ba revision: 7963ebdd52b93f96b812eff2eab8d94097147b9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:50.991344) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:50.991772) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:50.992107) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:51.023287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:51.023564) ========= 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=03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 08:22:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-08-25 08:22:51 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071120 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:51.109302) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:51.109671) ========= 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=03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017823 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:51.160164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:51.160556) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7963ebdd52b93f96b812eff2eab8d94097147b9c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7963ebdd52b93f96b812eff2eab8d94097147b9c --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=03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 08:22:51,494 truncating revision to first 12 chars 2016-08-25 08:22:51,494 Setting DEBUG logging. 2016-08-25 08:22:51,494 attempt 1/10 2016-08-25 08:22:51,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7963ebdd52b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 08:22:51,788 unpacking tar archive at: mozilla-central-7963ebdd52b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.580232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:51.754302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:51.754614) ========= script_repo_revision: 7963ebdd52b93f96b812eff2eab8d94097147b9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:51.755024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:51.755350) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:51.770645) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-25 08:22:51.771010) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:22:52 INFO - MultiFileLogger online at 20160825 08:22:52 in /builds/slave/test 08:22:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:22:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:22:52 INFO - {'append_to_log': False, 08:22:52 INFO - 'base_work_dir': '/builds/slave/test', 08:22:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:22:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:22:52 INFO - 'branch': 'Firefox-Non-PGO', 08:22:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:22:52 INFO - 'config_files': ('talos/linux_config.py',), 08:22:52 INFO - 'default_actions': ('clobber', 08:22:52 INFO - 'read-buildbot-config', 08:22:52 INFO - 'download-and-extract', 08:22:52 INFO - 'populate-webroot', 08:22:52 INFO - 'create-virtualenv', 08:22:52 INFO - 'install', 08:22:52 INFO - 'run-tests'), 08:22:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:22:52 INFO - 'download_minidump_stackwalk': True, 08:22:52 INFO - 'download_symbols': 'ondemand', 08:22:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:22:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:22:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:22:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:22:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:22:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:22:52 INFO - 'installer_path': 'installer.exe', 08:22:52 INFO - 'log_level': 'info', 08:22:52 INFO - 'log_name': 'talos', 08:22:52 INFO - 'log_to_console': True, 08:22:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:22:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:22:52 INFO - 'opt_config_files': (), 08:22:52 INFO - 'pip_index': False, 08:22:52 INFO - 'sps_profile': False, 08:22:52 INFO - 'sps_profile_interval': 0, 08:22:52 INFO - 'suite': 'dromaeojs', 08:22:52 INFO - 'system_bits': '32', 08:22:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:22:52 INFO - 'title': 'talos-linux64-ix-047', 08:22:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:22:52 INFO - 'use_talos_json': True, 08:22:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:22:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:22:52 INFO - 'work_dir': 'build'} 08:22:52 INFO - [mozharness: 2016-08-25 15:22:52.203043Z] Running clobber step. 08:22:52 INFO - Running pre-action listener: _resource_record_pre_action 08:22:52 INFO - Running main action method: clobber 08:22:52 INFO - rmtree: /builds/slave/test/build 08:22:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:22:52 INFO - Running post-action listener: _resource_record_post_action 08:22:52 INFO - [mozharness: 2016-08-25 15:22:52.664987Z] Finished clobber step (success) 08:22:52 INFO - [mozharness: 2016-08-25 15:22:52.665090Z] Running read-buildbot-config step. 08:22:52 INFO - Running pre-action listener: _resource_record_pre_action 08:22:52 INFO - Running main action method: read_buildbot_config 08:22:52 INFO - Using buildbot properties: 08:22:52 INFO - { 08:22:52 INFO - "project": "", 08:22:52 INFO - "product": "firefox", 08:22:52 INFO - "script_repo_revision": "production", 08:22:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:22:52 INFO - "repository": "", 08:22:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:22:52 INFO - "buildid": "20160825054326", 08:22:52 INFO - "pgo_build": "False", 08:22:52 INFO - "basedir": "/builds/slave/test", 08:22:52 INFO - "buildnumber": 615, 08:22:52 INFO - "slavename": "talos-linux64-ix-047", 08:22:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:22:52 INFO - "platform": "ubuntu64_hw", 08:22:52 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:22:52 INFO - "branch": "mozilla-central", 08:22:52 INFO - "repo_path": "mozilla-central", 08:22:52 INFO - "revision": "7963ebdd52b93f96b812eff2eab8d94097147b9c", 08:22:52 INFO - "stage_platform": "linux64", 08:22:52 INFO - "builduid": "7e29b840d0b84dbe8217f7fde66c11ba", 08:22:52 INFO - "slavebuilddir": "test" 08:22:52 INFO - } 08:22:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:22:52 INFO - Running post-action listener: _resource_record_post_action 08:22:52 INFO - [mozharness: 2016-08-25 15:22:52.667542Z] Finished read-buildbot-config step (success) 08:22:52 INFO - [mozharness: 2016-08-25 15:22:52.667629Z] Running download-and-extract step. 08:22:52 INFO - Running pre-action listener: _resource_record_pre_action 08:22:52 INFO - Running main action method: download_and_extract 08:22:52 INFO - mkdir: /builds/slave/test/build/tests 08:22:52 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')]} 08:22:52 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:22:52 INFO - Downloading https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:22:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:22:53 INFO - Downloaded 1361 bytes. 08:22:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:22:53 INFO - Using the following test package requirements: 08:22:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:22:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:22:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:53 INFO - u'jsshell-linux-x86_64.zip'], 08:22:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:22:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:22:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:22:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:22:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:22:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:53 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:53 INFO - Downloading https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:22:54 INFO - Downloaded 20324311 bytes. 08:22:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:22:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:22:58 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')]} 08:22:58 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:58 INFO - Downloading https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:22:59 INFO - Downloaded 20324311 bytes. 08:22:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:23:03 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')]} 08:23:03 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:03 INFO - Downloading https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:23:04 INFO - Downloaded 14413981 bytes. 08:23:04 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:23: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')]} 08:23:04 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:23:04 INFO - Downloading https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:23:05 INFO - Downloaded 55750173 bytes. 08:23:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:23:05 INFO - mkdir: /builds/slave/test/properties 08:23:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:05 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:05 INFO - Contents: 08:23:05 INFO - build_url:https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:23:06 INFO - Running post-action listener: _resource_record_post_action 08:23:06 INFO - Running post-action listener: set_extra_try_arguments 08:23:06 INFO - [mozharness: 2016-08-25 15:23:06.617160Z] Finished download-and-extract step (success) 08:23:06 INFO - [mozharness: 2016-08-25 15:23:06.617503Z] Running populate-webroot step. 08:23:06 INFO - Running pre-action listener: _resource_record_pre_action 08:23:06 INFO - Running main action method: populate_webroot 08:23:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:06 INFO - '--tppagecycles', 08:23:06 INFO - '7'], 08:23:06 INFO - 'tests': ['tsvgm']}}, 08:23:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:23:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:23:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:06 INFO - 'talos_options': ['--disable-e10s'], 08:23:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:06 INFO - 'talos_options': ['--disable-e10s'], 08:23:06 INFO - 'tests': ['damp', 'tps']}, 08:23:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:06 INFO - 'tests': ['damp', 'tps']}, 08:23:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:06 INFO - 'tests': ['dromaeo_dom']}, 08:23:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:23:06 INFO - 'tests': ['basic_compositor_video']}, 08:23:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:23:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:06 INFO - 'tests': ['a11yr', 08:23:06 INFO - 'ts_paint', 08:23:06 INFO - 'tpaint', 08:23:06 INFO - 'sessionrestore', 08:23:06 INFO - 'sessionrestore_no_auto_restore', 08:23:06 INFO - 'tabpaint']}, 08:23:06 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:06 INFO - 'ts_paint', 08:23:06 INFO - 'tpaint', 08:23:06 INFO - 'sessionrestore', 08:23:06 INFO - 'sessionrestore_no_auto_restore', 08:23:06 INFO - 'tabpaint']}, 08:23:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:06 INFO - 'ts_paint', 08:23:06 INFO - 'tpaint', 08:23:06 INFO - 'sessionrestore', 08:23:06 INFO - 'sessionrestore_no_auto_restore', 08:23:06 INFO - 'tabpaint']}, 08:23:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:06 INFO - 'ts_paint', 08:23:06 INFO - 'tpaint', 08:23:06 INFO - 'sessionrestore', 08:23:06 INFO - 'sessionrestore_no_auto_restore', 08:23:06 INFO - 'tabpaint']}, 08:23:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:06 INFO - 'tests': ['a11yr', 08:23:06 INFO - 'ts_paint', 08:23:06 INFO - 'tpaint', 08:23:06 INFO - 'sessionrestore', 08:23:06 INFO - 'sessionrestore_no_auto_restore', 08:23:06 INFO - 'tabpaint']}, 08:23:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:06 INFO - 'tests': ['a11yr', 08:23:06 INFO - 'ts_paint', 08:23:06 INFO - 'tpaint', 08:23:06 INFO - 'sessionrestore', 08:23:06 INFO - 'sessionrestore_no_auto_restore', 08:23:06 INFO - 'tabpaint']}, 08:23:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:06 INFO - 'tests': ['tsvgx', 08:23:06 INFO - 'tsvgr_opacity', 08:23:06 INFO - 'tart', 08:23:06 INFO - 'tscrollx', 08:23:06 INFO - 'cart']}, 08:23:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:06 INFO - 'tsvgr_opacity', 08:23:06 INFO - 'tart', 08:23:06 INFO - 'tscrollx', 08:23:06 INFO - 'cart']}, 08:23:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:06 INFO - 'talos_options': ['--disable-e10s'], 08:23:06 INFO - 'tests': ['tp5o']}, 08:23:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:06 INFO - 'tests': ['tp5o']}, 08:23:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:06 INFO - 'talos_options': ['--disable-e10s', 08:23:06 INFO - '--xperf_path', 08:23:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:06 INFO - 'tests': ['tp5n']}, 08:23:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:06 INFO - 'talos_options': ['--xperf_path', 08:23:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:06 INFO - 'tests': ['tp5n']}}, 08:23:06 INFO - 'talos.zip': {'path': '', 08:23:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:06 INFO - Running post-action listener: _resource_record_post_action 08:23:06 INFO - [mozharness: 2016-08-25 15:23:06.637663Z] Finished populate-webroot step (success) 08:23:06 INFO - [mozharness: 2016-08-25 15:23:06.637757Z] Running create-virtualenv step. 08:23:06 INFO - Running pre-action listener: _resource_record_pre_action 08:23:06 INFO - Running main action method: create_virtualenv 08:23:06 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:06 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 08:23:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:06 INFO - Using real prefix '/usr' 08:23:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:07 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:09 INFO - Installing pip.................done. 08:23:09 INFO - Return code: 0 08:23:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23:09 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')]} 08:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:09 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')]} 08:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:09 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 0x7f66ea212f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd78090>, '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 0xd7b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7be40>, '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': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', '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 08:23:09 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 08:23:09 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 08:23:09 INFO - Using env: {'DISPLAY': ':0', 08:23:09 INFO - 'HOME': '/home/cltbld', 08:23:09 INFO - 'LANG': 'en_US.UTF-8', 08:23:09 INFO - 'LANGUAGE': 'en_US:en', 08:23:09 INFO - 'LOGNAME': 'cltbld', 08:23:09 INFO - 'MAIL': '/var/mail/cltbld', 08:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:09 INFO - 'MOZ_NO_REMOTE': '1', 08:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:09 INFO - 'NO_EM_RESTART': '1', 08:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:09 INFO - 'PWD': '/builds/slave/test', 08:23:09 INFO - 'SHELL': '/bin/bash', 08:23:09 INFO - 'SHLVL': '1', 08:23:09 INFO - 'TERM': 'linux', 08:23:09 INFO - 'TMOUT': '86400', 08:23:09 INFO - 'USER': 'cltbld', 08:23:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', 08:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:09 INFO - '_': '/tools/buildbot/bin/python'} 08:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:09 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 08:23:09 INFO - Cleaning up... 08:23:09 INFO - Return code: 0 08:23:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23:09 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')]} 08:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:09 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')]} 08:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:09 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 0x7f66ea212f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd78090>, '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 0xd7b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7be40>, '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': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', '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 08:23:09 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 08:23:09 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 08:23:09 INFO - Using env: {'DISPLAY': ':0', 08:23:09 INFO - 'HOME': '/home/cltbld', 08:23:09 INFO - 'LANG': 'en_US.UTF-8', 08:23:09 INFO - 'LANGUAGE': 'en_US:en', 08:23:09 INFO - 'LOGNAME': 'cltbld', 08:23:09 INFO - 'MAIL': '/var/mail/cltbld', 08:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:09 INFO - 'MOZ_NO_REMOTE': '1', 08:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:09 INFO - 'NO_EM_RESTART': '1', 08:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:09 INFO - 'PWD': '/builds/slave/test', 08:23:09 INFO - 'SHELL': '/bin/bash', 08:23:09 INFO - 'SHLVL': '1', 08:23:09 INFO - 'TERM': 'linux', 08:23:09 INFO - 'TMOUT': '86400', 08:23:09 INFO - 'USER': 'cltbld', 08:23:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', 08:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:09 INFO - '_': '/tools/buildbot/bin/python'} 08:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:09 INFO - Downloading/unpacking psutil>=3.1.1 08:23:09 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 08:23:09 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 08:23:09 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 08:23:09 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 08:23:09 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 08:23:09 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 08:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:11 INFO - Installing collected packages: psutil 08:23:11 INFO - Running setup.py install for psutil 08:23:11 INFO - building 'psutil._psutil_linux' extension 08:23:11 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 08:23:11 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 08:23:11 INFO - building 'psutil._psutil_posix' extension 08:23:11 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 08:23:11 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 08:23:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:12 INFO - Successfully installed psutil 08:23:12 INFO - Cleaning up... 08:23:12 INFO - Return code: 0 08:23:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f66ea212f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd78090>, '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 0xd7b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7be40>, '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': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', '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 08:23:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:23:12 INFO - Using env: {'DISPLAY': ':0', 08:23:12 INFO - 'HOME': '/home/cltbld', 08:23:12 INFO - 'LANG': 'en_US.UTF-8', 08:23:12 INFO - 'LANGUAGE': 'en_US:en', 08:23:12 INFO - 'LOGNAME': 'cltbld', 08:23:12 INFO - 'MAIL': '/var/mail/cltbld', 08:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:12 INFO - 'MOZ_NO_REMOTE': '1', 08:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:12 INFO - 'NO_EM_RESTART': '1', 08:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:12 INFO - 'PWD': '/builds/slave/test', 08:23:12 INFO - 'SHELL': '/bin/bash', 08:23:12 INFO - 'SHLVL': '1', 08:23:12 INFO - 'TERM': 'linux', 08:23:12 INFO - 'TMOUT': '86400', 08:23:12 INFO - 'USER': 'cltbld', 08:23:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', 08:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:12 INFO - '_': '/tools/buildbot/bin/python'} 08:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:23:14 INFO - Installing collected packages: mozsystemmonitor 08:23:14 INFO - Running setup.py install for mozsystemmonitor 08:23:14 INFO - Successfully installed mozsystemmonitor 08:23:14 INFO - Cleaning up... 08:23:14 INFO - Return code: 0 08:23:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:23:14 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')]} 08:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:14 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')]} 08:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:14 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 0x7f66ea212f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd78090>, '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 0xd7b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7be40>, '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': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', '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 08:23:14 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 08:23:14 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 08:23:14 INFO - Using env: {'DISPLAY': ':0', 08:23:14 INFO - 'HOME': '/home/cltbld', 08:23:14 INFO - 'LANG': 'en_US.UTF-8', 08:23:14 INFO - 'LANGUAGE': 'en_US:en', 08:23:14 INFO - 'LOGNAME': 'cltbld', 08:23:14 INFO - 'MAIL': '/var/mail/cltbld', 08:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:14 INFO - 'MOZ_NO_REMOTE': '1', 08:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:14 INFO - 'NO_EM_RESTART': '1', 08:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:14 INFO - 'PWD': '/builds/slave/test', 08:23:14 INFO - 'SHELL': '/bin/bash', 08:23:14 INFO - 'SHLVL': '1', 08:23:14 INFO - 'TERM': 'linux', 08:23:14 INFO - 'TMOUT': '86400', 08:23:14 INFO - 'USER': 'cltbld', 08:23:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', 08:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:14 INFO - '_': '/tools/buildbot/bin/python'} 08:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:14 INFO - Downloading/unpacking jsonschema==2.5.1 08:23:14 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 08:23:14 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 08:23:14 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 08:23:14 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 08:23:14 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 08:23:14 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 08:23:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:23:16 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 08:23:16 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 08:23:16 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 08:23:16 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 08:23:16 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 08:23:16 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 08:23:16 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:16 INFO - warning: no files found matching '*.txt' 08:23:16 INFO - no previously-included directories found matching 'build' 08:23:16 INFO - no previously-included directories found matching 'dist' 08:23:16 INFO - no previously-included directories found matching '.git*' 08:23:16 INFO - Installing collected packages: jsonschema, functools32 08:23:16 INFO - Running setup.py install for functools32 08:23:16 INFO - warning: no files found matching '*.txt' 08:23:16 INFO - no previously-included directories found matching 'build' 08:23:16 INFO - no previously-included directories found matching 'dist' 08:23:16 INFO - no previously-included directories found matching '.git*' 08:23:16 INFO - Successfully installed jsonschema functools32 08:23:16 INFO - Cleaning up... 08:23:16 INFO - Return code: 0 08:23:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:23:16 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')]} 08:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:16 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')]} 08:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:16 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 0x7f66ea212f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd78090>, '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 0xd7b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7be40>, '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': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', '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 08:23:16 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 08:23:16 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 08:23:16 INFO - Using env: {'DISPLAY': ':0', 08:23:16 INFO - 'HOME': '/home/cltbld', 08:23:16 INFO - 'LANG': 'en_US.UTF-8', 08:23:16 INFO - 'LANGUAGE': 'en_US:en', 08:23:16 INFO - 'LOGNAME': 'cltbld', 08:23:16 INFO - 'MAIL': '/var/mail/cltbld', 08:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:16 INFO - 'MOZ_NO_REMOTE': '1', 08:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:16 INFO - 'NO_EM_RESTART': '1', 08:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:16 INFO - 'PWD': '/builds/slave/test', 08:23:16 INFO - 'SHELL': '/bin/bash', 08:23:16 INFO - 'SHLVL': '1', 08:23:16 INFO - 'TERM': 'linux', 08:23:16 INFO - 'TMOUT': '86400', 08:23:16 INFO - 'USER': 'cltbld', 08:23:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', 08:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:16 INFO - '_': '/tools/buildbot/bin/python'} 08:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:23:17 INFO - Cleaning up... 08:23:17 INFO - Return code: 0 08:23:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f66ea212f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd78090>, '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 0xd7b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7be40>, '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': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', '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 08:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:23:17 INFO - Using env: {'DISPLAY': ':0', 08:23:17 INFO - 'HOME': '/home/cltbld', 08:23:17 INFO - 'LANG': 'en_US.UTF-8', 08:23:17 INFO - 'LANGUAGE': 'en_US:en', 08:23:17 INFO - 'LOGNAME': 'cltbld', 08:23:17 INFO - 'MAIL': '/var/mail/cltbld', 08:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:17 INFO - 'MOZ_NO_REMOTE': '1', 08:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:17 INFO - 'NO_EM_RESTART': '1', 08:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:17 INFO - 'PWD': '/builds/slave/test', 08:23:17 INFO - 'SHELL': '/bin/bash', 08:23:17 INFO - 'SHLVL': '1', 08:23:17 INFO - 'TERM': 'linux', 08:23:17 INFO - 'TMOUT': '86400', 08:23:17 INFO - 'USER': 'cltbld', 08:23:17 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', 08:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:17 INFO - '_': '/tools/buildbot/bin/python'} 08:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:17 INFO - Downloading/unpacking blobuploader==1.2.4 08:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:19 INFO - Downloading blobuploader-1.2.4.tar.gz 08:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:23:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:23:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:19 INFO - Downloading docopt-0.6.1.tar.gz 08:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:23:20 INFO - Installing collected packages: blobuploader, requests, docopt 08:23:20 INFO - Running setup.py install for blobuploader 08:23:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:23:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:23:20 INFO - Running setup.py install for requests 08:23:20 INFO - Running setup.py install for docopt 08:23:20 INFO - Successfully installed blobuploader requests docopt 08:23:20 INFO - Cleaning up... 08:23:20 INFO - Return code: 0 08:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:20 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 0x7f66ea212f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd78090>, '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 0xd7b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7be40>, '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': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', '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 08:23:20 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 08:23:20 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 08:23:20 INFO - Using env: {'DISPLAY': ':0', 08:23:20 INFO - 'HOME': '/home/cltbld', 08:23:20 INFO - 'LANG': 'en_US.UTF-8', 08:23:20 INFO - 'LANGUAGE': 'en_US:en', 08:23:20 INFO - 'LOGNAME': 'cltbld', 08:23:20 INFO - 'MAIL': '/var/mail/cltbld', 08:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:20 INFO - 'MOZ_NO_REMOTE': '1', 08:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:20 INFO - 'NO_EM_RESTART': '1', 08:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:20 INFO - 'PWD': '/builds/slave/test', 08:23:20 INFO - 'SHELL': '/bin/bash', 08:23:20 INFO - 'SHLVL': '1', 08:23:20 INFO - 'TERM': 'linux', 08:23:20 INFO - 'TMOUT': '86400', 08:23:20 INFO - 'USER': 'cltbld', 08:23:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', 08:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:20 INFO - '_': '/tools/buildbot/bin/python'} 08:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:20 INFO - Running setup.py (path:/tmp/pip-4WWPl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:20 INFO - Running setup.py (path:/tmp/pip-dVvjaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:21 INFO - Running setup.py (path:/tmp/pip-jQU2ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:21 INFO - Running setup.py (path:/tmp/pip-J_uFbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:21 INFO - Running setup.py (path:/tmp/pip-HEznaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:21 INFO - Running setup.py (path:/tmp/pip-dfxxDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:21 INFO - Running setup.py (path:/tmp/pip-uiayaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:21 INFO - Running setup.py (path:/tmp/pip-yDQVek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:21 INFO - Running setup.py (path:/tmp/pip-IF5Oa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:21 INFO - Running setup.py (path:/tmp/pip-VnnbSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:21 INFO - Running setup.py (path:/tmp/pip-AJJfZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:21 INFO - Running setup.py (path:/tmp/pip-jyPTQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:21 INFO - Running setup.py (path:/tmp/pip-uKHCFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:21 INFO - Running setup.py (path:/tmp/pip-KMv3kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:21 INFO - Running setup.py (path:/tmp/pip-7jCQPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:21 INFO - Running setup.py (path:/tmp/pip-6rafa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:22 INFO - Running setup.py (path:/tmp/pip-idwOWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:23:22 INFO - Running setup.py install for manifestparser 08:23:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozcrash 08:23:22 INFO - Running setup.py install for mozdebug 08:23:22 INFO - Running setup.py install for mozdevice 08:23:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozfile 08:23:22 INFO - Running setup.py install for mozhttpd 08:23:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozinfo 08:23:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozInstall 08:23:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozleak 08:23:22 INFO - Running setup.py install for mozlog 08:23:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Running setup.py install for moznetwork 08:23:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Running setup.py install for mozprocess 08:23:23 INFO - Running setup.py install for mozprofile 08:23:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Running setup.py install for mozrunner 08:23:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Running setup.py install for mozscreenshot 08:23:23 INFO - Running setup.py install for moztest 08:23:23 INFO - Running setup.py install for mozversion 08:23:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:23:23 INFO - Cleaning up... 08:23:23 INFO - Return code: 0 08:23:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:23 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 0x7f66ea212f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd78090>, '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 0xd7b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7be40>, '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': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', '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 08:23:23 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 08:23:23 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 08:23:23 INFO - Using env: {'DISPLAY': ':0', 08:23:23 INFO - 'HOME': '/home/cltbld', 08:23:23 INFO - 'LANG': 'en_US.UTF-8', 08:23:23 INFO - 'LANGUAGE': 'en_US:en', 08:23:23 INFO - 'LOGNAME': 'cltbld', 08:23:23 INFO - 'MAIL': '/var/mail/cltbld', 08:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:23 INFO - 'MOZ_NO_REMOTE': '1', 08:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:23 INFO - 'NO_EM_RESTART': '1', 08:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:23 INFO - 'PWD': '/builds/slave/test', 08:23:23 INFO - 'SHELL': '/bin/bash', 08:23:23 INFO - 'SHLVL': '1', 08:23:23 INFO - 'TERM': 'linux', 08:23:23 INFO - 'TMOUT': '86400', 08:23:23 INFO - 'USER': 'cltbld', 08:23:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', 08:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:23 INFO - '_': '/tools/buildbot/bin/python'} 08:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:24 INFO - Running setup.py (path:/tmp/pip-VszNZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:24 INFO - Running setup.py (path:/tmp/pip-J5OyHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:24 INFO - Running setup.py (path:/tmp/pip-sthoR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:24 INFO - Running setup.py (path:/tmp/pip-QUl8Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:24 INFO - Running setup.py (path:/tmp/pip-IZZ1X5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:24 INFO - Running setup.py (path:/tmp/pip-TMvo_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:24 INFO - Running setup.py (path:/tmp/pip-m_T8sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:24 INFO - Running setup.py (path:/tmp/pip-uBG4j_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:24 INFO - Running setup.py (path:/tmp/pip-zEb7NO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:24 INFO - Running setup.py (path:/tmp/pip-IHoN8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:24 INFO - Running setup.py (path:/tmp/pip-haWZCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:24 INFO - Running setup.py (path:/tmp/pip-0QV1Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:24 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)) 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:24 INFO - Running setup.py (path:/tmp/pip-oHrS1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:25 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)) 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:25 INFO - Running setup.py (path:/tmp/pip-q8S_zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:25 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)) 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:25 INFO - Running setup.py (path:/tmp/pip-J8RLlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:25 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)) 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:25 INFO - Running setup.py (path:/tmp/pip-tfgeNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:25 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)) 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:25 INFO - Running setup.py (path:/tmp/pip-OHxFok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:25 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)) 08:23:25 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)) 08:23:25 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)) 08:23:25 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)) 08:23:25 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)) 08:23:25 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)) 08:23:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:27 INFO - Downloading blessings-1.6.tar.gz 08:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:27 INFO - Installing collected packages: blessings 08:23:27 INFO - Running setup.py install for blessings 08:23:27 INFO - Successfully installed blessings 08:23:27 INFO - Cleaning up... 08:23:27 INFO - Return code: 0 08:23:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:27 INFO - Reading from file tmpfile_stdout 08:23:27 INFO - Current package versions: 08:23:27 INFO - argparse == 1.2.1 08:23:27 INFO - blessings == 1.6 08:23:27 INFO - blobuploader == 1.2.4 08:23:27 INFO - docopt == 0.6.1 08:23:27 INFO - functools32 == 3.2.3-2 08:23:27 INFO - jsonschema == 2.5.1 08:23:27 INFO - manifestparser == 1.1 08:23:27 INFO - mozInstall == 1.12 08:23:27 INFO - mozcrash == 0.17 08:23:27 INFO - mozdebug == 0.1 08:23:27 INFO - mozdevice == 0.48 08:23:27 INFO - mozfile == 1.2 08:23:27 INFO - mozhttpd == 0.7 08:23:27 INFO - mozinfo == 0.9 08:23:27 INFO - mozleak == 0.1 08:23:27 INFO - mozlog == 3.3 08:23:27 INFO - moznetwork == 0.27 08:23:27 INFO - mozprocess == 0.23 08:23:27 INFO - mozprofile == 0.28 08:23:27 INFO - mozrunner == 6.12 08:23:27 INFO - mozscreenshot == 0.1 08:23:27 INFO - mozsystemmonitor == 0.3 08:23:27 INFO - moztest == 0.7 08:23:27 INFO - mozversion == 1.4 08:23:27 INFO - psutil == 3.1.1 08:23:27 INFO - requests == 1.2.3 08:23:27 INFO - wsgiref == 0.1.2 08:23:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:27 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 0x7f66ea212f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd78090>, '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 0xd7b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7be40>, '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': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', '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 08:23:27 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 08:23:27 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 08:23:27 INFO - Using env: {'DISPLAY': ':0', 08:23:27 INFO - 'HOME': '/home/cltbld', 08:23:27 INFO - 'LANG': 'en_US.UTF-8', 08:23:27 INFO - 'LANGUAGE': 'en_US:en', 08:23:27 INFO - 'LOGNAME': 'cltbld', 08:23:27 INFO - 'MAIL': '/var/mail/cltbld', 08:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:27 INFO - 'MOZ_NO_REMOTE': '1', 08:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:27 INFO - 'NO_EM_RESTART': '1', 08:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:27 INFO - 'PWD': '/builds/slave/test', 08:23:27 INFO - 'SHELL': '/bin/bash', 08:23:27 INFO - 'SHLVL': '1', 08:23:27 INFO - 'TERM': 'linux', 08:23:27 INFO - 'TMOUT': '86400', 08:23:27 INFO - 'USER': 'cltbld', 08:23:27 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', 08:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:27 INFO - '_': '/tools/buildbot/bin/python'} 08:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:27 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)) 08:23:27 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)) 08:23:27 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)) 08:23:27 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)) 08:23:27 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)) 08:23:27 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)) 08:23:27 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)) 08:23:27 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)) 08:23:27 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)) 08:23:27 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)) 08:23:27 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)) 08:23:27 INFO - Cleaning up... 08:23:27 INFO - Return code: 0 08:23:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:27 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 0x7f66ea212f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd78090>, '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 0xd7b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7be40>, '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': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', '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 08:23:27 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 08:23:27 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 08:23:27 INFO - Using env: {'DISPLAY': ':0', 08:23:27 INFO - 'HOME': '/home/cltbld', 08:23:27 INFO - 'LANG': 'en_US.UTF-8', 08:23:27 INFO - 'LANGUAGE': 'en_US:en', 08:23:27 INFO - 'LOGNAME': 'cltbld', 08:23:27 INFO - 'MAIL': '/var/mail/cltbld', 08:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:27 INFO - 'MOZ_NO_REMOTE': '1', 08:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:27 INFO - 'NO_EM_RESTART': '1', 08:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:27 INFO - 'PWD': '/builds/slave/test', 08:23:27 INFO - 'SHELL': '/bin/bash', 08:23:27 INFO - 'SHLVL': '1', 08:23:27 INFO - 'TERM': 'linux', 08:23:27 INFO - 'TMOUT': '86400', 08:23:27 INFO - 'USER': 'cltbld', 08:23:27 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', 08:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:27 INFO - '_': '/tools/buildbot/bin/python'} 08:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:23:28 INFO - Cleaning up... 08:23:28 INFO - Return code: 0 08:23:28 INFO - Running post-action listener: _resource_record_post_action 08:23:28 INFO - Running post-action listener: _start_resource_monitoring 08:23:28 INFO - Starting resource monitoring. 08:23:28 INFO - [mozharness: 2016-08-25 15:23:28.154882Z] Finished create-virtualenv step (success) 08:23:28 INFO - [mozharness: 2016-08-25 15:23:28.155342Z] Running install step. 08:23:28 INFO - Running pre-action listener: _resource_record_pre_action 08:23:28 INFO - Running main action method: install 08:23:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:28 INFO - Reading from file tmpfile_stdout 08:23:28 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:28 INFO - Reading from file tmpfile_stdout 08:23:28 INFO - Output received: 08:23:28 INFO - Usage: mozinstall [options] installer 08:23:28 INFO - Options: 08:23:28 INFO - -h, --help show this help message and exit 08:23:28 INFO - -d DEST, --destination=DEST 08:23:28 INFO - Directory to install application into. [default: 08:23:28 INFO - "/builds/slave/test"] 08:23:28 INFO - --app=APP Application being installed. [default: firefox] 08:23:28 INFO - mkdir: /builds/slave/test/build/application 08:23:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:23:44 INFO - Reading from file tmpfile_stdout 08:23:44 INFO - Output received: 08:23:44 INFO - /builds/slave/test/build/application/firefox/firefox 08:23:44 INFO - Running post-action listener: _resource_record_post_action 08:23:44 INFO - [mozharness: 2016-08-25 15:23:44.537597Z] Finished install step (success) 08:23:44 INFO - [mozharness: 2016-08-25 15:23:44.537846Z] Running run-tests step. 08:23:44 INFO - Running pre-action listener: _resource_record_pre_action 08:23:44 INFO - Running main action method: run_tests 08:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:23:44 INFO - Python 2.7.3 08:23:44 INFO - Return code: 0 08:23:44 INFO - grabbing minidump binary from tooltool 08:23:44 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')]} 08:23:44 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 0xd78090>, '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 0xd7b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7be40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:23:44 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 08:23:44 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 08:23:44 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 08:23:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:23:44 INFO - Return code: 0 08:23:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:23:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:23:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:23:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:23:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 08:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 08:23:44 INFO - Using env: {'DISPLAY': ':0', 08:23:44 INFO - 'HOME': '/home/cltbld', 08:23:44 INFO - 'LANG': 'en_US.UTF-8', 08:23:44 INFO - 'LANGUAGE': 'en_US:en', 08:23:44 INFO - 'LOGNAME': 'cltbld', 08:23:44 INFO - 'MAIL': '/var/mail/cltbld', 08:23:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:44 INFO - 'MOZ_NO_REMOTE': '1', 08:23:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:44 INFO - 'NO_EM_RESTART': '1', 08:23:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:44 INFO - 'PWD': '/builds/slave/test', 08:23:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:44 INFO - 'SHELL': '/bin/bash', 08:23:44 INFO - 'SHLVL': '1', 08:23:44 INFO - 'TERM': 'linux', 08:23:44 INFO - 'TMOUT': '86400', 08:23:44 INFO - 'USER': 'cltbld', 08:23:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023', 08:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:44 INFO - '_': '/tools/buildbot/bin/python'} 08:23:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 08:23:44 INFO - mozversion application_buildid: 20160825054326 08:23:44 INFO - mozversion application_changeset: 7963ebdd52b93f96b812eff2eab8d94097147b9c 08:23:44 INFO - mozversion application_display_name: Nightly 08:23:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:23:44 INFO - mozversion application_name: Firefox 08:23:44 INFO - mozversion application_remotingname: firefox 08:23:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:23:44 INFO - mozversion application_vendor: Mozilla 08:23:44 INFO - mozversion application_version: 51.0a1 08:23:44 INFO - mozversion platform_buildid: 20160825054326 08:23:44 INFO - mozversion platform_changeset: 7963ebdd52b93f96b812eff2eab8d94097147b9c 08:23:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:23:44 INFO - mozversion platform_version: 51.0a1 08:23:44 INFO - using testdate: 1472138624 08:23:44 INFO - actual date: 1472138624 08:23:44 INFO - starting webserver on 'localhost:51497' 08:23:44 INFO - SUITE-START | Running 2 tests 08:23:44 INFO - TEST-START | dromaeo_css 08:23:44 INFO - operating with platform_type : linux_ 08:23:44 INFO - Initialising browser for dromaeo_css test... 08:23:44 INFO - TEST-INFO | started process 22106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF9FXbr/profile http://localhost:51497/getInfo.html) 08:23:49 INFO - PROCESS | 22106 | __metrics Screen width/height:1600/1200 08:23:49 INFO - PROCESS | 22106 | colorDepth:24 08:23:49 INFO - PROCESS | 22106 | Browser inner width/height: 1024/697 08:23:49 INFO - PROCESS | 22106 | __metrics 08:23:49 INFO - PROCESS | 22106 | 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" 08:23:49 INFO - PROCESS | 22106 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:50 INFO - PROCESS | 22106 | console.error: PushService: 08:23:50 INFO - PROCESS | 22106 | stateChangeProcessEnqueue: Error transitioning state 08:23:50 INFO - PROCESS | 22106 | UnknownError 08:23:51 INFO - TEST-INFO | 22106: exit 0 08:23:51 INFO - Browser initialized. 08:23:51 INFO - Running cycle 1/1 for dromaeo_css test... 08:23:51 INFO - TEST-INFO | started process 22187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF9FXbr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:03 INFO - PROCESS | 22187 | RSS: Main: 179314688 08:24:03 INFO - PROCESS | 22187 | 08:24:54 INFO - PROCESS | 22187 | 1472138694605 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] 08:27:08 INFO - PROCESS | 22187 | Cycle 1(1): loaded http://localhost:51497/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51497/tests/dromaeo/cssquery-ext.html) 08:27:09 INFO - PROCESS | 22187 | RSS: Main: 302579712 08:27:09 INFO - PROCESS | 22187 | 08:30:11 INFO - PROCESS | 22187 | Cycle 1(1): loaded http://localhost:51497/tests/dromaeo/cssquery-ext.html (next: http://localhost:51497/tests/dromaeo/cssquery-jquery.html) 08:30:12 INFO - PROCESS | 22187 | RSS: Main: 272711680 08:30:12 INFO - PROCESS | 22187 | 08:33:14 INFO - PROCESS | 22187 | Cycle 1(1): loaded http://localhost:51497/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51497/tests/dromaeo/cssquery-mootools.html) 08:33:15 INFO - PROCESS | 22187 | RSS: Main: 247279616 08:33:15 INFO - PROCESS | 22187 | 08:36:17 INFO - PROCESS | 22187 | Cycle 1(1): loaded http://localhost:51497/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51497/tests/dromaeo/cssquery-prototype.html) 08:36:18 INFO - PROCESS | 22187 | RSS: Main: 216715264 08:36:18 INFO - PROCESS | 22187 | 08:39:21 INFO - PROCESS | 22187 | Cycle 1(1): loaded http://localhost:51497/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51497/tests/dromaeo/cssquery-yui.html) 08:39:22 INFO - PROCESS | 22187 | RSS: Main: 217280512 08:39:22 INFO - PROCESS | 22187 | 08:42:25 INFO - PROCESS | 22187 | Cycle 1(1): loaded http://localhost:51497/tests/dromaeo/cssquery-yui.html (next: http://localhost:51497/tests/dromaeo/cssquery-dojo.html) 08:42:25 INFO - PROCESS | 22187 | RSS: Main: 299728896 08:42:25 INFO - PROCESS | 22187 | 08:42:25 INFO - PROCESS | 22187 | __start_tp_report 08:42:25 INFO - PROCESS | 22187 | _x_x_mozilla_page_load 08:42:25 INFO - PROCESS | 22187 | _x_x_mozilla_page_load_details 08:42:25 INFO - PROCESS | 22187 | |i|pagename|runs| 08:42:25 INFO - PROCESS | 22187 | |0;dojo.html;2577.9355516112096;2581.4966081614093;2593.4294455219847;2604.9348766280846;2627.855467949263;4472.41858558387;4523.592876641102;4604.493505714368;4650.23271160259;4727.52724727527;4660.720356778587;4663.370444989934;4711.269753188253;4744.383230180072;4753.643476739249;4224.61978421942;4267.765272909989;4324.718893271927;4384.868453946387;4421.9829439229;4285.721428107163;4307.353896915456;4318.438602981623;4343.04453020335;4380.934285985712;4217.135487225111;4255.425517555122;4261.2329780639475;4263;4295.52749197588;4206.3690446432975;4256;4264.466941632296;4271.124419494027;4272.380504826782;4244.151169766028;4296.763677997709;4301.741895486281;4317.266064768997;4361.498427680825;4530.433695788027;4668.346431499593;4690.132325519756;4704.059188162347;4707.38803955487;4921.458639549646;4939.481354457766;4986.152354099775;4997.125503036954;5003.224500202475;4965.627577931634;5003.024410240005;5003.374578177728;5029.06962211992;5074.720890351029;4544.341070544819;4649.581537661559;4687.882802929886;4695.483496815347;4702.130105930414;5075.593952483792;5114.105031619451;5141.794328226903;5198.9740051299505;5202.739863006835;4905.3623029006;4919.06537757832;4932.21084626458;4955.603551715854;4968.105740966661;4790.856274311776;4915.3855768029;4975.402951645826;4982.77577509013;4989.426215985208;4949.851504454872;5000.699958002531;5028.296038554606;5038.672486288379;5061.013102444987;4940.110780059552;4958.7024778513405;4958.975205124024;4959.454460009396;5020.949790502048;4144.79276036203;4276.31578947367;4278.187144442546;4281.422008028876;4338.826446942087;3643.562772467321;3693.722970777149;3728.5339332583426;3765.792881391495;3804.6385593368586;4280.122574872144;4282.164977829356;4282.89292767677;4286.571342865688;4337.1976184405985;4934.703917764874;4947.060058588857;4968.552830245295;4971.925421118686;5012.273220383024;4162.812673429703;4217.072244106292;4231.132617813341;4251.319788833772;4306.504751953566;4493.955060449419;4494.685372023992;4536.115457485825;4545.477270113913;4550.726956382628;4640.767961601907;4642.837500687459;4648.83729069481;4652.185867473247;4709.646776491708;4765.0469906019625;4826.58973987201;4827.903441931212;4894.437139728834;4923.729194894315;4635.258358662598;4654.394928659252;4712.034033023154;4754.120487709784;4763.904721905473;4990.925136123034;5000.349954505891;5003.099442100457;5059.747012649426;5061.797528098835;5054.2923990642075;5065.290859279778;5065.8733531662;5066.974665126798;5123.846284611468;4826.227803551415;4889.119958407521;4913.674016052167;4917.311576379381;4984.75076246179;4749.121412538691;4756.643251756202;4811.037792441456;4879.170541007966;4887.218045112765;4756.405449318835;4762.595179409789;4763.333133361401;4763.476017637988;4815;4780.474147843804;4827.879303017312;4840.782164802522;4845.6123510118405;4902.2156454967035;4645.372874661877;4671.065786842577;4679.368285281444;4697.647676424213;4776 08:42:25 INFO - PROCESS | 22187 | |1;ext.html;555.6221769196947;559.3707079535523;570.9457601527855;578.9276340457443;578.9752138714475;28280;39074;40478.39282410759;40608.18783624329;44085.33871991923;41368.37947430791;41633.791831040806;41680.79159604205;41682;41689.58310416895;7705.730299439535;7839.764807055797;7844.254795794391;7845.803854903616;7848.568328741917;7217.963910180441;9849.704508864745;10082.243831712614;10088.243381746363;10471.79056418875;10210.183185345155;10265.435401052939;10270.640527581536;10276.640317588886;10280.794384112312;10011.74970625733;10070.647527336509;10077.244206684529;10078.697639070839;10084.445355505444;9774.951125244399;9900.356476828983;9905.801883962353;9907.653232136912;9912.90087099127;38201.617983820084;38617.227655447015;38621.42067868956;38642;38692;2957.512010518262;3056.617922759655;3102.4260511805387;3154.847182425971;3608.4948107265004;28927.85536072306;29101.12696619105;29125.271868203465;29791.85104074466;30897.845510772528;3315.3037862049;3516.1912760065075;3546.131197856542;3599.5500562429697;3618.059304580802;197025;247147;247473;247532.9999999982;248584;52841.47158528365;53776;53823;53933.191002135;54451;32289;32780.508292375634;33007.83496082504;34495.4825677615;34503.13742156416;13720.93139534296;13905.374258158407;13910.58268251954;13933.721325573431;13941.372638231102;9349.719508414759;10119.342242754197;10617.203709721802;10685.946570267255;10692.839607405895;17520.38678646241;17996.190171442315;18071.548211294823;18078.5480362992;18252.726209106873;6715.630640314829;6797;6863.519553631198;6872.931270687329;6952.965235173893;807.3984881263378;898.6540182029966;960.7598100474881;962.629387685746;969.1132613658424;27383.726162738516;27908.720912791017;28090.578641320397;28521.857390712914;28681.13956581306;938.3619138985418;977.3793641037992;1008.485672307114;1014.0619926567895;1042.838360054193;14772.778408323884;15264.465743698916;15318.846811531743;15435.691286174213;15476.303566339542;386570;390616;392224;392632;393134;48737.512624874005;49075.75462122667;49102.26346604733;49257;49293.75353123211;1068.1508200980084;1094.9178811589163;1144.8683401408944;1151.2459339132881;1179.9705007374885;25375.238742837744;28604.42791144207;29234.269143270736;29934.101976940725;29982.25044373908;41884.79057604692;42389;42392;42398;42418.57581424146;283750;284374;285515;285577;285700;24612.6308105375;25677.486450271263;25697.100601478858;26493.205203843914;26596;41018.58981410267;41165.79417102895;41397;42087.789561052;42405.363919540614;35322.823385882904;35444.46833297554;35819.64180358163;36112.81943590265;36645.63354366422;34578;35483.64516354803;35724.07035226175;35773.46339804853;35920.820395898896;35060.12349691176;35181.29637407186;35621.1094722634;35787;36272.81863590771;30689.232769180948;32798.18004549905;32940.50589241115;32991.50512742263;33128.33743325168;25090.62364064504;25099.623505647796;25513.74486255188;25976.350591234615;25999.610005850307 08:42:25 INFO - PROCESS | 22187 | |2;jquery.html;347.4562309984872;354.599362317113;361.54445398797526;363.33872352318775;378.6194874151477;12803.615891523257;16134.75797863033;16786.328546858127;17162.742558861628;18046.09769511526;17132.571685707833;17378.56553586161;17463.73804392932;17586.736198957027;17681.20434580444;4926.753662316888;5287.259783630295;5549.278593782823;5569.888602227953;5651.095824668054;3551.698105661022;5185.55922746567;5605.831825045255;5636.830895073154;5646.2942132233475;5446.455354464561;5586.078297080977;5587.804426845061;5590.245316882229;5595.328560572717;5335.706536140511;5437;5468.4531546845;5588.0779671354385;5592.720363981784;5273.182656688219;5289.576833853283;5293.788248470095;5295.735213239361;5296;11915.463804128834;17379.39172128982;18770.96759678217;19579.80420195794;19750;1853.369854249548;1914.1099388784144;1944.445832937606;1962.519182800209;1999.4201681512488;8851.911480885237;9091.909080909172;9208.447493150365;9712.465814380206;9819.116279534876;1747.3534792126868;1777.306850328373;1781.7594624725625;1808.3580328983153;1821.945341639753;61326;66137.3386266136;69852.6507367465;70122.64938675326;72070.63964680195;10018.849717254247;10112.241581881388;10183.54174062169;10471.895281047244;10478.63324783629;13965.650858728613;13966.162030278216;13971.650708732159;13976.790348144787;13986.510472133426;6857.931420685729;6981.3716765490335;6995.755148569776;7195.424366050704;7224.67488962998;6443.162388889415;6505.6847456463565;6659.700313485808;6660.9000864987065;6752.459803215731;4159.085001299709;4257.638100761408;4268.338407546835;4300.268954277781;4467.084247729208;1837.6324735053042;1846.26149540185;1848.1683242540641;1913.2442685139292;1937.9612407751765;755.6108604068909;802.4102284820652;805.3034125481533;815.8490679224244;831.9292860106958;16697.582560436087;16992.235349409308;17541.912290438468;17709.645807084045;18184.545386365447;835.4319063037071;853.4921721575653;863.5250612163285;916.3951791817502;931.4923366765129;9397.859032114524;10003.649872254437;10024.298299119138;10046.196304295785;10200.285979981478;386012;389812;395848;399702;400757;76481.61759191168;78559.60720196362;78660.60669696615;78716;80561.59719201367;845.6828689241535;853.0739563297824;886.689658619491;887.5517863478901;888.9866652000226;15103.924480377527;15131.940764146404;15418;15683.607909802346;16026.439074632332;37384;37819.432708508844;38259.42610860783;38595;38782;50459;50516.74741626268;50607;51482.48517514777;51958.22062668987;7569.129550101588;7661.846763064819;7716.92283077162;7904.920950790419;8092.79768005781;11559.942200288944;11600.767984640428;11833.763324733629;11930.22453540517;12070.577529786415;9378.390404623678;9571.234301256021;9598.808023839345;9737.756556086155;10038.29731918788;10036.197104231498;10148.644797432054;10307.94846025765;10366;10701.839472408075;9230.215431688113;9612.231021518402;9644.75888102803;9824.803503930025;10326.173906087344;7585.393168546393;7629.2752188542;7718.614069296625;7785.299323060952;7818.843623127619;8495.277901378453;9079.954600226956;9273.397229180082;9332.393394429611;9814.75463113428 08:42:25 INFO - PROCESS | 22187 | |3;mootools.html;1246.0841281657986;1320.5774152271272;1367.0635614603996;1390.8748212660857;1629.861461775749;7543.924560754398;7851.293383595483;7947.403944704141;8107.108218096005;8112.959435202816;7873.291403773659;7992.600369981492;7993.400494962872;8021.3983951203745;8047.195280471949;1836.9540761481003;2131.7761635028332;2236.127910115052;2253.9098436062536;2260.400993736661;2178.684090806832;2242.76450972648;2242.7981481666648;2246.1127854497463;2248.033345661365;2171.272623671064;2185.25701261571;2185.901634426447;2191.660292654633;2241.8991145398495;2044.5604195097976;2103.863248888825;2111.144986280559;2113.080809847706;2124.415785658941;2192.353255789546;2209.5470428562107;2210.10490751246;2215.1582398688397;2217.2018073493527;8174;8180.263776260105;8216.548089855056;8236.299914507274;8247.628856701464;4471.23988921884;4603.5166307537565;4614.976925115353;4615.353850460938;4615.930761038587;2831.447867665806;2870.598116263725;2985.9402811943855;2986.1937276935323;3007.3534190149003;889.7330800759746;894.9507777072258;911.5351170902821;919.6735159018585;939.2767568971854;10693.358398496115;10810.945945270301;10819.729506762314;10821.513031913582;10840.999999999922;3808.27642747877;3976.781277029791;4007.8998025049023;4046.4132700758223;4155.542890282067;8408.747737567883;8414.579271036424;8420.368472364597;8427.705030323908;8438;4386.934195987063;4387.736735795863;4391.407160033418;4392.682195341385;4393.51671316155;3683.686886614614;4048.5344185418467;4049.331860243086;4109.157622687342;4205.76868272248;3418.162550175223;3432.5537680101925;3490.5636795400574;3528.259065596202;3571.392863213208;1027.825269704152;1034.4672493665769;1037.5123691864812;1038.7922415516928;1043.3166276089173;836.3768992100802;840.7309660908572;851.8977722673195;884.045231150356;897.7665806890255;5460.31746031746;5515.338159420895;5530.364008139035;5607.383187849333;5769.105788602773;409.44929070400264;416.983320667176;420.8926723685441;425.56804843084296;427.95720427956957;3808.961910380916;3889.4749208857006;3889.4943657324366;3893.162969961472;4017.8392864285684;8787.253083487847;8995.505247211335;9025.32310076747;9039.186473217442;9040.728778136667;8819.01840490796;8933.330000250007;8946.86579701305;8958.372913896095;9089.181973622273;6844.486663500257;7019;7023.086998690138;7025.89461158083;7028.824279393056;4999.550040496373;5068.873278168076;5142.820001299937;5154.690718556899;5391.838244852661;8378.539180344897;8407.2433480987;8444.155584441507;8452.830943380975;8504.44721093127;8409.117042710672;8506.191911768372;8538.231559159705;8547.658093676184;8564.272036876686;5792.884142317214;5927.229460170151;5986.6707331097205;6196.411340922786;6258.468030217483;7351.301626345488;7572.280633339824;7626.313631773167;7828.373730101692;7833.138354781084;6909.550879192836;6998.75504357345;7030.753923612649;7046.401055910305;7263.273672632906;6699.933000669931;6745.2242992056545;6749.156355455568;6777.8983315249325;6782.152230971129;6648.767293144717;6663.666816659244;6696.1629796275465;6701.932980670326;6713.63075030878;4732.550407711262;4754.667173297836;4758.072175925661;4884.194107972145;4966.875828104182;4632.212523870882;4693.178693728652;4746;4793.0413917216;4961.578265847444 08:42:25 INFO - PROCESS | 22187 | |4;prototype.html;299.5013302850753;303.54922939434937;305.82873590789154;309.29172195671913;312.2739630359415;4752.928706069403;4790.209615413457;4804.663673542854;4822.20312218913;4829.372181616393;4738.881527961803;4743.335932969387;4744.335792988984;4744.4306683198065;4744.97627511862;3553.6268691787377;3664.8167591620445;3675.2833197526493;3676.76101053432;3684.649958253975;3612.9096772580633;3735.159589092446;3770.8114594270314;3778.6032466591023;3815.5802861685193;3729.384651532494;3735.1595890924596;3744.3634582121103;3752.5552662225105;3767.5478942526934;3560.9821950890077;3729.216864458467;3755.117547376364;3766.868159614428;3768.717346199046;3322.5680661513848;3331.4508753429527;3337.8497967591275;3338.96661033389;3348.7061362966447;4547.886302842422;4590.265557510816;4627.190241707688;4639.744814035227;4645.976770116162;4246.320588705792;4250.702450828443;4251.426057482231;4255.9358711025125;4285.507166675841;4754.286856971447;4954;4970.74416257352;4995.3783506957525;4999.225429886412;3570.6786389225094;3575.6781889630056;3579.355715971124;3587.336342776595;3591.6228795976567;5180.886109486479;5216.217567364888;5222.1905604630965;5237.6071794615555;5246.65896716716;3551.7336199784604;3632.3461776880417;3656.305301992613;3665.211979424383;3675.963240367562;3705.7220708446976;3711.498947642088;3719.1817800083936;3736.701928314067;3739.2521495700967;4204.453421055243;4250.107477429774;4250.341197114452;4258.339957306623;4272.401863739079;4992.975035124801;5000.62495312853;5008.949910500921;5014.674046186986;5069.949300507022;1253.6489782860813;1317.367663521515;1319.8649161720912;1323.715401188749;1330.4345653097396;903.304455569208;911.6809116809196;929.1776777551916;930.7527912597152;933.4912472702393;3954.6074624852126;4261.232978063978;4292.785360732013;4434.467863856294;4442.911141777146;5148.9742551287;5151.742412879341;5157.561607263349;5170.484070831871;5199.7920083197005;4453.22068637987;4458.888527786767;4461.420015398043;4461.5092339842595;4472.195004899149;2626.7898568114506;2705.066751970567;2720.7687346575367;2738.4523095381005;2743.1907587261408;4862.319275301461;4869.342638743795;4883.780229889663;4889.779959901813;4913.484084171182;5253.504585321942;5256.6057545684225;5262.97368513155;5272.472752724773;5275.182346736262;4742.842006886858;4837.830675926326;4851.223804191312;4858.319835223072;4898.559129678346;5094.057599344133;5128.358955130609;5135.38375394955;5136.383633963948;5147.382314122179;5095.668781529189;5098.745062746922;5104.69371837691;5112.795488180431;5120.974395128001;4638.837640682695;4924.901501970012;4949.752512374439;4951.257311403174;4958.157113290677;3688.926221475609;3696.500972368696;3697.1311741741206;3705.5182826232417;3715.721320900889;5169.121249387538;5200.557952574073;5226.947730522798;5239.580833533384;5242.790288388422;4916.844541532809;4981.900361992813;4986.650934434555;5002.224655178453;5012.295819421414;5013.924791128063;5034.219695947134;5035.169197082587;5035.582920198399;5037.974810125926;4971.577415919687;4991.155041626238;4995.750212489288;5005.7997680092385;5011.599072074152;4860.3681521401995;4871.732054736882;4917.409910810726;5051.2423136529815;5059.848204553869;4915.975420122876;4919.409670839522;4923.483034281349;4925.729084900221;4933.210686290176 08:42:25 INFO - PROCESS | 22187 | |5;yui.html;640.318061264753;665.8634979829138;672.8586996730686;721.5959062924759;756.375989808408;13044.217346959178;14060;14108.435662573498;14131.29343532823;14146.221957792317;12742.617721468348;12835;12841.1011229214;12870.034747393936;12873.291968941729;609.4119174996127;729.5804912175494;743.71738739279;747.8466914282586;749.7488341405635;757.9469437139403;759.9924000759977;760.1903972269542;761.0790942958998;761.9276168763959;804.9436539442241;805.3275514945028;806.5080301016376;806.7942674617993;807.289585165054;646.1922596754057;775.4533054196778;794.9824224992019;798.6246464161893;806.4556424413527;585.4321308330913;586.8796896636179;586.9911951320734;587.1427715535324;587.1603606842214;13541.255230962392;13544.661383465493;13557.457701691921;13565.118267312691;13575.45698172072;12893.355332233445;13227.537036203783;13541.729165416637;13557.389917453738;13774.173549587056;11451.484683189277;11489.482973266224;11692.240004399688;12046.759064818654;12051.337176455292;4066.8576599818866;4115.259253334399;4194.832206711728;4231.87304380869;4238;64556.677216613614;64922.3507764921;66962;67964.6601766993;68893.3110668897;10176.694699159038;10608.89391106079;10609.681709548726;10736.463176841127;10751.354918704747;19904.20862122416;19939.10274037672;19951.401457956286;19960.90019549893;19971.60056798856;6917.827054323682;6922.03091567181;6955.826104347432;7007.299270072952;7201.4238860891;3766.981165094157;3767.585565587783;3791.260704162717;3802.429635554689;3843.6925045996254;2733.180045986196;2821.195959151632;2833.249188964926;2836.8014239003073;2837.801353905248;477.7276952137318;483.5502982226493;490.3258020222194;491.93358896548506;496.18873142412417;521.7547752556293;551.6607286518843;602.9366916473795;615.4276522833718;622.1134882792003;8143;8726.69456569017;8889.955550222337;9033.187013168847;9177.77055573616;535.7443479466447;589.2310534752189;619.3868070610154;628.6982248520736;650.5641220382355;4084.4485994390375;4236.4704411948505;4313.202057619288;4325.805338759764;4372.366006928977;98325;102988;105023;108794.45602771935;110074.44962775295;51180.3588290838;53776.73111634495;53982;92300;94825.5258723702;76867;77088.99999999888;77861.22138778653;78201.60899195468;78238;8131.593420329078;8199.918000819915;8213.753587392388;8300.377471689768;8479.830403392021;43639.781801090794;44725.32912006388;44894.3265851019;45779.31331029971;46047;63570.36429635644;65682.67158664177;67115.66442167757;68168;68212;10902.563897444013;10970.506327215135;11170.832437513282;11232.719182020515;11768.94115529417;11742.70643233926;11840.881591183977;11860.22908510944;12322.691932701395;12337.691557711129;10849.294795838245;10918.34489930575;10975.780484390109;11312.94343528277;11596.130290228099;10295.897041029793;10414.791704166026;10662.093722033715;10783.838242426527;11158;11219.270747401393;11320;11411.25826821254;11795.879391457798;11887.524499019943;9163.725088247364;9509.286803489627;9948.751281217737;10107.64623238183;10164.085232329126;8602.354823388147;9215.76960575991;9771.218302535923;9821.705348839547;9827.55775990068 08:42:25 INFO - PROCESS | 22187 | __end_tp_report 08:42:25 INFO - PROCESS | 22187 | __start_cc_report 08:42:25 INFO - PROCESS | 22187 | _x_x_mozilla_cycle_collect,1115 08:42:25 INFO - PROCESS | 22187 | __end_cc_report 08:42:25 INFO - PROCESS | 22187 | __startTimestamp1472139745569__endTimestamp 08:42:25 INFO - PROCESS | 22187 | 08:42:25 INFO - PROCESS | 22187 | ------- Summary: start ------- 08:42:25 INFO - PROCESS | 22187 | Number of tests: 6 08:42:25 INFO - PROCESS | 22187 | 08:42:25 INFO - PROCESS | 22187 | [#0] dojo.html Cycles:165 Average:4606.44 Median:4711.27 stddev:483.55 (10.3%) stddev-sans-first:458.10 08:42:25 INFO - PROCESS | 22187 | Values: 2577.9 2581.5 2593.4 2604.9 2627.9 4472.4 4523.6 4604.5 4650.2 4727.5 4660.7 4663.4 4711.3 4744.4 4753.6 4224.6 4267.8 4324.7 4384.9 4422.0 4285.7 4307.4 4318.4 4343.0 4380.9 4217.1 4255.4 4261.2 4263.0 4295.5 4206.4 4256.0 4264.5 4271.1 4272.4 4244.2 4296.8 4301.7 4317.3 4361.5 4530.4 4668.3 4690.1 4704.1 4707.4 4921.5 4939.5 4986.2 4997.1 5003.2 4965.6 5003.0 5003.4 5029.1 5074.7 4544.3 4649.6 4687.9 4695.5 4702.1 5075.6 5114.1 5141.8 5199.0 5202.7 4905.4 4919.1 4932.2 4955.6 4968.1 4790.9 4915.4 4975.4 4982.8 4989.4 4949.9 5000.7 5028.3 5038.7 5061.0 4940.1 4958.7 4959.0 4959.5 5020.9 4144.8 4276.3 4278.2 4281.4 4338.8 3643.6 3693.7 3728.5 3765.8 3804.6 4280.1 4282.2 4282.9 4286.6 4337.2 4934.7 4947.1 4968.6 4971.9 5012.3 4162.8 4217.1 4231.1 4251.3 4306.5 4494.0 4494.7 4536.1 4545.5 4550.7 4640.8 4642.8 4648.8 4652.2 4709.6 4765.0 4826.6 4827.9 4894.4 4923.7 4635.3 4654.4 4712.0 4754.1 4763.9 4990.9 5000.3 5003.1 5059.7 5061.8 5054.3 5065.3 5065.9 5067.0 5123.8 4826.2 4889.1 4913.7 4917.3 4984.8 4749.1 4756.6 4811.0 4879.2 4887.2 4756.4 4762.6 4763.3 4763.5 4815.0 4780.5 4827.9 4840.8 4845.6 4902.2 4645.4 4671.1 4679.4 4697.6 4776.0 08:42:25 INFO - PROCESS | 22187 | 08:42:25 INFO - PROCESS | 22187 | [#1] ext.html Cycles:180 Average:45879.84 Median:34540.57 stddev:81864.94 (237.0%) stddev-sans-first:82023.86 08:42:25 INFO - PROCESS | 22187 | Values: 555.6 559.4 570.9 578.9 579.0 28280.0 39074.0 40478.4 40608.2 44085.3 41368.4 41633.8 41680.8 41682.0 41689.6 7705.7 7839.8 7844.3 7845.8 7848.6 7218.0 9849.7 10082.2 10088.2 10471.8 10210.2 10265.4 10270.6 10276.6 10280.8 10011.7 10070.6 10077.2 10078.7 10084.4 9775.0 9900.4 9905.8 9907.7 9912.9 38201.6 38617.2 38621.4 38642.0 38692.0 2957.5 3056.6 3102.4 3154.8 3608.5 28927.9 29101.1 29125.3 29791.9 30897.8 3315.3 3516.2 3546.1 3599.6 3618.1 197025.0 247147.0 247473.0 247533.0 248584.0 52841.5 53776.0 53823.0 53933.2 54451.0 32289.0 32780.5 33007.8 34495.5 34503.1 13720.9 13905.4 13910.6 13933.7 13941.4 9349.7 10119.3 10617.2 10685.9 10692.8 17520.4 17996.2 18071.5 18078.5 18252.7 6715.6 6797.0 6863.5 6872.9 6953.0 807.4 898.7 960.8 962.6 969.1 27383.7 27908.7 28090.6 28521.9 28681.1 938.4 977.4 1008.5 1014.1 1042.8 14772.8 15264.5 15318.8 15435.7 15476.3 386570.0 390616.0 392224.0 392632.0 393134.0 48737.5 49075.8 49102.3 49257.0 49293.8 1068.2 1094.9 1144.9 1151.2 1180.0 25375.2 28604.4 29234.3 29934.1 29982.3 41884.8 42389.0 42392.0 42398.0 42418.6 283750.0 284374.0 285515.0 285577.0 285700.0 24612.6 25677.5 25697.1 26493.2 26596.0 41018.6 41165.8 41397.0 42087.8 42405.4 35322.8 35444.5 35819.6 36112.8 36645.6 34578.0 35483.6 35724.1 35773.5 35920.8 35060.1 35181.3 35621.1 35787.0 36272.8 30689.2 32798.2 32940.5 32991.5 33128.3 25090.6 25099.6 25513.7 25976.4 25999.6 08:42:25 INFO - PROCESS | 22187 | 08:42:25 INFO - PROCESS | 22187 | [#2] jquery.html Cycles:180 Average:24364.55 Median:51044.74 stddev:65142.48 (127.6%) stddev-sans-first:65300.26 08:42:25 INFO - PROCESS | 22187 | Values: 347.5 354.6 361.5 363.3 378.6 12803.6 16134.8 16786.3 17162.7 18046.1 17132.6 17378.6 17463.7 17586.7 17681.2 4926.8 5287.3 5549.3 5569.9 5651.1 3551.7 5185.6 5605.8 5636.8 5646.3 5446.5 5586.1 5587.8 5590.2 5595.3 5335.7 5437.0 5468.5 5588.1 5592.7 5273.2 5289.6 5293.8 5295.7 5296.0 11915.5 17379.4 18771.0 19579.8 19750.0 1853.4 1914.1 1944.4 1962.5 1999.4 8851.9 9091.9 9208.4 9712.5 9819.1 1747.4 1777.3 1781.8 1808.4 1821.9 61326.0 66137.3 69852.7 70122.6 72070.6 10018.8 10112.2 10183.5 10471.9 10478.6 13965.7 13966.2 13971.7 13976.8 13986.5 6857.9 6981.4 6995.8 7195.4 7224.7 6443.2 6505.7 6659.7 6660.9 6752.5 4159.1 4257.6 4268.3 4300.3 4467.1 1837.6 1846.3 1848.2 1913.2 1938.0 755.6 802.4 805.3 815.8 831.9 16697.6 16992.2 17541.9 17709.6 18184.5 835.4 853.5 863.5 916.4 931.5 9397.9 10003.6 10024.3 10046.2 10200.3 386012.0 389812.0 395848.0 399702.0 400757.0 76481.6 78559.6 78660.6 78716.0 80561.6 845.7 853.1 886.7 887.6 889.0 15103.9 15131.9 15418.0 15683.6 16026.4 37384.0 37819.4 38259.4 38595.0 38782.0 50459.0 50516.7 50607.0 51482.5 51958.2 7569.1 7661.8 7716.9 7904.9 8092.8 11559.9 11600.8 11833.8 11930.2 12070.6 9378.4 9571.2 9598.8 9737.8 10038.3 10036.2 10148.6 10307.9 10366.0 10701.8 9230.2 9612.2 9644.8 9824.8 10326.2 7585.4 7629.3 7718.6 7785.3 7818.8 8495.3 9080.0 9273.4 9332.4 9814.8 08:42:25 INFO - PROCESS | 22187 | 08:42:25 INFO - PROCESS | 22187 | [#3] mootools.html Cycles:180 Average:5068.98 Median:5034.21 stddev:2821.49 (56.0%) stddev-sans-first:2814.78 08:42:25 INFO - PROCESS | 22187 | Values: 1246.1 1320.6 1367.1 1390.9 1629.9 7543.9 7851.3 7947.4 8107.1 8113.0 7873.3 7992.6 7993.4 8021.4 8047.2 1837.0 2131.8 2236.1 2253.9 2260.4 2178.7 2242.8 2242.8 2246.1 2248.0 2171.3 2185.3 2185.9 2191.7 2241.9 2044.6 2103.9 2111.1 2113.1 2124.4 2192.4 2209.5 2210.1 2215.2 2217.2 8174.0 8180.3 8216.5 8236.3 8247.6 4471.2 4603.5 4615.0 4615.4 4615.9 2831.4 2870.6 2985.9 2986.2 3007.4 889.7 895.0 911.5 919.7 939.3 10693.4 10810.9 10819.7 10821.5 10841.0 3808.3 3976.8 4007.9 4046.4 4155.5 8408.7 8414.6 8420.4 8427.7 8438.0 4386.9 4387.7 4391.4 4392.7 4393.5 3683.7 4048.5 4049.3 4109.2 4205.8 3418.2 3432.6 3490.6 3528.3 3571.4 1027.8 1034.5 1037.5 1038.8 1043.3 836.4 840.7 851.9 884.0 897.8 5460.3 5515.3 5530.4 5607.4 5769.1 409.4 417.0 420.9 425.6 428.0 3809.0 3889.5 3889.5 3893.2 4017.8 8787.3 8995.5 9025.3 9039.2 9040.7 8819.0 8933.3 8946.9 8958.4 9089.2 6844.5 7019.0 7023.1 7025.9 7028.8 4999.6 5068.9 5142.8 5154.7 5391.8 8378.5 8407.2 8444.2 8452.8 8504.4 8409.1 8506.2 8538.2 8547.7 8564.3 5792.9 5927.2 5986.7 6196.4 6258.5 7351.3 7572.3 7626.3 7828.4 7833.1 6909.6 6998.8 7030.8 7046.4 7263.3 6699.9 6745.2 6749.2 6777.9 6782.2 6648.8 6663.7 6696.2 6701.9 6713.6 4732.6 4754.7 4758.1 4884.2 4966.9 4632.2 4693.2 4746.0 4793.0 4961.6 08:42:25 INFO - PROCESS | 22187 | 08:42:25 INFO - PROCESS | 22187 | [#4] prototype.html Cycles:180 Average:4167.07 Median:4744.70 stddev:1201.99 (25.3%) stddev-sans-first:1169.78 08:42:25 INFO - PROCESS | 22187 | Values: 299.5 303.5 305.8 309.3 312.3 4752.9 4790.2 4804.7 4822.2 4829.4 4738.9 4743.3 4744.3 4744.4 4745.0 3553.6 3664.8 3675.3 3676.8 3684.6 3612.9 3735.2 3770.8 3778.6 3815.6 3729.4 3735.2 3744.4 3752.6 3767.5 3561.0 3729.2 3755.1 3766.9 3768.7 3322.6 3331.5 3337.8 3339.0 3348.7 4547.9 4590.3 4627.2 4639.7 4646.0 4246.3 4250.7 4251.4 4255.9 4285.5 4754.3 4954.0 4970.7 4995.4 4999.2 3570.7 3575.7 3579.4 3587.3 3591.6 5180.9 5216.2 5222.2 5237.6 5246.7 3551.7 3632.3 3656.3 3665.2 3676.0 3705.7 3711.5 3719.2 3736.7 3739.3 4204.5 4250.1 4250.3 4258.3 4272.4 4993.0 5000.6 5008.9 5014.7 5069.9 1253.6 1317.4 1319.9 1323.7 1330.4 903.3 911.7 929.2 930.8 933.5 3954.6 4261.2 4292.8 4434.5 4442.9 5149.0 5151.7 5157.6 5170.5 5199.8 4453.2 4458.9 4461.4 4461.5 4472.2 2626.8 2705.1 2720.8 2738.5 2743.2 4862.3 4869.3 4883.8 4889.8 4913.5 5253.5 5256.6 5263.0 5272.5 5275.2 4742.8 4837.8 4851.2 4858.3 4898.6 5094.1 5128.4 5135.4 5136.4 5147.4 5095.7 5098.7 5104.7 5112.8 5121.0 4638.8 4924.9 4949.8 4951.3 4958.2 3688.9 3696.5 3697.1 3705.5 3715.7 5169.1 5200.6 5226.9 5239.6 5242.8 4916.8 4981.9 4986.7 5002.2 5012.3 5013.9 5034.2 5035.2 5035.6 5038.0 4971.6 4991.2 4995.8 5005.8 5011.6 4860.4 4871.7 4917.4 5051.2 5059.8 4916.0 4919.4 4923.5 4925.7 4933.2 08:42:25 INFO - PROCESS | 22187 | 08:42:25 INFO - PROCESS | 22187 | [#5] yui.html Cycles:180 Average:17971.28 Median:23262.36 stddev:25891.80 (111.3%) stddev-sans-first:25931.73 08:42:25 INFO - PROCESS | 22187 | Values: 640.3 665.9 672.9 721.6 756.4 13044.2 14060.0 14108.4 14131.3 14146.2 12742.6 12835.0 12841.1 12870.0 12873.3 609.4 729.6 743.7 747.8 749.7 757.9 760.0 760.2 761.1 761.9 804.9 805.3 806.5 806.8 807.3 646.2 775.5 795.0 798.6 806.5 585.4 586.9 587.0 587.1 587.2 13541.3 13544.7 13557.5 13565.1 13575.5 12893.4 13227.5 13541.7 13557.4 13774.2 11451.5 11489.5 11692.2 12046.8 12051.3 4066.9 4115.3 4194.8 4231.9 4238.0 64556.7 64922.4 66962.0 67964.7 68893.3 10176.7 10608.9 10609.7 10736.5 10751.4 19904.2 19939.1 19951.4 19960.9 19971.6 6917.8 6922.0 6955.8 7007.3 7201.4 3767.0 3767.6 3791.3 3802.4 3843.7 2733.2 2821.2 2833.2 2836.8 2837.8 477.7 483.6 490.3 491.9 496.2 521.8 551.7 602.9 615.4 622.1 8143.0 8726.7 8890.0 9033.2 9177.8 535.7 589.2 619.4 628.7 650.6 4084.4 4236.5 4313.2 4325.8 4372.4 98325.0 102988.0 105023.0 108794.5 110074.4 51180.4 53776.7 53982.0 92300.0 94825.5 76867.0 77089.0 77861.2 78201.6 78238.0 8131.6 8199.9 8213.8 8300.4 8479.8 43639.8 44725.3 44894.3 45779.3 46047.0 63570.4 65682.7 67115.7 68168.0 68212.0 10902.6 10970.5 11170.8 11232.7 11768.9 11742.7 11840.9 11860.2 12322.7 12337.7 10849.3 10918.3 10975.8 11312.9 11596.1 10295.9 10414.8 10662.1 10783.8 11158.0 11219.3 11320.0 11411.3 11795.9 11887.5 9163.7 9509.3 9948.8 10107.6 10164.1 8602.4 9215.8 9771.2 9821.7 9827.6 08:42:25 INFO - PROCESS | 22187 | -------- Summary: end -------- 08:42:25 INFO - PROCESS | 22187 | 08:42:26 INFO - TEST-INFO | 22187: exit 0 08:42:26 INFO - TEST-OK | dromaeo_css | took 1121691ms 08:42:26 INFO - TEST-START | kraken 08:42:26 INFO - operating with platform_type : linux_ 08:42:26 INFO - Initialising browser for kraken test... 08:42:26 INFO - TEST-INFO | started process 22489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8sGVSF/profile http://localhost:51497/getInfo.html) 08:42:31 INFO - PROCESS | 22489 | __metrics Screen width/height:1600/1200 08:42:31 INFO - PROCESS | 22489 | colorDepth:24 08:42:31 INFO - PROCESS | 22489 | Browser inner width/height: 1024/697 08:42:31 INFO - PROCESS | 22489 | __metrics 08:42:31 INFO - PROCESS | 22489 | 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" 08:42:31 INFO - PROCESS | 22489 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:32 INFO - PROCESS | 22489 | console.error: PushService: 08:42:32 INFO - PROCESS | 22489 | stateChangeProcessEnqueue: Error transitioning state 08:42:32 INFO - PROCESS | 22489 | UnknownError 08:42:32 INFO - TEST-INFO | 22489: exit 0 08:42:32 INFO - Browser initialized. 08:42:32 INFO - Running cycle 1/1 for kraken test... 08:42:32 INFO - TEST-INFO | started process 22570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8sGVSF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:45 INFO - PROCESS | 22570 | RSS: Main: 179593216 08:42:45 INFO - PROCESS | 22570 | 08:42:47 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51497/tests/kraken/driver.html?testName=audio-beat-detection) 08:42:48 INFO - PROCESS | 22570 | RSS: Main: 233549824 08:42:48 INFO - PROCESS | 22570 | 08:42:51 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51497/tests/kraken/driver.html?testName=audio-dft) 08:42:52 INFO - PROCESS | 22570 | RSS: Main: 223682560 08:42:52 INFO - PROCESS | 22570 | 08:42:55 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51497/tests/kraken/driver.html?testName=audio-fft) 08:42:56 INFO - PROCESS | 22570 | RSS: Main: 302370816 08:42:56 INFO - PROCESS | 22570 | 08:42:58 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51497/tests/kraken/driver.html?testName=audio-oscillator) 08:42:58 INFO - PROCESS | 22570 | RSS: Main: 213078016 08:42:58 INFO - PROCESS | 22570 | 08:43:01 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51497/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:43:01 INFO - PROCESS | 22570 | RSS: Main: 213893120 08:43:01 INFO - PROCESS | 22570 | 08:43:04 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51497/tests/kraken/driver.html?testName=imaging-darkroom) 08:43:05 INFO - PROCESS | 22570 | RSS: Main: 252162048 08:43:05 INFO - PROCESS | 22570 | 08:43:09 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51497/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:09 INFO - PROCESS | 22570 | RSS: Main: 246607872 08:43:09 INFO - PROCESS | 22570 | 08:43:12 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51497/tests/kraken/driver.html?testName=json-parse-financial) 08:43:13 INFO - PROCESS | 22570 | RSS: Main: 249733120 08:43:13 INFO - PROCESS | 22570 | 08:43:14 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51497/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:15 INFO - PROCESS | 22570 | RSS: Main: 213245952 08:43:15 INFO - PROCESS | 22570 | 08:43:17 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:18 INFO - PROCESS | 22570 | RSS: Main: 220602368 08:43:18 INFO - PROCESS | 22570 | 08:43:20 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:20 INFO - PROCESS | 22570 | RSS: Main: 222175232 08:43:20 INFO - PROCESS | 22570 | 08:43:23 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:24 INFO - PROCESS | 22570 | RSS: Main: 222113792 08:43:24 INFO - PROCESS | 22570 | 08:43:27 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:27 INFO - PROCESS | 22570 | RSS: Main: 220606464 08:43:27 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51497/tests/kraken/driver.html?testName=ai-astar) 08:43:29 INFO - PROCESS | 22570 | RSS: Main: 271638528 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | __start_tp_report 08:43:29 INFO - PROCESS | 22570 | _x_x_mozilla_page_load 08:43:29 INFO - PROCESS | 22570 | _x_x_mozilla_page_load_details 08:43:29 INFO - PROCESS | 22570 | |i|pagename|runs| 08:43:29 INFO - PROCESS | 22570 | |0;ai-astar;116;115;132;116;115;117;116;114;114;115 08:43:29 INFO - PROCESS | 22570 | |1;audio-beat-detection;160;124;148;186;122;159;147;124;179;122 08:43:29 INFO - PROCESS | 22570 | |2;audio-dft;162;163;162;162;161;161;161;161;161;160 08:43:29 INFO - PROCESS | 22570 | |3;audio-fft;75;74;77;164;78;77;78;77;181;77 08:43:29 INFO - PROCESS | 22570 | |4;audio-oscillator;87;89;165;87;87;85;145;86;86;143 08:43:29 INFO - PROCESS | 22570 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;117;117;116 08:43:29 INFO - PROCESS | 22570 | |6;imaging-darkroom;146;146;146;146;147;146;146;145;146;146 08:43:29 INFO - PROCESS | 22570 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 08:43:29 INFO - PROCESS | 22570 | |8;json-parse-financial;66;66;67;67;66;67;66;66;66;67 08:43:29 INFO - PROCESS | 22570 | |9;json-stringify-tinderbox;64;65;66;65;66;64;66;65;66;65 08:43:29 INFO - PROCESS | 22570 | |10;stanford-crypto-aes;82;82;89;82;85;86;88;88;83;81 08:43:29 INFO - PROCESS | 22570 | |11;stanford-crypto-ccm;137;135;133;133;132;133;149;136;187;141 08:43:29 INFO - PROCESS | 22570 | |12;stanford-crypto-pbkdf2;174;175;173;169;173;173;169;171;174;174 08:43:29 INFO - PROCESS | 22570 | |13;stanford-crypto-sha256-iterative;67;68;69;69;68;68;68;68;68;67 08:43:29 INFO - PROCESS | 22570 | __end_tp_report 08:43:29 INFO - PROCESS | 22570 | __start_cc_report 08:43:29 INFO - PROCESS | 22570 | _x_x_mozilla_cycle_collect,2000 08:43:29 INFO - PROCESS | 22570 | __end_cc_report 08:43:29 INFO - PROCESS | 22570 | __startTimestamp1472139809962__endTimestamp 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | ------- Summary: start ------- 08:43:29 INFO - PROCESS | 22570 | Number of tests: 14 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#0] ai-astar Cycles:10 Average:117.00 Median:116.00 stddev:5.35 (4.6%) stddev-sans-first:5.67 08:43:29 INFO - PROCESS | 22570 | Values: 116.0 115.0 132.0 116.0 115.0 117.0 116.0 114.0 114.0 115.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:153.50 stddev:23.96 (15.6%) stddev-sans-first:24.95 08:43:29 INFO - PROCESS | 22570 | Values: 160.0 124.0 148.0 186.0 122.0 159.0 147.0 124.0 179.0 122.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 08:43:29 INFO - PROCESS | 22570 | Values: 162.0 163.0 162.0 162.0 161.0 161.0 161.0 161.0 161.0 160.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#3] audio-fft Cycles:10 Average:95.80 Median:77.00 stddev:40.64 (52.8%) stddev-sans-first:42.40 08:43:29 INFO - PROCESS | 22570 | Values: 75.0 74.0 77.0 164.0 78.0 77.0 78.0 77.0 181.0 77.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#4] audio-oscillator Cycles:10 Average:106.00 Median:86.50 stddev:31.59 (36.5%) stddev-sans-first:32.75 08:43:29 INFO - PROCESS | 22570 | Values: 87.0 89.0 165.0 87.0 87.0 85.0 145.0 86.0 86.0 143.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:43:29 INFO - PROCESS | 22570 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 08:43:29 INFO - PROCESS | 22570 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 146.0 146.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:43:29 INFO - PROCESS | 22570 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 08:43:29 INFO - PROCESS | 22570 | Values: 66.0 66.0 67.0 67.0 66.0 67.0 66.0 66.0 66.0 67.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 08:43:29 INFO - PROCESS | 22570 | Values: 64.0 65.0 66.0 65.0 66.0 64.0 66.0 65.0 66.0 65.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.50 stddev:2.99 (3.5%) stddev-sans-first:3.02 08:43:29 INFO - PROCESS | 22570 | Values: 82.0 82.0 89.0 82.0 85.0 86.0 88.0 88.0 83.0 81.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:136.50 stddev:16.75 (12.3%) stddev-sans-first:17.69 08:43:29 INFO - PROCESS | 22570 | Values: 137.0 135.0 133.0 133.0 132.0 133.0 149.0 136.0 187.0 141.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.50 stddev:2.12 (1.2%) stddev-sans-first:2.18 08:43:29 INFO - PROCESS | 22570 | Values: 174.0 175.0 173.0 169.0 173.0 173.0 169.0 171.0 174.0 174.0 08:43:29 INFO - PROCESS | 22570 | 08:43:29 INFO - PROCESS | 22570 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 08:43:29 INFO - PROCESS | 22570 | Values: 67.0 68.0 69.0 69.0 68.0 68.0 68.0 68.0 68.0 67.0 08:43:29 INFO - PROCESS | 22570 | -------- Summary: end -------- 08:43:29 INFO - PROCESS | 22570 | 08:43:31 INFO - TEST-INFO | 22570: exit 0 08:43:31 INFO - TEST-OK | kraken | took 64860ms 08:43:31 INFO - SUITE-END | took 1186s 08:43:31 INFO - Completed test suite (00:19:46) 08:43:31 INFO - javascript benchmark 08:43:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.9355516112096, 2581.4966081614093, 2593.4294455219847, 2604.9348766280846, 2627.855467949263, 4472.41858558387, 4523.592876641102, 4604.493505714368, 4650.23271160259, 4727.52724727527, 4660.720356778587, 4663.370444989934, 4711.269753188253, 4744.383230180072, 4753.643476739249, 4224.61978421942, 4267.765272909989, 4324.718893271927, 4384.868453946387, 4421.9829439229, 4285.721428107163, 4307.353896915456, 4318.438602981623, 4343.04453020335, 4380.934285985712, 4217.135487225111, 4255.425517555122, 4261.2329780639475, 4263.0, 4295.52749197588, 4206.3690446432975, 4256.0, 4264.466941632296, 4271.124419494027, 4272.380504826782, 4244.151169766028, 4296.763677997709, 4301.741895486281, 4317.266064768997, 4361.498427680825, 4530.433695788027, 4668.346431499593, 4690.132325519756, 4704.059188162347, 4707.38803955487, 4921.458639549646, 4939.481354457766, 4986.152354099775, 4997.125503036954, 5003.224500202475, 4965.627577931634, 5003.024410240005, 5003.374578177728, 5029.06962211992, 5074.720890351029, 4544.341070544819, 4649.581537661559, 4687.882802929886, 4695.483496815347, 4702.130105930414, 5075.593952483792, 5114.105031619451, 5141.794328226903, 5198.9740051299505, 5202.739863006835, 4905.3623029006, 4919.06537757832, 4932.21084626458, 4955.603551715854, 4968.105740966661, 4790.856274311776, 4915.3855768029, 4975.402951645826, 4982.77577509013, 4989.426215985208, 4949.851504454872, 5000.699958002531, 5028.296038554606, 5038.672486288379, 5061.013102444987, 4940.110780059552, 4958.7024778513405, 4958.975205124024, 4959.454460009396, 5020.949790502048, 4144.79276036203, 4276.31578947367, 4278.187144442546, 4281.422008028876, 4338.826446942087, 3643.562772467321, 3693.722970777149, 3728.5339332583426, 3765.792881391495, 3804.6385593368586, 4280.122574872144, 4282.164977829356, 4282.89292767677, 4286.571342865688, 4337.1976184405985, 4934.703917764874, 4947.060058588857, 4968.552830245295, 4971.925421118686, 5012.273220383024, 4162.812673429703, 4217.072244106292, 4231.132617813341, 4251.319788833772, 4306.504751953566, 4493.955060449419, 4494.685372023992, 4536.115457485825, 4545.477270113913, 4550.726956382628, 4640.767961601907, 4642.837500687459, 4648.83729069481, 4652.185867473247, 4709.646776491708, 4765.0469906019625, 4826.58973987201, 4827.903441931212, 4894.437139728834, 4923.729194894315, 4635.258358662598, 4654.394928659252, 4712.034033023154, 4754.120487709784, 4763.904721905473, 4990.925136123034, 5000.349954505891, 5003.099442100457, 5059.747012649426, 5061.797528098835, 5054.2923990642075, 5065.290859279778, 5065.8733531662, 5066.974665126798, 5123.846284611468, 4826.227803551415, 4889.119958407521, 4913.674016052167, 4917.311576379381, 4984.75076246179, 4749.121412538691, 4756.643251756202, 4811.037792441456, 4879.170541007966, 4887.218045112765, 4756.405449318835, 4762.595179409789, 4763.333133361401, 4763.476017637988, 4815.0, 4780.474147843804, 4827.879303017312, 4840.782164802522, 4845.6123510118405, 4902.2156454967035, 4645.372874661877, 4671.065786842577, 4679.368285281444, 4697.647676424213, 4776.0], "value": 4575.546105397344, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.6221769196947, 559.3707079535523, 570.9457601527855, 578.9276340457443, 578.9752138714475, 28280.0, 39074.0, 40478.39282410759, 40608.18783624329, 44085.33871991923, 41368.37947430791, 41633.791831040806, 41680.79159604205, 41682.0, 41689.58310416895, 7705.730299439535, 7839.764807055797, 7844.254795794391, 7845.803854903616, 7848.568328741917, 7217.963910180441, 9849.704508864745, 10082.243831712614, 10088.243381746363, 10471.79056418875, 10210.183185345155, 10265.435401052939, 10270.640527581536, 10276.640317588886, 10280.794384112312, 10011.74970625733, 10070.647527336509, 10077.244206684529, 10078.697639070839, 10084.445355505444, 9774.951125244399, 9900.356476828983, 9905.801883962353, 9907.653232136912, 9912.90087099127, 38201.617983820084, 38617.227655447015, 38621.42067868956, 38642.0, 38692.0, 2957.512010518262, 3056.617922759655, 3102.4260511805387, 3154.847182425971, 3608.4948107265004, 28927.85536072306, 29101.12696619105, 29125.271868203465, 29791.85104074466, 30897.845510772528, 3315.3037862049, 3516.1912760065075, 3546.131197856542, 3599.5500562429697, 3618.059304580802, 197025.0, 247147.0, 247473.0, 247532.9999999982, 248584.0, 52841.47158528365, 53776.0, 53823.0, 53933.191002135, 54451.0, 32289.0, 32780.508292375634, 33007.83496082504, 34495.4825677615, 34503.13742156416, 13720.93139534296, 13905.374258158407, 13910.58268251954, 13933.721325573431, 13941.372638231102, 9349.719508414759, 10119.342242754197, 10617.203709721802, 10685.946570267255, 10692.839607405895, 17520.38678646241, 17996.190171442315, 18071.548211294823, 18078.5480362992, 18252.726209106873, 6715.630640314829, 6797.0, 6863.519553631198, 6872.931270687329, 6952.965235173893, 807.3984881263378, 898.6540182029966, 960.7598100474881, 962.629387685746, 969.1132613658424, 27383.726162738516, 27908.720912791017, 28090.578641320397, 28521.857390712914, 28681.13956581306, 938.3619138985418, 977.3793641037992, 1008.485672307114, 1014.0619926567895, 1042.838360054193, 14772.778408323884, 15264.465743698916, 15318.846811531743, 15435.691286174213, 15476.303566339542, 386570.0, 390616.0, 392224.0, 392632.0, 393134.0, 48737.512624874005, 49075.75462122667, 49102.26346604733, 49257.0, 49293.75353123211, 1068.1508200980084, 1094.9178811589163, 1144.8683401408944, 1151.2459339132881, 1179.9705007374885, 25375.238742837744, 28604.42791144207, 29234.269143270736, 29934.101976940725, 29982.25044373908, 41884.79057604692, 42389.0, 42392.0, 42398.0, 42418.57581424146, 283750.0, 284374.0, 285515.0, 285577.0, 285700.0, 24612.6308105375, 25677.486450271263, 25697.100601478858, 26493.205203843914, 26596.0, 41018.58981410267, 41165.79417102895, 41397.0, 42087.789561052, 42405.363919540614, 35322.823385882904, 35444.46833297554, 35819.64180358163, 36112.81943590265, 36645.63354366422, 34578.0, 35483.64516354803, 35724.07035226175, 35773.46339804853, 35920.820395898896, 35060.12349691176, 35181.29637407186, 35621.1094722634, 35787.0, 36272.81863590771, 30689.232769180948, 32798.18004549905, 32940.50589241115, 32991.50512742263, 33128.33743325168, 25090.62364064504, 25099.623505647796, 25513.74486255188, 25976.350591234615, 25999.610005850307], "value": 17666.822678740085, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.4562309984872, 354.599362317113, 361.54445398797526, 363.33872352318775, 378.6194874151477, 12803.615891523257, 16134.75797863033, 16786.328546858127, 17162.742558861628, 18046.09769511526, 17132.571685707833, 17378.56553586161, 17463.73804392932, 17586.736198957027, 17681.20434580444, 4926.753662316888, 5287.259783630295, 5549.278593782823, 5569.888602227953, 5651.095824668054, 3551.698105661022, 5185.55922746567, 5605.831825045255, 5636.830895073154, 5646.2942132233475, 5446.455354464561, 5586.078297080977, 5587.804426845061, 5590.245316882229, 5595.328560572717, 5335.706536140511, 5437.0, 5468.4531546845, 5588.0779671354385, 5592.720363981784, 5273.182656688219, 5289.576833853283, 5293.788248470095, 5295.735213239361, 5296.0, 11915.463804128834, 17379.39172128982, 18770.96759678217, 19579.80420195794, 19750.0, 1853.369854249548, 1914.1099388784144, 1944.445832937606, 1962.519182800209, 1999.4201681512488, 8851.911480885237, 9091.909080909172, 9208.447493150365, 9712.465814380206, 9819.116279534876, 1747.3534792126868, 1777.306850328373, 1781.7594624725625, 1808.3580328983153, 1821.945341639753, 61326.0, 66137.3386266136, 69852.6507367465, 70122.64938675326, 72070.63964680195, 10018.849717254247, 10112.241581881388, 10183.54174062169, 10471.895281047244, 10478.63324783629, 13965.650858728613, 13966.162030278216, 13971.650708732159, 13976.790348144787, 13986.510472133426, 6857.931420685729, 6981.3716765490335, 6995.755148569776, 7195.424366050704, 7224.67488962998, 6443.162388889415, 6505.6847456463565, 6659.700313485808, 6660.9000864987065, 6752.459803215731, 4159.085001299709, 4257.638100761408, 4268.338407546835, 4300.268954277781, 4467.084247729208, 1837.6324735053042, 1846.26149540185, 1848.1683242540641, 1913.2442685139292, 1937.9612407751765, 755.6108604068909, 802.4102284820652, 805.3034125481533, 815.8490679224244, 831.9292860106958, 16697.582560436087, 16992.235349409308, 17541.912290438468, 17709.645807084045, 18184.545386365447, 835.4319063037071, 853.4921721575653, 863.5250612163285, 916.3951791817502, 931.4923366765129, 9397.859032114524, 10003.649872254437, 10024.298299119138, 10046.196304295785, 10200.285979981478, 386012.0, 389812.0, 395848.0, 399702.0, 400757.0, 76481.61759191168, 78559.60720196362, 78660.60669696615, 78716.0, 80561.59719201367, 845.6828689241535, 853.0739563297824, 886.689658619491, 887.5517863478901, 888.9866652000226, 15103.924480377527, 15131.940764146404, 15418.0, 15683.607909802346, 16026.439074632332, 37384.0, 37819.432708508844, 38259.42610860783, 38595.0, 38782.0, 50459.0, 50516.74741626268, 50607.0, 51482.48517514777, 51958.22062668987, 7569.129550101588, 7661.846763064819, 7716.92283077162, 7904.920950790419, 8092.79768005781, 11559.942200288944, 11600.767984640428, 11833.763324733629, 11930.22453540517, 12070.577529786415, 9378.390404623678, 9571.234301256021, 9598.808023839345, 9737.756556086155, 10038.29731918788, 10036.197104231498, 10148.644797432054, 10307.94846025765, 10366.0, 10701.839472408075, 9230.215431688113, 9612.231021518402, 9644.75888102803, 9824.803503930025, 10326.173906087344, 7585.393168546393, 7629.2752188542, 7718.614069296625, 7785.299323060952, 7818.843623127619, 8495.277901378453, 9079.954600226956, 9273.397229180082, 9332.393394429611, 9814.75463113428], "value": 8135.137841445549, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1246.0841281657986, 1320.5774152271272, 1367.0635614603996, 1390.8748212660857, 1629.861461775749, 7543.924560754398, 7851.293383595483, 7947.403944704141, 8107.108218096005, 8112.959435202816, 7873.291403773659, 7992.600369981492, 7993.400494962872, 8021.3983951203745, 8047.195280471949, 1836.9540761481003, 2131.7761635028332, 2236.127910115052, 2253.9098436062536, 2260.400993736661, 2178.684090806832, 2242.76450972648, 2242.7981481666648, 2246.1127854497463, 2248.033345661365, 2171.272623671064, 2185.25701261571, 2185.901634426447, 2191.660292654633, 2241.8991145398495, 2044.5604195097976, 2103.863248888825, 2111.144986280559, 2113.080809847706, 2124.415785658941, 2192.353255789546, 2209.5470428562107, 2210.10490751246, 2215.1582398688397, 2217.2018073493527, 8174.0, 8180.263776260105, 8216.548089855056, 8236.299914507274, 8247.628856701464, 4471.23988921884, 4603.5166307537565, 4614.976925115353, 4615.353850460938, 4615.930761038587, 2831.447867665806, 2870.598116263725, 2985.9402811943855, 2986.1937276935323, 3007.3534190149003, 889.7330800759746, 894.9507777072258, 911.5351170902821, 919.6735159018585, 939.2767568971854, 10693.358398496115, 10810.945945270301, 10819.729506762314, 10821.513031913582, 10840.999999999922, 3808.27642747877, 3976.781277029791, 4007.8998025049023, 4046.4132700758223, 4155.542890282067, 8408.747737567883, 8414.579271036424, 8420.368472364597, 8427.705030323908, 8438.0, 4386.934195987063, 4387.736735795863, 4391.407160033418, 4392.682195341385, 4393.51671316155, 3683.686886614614, 4048.5344185418467, 4049.331860243086, 4109.157622687342, 4205.76868272248, 3418.162550175223, 3432.5537680101925, 3490.5636795400574, 3528.259065596202, 3571.392863213208, 1027.825269704152, 1034.4672493665769, 1037.5123691864812, 1038.7922415516928, 1043.3166276089173, 836.3768992100802, 840.7309660908572, 851.8977722673195, 884.045231150356, 897.7665806890255, 5460.31746031746, 5515.338159420895, 5530.364008139035, 5607.383187849333, 5769.105788602773, 409.44929070400264, 416.983320667176, 420.8926723685441, 425.56804843084296, 427.95720427956957, 3808.961910380916, 3889.4749208857006, 3889.4943657324366, 3893.162969961472, 4017.8392864285684, 8787.253083487847, 8995.505247211335, 9025.32310076747, 9039.186473217442, 9040.728778136667, 8819.01840490796, 8933.330000250007, 8946.86579701305, 8958.372913896095, 9089.181973622273, 6844.486663500257, 7019.0, 7023.086998690138, 7025.89461158083, 7028.824279393056, 4999.550040496373, 5068.873278168076, 5142.820001299937, 5154.690718556899, 5391.838244852661, 8378.539180344897, 8407.2433480987, 8444.155584441507, 8452.830943380975, 8504.44721093127, 8409.117042710672, 8506.191911768372, 8538.231559159705, 8547.658093676184, 8564.272036876686, 5792.884142317214, 5927.229460170151, 5986.6707331097205, 6196.411340922786, 6258.468030217483, 7351.301626345488, 7572.280633339824, 7626.313631773167, 7828.373730101692, 7833.138354781084, 6909.550879192836, 6998.75504357345, 7030.753923612649, 7046.401055910305, 7263.273672632906, 6699.933000669931, 6745.2242992056545, 6749.156355455568, 6777.8983315249325, 6782.152230971129, 6648.767293144717, 6663.666816659244, 6696.1629796275465, 6701.932980670326, 6713.63075030878, 4732.550407711262, 4754.667173297836, 4758.072175925661, 4884.194107972145, 4966.875828104182, 4632.212523870882, 4693.178693728652, 4746.0, 4793.0413917216, 4961.578265847444], "value": 4017.6820893351774, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.5013302850753, 303.54922939434937, 305.82873590789154, 309.29172195671913, 312.2739630359415, 4752.928706069403, 4790.209615413457, 4804.663673542854, 4822.20312218913, 4829.372181616393, 4738.881527961803, 4743.335932969387, 4744.335792988984, 4744.4306683198065, 4744.97627511862, 3553.6268691787377, 3664.8167591620445, 3675.2833197526493, 3676.76101053432, 3684.649958253975, 3612.9096772580633, 3735.159589092446, 3770.8114594270314, 3778.6032466591023, 3815.5802861685193, 3729.384651532494, 3735.1595890924596, 3744.3634582121103, 3752.5552662225105, 3767.5478942526934, 3560.9821950890077, 3729.216864458467, 3755.117547376364, 3766.868159614428, 3768.717346199046, 3322.5680661513848, 3331.4508753429527, 3337.8497967591275, 3338.96661033389, 3348.7061362966447, 4547.886302842422, 4590.265557510816, 4627.190241707688, 4639.744814035227, 4645.976770116162, 4246.320588705792, 4250.702450828443, 4251.426057482231, 4255.9358711025125, 4285.507166675841, 4754.286856971447, 4954.0, 4970.74416257352, 4995.3783506957525, 4999.225429886412, 3570.6786389225094, 3575.6781889630056, 3579.355715971124, 3587.336342776595, 3591.6228795976567, 5180.886109486479, 5216.217567364888, 5222.1905604630965, 5237.6071794615555, 5246.65896716716, 3551.7336199784604, 3632.3461776880417, 3656.305301992613, 3665.211979424383, 3675.963240367562, 3705.7220708446976, 3711.498947642088, 3719.1817800083936, 3736.701928314067, 3739.2521495700967, 4204.453421055243, 4250.107477429774, 4250.341197114452, 4258.339957306623, 4272.401863739079, 4992.975035124801, 5000.62495312853, 5008.949910500921, 5014.674046186986, 5069.949300507022, 1253.6489782860813, 1317.367663521515, 1319.8649161720912, 1323.715401188749, 1330.4345653097396, 903.304455569208, 911.6809116809196, 929.1776777551916, 930.7527912597152, 933.4912472702393, 3954.6074624852126, 4261.232978063978, 4292.785360732013, 4434.467863856294, 4442.911141777146, 5148.9742551287, 5151.742412879341, 5157.561607263349, 5170.484070831871, 5199.7920083197005, 4453.22068637987, 4458.888527786767, 4461.420015398043, 4461.5092339842595, 4472.195004899149, 2626.7898568114506, 2705.066751970567, 2720.7687346575367, 2738.4523095381005, 2743.1907587261408, 4862.319275301461, 4869.342638743795, 4883.780229889663, 4889.779959901813, 4913.484084171182, 5253.504585321942, 5256.6057545684225, 5262.97368513155, 5272.472752724773, 5275.182346736262, 4742.842006886858, 4837.830675926326, 4851.223804191312, 4858.319835223072, 4898.559129678346, 5094.057599344133, 5128.358955130609, 5135.38375394955, 5136.383633963948, 5147.382314122179, 5095.668781529189, 5098.745062746922, 5104.69371837691, 5112.795488180431, 5120.974395128001, 4638.837640682695, 4924.901501970012, 4949.752512374439, 4951.257311403174, 4958.157113290677, 3688.926221475609, 3696.500972368696, 3697.1311741741206, 3705.5182826232417, 3715.721320900889, 5169.121249387538, 5200.557952574073, 5226.947730522798, 5239.580833533384, 5242.790288388422, 4916.844541532809, 4981.900361992813, 4986.650934434555, 5002.224655178453, 5012.295819421414, 5013.924791128063, 5034.219695947134, 5035.169197082587, 5035.582920198399, 5037.974810125926, 4971.577415919687, 4991.155041626238, 4995.750212489288, 5005.7997680092385, 5011.599072074152, 4860.3681521401995, 4871.732054736882, 4917.409910810726, 5051.2423136529815, 5059.848204553869, 4915.975420122876, 4919.409670839522, 4923.483034281349, 4925.729084900221, 4933.210686290176], "value": 3793.277374815197, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.318061264753, 665.8634979829138, 672.8586996730686, 721.5959062924759, 756.375989808408, 13044.217346959178, 14060.0, 14108.435662573498, 14131.29343532823, 14146.221957792317, 12742.617721468348, 12835.0, 12841.1011229214, 12870.034747393936, 12873.291968941729, 609.4119174996127, 729.5804912175494, 743.71738739279, 747.8466914282586, 749.7488341405635, 757.9469437139403, 759.9924000759977, 760.1903972269542, 761.0790942958998, 761.9276168763959, 804.9436539442241, 805.3275514945028, 806.5080301016376, 806.7942674617993, 807.289585165054, 646.1922596754057, 775.4533054196778, 794.9824224992019, 798.6246464161893, 806.4556424413527, 585.4321308330913, 586.8796896636179, 586.9911951320734, 587.1427715535324, 587.1603606842214, 13541.255230962392, 13544.661383465493, 13557.457701691921, 13565.118267312691, 13575.45698172072, 12893.355332233445, 13227.537036203783, 13541.729165416637, 13557.389917453738, 13774.173549587056, 11451.484683189277, 11489.482973266224, 11692.240004399688, 12046.759064818654, 12051.337176455292, 4066.8576599818866, 4115.259253334399, 4194.832206711728, 4231.87304380869, 4238.0, 64556.677216613614, 64922.3507764921, 66962.0, 67964.6601766993, 68893.3110668897, 10176.694699159038, 10608.89391106079, 10609.681709548726, 10736.463176841127, 10751.354918704747, 19904.20862122416, 19939.10274037672, 19951.401457956286, 19960.90019549893, 19971.60056798856, 6917.827054323682, 6922.03091567181, 6955.826104347432, 7007.299270072952, 7201.4238860891, 3766.981165094157, 3767.585565587783, 3791.260704162717, 3802.429635554689, 3843.6925045996254, 2733.180045986196, 2821.195959151632, 2833.249188964926, 2836.8014239003073, 2837.801353905248, 477.7276952137318, 483.5502982226493, 490.3258020222194, 491.93358896548506, 496.18873142412417, 521.7547752556293, 551.6607286518843, 602.9366916473795, 615.4276522833718, 622.1134882792003, 8143.0, 8726.69456569017, 8889.955550222337, 9033.187013168847, 9177.77055573616, 535.7443479466447, 589.2310534752189, 619.3868070610154, 628.6982248520736, 650.5641220382355, 4084.4485994390375, 4236.4704411948505, 4313.202057619288, 4325.805338759764, 4372.366006928977, 98325.0, 102988.0, 105023.0, 108794.45602771935, 110074.44962775295, 51180.3588290838, 53776.73111634495, 53982.0, 92300.0, 94825.5258723702, 76867.0, 77088.99999999888, 77861.22138778653, 78201.60899195468, 78238.0, 8131.593420329078, 8199.918000819915, 8213.753587392388, 8300.377471689768, 8479.830403392021, 43639.781801090794, 44725.32912006388, 44894.3265851019, 45779.31331029971, 46047.0, 63570.36429635644, 65682.67158664177, 67115.66442167757, 68168.0, 68212.0, 10902.563897444013, 10970.506327215135, 11170.832437513282, 11232.719182020515, 11768.94115529417, 11742.70643233926, 11840.881591183977, 11860.22908510944, 12322.691932701395, 12337.691557711129, 10849.294795838245, 10918.34489930575, 10975.780484390109, 11312.94343528277, 11596.130290228099, 10295.897041029793, 10414.791704166026, 10662.093722033715, 10783.838242426527, 11158.0, 11219.270747401393, 11320.0, 11411.25826821254, 11795.879391457798, 11887.524499019943, 9163.725088247364, 9509.286803489627, 9948.751281217737, 10107.64623238183, 10164.085232329126, 8602.354823388147, 9215.76960575991, 9771.218302535923, 9821.705348839547, 9827.55775990068], "value": 6618.295822737379, "unit": "score"}], "name": "dromaeo_css", "value": 6362.46922702068, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 132.0, 116.0, 115.0, 117.0, 116.0, 114.0, 114.0, 115.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 124.0, 148.0, 186.0, 122.0, 159.0, 147.0, 124.0, 179.0, 122.0], "value": 147.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 164.0, 78.0, 77.0, 78.0, 77.0, 181.0, 77.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 165.0, 87.0, 87.0, 85.0, 145.0, 86.0, 86.0, 143.0], "value": 106.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 65.0, 66.0, 64.0, 66.0, 65.0, 66.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 89.0, 82.0, 85.0, 86.0, 88.0, 88.0, 83.0, 81.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 133.0, 133.0, 132.0, 133.0, 149.0, 136.0, 187.0, 141.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 173.0, 169.0, 173.0, 173.0, 169.0, 171.0, 174.0, 174.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1583.3999999999999, "alertThreshold": 2.0}]} 08:43:31 INFO - Return code: 0 08:43:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:43:31 INFO - # TBPL SUCCESS # 08:43:31 INFO - Running post-action listener: _resource_record_post_action 08:43:31 INFO - [mozharness: 2016-08-25 15:43:31.784179Z] Finished run-tests step (success) 08:43:31 INFO - Running post-run listener: _resource_record_post_run 08:43:31 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 416530432; Read time: 0; Write time: 295884 08:43:31 INFO - TinderboxPrint: CPU usage
13.0% 08:43:31 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:43:31 INFO - TinderboxPrint: I/O write bytes / time
416,530,432 / 295,884 08:43:31 INFO - TinderboxPrint: CPU idle
8,349.2 (87.0%) 08:43:31 INFO - TinderboxPrint: CPU user
1,201.0 (12.5%) 08:43:31 INFO - TinderboxPrint: Swap in / out
0 / 0 08:43:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124837888; Read time: 0; Write time: 86416 08:43:31 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291692544; Read time: 0; Write time: 209468 08:43:32 INFO - Running post-run listener: _upload_blobber_files 08:43:32 INFO - Blob upload gear active. 08:43:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:43:32 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 08:43:32 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:43:32 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:43:32 INFO - (blobuploader) - INFO - Open directory for files ... 08:43:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:43:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:43:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:36 INFO - (blobuploader) - INFO - Done attempting. 08:43:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:43:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:43:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:37 INFO - (blobuploader) - INFO - Done attempting. 08:43:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:43:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:43:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:38 INFO - (blobuploader) - INFO - Done attempting. 08:43:38 INFO - (blobuploader) - INFO - Iteration through files over. 08:43:38 INFO - Return code: 0 08:43:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:43:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:43:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07a274d86ee83542f54904c4d620f20a5977a5fd9c96cbdc251d40ff4b993c9781d4adca705eb67b5062d0d09c1954e4fb4a853ea117888d12e3a7943a29b888", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/281a38ec38c3e95f5ae74baf0fe7b05a82c896427e3d65fd38f37a43f75509df2e86a8f12109226c40f5c4cba47dfd1c685dfae102bf3986dd9af9de8652fbb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23695bd10aed5cc5d9fab5efcdf885e003455d8cac19bc35365b0c0becd51006140ffc0776115511503bc1a6c2a7451ef6238581675f9a6bbb2f1da8bfa7d922"} 08:43:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:38 INFO - Contents: 08:43:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07a274d86ee83542f54904c4d620f20a5977a5fd9c96cbdc251d40ff4b993c9781d4adca705eb67b5062d0d09c1954e4fb4a853ea117888d12e3a7943a29b888", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/281a38ec38c3e95f5ae74baf0fe7b05a82c896427e3d65fd38f37a43f75509df2e86a8f12109226c40f5c4cba47dfd1c685dfae102bf3986dd9af9de8652fbb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23695bd10aed5cc5d9fab5efcdf885e003455d8cac19bc35365b0c0becd51006140ffc0776115511503bc1a6c2a7451ef6238581675f9a6bbb2f1da8bfa7d922"} 08:43:38 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:38 INFO - Copying logs to upload dir... 08:43:38 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.988107 ========= master_lag: 0.69 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-25 08:43:38.447031) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 08:43:38.454535) ========= 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=03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07a274d86ee83542f54904c4d620f20a5977a5fd9c96cbdc251d40ff4b993c9781d4adca705eb67b5062d0d09c1954e4fb4a853ea117888d12e3a7943a29b888", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/281a38ec38c3e95f5ae74baf0fe7b05a82c896427e3d65fd38f37a43f75509df2e86a8f12109226c40f5c4cba47dfd1c685dfae102bf3986dd9af9de8652fbb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23695bd10aed5cc5d9fab5efcdf885e003455d8cac19bc35365b0c0becd51006140ffc0776115511503bc1a6c2a7451ef6238581675f9a6bbb2f1da8bfa7d922"} build_url:https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07a274d86ee83542f54904c4d620f20a5977a5fd9c96cbdc251d40ff4b993c9781d4adca705eb67b5062d0d09c1954e4fb4a853ea117888d12e3a7943a29b888", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/281a38ec38c3e95f5ae74baf0fe7b05a82c896427e3d65fd38f37a43f75509df2e86a8f12109226c40f5c4cba47dfd1c685dfae102bf3986dd9af9de8652fbb8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23695bd10aed5cc5d9fab5efcdf885e003455d8cac19bc35365b0c0becd51006140ffc0776115511503bc1a6c2a7451ef6238581675f9a6bbb2f1da8bfa7d922"}' ========= master_lag: 0.35 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 08:43:38.812152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:43:38.812526) ========= 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=03627c79f6bb3d1578c4a402000001ba-1472137779.792215-949503023 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:43:38.829375) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 08:43:38.829697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 08:43:38.833956) ========= ========= Total master_lag: 1.11 =========