builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1472133967.78 results: success (0) buildid: 20160825054326 builduid: 7e29b840d0b84dbe8217f7fde66c11ba revision: 7963ebdd52b93f96b812eff2eab8d94097147b9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 07:06:07.778824) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 07:06:07.779281) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 07:06:07.779548) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 07:06:07.845973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:06:07.846255) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 07:06:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-08-25 07:06:09 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:06:07.984872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:06:07.985164) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018120 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:06:08.039339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-25 07:06:08.039752) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 07:06:09,164 truncating revision to first 12 chars 2016-08-25 07:06:09,164 Setting DEBUG logging. 2016-08-25 07:06:09,164 attempt 1/10 2016-08-25 07:06:09,164 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 07:06:10,021 unpacking tar archive at: mozilla-central-7963ebdd52b9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.152653 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-25 07:06:09.209217) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 07:06:09.209608) ========= script_repo_revision: 7963ebdd52b93f96b812eff2eab8d94097147b9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 07:06:09.210022) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 07:06:09.210302) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 07:06:09.220298) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-25 07:06:09.220612) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:06:10 INFO - MultiFileLogger online at 20160825 07:06:10 in /builds/slave/test 07:06:10 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 07:06:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:06:10 INFO - {'append_to_log': False, 07:06:10 INFO - 'base_work_dir': '/builds/slave/test', 07:06:10 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:06:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:06:10 INFO - 'branch': 'Firefox-Non-PGO', 07:06:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:06:10 INFO - 'config_files': ('talos/linux_config.py',), 07:06:10 INFO - 'default_actions': ('clobber', 07:06:10 INFO - 'read-buildbot-config', 07:06:10 INFO - 'download-and-extract', 07:06:10 INFO - 'populate-webroot', 07:06:10 INFO - 'create-virtualenv', 07:06:10 INFO - 'install', 07:06:10 INFO - 'run-tests'), 07:06:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:06:10 INFO - 'download_minidump_stackwalk': True, 07:06:10 INFO - 'download_symbols': 'ondemand', 07:06:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:06:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:06:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:06:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:06:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:06:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:06:10 INFO - 'installer_path': 'installer.exe', 07:06:10 INFO - 'log_level': 'info', 07:06:10 INFO - 'log_name': 'talos', 07:06:10 INFO - 'log_to_console': True, 07:06:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:06:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:06:10 INFO - 'opt_config_files': (), 07:06:10 INFO - 'pip_index': False, 07:06:10 INFO - 'sps_profile': False, 07:06:10 INFO - 'sps_profile_interval': 0, 07:06:10 INFO - 'suite': 'dromaeojs', 07:06:10 INFO - 'system_bits': '32', 07:06:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:06:10 INFO - 'title': 'talos-linux64-ix-051', 07:06:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:06:10 INFO - 'use_talos_json': True, 07:06:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:06:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:06:10 INFO - 'work_dir': 'build'} 07:06:10 INFO - [mozharness: 2016-08-25 14:06:10.438290Z] Running clobber step. 07:06:10 INFO - Running pre-action listener: _resource_record_pre_action 07:06:10 INFO - Running main action method: clobber 07:06:10 INFO - rmtree: /builds/slave/test/build 07:06:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:06:10 INFO - Running post-action listener: _resource_record_post_action 07:06:10 INFO - [mozharness: 2016-08-25 14:06:10.899929Z] Finished clobber step (success) 07:06:10 INFO - [mozharness: 2016-08-25 14:06:10.900030Z] Running read-buildbot-config step. 07:06:10 INFO - Running pre-action listener: _resource_record_pre_action 07:06:10 INFO - Running main action method: read_buildbot_config 07:06:10 INFO - Using buildbot properties: 07:06:10 INFO - { 07:06:10 INFO - "project": "", 07:06:10 INFO - "product": "firefox", 07:06:10 INFO - "script_repo_revision": "production", 07:06:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:06:10 INFO - "repository": "", 07:06:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:06:10 INFO - "buildid": "20160825054326", 07:06:10 INFO - "pgo_build": "False", 07:06:10 INFO - "basedir": "/builds/slave/test", 07:06:10 INFO - "buildnumber": 611, 07:06:10 INFO - "slavename": "talos-linux64-ix-051", 07:06:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:06:10 INFO - "platform": "ubuntu64_hw", 07:06:10 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:06:10 INFO - "branch": "mozilla-central", 07:06:10 INFO - "repo_path": "mozilla-central", 07:06:10 INFO - "revision": "7963ebdd52b93f96b812eff2eab8d94097147b9c", 07:06:10 INFO - "stage_platform": "linux64", 07:06:10 INFO - "builduid": "7e29b840d0b84dbe8217f7fde66c11ba", 07:06:10 INFO - "slavebuilddir": "test" 07:06:10 INFO - } 07:06:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:06:10 INFO - Running post-action listener: _resource_record_post_action 07:06:10 INFO - [mozharness: 2016-08-25 14:06:10.902480Z] Finished read-buildbot-config step (success) 07:06:10 INFO - [mozharness: 2016-08-25 14:06:10.902569Z] Running download-and-extract step. 07:06:10 INFO - Running pre-action listener: _resource_record_pre_action 07:06:10 INFO - Running main action method: download_and_extract 07:06:10 INFO - mkdir: /builds/slave/test/build/tests 07:06:10 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')]} 07:06:10 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:06:10 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 07:06:10 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 07:06:11 INFO - Downloaded 1361 bytes. 07:06:11 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:06:11 INFO - Using the following test package requirements: 07:06:11 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:11 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:06:11 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:06:11 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:11 INFO - u'jsshell-linux-x86_64.zip'], 07:06:11 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:06:11 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:11 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:06:11 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:06:11 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:06:11 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:06:11 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:11 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:06:11 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 07:06:11 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 07:06:12 INFO - Downloaded 20324311 bytes. 07:06:12 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 07:06:16 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 07:06: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')]} 07:06:16 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:06:16 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 07:06:16 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 07:06:17 INFO - Downloaded 20324311 bytes. 07:06:17 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 07:06:22 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')]} 07:06:22 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:22 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 07:06:22 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 07:06:23 INFO - Downloaded 14413981 bytes. 07:06:23 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 07:06: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')]} 07:06:23 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:06:23 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 07:06:23 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 07:06:26 INFO - Downloaded 55750173 bytes. 07:06:26 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 07:06:26 INFO - mkdir: /builds/slave/test/properties 07:06:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:26 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:26 INFO - Contents: 07:06:26 INFO - build_url:https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:06:26 INFO - Running post-action listener: _resource_record_post_action 07:06:26 INFO - Running post-action listener: set_extra_try_arguments 07:06:26 INFO - [mozharness: 2016-08-25 14:06:26.877893Z] Finished download-and-extract step (success) 07:06:26 INFO - [mozharness: 2016-08-25 14:06:26.878117Z] Running populate-webroot step. 07:06:26 INFO - Running pre-action listener: _resource_record_pre_action 07:06:26 INFO - Running main action method: populate_webroot 07:06:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:26 INFO - '--tppagecycles', 07:06:26 INFO - '7'], 07:06:26 INFO - 'tests': ['tsvgm']}}, 07:06:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:06:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:06:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:06:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:26 INFO - 'talos_options': ['--disable-e10s'], 07:06:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:26 INFO - 'talos_options': ['--disable-e10s'], 07:06:26 INFO - 'tests': ['damp', 'tps']}, 07:06:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:26 INFO - 'tests': ['damp', 'tps']}, 07:06:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:06:26 INFO - 'tests': ['dromaeo_dom']}, 07:06:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:06:26 INFO - 'tests': ['basic_compositor_video']}, 07:06:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:06:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:06:26 INFO - 'tests': ['a11yr', 07:06:26 INFO - 'ts_paint', 07:06:26 INFO - 'tpaint', 07:06:26 INFO - 'sessionrestore', 07:06:26 INFO - 'sessionrestore_no_auto_restore', 07:06:26 INFO - 'tabpaint']}, 07:06:26 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:26 INFO - 'ts_paint', 07:06:26 INFO - 'tpaint', 07:06:26 INFO - 'sessionrestore', 07:06:26 INFO - 'sessionrestore_no_auto_restore', 07:06:26 INFO - 'tabpaint']}, 07:06:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:06:26 INFO - 'ts_paint', 07:06:26 INFO - 'tpaint', 07:06:26 INFO - 'sessionrestore', 07:06:26 INFO - 'sessionrestore_no_auto_restore', 07:06:26 INFO - 'tabpaint']}, 07:06:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:06:26 INFO - 'ts_paint', 07:06:26 INFO - 'tpaint', 07:06:26 INFO - 'sessionrestore', 07:06:26 INFO - 'sessionrestore_no_auto_restore', 07:06:26 INFO - 'tabpaint']}, 07:06:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:06:26 INFO - 'tests': ['a11yr', 07:06:26 INFO - 'ts_paint', 07:06:26 INFO - 'tpaint', 07:06:26 INFO - 'sessionrestore', 07:06:26 INFO - 'sessionrestore_no_auto_restore', 07:06:26 INFO - 'tabpaint']}, 07:06:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:06:26 INFO - 'tests': ['a11yr', 07:06:26 INFO - 'ts_paint', 07:06:26 INFO - 'tpaint', 07:06:26 INFO - 'sessionrestore', 07:06:26 INFO - 'sessionrestore_no_auto_restore', 07:06:26 INFO - 'tabpaint']}, 07:06:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:06:26 INFO - 'tests': ['tsvgx', 07:06:26 INFO - 'tsvgr_opacity', 07:06:26 INFO - 'tart', 07:06:26 INFO - 'tscrollx', 07:06:26 INFO - 'cart']}, 07:06:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:26 INFO - 'tsvgr_opacity', 07:06:26 INFO - 'tart', 07:06:26 INFO - 'tscrollx', 07:06:26 INFO - 'cart']}, 07:06:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:26 INFO - 'talos_options': ['--disable-e10s'], 07:06:26 INFO - 'tests': ['tp5o']}, 07:06:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:26 INFO - 'tests': ['tp5o']}, 07:06:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:26 INFO - 'talos_options': ['--disable-e10s', 07:06:26 INFO - '--xperf_path', 07:06:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:26 INFO - 'tests': ['tp5n']}, 07:06:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:26 INFO - 'talos_options': ['--xperf_path', 07:06:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:26 INFO - 'tests': ['tp5n']}}, 07:06:26 INFO - 'talos.zip': {'path': '', 07:06:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:26 INFO - Running post-action listener: _resource_record_post_action 07:06:26 INFO - [mozharness: 2016-08-25 14:06:26.898455Z] Finished populate-webroot step (success) 07:06:26 INFO - [mozharness: 2016-08-25 14:06:26.898543Z] Running create-virtualenv step. 07:06:26 INFO - Running pre-action listener: _resource_record_pre_action 07:06:26 INFO - Running main action method: create_virtualenv 07:06:26 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:06:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:26 INFO - Using real prefix '/usr' 07:06:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:27 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:29 INFO - Installing pip.................done. 07:06:29 INFO - Return code: 0 07:06:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c4e27bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c85d20>, '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 0x1c86c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c870b0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', '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 07:06:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:06:29 INFO - Using env: {'DISPLAY': ':0', 07:06:29 INFO - 'HOME': '/home/cltbld', 07:06:29 INFO - 'LANG': 'en_US.UTF-8', 07:06:29 INFO - 'LANGUAGE': 'en_US:en', 07:06:29 INFO - 'LOGNAME': 'cltbld', 07:06:29 INFO - 'MAIL': '/var/mail/cltbld', 07:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:29 INFO - 'MOZ_NO_REMOTE': '1', 07:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:29 INFO - 'NO_EM_RESTART': '1', 07:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:29 INFO - 'PWD': '/builds/slave/test', 07:06:29 INFO - 'SHELL': '/bin/bash', 07:06:29 INFO - 'SHLVL': '1', 07:06:29 INFO - 'TERM': 'linux', 07:06:29 INFO - 'TMOUT': '86400', 07:06:29 INFO - 'USER': 'cltbld', 07:06:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', 07:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:29 INFO - '_': '/tools/buildbot/bin/python'} 07:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:06:29 INFO - Cleaning up... 07:06:29 INFO - Return code: 0 07:06:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c4e27bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c85d20>, '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 0x1c86c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c870b0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', '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 07:06:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:06:29 INFO - Using env: {'DISPLAY': ':0', 07:06:29 INFO - 'HOME': '/home/cltbld', 07:06:29 INFO - 'LANG': 'en_US.UTF-8', 07:06:29 INFO - 'LANGUAGE': 'en_US:en', 07:06:29 INFO - 'LOGNAME': 'cltbld', 07:06:29 INFO - 'MAIL': '/var/mail/cltbld', 07:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:29 INFO - 'MOZ_NO_REMOTE': '1', 07:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:29 INFO - 'NO_EM_RESTART': '1', 07:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:29 INFO - 'PWD': '/builds/slave/test', 07:06:29 INFO - 'SHELL': '/bin/bash', 07:06:29 INFO - 'SHLVL': '1', 07:06:29 INFO - 'TERM': 'linux', 07:06:29 INFO - 'TMOUT': '86400', 07:06:29 INFO - 'USER': 'cltbld', 07:06:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', 07:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:29 INFO - '_': '/tools/buildbot/bin/python'} 07:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:29 INFO - Downloading/unpacking psutil>=3.1.1 07:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:31 INFO - Installing collected packages: psutil 07:06:31 INFO - Running setup.py install for psutil 07:06:31 INFO - building 'psutil._psutil_linux' extension 07:06:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:06:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:06:32 INFO - building 'psutil._psutil_posix' extension 07:06:32 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 07:06:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:06:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:32 INFO - Successfully installed psutil 07:06:32 INFO - Cleaning up... 07:06:32 INFO - Return code: 0 07:06:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c4e27bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c85d20>, '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 0x1c86c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c870b0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', '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 07:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:06:32 INFO - Using env: {'DISPLAY': ':0', 07:06:32 INFO - 'HOME': '/home/cltbld', 07:06:32 INFO - 'LANG': 'en_US.UTF-8', 07:06:32 INFO - 'LANGUAGE': 'en_US:en', 07:06:32 INFO - 'LOGNAME': 'cltbld', 07:06:32 INFO - 'MAIL': '/var/mail/cltbld', 07:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:32 INFO - 'MOZ_NO_REMOTE': '1', 07:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:32 INFO - 'NO_EM_RESTART': '1', 07:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:32 INFO - 'PWD': '/builds/slave/test', 07:06:32 INFO - 'SHELL': '/bin/bash', 07:06:32 INFO - 'SHLVL': '1', 07:06:32 INFO - 'TERM': 'linux', 07:06:32 INFO - 'TMOUT': '86400', 07:06:32 INFO - 'USER': 'cltbld', 07:06:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', 07:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:32 INFO - '_': '/tools/buildbot/bin/python'} 07:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:34 INFO - Installing collected packages: mozsystemmonitor 07:06:34 INFO - Running setup.py install for mozsystemmonitor 07:06:34 INFO - Successfully installed mozsystemmonitor 07:06:34 INFO - Cleaning up... 07:06:34 INFO - Return code: 0 07:06:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c4e27bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c85d20>, '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 0x1c86c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c870b0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', '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 07:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:06:34 INFO - Using env: {'DISPLAY': ':0', 07:06:34 INFO - 'HOME': '/home/cltbld', 07:06:34 INFO - 'LANG': 'en_US.UTF-8', 07:06:34 INFO - 'LANGUAGE': 'en_US:en', 07:06:34 INFO - 'LOGNAME': 'cltbld', 07:06:34 INFO - 'MAIL': '/var/mail/cltbld', 07:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:34 INFO - 'MOZ_NO_REMOTE': '1', 07:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:34 INFO - 'NO_EM_RESTART': '1', 07:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:34 INFO - 'PWD': '/builds/slave/test', 07:06:34 INFO - 'SHELL': '/bin/bash', 07:06:34 INFO - 'SHLVL': '1', 07:06:34 INFO - 'TERM': 'linux', 07:06:34 INFO - 'TMOUT': '86400', 07:06:34 INFO - 'USER': 'cltbld', 07:06:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', 07:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:34 INFO - '_': '/tools/buildbot/bin/python'} 07:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:34 INFO - Downloading/unpacking jsonschema==2.5.1 07:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:37 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:37 INFO - warning: no files found matching '*.txt' 07:06:37 INFO - no previously-included directories found matching 'build' 07:06:37 INFO - no previously-included directories found matching 'dist' 07:06:37 INFO - no previously-included directories found matching '.git*' 07:06:37 INFO - Installing collected packages: jsonschema, functools32 07:06:37 INFO - Running setup.py install for functools32 07:06:37 INFO - warning: no files found matching '*.txt' 07:06:37 INFO - no previously-included directories found matching 'build' 07:06:37 INFO - no previously-included directories found matching 'dist' 07:06:37 INFO - no previously-included directories found matching '.git*' 07:06:37 INFO - Successfully installed jsonschema functools32 07:06:37 INFO - Cleaning up... 07:06:37 INFO - Return code: 0 07:06:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5c4e27bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c85d20>, '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 0x1c86c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c870b0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', '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 07:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:06:37 INFO - Using env: {'DISPLAY': ':0', 07:06:37 INFO - 'HOME': '/home/cltbld', 07:06:37 INFO - 'LANG': 'en_US.UTF-8', 07:06:37 INFO - 'LANGUAGE': 'en_US:en', 07:06:37 INFO - 'LOGNAME': 'cltbld', 07:06:37 INFO - 'MAIL': '/var/mail/cltbld', 07:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:37 INFO - 'MOZ_NO_REMOTE': '1', 07:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:37 INFO - 'NO_EM_RESTART': '1', 07:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:37 INFO - 'PWD': '/builds/slave/test', 07:06:37 INFO - 'SHELL': '/bin/bash', 07:06:37 INFO - 'SHLVL': '1', 07:06:37 INFO - 'TERM': 'linux', 07:06:37 INFO - 'TMOUT': '86400', 07:06:37 INFO - 'USER': 'cltbld', 07:06:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', 07:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:37 INFO - '_': '/tools/buildbot/bin/python'} 07:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:06:37 INFO - Cleaning up... 07:06:37 INFO - Return code: 0 07:06:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c4e27bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c85d20>, '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 0x1c86c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c870b0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', '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 07:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:06:37 INFO - Using env: {'DISPLAY': ':0', 07:06:37 INFO - 'HOME': '/home/cltbld', 07:06:37 INFO - 'LANG': 'en_US.UTF-8', 07:06:37 INFO - 'LANGUAGE': 'en_US:en', 07:06:37 INFO - 'LOGNAME': 'cltbld', 07:06:37 INFO - 'MAIL': '/var/mail/cltbld', 07:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:37 INFO - 'MOZ_NO_REMOTE': '1', 07:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:37 INFO - 'NO_EM_RESTART': '1', 07:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:37 INFO - 'PWD': '/builds/slave/test', 07:06:37 INFO - 'SHELL': '/bin/bash', 07:06:37 INFO - 'SHLVL': '1', 07:06:37 INFO - 'TERM': 'linux', 07:06:37 INFO - 'TMOUT': '86400', 07:06:37 INFO - 'USER': 'cltbld', 07:06:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', 07:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:37 INFO - '_': '/tools/buildbot/bin/python'} 07:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:37 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:39 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 INFO - Downloading docopt-0.6.1.tar.gz 07:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:40 INFO - Running setup.py install for blobuploader 07:06:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:40 INFO - Running setup.py install for requests 07:06:40 INFO - Running setup.py install for docopt 07:06:40 INFO - Successfully installed blobuploader requests docopt 07:06:40 INFO - Cleaning up... 07:06:41 INFO - Return code: 0 07:06:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:41 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')]} 07:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:41 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')]} 07:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:41 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 0x7f5c4e27bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c85d20>, '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 0x1c86c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c870b0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', '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 07:06:41 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 07:06:41 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 07:06:41 INFO - Using env: {'DISPLAY': ':0', 07:06:41 INFO - 'HOME': '/home/cltbld', 07:06:41 INFO - 'LANG': 'en_US.UTF-8', 07:06:41 INFO - 'LANGUAGE': 'en_US:en', 07:06:41 INFO - 'LOGNAME': 'cltbld', 07:06:41 INFO - 'MAIL': '/var/mail/cltbld', 07:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:41 INFO - 'MOZ_NO_REMOTE': '1', 07:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:41 INFO - 'NO_EM_RESTART': '1', 07:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:41 INFO - 'PWD': '/builds/slave/test', 07:06:41 INFO - 'SHELL': '/bin/bash', 07:06:41 INFO - 'SHLVL': '1', 07:06:41 INFO - 'TERM': 'linux', 07:06:41 INFO - 'TMOUT': '86400', 07:06:41 INFO - 'USER': 'cltbld', 07:06:41 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', 07:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:41 INFO - '_': '/tools/buildbot/bin/python'} 07:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:41 INFO - Running setup.py (path:/tmp/pip-AHpteJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:41 INFO - Running setup.py (path:/tmp/pip-2gNVMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:41 INFO - Running setup.py (path:/tmp/pip-eheOM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:41 INFO - Running setup.py (path:/tmp/pip-RftnCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:41 INFO - Running setup.py (path:/tmp/pip-WYJpQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:41 INFO - Running setup.py (path:/tmp/pip-tULyk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:41 INFO - Running setup.py (path:/tmp/pip-nLVaGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:41 INFO - Running setup.py (path:/tmp/pip-En35lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:41 INFO - Running setup.py (path:/tmp/pip-eEEJCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:41 INFO - Running setup.py (path:/tmp/pip-55WT2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:41 INFO - Running setup.py (path:/tmp/pip-eAVYwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:42 INFO - Running setup.py (path:/tmp/pip-l0Wbsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:42 INFO - Running setup.py (path:/tmp/pip-nsuLXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:42 INFO - Running setup.py (path:/tmp/pip-f9OexL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:42 INFO - Running setup.py (path:/tmp/pip-6HXXDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:42 INFO - Running setup.py (path:/tmp/pip-MUy9SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:42 INFO - Running setup.py (path:/tmp/pip-vYAstl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:42 INFO - Running setup.py install for manifestparser 07:06:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:42 INFO - Running setup.py install for mozcrash 07:06:42 INFO - Running setup.py install for mozdebug 07:06:42 INFO - Running setup.py install for mozdevice 07:06:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:06:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:42 INFO - Running setup.py install for mozfile 07:06:42 INFO - Running setup.py install for mozhttpd 07:06:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Running setup.py install for mozinfo 07:06:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Running setup.py install for mozInstall 07:06:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Running setup.py install for mozleak 07:06:43 INFO - Running setup.py install for mozlog 07:06:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Running setup.py install for moznetwork 07:06:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Running setup.py install for mozprocess 07:06:43 INFO - Running setup.py install for mozprofile 07:06:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Running setup.py install for mozrunner 07:06:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Running setup.py install for mozscreenshot 07:06:44 INFO - Running setup.py install for moztest 07:06:44 INFO - Running setup.py install for mozversion 07:06:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:44 INFO - Cleaning up... 07:06:44 INFO - Return code: 0 07:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:44 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 0x7f5c4e27bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c85d20>, '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 0x1c86c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c870b0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', '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 07:06:44 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 07:06:44 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 07:06:44 INFO - Using env: {'DISPLAY': ':0', 07:06:44 INFO - 'HOME': '/home/cltbld', 07:06:44 INFO - 'LANG': 'en_US.UTF-8', 07:06:44 INFO - 'LANGUAGE': 'en_US:en', 07:06:44 INFO - 'LOGNAME': 'cltbld', 07:06:44 INFO - 'MAIL': '/var/mail/cltbld', 07:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:44 INFO - 'MOZ_NO_REMOTE': '1', 07:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:44 INFO - 'NO_EM_RESTART': '1', 07:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:44 INFO - 'PWD': '/builds/slave/test', 07:06:44 INFO - 'SHELL': '/bin/bash', 07:06:44 INFO - 'SHLVL': '1', 07:06:44 INFO - 'TERM': 'linux', 07:06:44 INFO - 'TMOUT': '86400', 07:06:44 INFO - 'USER': 'cltbld', 07:06:44 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', 07:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:44 INFO - '_': '/tools/buildbot/bin/python'} 07:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:44 INFO - Running setup.py (path:/tmp/pip-1rleCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:44 INFO - Running setup.py (path:/tmp/pip-gqJ1ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:44 INFO - Running setup.py (path:/tmp/pip-DuJpLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:44 INFO - Running setup.py (path:/tmp/pip-laGL72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:44 INFO - Running setup.py (path:/tmp/pip-tNodn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:44 INFO - Running setup.py (path:/tmp/pip-Ju2iVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:44 INFO - Running setup.py (path:/tmp/pip-g4mOhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:44 INFO - Running setup.py (path:/tmp/pip-whd6Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:45 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)) 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:45 INFO - Running setup.py (path:/tmp/pip-2WuThe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:45 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)) 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:45 INFO - Running setup.py (path:/tmp/pip-TaC2k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:45 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)) 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:45 INFO - Running setup.py (path:/tmp/pip-zYIWhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:45 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)) 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:45 INFO - Running setup.py (path:/tmp/pip-cwWc6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:45 INFO - Running setup.py (path:/tmp/pip-XSRqm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:45 INFO - Running setup.py (path:/tmp/pip-yN2Evx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:45 INFO - Running setup.py (path:/tmp/pip-zGoXiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:45 INFO - Running setup.py (path:/tmp/pip-8u6n8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:45 INFO - Running setup.py (path:/tmp/pip-8MMm_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:47 INFO - Downloading blessings-1.6.tar.gz 07:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:47 INFO - Installing collected packages: blessings 07:06:47 INFO - Running setup.py install for blessings 07:06:47 INFO - Successfully installed blessings 07:06:47 INFO - Cleaning up... 07:06:47 INFO - Return code: 0 07:06:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:48 INFO - Reading from file tmpfile_stdout 07:06:48 INFO - Current package versions: 07:06:48 INFO - argparse == 1.2.1 07:06:48 INFO - blessings == 1.6 07:06:48 INFO - blobuploader == 1.2.4 07:06:48 INFO - docopt == 0.6.1 07:06:48 INFO - functools32 == 3.2.3-2 07:06:48 INFO - jsonschema == 2.5.1 07:06:48 INFO - manifestparser == 1.1 07:06:48 INFO - mozInstall == 1.12 07:06:48 INFO - mozcrash == 0.17 07:06:48 INFO - mozdebug == 0.1 07:06:48 INFO - mozdevice == 0.48 07:06:48 INFO - mozfile == 1.2 07:06:48 INFO - mozhttpd == 0.7 07:06:48 INFO - mozinfo == 0.9 07:06:48 INFO - mozleak == 0.1 07:06:48 INFO - mozlog == 3.3 07:06:48 INFO - moznetwork == 0.27 07:06:48 INFO - mozprocess == 0.23 07:06:48 INFO - mozprofile == 0.28 07:06:48 INFO - mozrunner == 6.12 07:06:48 INFO - mozscreenshot == 0.1 07:06:48 INFO - mozsystemmonitor == 0.3 07:06:48 INFO - moztest == 0.7 07:06:48 INFO - mozversion == 1.4 07:06:48 INFO - psutil == 3.1.1 07:06:48 INFO - requests == 1.2.3 07:06:48 INFO - wsgiref == 0.1.2 07:06:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:48 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 0x7f5c4e27bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c85d20>, '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 0x1c86c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c870b0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', '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 07:06:48 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 07:06:48 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 07:06:48 INFO - Using env: {'DISPLAY': ':0', 07:06:48 INFO - 'HOME': '/home/cltbld', 07:06:48 INFO - 'LANG': 'en_US.UTF-8', 07:06:48 INFO - 'LANGUAGE': 'en_US:en', 07:06:48 INFO - 'LOGNAME': 'cltbld', 07:06:48 INFO - 'MAIL': '/var/mail/cltbld', 07:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:48 INFO - 'MOZ_NO_REMOTE': '1', 07:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:48 INFO - 'NO_EM_RESTART': '1', 07:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:48 INFO - 'PWD': '/builds/slave/test', 07:06:48 INFO - 'SHELL': '/bin/bash', 07:06:48 INFO - 'SHLVL': '1', 07:06:48 INFO - 'TERM': 'linux', 07:06:48 INFO - 'TMOUT': '86400', 07:06:48 INFO - 'USER': 'cltbld', 07:06:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', 07:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:48 INFO - '_': '/tools/buildbot/bin/python'} 07:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:48 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)) 07:06:48 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)) 07:06:48 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)) 07:06:48 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)) 07:06:48 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)) 07:06:48 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)) 07:06:48 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)) 07:06:48 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)) 07:06:48 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)) 07:06:48 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)) 07:06:48 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)) 07:06:48 INFO - Cleaning up... 07:06:48 INFO - Return code: 0 07:06:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c4e27bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c85d20>, '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 0x1c86c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c870b0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', '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 07:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:06:48 INFO - Using env: {'DISPLAY': ':0', 07:06:48 INFO - 'HOME': '/home/cltbld', 07:06:48 INFO - 'LANG': 'en_US.UTF-8', 07:06:48 INFO - 'LANGUAGE': 'en_US:en', 07:06:48 INFO - 'LOGNAME': 'cltbld', 07:06:48 INFO - 'MAIL': '/var/mail/cltbld', 07:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:48 INFO - 'MOZ_NO_REMOTE': '1', 07:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:48 INFO - 'NO_EM_RESTART': '1', 07:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:48 INFO - 'PWD': '/builds/slave/test', 07:06:48 INFO - 'SHELL': '/bin/bash', 07:06:48 INFO - 'SHLVL': '1', 07:06:48 INFO - 'TERM': 'linux', 07:06:48 INFO - 'TMOUT': '86400', 07:06:48 INFO - 'USER': 'cltbld', 07:06:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', 07:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:48 INFO - '_': '/tools/buildbot/bin/python'} 07:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:48 INFO - Cleaning up... 07:06:48 INFO - Return code: 0 07:06:48 INFO - Running post-action listener: _resource_record_post_action 07:06:48 INFO - Running post-action listener: _start_resource_monitoring 07:06:48 INFO - Starting resource monitoring. 07:06:48 INFO - [mozharness: 2016-08-25 14:06:48.566161Z] Finished create-virtualenv step (success) 07:06:48 INFO - [mozharness: 2016-08-25 14:06:48.566674Z] Running install step. 07:06:48 INFO - Running pre-action listener: _resource_record_pre_action 07:06:48 INFO - Running main action method: install 07:06:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:48 INFO - Reading from file tmpfile_stdout 07:06:48 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:48 INFO - Reading from file tmpfile_stdout 07:06:48 INFO - Output received: 07:06:48 INFO - Usage: mozinstall [options] installer 07:06:48 INFO - Options: 07:06:48 INFO - -h, --help show this help message and exit 07:06:48 INFO - -d DEST, --destination=DEST 07:06:48 INFO - Directory to install application into. [default: 07:06:48 INFO - "/builds/slave/test"] 07:06:48 INFO - --app=APP Application being installed. [default: firefox] 07:06:48 INFO - mkdir: /builds/slave/test/build/application 07:06:48 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'] 07:06:48 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 07:07:04 INFO - Reading from file tmpfile_stdout 07:07:04 INFO - Output received: 07:07:04 INFO - /builds/slave/test/build/application/firefox/firefox 07:07:04 INFO - Running post-action listener: _resource_record_post_action 07:07:04 INFO - [mozharness: 2016-08-25 14:07:04.955306Z] Finished install step (success) 07:07:04 INFO - [mozharness: 2016-08-25 14:07:04.955640Z] Running run-tests step. 07:07:04 INFO - Running pre-action listener: _resource_record_pre_action 07:07:04 INFO - Running main action method: run_tests 07:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:07:04 INFO - Python 2.7.3 07:07:04 INFO - Return code: 0 07:07:04 INFO - grabbing minidump binary from tooltool 07:07: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')]} 07:07:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c85d20>, '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 0x1c86c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c870b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:07:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:07:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:07:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:07:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:05 INFO - Return code: 0 07:07:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:07:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:07:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:07:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:07:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:07:05 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-051', '--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 07:07:05 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-051 --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 07:07:05 INFO - Using env: {'DISPLAY': ':0', 07:07:05 INFO - 'HOME': '/home/cltbld', 07:07:05 INFO - 'LANG': 'en_US.UTF-8', 07:07:05 INFO - 'LANGUAGE': 'en_US:en', 07:07:05 INFO - 'LOGNAME': 'cltbld', 07:07:05 INFO - 'MAIL': '/var/mail/cltbld', 07:07:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:07:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:05 INFO - 'MOZ_NO_REMOTE': '1', 07:07:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:05 INFO - 'NO_EM_RESTART': '1', 07:07:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:05 INFO - 'PWD': '/builds/slave/test', 07:07:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:07:05 INFO - 'SHELL': '/bin/bash', 07:07:05 INFO - 'SHLVL': '1', 07:07:05 INFO - 'TERM': 'linux', 07:07:05 INFO - 'TMOUT': '86400', 07:07:05 INFO - 'USER': 'cltbld', 07:07:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378', 07:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:05 INFO - '_': '/tools/buildbot/bin/python'} 07:07:05 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-051', '--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 07:07:05 INFO - mozversion application_buildid: 20160825054326 07:07:05 INFO - mozversion application_changeset: 7963ebdd52b93f96b812eff2eab8d94097147b9c 07:07:05 INFO - mozversion application_display_name: Nightly 07:07:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:05 INFO - mozversion application_name: Firefox 07:07:05 INFO - mozversion application_remotingname: firefox 07:07:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:07:05 INFO - mozversion application_vendor: Mozilla 07:07:05 INFO - mozversion application_version: 51.0a1 07:07:05 INFO - mozversion platform_buildid: 20160825054326 07:07:05 INFO - mozversion platform_changeset: 7963ebdd52b93f96b812eff2eab8d94097147b9c 07:07:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:07:05 INFO - mozversion platform_version: 51.0a1 07:07:05 INFO - using testdate: 1472134025 07:07:05 INFO - actual date: 1472134025 07:07:05 INFO - starting webserver on 'localhost:49396' 07:07:05 INFO - SUITE-START | Running 2 tests 07:07:05 INFO - TEST-START | dromaeo_css 07:07:05 INFO - operating with platform_type : linux_ 07:07:05 INFO - Initialising browser for dromaeo_css test... 07:07:05 INFO - TEST-INFO | started process 10774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq1xPyZ/profile http://localhost:49396/getInfo.html) 07:07:09 INFO - PROCESS | 10774 | __metrics Screen width/height:1600/1200 07:07:09 INFO - PROCESS | 10774 | colorDepth:24 07:07:09 INFO - PROCESS | 10774 | Browser inner width/height: 1024/697 07:07:09 INFO - PROCESS | 10774 | __metrics 07:07:10 INFO - PROCESS | 10774 | 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" 07:07:10 INFO - PROCESS | 10774 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:07:10 INFO - PROCESS | 10774 | console.error: PushService: 07:07:10 INFO - PROCESS | 10774 | stateChangeProcessEnqueue: Error transitioning state 07:07:10 INFO - PROCESS | 10774 | UnknownError 07:07:11 INFO - TEST-INFO | 10774: exit 0 07:07:11 INFO - Browser initialized. 07:07:11 INFO - Running cycle 1/1 for dromaeo_css test... 07:07:11 INFO - TEST-INFO | started process 10858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq1xPyZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:23 INFO - PROCESS | 10858 | RSS: Main: 179564544 07:07:23 INFO - PROCESS | 10858 | 07:08:14 INFO - PROCESS | 10858 | 1472134094724 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] 07:10:28 INFO - PROCESS | 10858 | Cycle 1(1): loaded http://localhost:49396/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49396/tests/dromaeo/cssquery-ext.html) 07:10:29 INFO - PROCESS | 10858 | RSS: Main: 269955072 07:10:29 INFO - PROCESS | 10858 | 07:13:31 INFO - PROCESS | 10858 | Cycle 1(1): loaded http://localhost:49396/tests/dromaeo/cssquery-ext.html (next: http://localhost:49396/tests/dromaeo/cssquery-jquery.html) 07:13:32 INFO - PROCESS | 10858 | RSS: Main: 270737408 07:13:32 INFO - PROCESS | 10858 | 07:16:34 INFO - PROCESS | 10858 | Cycle 1(1): loaded http://localhost:49396/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49396/tests/dromaeo/cssquery-mootools.html) 07:16:35 INFO - PROCESS | 10858 | RSS: Main: 216350720 07:16:35 INFO - PROCESS | 10858 | 07:19:37 INFO - PROCESS | 10858 | Cycle 1(1): loaded http://localhost:49396/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49396/tests/dromaeo/cssquery-prototype.html) 07:19:38 INFO - PROCESS | 10858 | RSS: Main: 218779648 07:19:38 INFO - PROCESS | 10858 | 07:22:41 INFO - PROCESS | 10858 | Cycle 1(1): loaded http://localhost:49396/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49396/tests/dromaeo/cssquery-yui.html) 07:22:42 INFO - PROCESS | 10858 | RSS: Main: 217276416 07:22:42 INFO - PROCESS | 10858 | 07:25:45 INFO - PROCESS | 10858 | Cycle 1(1): loaded http://localhost:49396/tests/dromaeo/cssquery-yui.html (next: http://localhost:49396/tests/dromaeo/cssquery-dojo.html) 07:25:45 INFO - PROCESS | 10858 | RSS: Main: 307687424 07:25:45 INFO - PROCESS | 10858 | 07:25:45 INFO - PROCESS | 10858 | __start_tp_report 07:25:45 INFO - PROCESS | 10858 | _x_x_mozilla_page_load 07:25:45 INFO - PROCESS | 10858 | _x_x_mozilla_page_load_details 07:25:45 INFO - PROCESS | 10858 | |i|pagename|runs| 07:25:45 INFO - PROCESS | 10858 | |0;dojo.html;2555.718870924199;2557.0666706652073;2580.638710580518;2592.325995241237;2608.2305719812653;4440.045390241105;4493.618042466394;4548.487709395034;4647.837325693606;4710.458297295812;4553.726776393419;4569.109023740372;4582.816687332503;4584.679072464929;4595.632349412047;4205.2220339237265;4288.849890253841;4294.871153865373;4302.741835489865;4314.762688052156;4249.872503824875;4276.700630955835;4289.120730250307;4335.024619460612;4353.281708518107;4227.577242275764;4431.512533621299;4434.35701823237;4435.068635586531;4439.600435960763;4244.596763307481;4269.060806622538;4273.4658167729185;4282.807273672693;4367.781610919441;4147.191297696951;4192.035831758682;4199.433076534659;4223.049813791903;4255.510616279136;4539.251023581105;4542.636589072867;4542.841000564964;4554;4583.220852455091;4913.091078150554;4918.360613120271;4928.43323017854;4944.456109827916;5004.574611158019;4839.395075615548;4912.852614421573;4949.430815456232;4958.3306253655655;4960.702357858504;4637.25803871379;4640.744759038218;4642.907141857211;4693.22561777303;4700.811967521329;5100.336956195671;5105.387353517527;5106;5118.718470484085;5120.948790512121;4741.857744267678;4781.737004464719;4783.234682450791;4787.042591481718;4892.804287828447;4931.950680493221;4932.038252540792;4948.802047918043;4950.752462376867;5008.073506401327;4858.854234372974;4890.608751299887;4895.094407534618;4898.044881248123;4957.975210123926;4773.71357718538;4825.734584597811;4829.396325459317;4908.607311415079;4925.310456536088;4217.662586993033;4231.153769246102;4247.936280955726;4262.722923009995;4272.230998420314;3699.204670995749;3739.700823934079;3776.0937375030344;3786.7917264550165;3787.905302367408;4265.019045619525;4266.552012038691;4270.252705776476;4314.460692413449;4321.870343889688;4762.571368576845;4935.383077115361;4979.402471703419;4996.175631020841;5052.924206136838;4185.16296740647;4218.49378074633;4240.257954857949;4243.193793179286;4291.957080429156;4466.754328511898;4473.284274516127;4478.910421791546;4486.439195100613;4539.432570928634;4524.04994951064;4664.207084795661;4670.906581868344;4672.439307283148;4716.622670186377;4858.58702010333;4897.95102048975;4912.70523768575;4930.087933732271;4986.451490335988;4608.147492713859;4625.907481850411;4640.535946405467;4641.002184530342;4695.990362072171;4675.3688252086895;4851.684640498356;4862.610991120772;4863.173260545786;4918.385201849769;4762.9523704762505;4839.782209800497;4856.028794241095;4861.465238823797;4873.415190177059;4803.471618122074;4803.567678908915;4803.855884323476;4848.151573474698;4857.319975203403;4790.712557246577;4794.376731024944;4795.448523419851;4797.976010119927;4844.612431005582;4568.063546972796;4745.549172828576;4749.643776716829;4762.880927976828;4796.784144713426;4922.827701030446;4929.2359684248995;4938.950610493849;4977.900441991213;4982.8754281143265;4643.7213767172725;4790.932517233212;4799.808007679654;4811.687240329367;4869.707817530818 07:25:45 INFO - PROCESS | 10858 | |1;ext.html;552.9336479622445;554.0055600197645;555.8860433611109;561.8483009587411;564.2733236296929;27553;30437.391252174944;30491.237719057033;37531.249375012485;39236.80381598095;39188;39606;39617.20765584687;39621.207575848464;39649.20701585967;7363.926360736405;7518.173000969889;7525.059367579052;7526.209747976438;7530.246975302453;7615.238476152396;7698.6150692465435;7708.653110610036;7710.036245469317;7712.113106992711;7695.268949449794;7726.459147859652;7734.1105772836;7740.806479837993;7742;7662.885056724153;7674.693012279502;7706.845863082707;7710.807229819244;7721;7553;7612;7615.238476152396;7620.961895190544;7631.2368763123795;37578.24843503142;37581.62418375836;37715.434268485995;37903;37990.81004594987;3088.320569474712;3091.6753740857334;3202;3323.7341012718925;3381.8140002299865;28522.286942826388;28704.712952870414;28796.568051479244;29836.254093647833;30238.697613023807;3497.475378693191;3504.789712617251;3520.9471857922154;3532.5231093802263;3608.116011577154;240424;241385;242080;242311;243403;50387.49612503901;50802.49197508051;50815.49184508107;50843;50868.491315087114;32030.519542206886;32859;32896.17759555982;53149;53264;14528.346224419927;14741.262936853114;14741.336639851232;14765.114093154445;14783.334749936279;11301.378424186749;11453.656390308304;11454.885451145548;11461.71345716347;11464.082873370277;17595.472135835946;17667.116644167996;17671.558211044827;17685.911570442066;17714.379996700052;6533;6702.765403210864;6709.36261055199;6718.361755633207;6806.149231346082;729.7409419655945;843.6843206199694;860.320346925934;941.6092321686424;956.9186619137312;24632.261032169063;26724;26833.329166770596;27029;29025;895.6104094718818;924.4083786376724;961.33667769239;988.4217732626494;1030.5723124903232;14487.78268325976;14860.405583776528;15002.174880381466;15035.924820375829;15073.883793264318;376914;378370;378626;379182;380054;44962;45479.54520454753;45541.54458455373;45580;45643.315350269775;1182.3201659046083;1185.958491452795;1206.4872429217723;1218.3055658274875;1218.7623413434474;26044.609330860432;27038;27451;28126;28172.647197032496;41573.37639935464;44832.32751508665;46693.299600506696;46694.76652616715;51108.233376500124;364750;368080;368933;369668;369773;37314.44028339631;37866.810665947596;37900.43149352707;37961.97703424875;38697.226055479296;41274;41543.58456415397;41699.37450938299;42244.1551168981;42374.152516950104;35226.11934701653;35406.11484712903;35466.11334716653;36020.4596931041;36123.819380902925;35067.64932350644;35114.47328290027;35237;35975.820120899225;35977.64022359848;34499.65500345065;35175.82412087923;35499.64500354963;35573;35859.82070089633;30552.694473054984;33168.844025138285;33188;33433.83283083569;33598.83200583982;24685.382865428506;25167.37081572975;25178.748212518374;25651.486970260117;25848.483030339663 07:25:45 INFO - PROCESS | 10858 | |2;jquery.html;341.0110679030812;364.8157680371412;370.5497820148519;374.47947353179086;381.07779174397956;12710.61868143956;14625.853741462595;16573.17134143291;16822.15889205541;17446.65106697865;15955.202239887989;16777.412790552335;16894.831051689478;16994.83005169948;17153.82846171538;4836.637252206081;5128.256402821588;5128.384593848743;5134.820281290155;5136.306598609196;3761.6426439488205;4777.06847164803;5021.17150670139;5100.770465329069;5109.897802043975;5970.910436343458;6044.667543285118;6049.727762250709;6052.788152414666;6060.030395136779;5903.409659034105;5979.820605381846;6014.1580178775;6048.274207095154;6058.96970515149;5289.814856480005;5303.124984377573;5327.600429967768;5341.4658534146665;5351.438098999588;19573.80426195734;21014.789852101436;21103.366898993056;21233.46916327089;21311.68032479514;2043.5197728533783;2069.4722845674255;2073.1914553324214;2285.8568221501623;2499.787518060967;12965.805512917314;13586.456541738318;13816.93091534546;13950.860491395058;14102.294885255798;1753.6317373351612;1810.5473631592101;1811.2664370929795;1814.8003719590833;1820.2627935686069;67710.32289677138;67926.66036669834;70492.64753676199;70732.6463367685;72133.639331803;8586.87119693205;9068.727938161866;9173.357864949523;9662.855057174149;9840.458774767456;11655.708607284885;11693.824592631117;11732.94133529327;11756.35340056288;11774.94112529432;7048.823779405556;7316.743913962986;7329.9267007329245;7336.376408005272;7372.299631534996;6854.246032936373;7072.186698529632;7112.182099058571;7201.927980720126;7376.557406555624;3719.088823238324;3795.9240815183543;3835.0412396900774;3962.40563915415;4124.896877578085;1820.1536285626983;1871.466632009898;1896.985112964585;1899.088437549956;1921.6060707555198;845.8435189489965;853.6713365354383;889.7019498467956;891.1266958380824;900.6892622045384;15746.291416886268;16586.253618587194;16594.336226550804;17179.82820171807;18056.548586285186;853.1809462915546;874.5408660453186;885.4421714320066;932.7854593443546;944.4191822029402;7579.734709285149;9311.767205819773;9449.645375891598;10302;10631.734206644742;408402;413437;413708;414135;415614;79658;81669.18330816734;82177.58911205406;82744.58627706823;85228.57385713032;887.6582515731361;937.990620093804;940.8071345374182;947.9289053321029;952.84754439288;15587.922060389625;15690.9215453922;15989.760153597472;16311;16479.17604119813;38558;39412.4822524841;39556.2088758229;39724.40413393744;40277.30571605668;52150.73924630353;52523;52945.470545294054;53111;53121.203181953075;7553.546787192786;7565.848683026419;7773.727919522789;7797.961010195139;8260.49802857432;10048.447335396331;11053.226274160732;11513.251638643462;11731.47208375608;11930.821037684615;9766.853497197406;9992;10057;10205.795884082128;10262.189466545744;10111.494425278559;10181.847272290774;10506.94746526293;10589.4705264738;11151.386673733023;9028.819423611621;9708.660196893075;10201.489925503844;10298.588056477656;10330.48347582633;7167.641617919187;7455.6644950978425;7532.54804711719;7538.660760265691;7627.694892204249;8276.875846862422;9584.808303834025;9868.062534059252;9949.900500994898;10012.599496020077 07:25:45 INFO - PROCESS | 10858 | |3;mootools.html;1173.0967155290427;1323.3780123342028;1338.5114433231868;1622.148372104644;1622.6673531925949;7497.475176737624;7995.600219989006;8004.39967002475;8006.719764808218;8010.118886922442;6746.561473504231;7540.132884718245;7710.884336734939;7776;7792.571408572526;2162.113533451285;2194.967075493869;2195.2536137713173;2196.6375548034634;2197.571473562656;2125.213670941746;2151.515908920488;2174.0760176924823;2193.035064571591;2199.296225207934;2138.8823614701187;2150.602138604363;2160.2763074370105;2165.891705414731;2195.6157672407344;2083.624947509448;2099.3806826986074;2103.63186442372;2111.3876975677035;2112.598606264805;2083.3020937985793;2135.1139277199945;2138.1661152150673;2138.871667699943;2149.1296025109855;7796.61016949156;7890.723824666166;7896.60516974149;7989.360851131895;7991;4467.128909862578;4559.133764584718;4575.6568257380495;4578.5650363215445;4595.448546174447;2828.292926768308;2945.5434407666844;2971.68797276285;2978.8659510321872;2990.2823322402683;861.4142383179435;912.977175570616;924.2698268368049;924.7872989212451;947.8483442649143;10091.19270458369;10151.64469243573;10843.186760992958;10869.782604347947;10939.453027348602;4046.5953404659886;4191.97904010478;4295.334223195409;4370.431843860278;4382.276924307454;9305.953470232605;9313.301502387212;9313.975462699098;9316.44101353921;9316.534173291308;4461.754603496839;4468.955310446854;4472.971216620195;4474.306482495218;4474.664400170001;3651.4887915691825;3969.226000929791;3970.3647416413237;4111.773852438085;4169.874903752892;3597.640235976434;3655.0862284428895;3721.3859713147567;3770.2271034437877;3795.449659799314;1185.1289302362757;1186.5016692988966;1193.6836738264367;1195.5994741761608;1198.2570806100273;838.6184286149787;843.8312337532395;848.7750746052301;863.210162701134;886.0430734806394;5155.690658560498;5383.138697808332;5474.42518535556;5487.259220005249;5601.663900166003;413.26026412721495;413.4893406642794;416.997915010423;418.5479681943494;436.3302330922083;3678.834452449646;3704.6480584344445;3705.055210921198;3740.1958578905123;3750.3249415104997;9347.252219822398;9806.803863922823;9815.509224538888;9835.950820245853;9914.801703966024;9479.810403791886;9503.809923801486;9504.667336643184;9513.66702165421;9515.381500202464;7353.0441042664115;7423.962880185564;7440.10718713747;7469.327760501581;7513.624318784039;5262.736863156751;5293.417724050274;5391.05656510117;5429.728513574384;5478.506934375925;8543.145685431407;8641.222289993932;8650.567471626267;8665.43674661145;8932.151445612657;8789.736307910773;8922.509261990654;8996.190342868911;9000.279977601645;9174.541272936192;6067;6526.836829079311;6731;6929.861402771816;7119.964400177966;7710.190430004769;7716.344110750424;7736.497127686907;7740.496867703581;7744.806379840549;6829.351211634887;6840.965795170992;6861.588304701534;6861.862762744817;7106.289371063059;6859.862802744017;6896.620685862325;6910.689018994258;6922.58464492132;6951.443884489127;6394.104825324552;6426.196725409324;6437.903431448438;6499.2200935887995;6507.479401647762;4659.510751371193;4763.166445872028;4827.348307978378;4854.975725121351;4910.6607506894225;4731.408573928259;4839.854804355875;4855.5387238212315;4908.092002979461;5086.669366491166 07:25:45 INFO - PROCESS | 10858 | |4;prototype.html;290.6541215953017;293.9720726530979;302.73208210733503;309.9008317338451;314.20662826363446;4796.28055791631;4797.856064318067;4806.3030860525205;4821.132196204686;4824.855254342367;4518.390017347657;4527.004059106991;4635.536446355362;4647.651426143036;4758.619310455164;3760.717946154036;3764.1342491227033;3764.736468447203;3773.471713960034;3778.244351129785;3754.1740817020213;3763.811809409532;3768.6608205261523;3782.602826703198;3783.6405541473514;3595.442706380502;3601.3877640801124;3744.1762812181278;3745.513083299167;3751.8874433766896;3730.123420996064;3749.081475038633;3750.1937083527037;3753.455748916419;3755.080005398695;3285.5728755261903;3316.0714999800093;3320.2900506239066;3320.837706802624;3329.3174899145615;4414.470263568361;4635.281531362644;4643.698159619614;4648.442186937556;4654.509837237096;4218.810153543098;4226.091390351089;4226.682998775073;4235.661147108224;4242.851500197478;5000.899982000376;5016.9715208382195;5020.322256495363;5024.824131155428;5033.798648054073;3543.7342199334894;3555.2711694102645;3561.94657080144;3565.1265439967374;3566.964330356689;4969.329140566014;5204.42751297357;5210.895782084375;5225.947740522584;5233.2935053768015;3634.036980200249;3649.6897763689853;3649.726270529668;3650.2699460108083;3652.4521321801412;3701.1864186548937;3702.426123950792;3703.6851867591017;3704.962950370462;3711.7030637548933;4110.815013324408;4147.149834283965;4224.260754367973;4243.811732714845;4244.299690551086;5001.4998500149695;5020.7740651670765;5026.170681837456;5026.899462010812;5026.974865125651;1255.1778585026823;1269.504893091695;1270.1363073110374;1272.5355245335386;1272.8090786381931;822.5434883639638;852.8550146475114;873.4104479476329;888.6045709659269;892.2282225874571;4392.956070439254;4393.165298593321;4393.692441529062;4401.207782599163;4404.493483249467;5093.828419463544;5111.801925172212;5114.360704911886;5118.539331460112;5119.59043276537;4211.241976444208;4357.670910372303;4372.672049596229;4400.163968845909;4404.4714634243455;2707.76983956362;2739.493193759161;2744.5608702607487;2745.3822889850026;2747.821391609539;4818.759062046954;4859.927101093415;4864.318995340655;4873.780679869415;4892.217245240744;5064.7467626619255;5254.7635356409055;5283.260343551906;5287.23335116406;5290.470952904679;4867.488913664085;4870.82952096682;4889.193283108319;4929.165729705505;4938.76530867276;5207.895842083061;5214.217867319932;5222.216667499905;5223.373195216598;5227.353383684127;4981.750912454435;5083.5678967288195;5099.57211980646;5107.412647545431;5123.641345105807;4881.3410189625365;4882.2432522959;4920.532549407801;4941.876453088702;4950.282209079735;3767.6797472215167;3796.46849441084;3812.4281357796553;3812.8284227209288;3816.866409675648;4914.680545764514;5075.568576670877;5132.820351287687;5141.53726164647;5159.974200128975;4928.334674818853;4957.132501812096;4961.776720047535;4967.205247160581;4968.527989840959;4959.652824302264;4993.15116430215;5026.421961474331;5040.874657712242;5057.216131499624;4787.195202095097;4794.448638406628;4826.396700412449;4864.659473836798;4956.950430495793;4732.881677958078;4909.3126962224605;4983.978284451606;5000.774965126505;5082.186850103965;4881.463039065629;4883.755812209446;4894.486078961801;4907.582855457326;4908.705477671351 07:25:45 INFO - PROCESS | 10858 | |5;yui.html;610.5725991805735;627.4415769964733;656.9146011018566;664.4983037806459;691.961942093185;11878.7624247515;12891.871081289184;12895.161814482064;12920.483180672785;12936.870631293696;13592.592222233325;13797.448102075905;13808.792868106986;13816.240106794148;13822.377992990314;607.0620890723842;728.1189760389934;741.1180694972992;755.845051764387;761.5773245848552;745.5824738146628;747.3722073458293;751.7481643649384;756.7880993321851;757.893894854718;798.1778767869075;798.9760307190764;799.1329407592768;799.2087833045273;800.1238643685156;629.9433051025384;768.5196752029981;789.3645615279697;790.3242727468019;794.8132188935596;587.7149582452507;587.9000569903127;587.9147523609053;588.6350462713145;588.7027051339089;11382.317060976367;11457.14071444645;11461.255018423775;11474.368909710047;11505;12239.816402753966;12305.384730763515;12790.808137877939;12843.29361885096;13219.744124308272;10455.529501172465;10475.738106547322;10558.208134389952;10567.68296951085;11273.661790146309;4066.1054567994993;4115.8971025724295;4129.834806607732;4228.640565551932;4274.658027357804;62559.6872015637;64041;64045.679771600844;64066;64200.3579964199;9833.852492212622;10256.333338333134;10493.317934334244;10691.144708423308;10709.357438553712;17280;17571.73642395365;17612.20745066475;17615.82384176142;17657.735133973;6247.219097612799;6367;6414.1340918976275;6575.44108750752;6611.20665520131;3513.4202856528896;3554.3957527220437;3580.98209508956;3625.5286812714708;3696.4455331699924;2579.484103179334;2663.3607934096067;2676.5048466033845;2677.9598306025423;2678.076063758;505.2219581843993;536.3992328592002;560.1345920552756;569.9857503562362;571.0321005894968;523.4876747845196;591.9082542205965;636.9777057802954;650.8242774450966;651.4007113455632;8769.868451973225;9102.226310763526;9108.225800806873;9143.634254629873;9243.95378023119;618.1963447518208;619.1764952613014;643.6170478565247;652.2564276724538;659.2484567592948;4205.747655140702;4230.238557059759;4253.787310634456;4286.89282767927;4326.978365108154;58975.410245896994;60380.09429858556;61759.82899152888;108794;109361;52582.21126683103;52649.473505264454;52948;77680.2231977673;92379.53810230906;77204.61397692976;77511.61244193742;78344;78369;78533;7573.129090154703;8086.15095414973;8094.79763005906;8317.792055198426;8321;46054.24321959755;46886.29670555013;47387;47535.286970694775;47808;37578;46562;49160;52739.73630131825;54519.727401364325;10930.453477325942;11078.944605276922;11195.328280302881;11211.495482703134;11396.601118960796;12207.87792122103;12926;13179;13385.933070334586;13996.580102596938;12205.816912746493;12362.814557781461;12595.74808503843;13056.543020994219;13099.541516046893;12070.155089144027;12142.514299427923;12497.750044999231;12708.491660333853;12941.611751647466;11681.299122052364;12010.219335743148;12299.262044277371;12306.569270075504;12437.76618079324;10072.345297555636;10096.949515252376;10198.286119971532;10590.099841513249;11073.390963497084;10473.371597704163;10510.001549852752;10751.892481075089;10861.185411094357;10894 07:25:45 INFO - PROCESS | 10858 | __end_tp_report 07:25:45 INFO - PROCESS | 10858 | __start_cc_report 07:25:45 INFO - PROCESS | 10858 | _x_x_mozilla_cycle_collect,911 07:25:45 INFO - PROCESS | 10858 | __end_cc_report 07:25:45 INFO - PROCESS | 10858 | __startTimestamp1472135145532__endTimestamp 07:25:45 INFO - PROCESS | 10858 | 07:25:45 INFO - PROCESS | 10858 | ------- Summary: start ------- 07:25:45 INFO - PROCESS | 10858 | Number of tests: 6 07:25:45 INFO - PROCESS | 10858 | 07:25:45 INFO - PROCESS | 10858 | [#0] dojo.html Cycles:165 Average:4570.21 Median:4675.37 stddev:465.49 (10.0%) stddev-sans-first:439.27 07:25:45 INFO - PROCESS | 10858 | Values: 2555.7 2557.1 2580.6 2592.3 2608.2 4440.0 4493.6 4548.5 4647.8 4710.5 4553.7 4569.1 4582.8 4584.7 4595.6 4205.2 4288.8 4294.9 4302.7 4314.8 4249.9 4276.7 4289.1 4335.0 4353.3 4227.6 4431.5 4434.4 4435.1 4439.6 4244.6 4269.1 4273.5 4282.8 4367.8 4147.2 4192.0 4199.4 4223.0 4255.5 4539.3 4542.6 4542.8 4554.0 4583.2 4913.1 4918.4 4928.4 4944.5 5004.6 4839.4 4912.9 4949.4 4958.3 4960.7 4637.3 4640.7 4642.9 4693.2 4700.8 5100.3 5105.4 5106.0 5118.7 5120.9 4741.9 4781.7 4783.2 4787.0 4892.8 4932.0 4932.0 4948.8 4950.8 5008.1 4858.9 4890.6 4895.1 4898.0 4958.0 4773.7 4825.7 4829.4 4908.6 4925.3 4217.7 4231.2 4247.9 4262.7 4272.2 3699.2 3739.7 3776.1 3786.8 3787.9 4265.0 4266.6 4270.3 4314.5 4321.9 4762.6 4935.4 4979.4 4996.2 5052.9 4185.2 4218.5 4240.3 4243.2 4292.0 4466.8 4473.3 4478.9 4486.4 4539.4 4524.0 4664.2 4670.9 4672.4 4716.6 4858.6 4898.0 4912.7 4930.1 4986.5 4608.1 4625.9 4640.5 4641.0 4696.0 4675.4 4851.7 4862.6 4863.2 4918.4 4763.0 4839.8 4856.0 4861.5 4873.4 4803.5 4803.6 4803.9 4848.2 4857.3 4790.7 4794.4 4795.4 4798.0 4844.6 4568.1 4745.5 4749.6 4762.9 4796.8 4922.8 4929.2 4939.0 4977.9 4982.9 4643.7 4790.9 4799.8 4811.7 4869.7 07:25:45 INFO - PROCESS | 10858 | 07:25:45 INFO - PROCESS | 10858 | [#1] ext.html Cycles:180 Average:47889.58 Median:369720.50 stddev:88412.09 (23.9%) stddev-sans-first:88588.68 07:25:45 INFO - PROCESS | 10858 | Values: 552.9 554.0 555.9 561.8 564.3 27553.0 30437.4 30491.2 37531.2 39236.8 39188.0 39606.0 39617.2 39621.2 39649.2 7363.9 7518.2 7525.1 7526.2 7530.2 7615.2 7698.6 7708.7 7710.0 7712.1 7695.3 7726.5 7734.1 7740.8 7742.0 7662.9 7674.7 7706.8 7710.8 7721.0 7553.0 7612.0 7615.2 7621.0 7631.2 37578.2 37581.6 37715.4 37903.0 37990.8 3088.3 3091.7 3202.0 3323.7 3381.8 28522.3 28704.7 28796.6 29836.3 30238.7 3497.5 3504.8 3520.9 3532.5 3608.1 240424.0 241385.0 242080.0 242311.0 243403.0 50387.5 50802.5 50815.5 50843.0 50868.5 32030.5 32859.0 32896.2 53149.0 53264.0 14528.3 14741.3 14741.3 14765.1 14783.3 11301.4 11453.7 11454.9 11461.7 11464.1 17595.5 17667.1 17671.6 17685.9 17714.4 6533.0 6702.8 6709.4 6718.4 6806.1 729.7 843.7 860.3 941.6 956.9 24632.3 26724.0 26833.3 27029.0 29025.0 895.6 924.4 961.3 988.4 1030.6 14487.8 14860.4 15002.2 15035.9 15073.9 376914.0 378370.0 378626.0 379182.0 380054.0 44962.0 45479.5 45541.5 45580.0 45643.3 1182.3 1186.0 1206.5 1218.3 1218.8 26044.6 27038.0 27451.0 28126.0 28172.6 41573.4 44832.3 46693.3 46694.8 51108.2 364750.0 368080.0 368933.0 369668.0 369773.0 37314.4 37866.8 37900.4 37962.0 38697.2 41274.0 41543.6 41699.4 42244.2 42374.2 35226.1 35406.1 35466.1 36020.5 36123.8 35067.6 35114.5 35237.0 35975.8 35977.6 34499.7 35175.8 35499.6 35573.0 35859.8 30552.7 33168.8 33188.0 33433.8 33598.8 24685.4 25167.4 25178.7 25651.5 25848.5 07:25:45 INFO - PROCESS | 10858 | 07:25:45 INFO - PROCESS | 10858 | [#2] jquery.html Cycles:180 Average:25238.86 Median:4806.85 stddev:68221.94 (1419.3%) stddev-sans-first:68387.70 07:25:45 INFO - PROCESS | 10858 | Values: 341.0 364.8 370.5 374.5 381.1 12710.6 14625.9 16573.2 16822.2 17446.7 15955.2 16777.4 16894.8 16994.8 17153.8 4836.6 5128.3 5128.4 5134.8 5136.3 3761.6 4777.1 5021.2 5100.8 5109.9 5970.9 6044.7 6049.7 6052.8 6060.0 5903.4 5979.8 6014.2 6048.3 6059.0 5289.8 5303.1 5327.6 5341.5 5351.4 19573.8 21014.8 21103.4 21233.5 21311.7 2043.5 2069.5 2073.2 2285.9 2499.8 12965.8 13586.5 13816.9 13950.9 14102.3 1753.6 1810.5 1811.3 1814.8 1820.3 67710.3 67926.7 70492.6 70732.6 72133.6 8586.9 9068.7 9173.4 9662.9 9840.5 11655.7 11693.8 11732.9 11756.4 11774.9 7048.8 7316.7 7329.9 7336.4 7372.3 6854.2 7072.2 7112.2 7201.9 7376.6 3719.1 3795.9 3835.0 3962.4 4124.9 1820.2 1871.5 1897.0 1899.1 1921.6 845.8 853.7 889.7 891.1 900.7 15746.3 16586.3 16594.3 17179.8 18056.5 853.2 874.5 885.4 932.8 944.4 7579.7 9311.8 9449.6 10302.0 10631.7 408402.0 413437.0 413708.0 414135.0 415614.0 79658.0 81669.2 82177.6 82744.6 85228.6 887.7 938.0 940.8 947.9 952.8 15587.9 15690.9 15989.8 16311.0 16479.2 38558.0 39412.5 39556.2 39724.4 40277.3 52150.7 52523.0 52945.5 53111.0 53121.2 7553.5 7565.8 7773.7 7798.0 8260.5 10048.4 11053.2 11513.3 11731.5 11930.8 9766.9 9992.0 10057.0 10205.8 10262.2 10111.5 10181.8 10506.9 10589.5 11151.4 9028.8 9708.7 10201.5 10298.6 10330.5 7167.6 7455.7 7532.5 7538.7 7627.7 8276.9 9584.8 9868.1 9949.9 10012.6 07:25:45 INFO - PROCESS | 10858 | 07:25:45 INFO - PROCESS | 10858 | [#3] mootools.html Cycles:180 Average:5163.62 Median:5209.21 stddev:2910.52 (55.9%) stddev-sans-first:2903.23 07:25:45 INFO - PROCESS | 10858 | Values: 1173.1 1323.4 1338.5 1622.1 1622.7 7497.5 7995.6 8004.4 8006.7 8010.1 6746.6 7540.1 7710.9 7776.0 7792.6 2162.1 2195.0 2195.3 2196.6 2197.6 2125.2 2151.5 2174.1 2193.0 2199.3 2138.9 2150.6 2160.3 2165.9 2195.6 2083.6 2099.4 2103.6 2111.4 2112.6 2083.3 2135.1 2138.2 2138.9 2149.1 7796.6 7890.7 7896.6 7989.4 7991.0 4467.1 4559.1 4575.7 4578.6 4595.4 2828.3 2945.5 2971.7 2978.9 2990.3 861.4 913.0 924.3 924.8 947.8 10091.2 10151.6 10843.2 10869.8 10939.5 4046.6 4192.0 4295.3 4370.4 4382.3 9306.0 9313.3 9314.0 9316.4 9316.5 4461.8 4469.0 4473.0 4474.3 4474.7 3651.5 3969.2 3970.4 4111.8 4169.9 3597.6 3655.1 3721.4 3770.2 3795.4 1185.1 1186.5 1193.7 1195.6 1198.3 838.6 843.8 848.8 863.2 886.0 5155.7 5383.1 5474.4 5487.3 5601.7 413.3 413.5 417.0 418.5 436.3 3678.8 3704.6 3705.1 3740.2 3750.3 9347.3 9806.8 9815.5 9836.0 9914.8 9479.8 9503.8 9504.7 9513.7 9515.4 7353.0 7424.0 7440.1 7469.3 7513.6 5262.7 5293.4 5391.1 5429.7 5478.5 8543.1 8641.2 8650.6 8665.4 8932.2 8789.7 8922.5 8996.2 9000.3 9174.5 6067.0 6526.8 6731.0 6929.9 7120.0 7710.2 7716.3 7736.5 7740.5 7744.8 6829.4 6841.0 6861.6 6861.9 7106.3 6859.9 6896.6 6910.7 6922.6 6951.4 6394.1 6426.2 6437.9 6499.2 6507.5 4659.5 4763.2 4827.3 4855.0 4910.7 4731.4 4839.9 4855.5 4908.1 5086.7 07:25:45 INFO - PROCESS | 10858 | 07:25:45 INFO - PROCESS | 10858 | [#4] prototype.html Cycles:180 Average:4156.69 Median:4772.91 stddev:1199.14 (25.1%) stddev-sans-first:1166.87 07:25:45 INFO - PROCESS | 10858 | Values: 290.7 294.0 302.7 309.9 314.2 4796.3 4797.9 4806.3 4821.1 4824.9 4518.4 4527.0 4635.5 4647.7 4758.6 3760.7 3764.1 3764.7 3773.5 3778.2 3754.2 3763.8 3768.7 3782.6 3783.6 3595.4 3601.4 3744.2 3745.5 3751.9 3730.1 3749.1 3750.2 3753.5 3755.1 3285.6 3316.1 3320.3 3320.8 3329.3 4414.5 4635.3 4643.7 4648.4 4654.5 4218.8 4226.1 4226.7 4235.7 4242.9 5000.9 5017.0 5020.3 5024.8 5033.8 3543.7 3555.3 3561.9 3565.1 3567.0 4969.3 5204.4 5210.9 5225.9 5233.3 3634.0 3649.7 3649.7 3650.3 3652.5 3701.2 3702.4 3703.7 3705.0 3711.7 4110.8 4147.1 4224.3 4243.8 4244.3 5001.5 5020.8 5026.2 5026.9 5027.0 1255.2 1269.5 1270.1 1272.5 1272.8 822.5 852.9 873.4 888.6 892.2 4393.0 4393.2 4393.7 4401.2 4404.5 5093.8 5111.8 5114.4 5118.5 5119.6 4211.2 4357.7 4372.7 4400.2 4404.5 2707.8 2739.5 2744.6 2745.4 2747.8 4818.8 4859.9 4864.3 4873.8 4892.2 5064.7 5254.8 5283.3 5287.2 5290.5 4867.5 4870.8 4889.2 4929.2 4938.8 5207.9 5214.2 5222.2 5223.4 5227.4 4981.8 5083.6 5099.6 5107.4 5123.6 4881.3 4882.2 4920.5 4941.9 4950.3 3767.7 3796.5 3812.4 3812.8 3816.9 4914.7 5075.6 5132.8 5141.5 5160.0 4928.3 4957.1 4961.8 4967.2 4968.5 4959.7 4993.2 5026.4 5040.9 5057.2 4787.2 4794.4 4826.4 4864.7 4957.0 4732.9 4909.3 4984.0 5000.8 5082.2 4881.5 4883.8 4894.5 4907.6 4908.7 07:25:45 INFO - PROCESS | 10858 | 07:25:45 INFO - PROCESS | 10858 | [#5] yui.html Cycles:180 Average:16632.21 Median:4306.94 stddev:22854.97 (530.7%) stddev-sans-first:22887.42 07:25:45 INFO - PROCESS | 10858 | Values: 610.6 627.4 656.9 664.5 692.0 11878.8 12891.9 12895.2 12920.5 12936.9 13592.6 13797.4 13808.8 13816.2 13822.4 607.1 728.1 741.1 755.8 761.6 745.6 747.4 751.7 756.8 757.9 798.2 799.0 799.1 799.2 800.1 629.9 768.5 789.4 790.3 794.8 587.7 587.9 587.9 588.6 588.7 11382.3 11457.1 11461.3 11474.4 11505.0 12239.8 12305.4 12790.8 12843.3 13219.7 10455.5 10475.7 10558.2 10567.7 11273.7 4066.1 4115.9 4129.8 4228.6 4274.7 62559.7 64041.0 64045.7 64066.0 64200.4 9833.9 10256.3 10493.3 10691.1 10709.4 17280.0 17571.7 17612.2 17615.8 17657.7 6247.2 6367.0 6414.1 6575.4 6611.2 3513.4 3554.4 3581.0 3625.5 3696.4 2579.5 2663.4 2676.5 2678.0 2678.1 505.2 536.4 560.1 570.0 571.0 523.5 591.9 637.0 650.8 651.4 8769.9 9102.2 9108.2 9143.6 9244.0 618.2 619.2 643.6 652.3 659.2 4205.7 4230.2 4253.8 4286.9 4327.0 58975.4 60380.1 61759.8 108794.0 109361.0 52582.2 52649.5 52948.0 77680.2 92379.5 77204.6 77511.6 78344.0 78369.0 78533.0 7573.1 8086.2 8094.8 8317.8 8321.0 46054.2 46886.3 47387.0 47535.3 47808.0 37578.0 46562.0 49160.0 52739.7 54519.7 10930.5 11078.9 11195.3 11211.5 11396.6 12207.9 12926.0 13179.0 13385.9 13996.6 12205.8 12362.8 12595.7 13056.5 13099.5 12070.2 12142.5 12497.8 12708.5 12941.6 11681.3 12010.2 12299.3 12306.6 12437.8 10072.3 10096.9 10198.3 10590.1 11073.4 10473.4 10510.0 10751.9 10861.2 10894.0 07:25:45 INFO - PROCESS | 10858 | -------- Summary: end -------- 07:25:45 INFO - PROCESS | 10858 | 07:25:46 INFO - TEST-INFO | 10858: exit 0 07:25:46 INFO - TEST-OK | dromaeo_css | took 1121249ms 07:25:46 INFO - TEST-START | kraken 07:25:46 INFO - operating with platform_type : linux_ 07:25:46 INFO - Initialising browser for kraken test... 07:25:46 INFO - TEST-INFO | started process 11161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqrZeS9/profile http://localhost:49396/getInfo.html) 07:25:50 INFO - PROCESS | 11161 | __metrics Screen width/height:1600/1200 07:25:50 INFO - PROCESS | 11161 | colorDepth:24 07:25:50 INFO - PROCESS | 11161 | Browser inner width/height: 1024/697 07:25:50 INFO - PROCESS | 11161 | __metrics 07:25:51 INFO - PROCESS | 11161 | 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" 07:25:51 INFO - PROCESS | 11161 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:25:52 INFO - PROCESS | 11161 | console.error: PushService: 07:25:52 INFO - PROCESS | 11161 | stateChangeProcessEnqueue: Error transitioning state 07:25:52 INFO - PROCESS | 11161 | UnknownError 07:25:52 INFO - TEST-INFO | 11161: exit 0 07:25:52 INFO - Browser initialized. 07:25:52 INFO - Running cycle 1/1 for kraken test... 07:25:52 INFO - TEST-INFO | started process 11243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqrZeS9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:04 INFO - PROCESS | 11243 | RSS: Main: 179736576 07:26:04 INFO - PROCESS | 11243 | 07:26:07 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49396/tests/kraken/driver.html?testName=audio-beat-detection) 07:26:08 INFO - PROCESS | 11243 | RSS: Main: 232476672 07:26:08 INFO - PROCESS | 11243 | 07:26:11 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49396/tests/kraken/driver.html?testName=audio-dft) 07:26:11 INFO - PROCESS | 11243 | RSS: Main: 223506432 07:26:11 INFO - PROCESS | 11243 | 07:26:15 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49396/tests/kraken/driver.html?testName=audio-fft) 07:26:15 INFO - PROCESS | 11243 | RSS: Main: 302317568 07:26:15 INFO - PROCESS | 11243 | 07:26:18 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49396/tests/kraken/driver.html?testName=audio-oscillator) 07:26:18 INFO - PROCESS | 11243 | RSS: Main: 212389888 07:26:18 INFO - PROCESS | 11243 | 07:26:20 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49396/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:26:21 INFO - PROCESS | 11243 | RSS: Main: 214740992 07:26:21 INFO - PROCESS | 11243 | 07:26:24 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49396/tests/kraken/driver.html?testName=imaging-darkroom) 07:26:25 INFO - PROCESS | 11243 | RSS: Main: 253669376 07:26:25 INFO - PROCESS | 11243 | 07:26:28 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49396/tests/kraken/driver.html?testName=imaging-desaturate) 07:26:29 INFO - PROCESS | 11243 | RSS: Main: 247611392 07:26:29 INFO - PROCESS | 11243 | 07:26:32 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49396/tests/kraken/driver.html?testName=json-parse-financial) 07:26:32 INFO - PROCESS | 11243 | RSS: Main: 250306560 07:26:32 INFO - PROCESS | 11243 | 07:26:34 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49396/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:35 INFO - PROCESS | 11243 | RSS: Main: 214310912 07:26:35 INFO - PROCESS | 11243 | 07:26:37 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:37 INFO - PROCESS | 11243 | RSS: Main: 221151232 07:26:37 INFO - PROCESS | 11243 | 07:26:39 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:40 INFO - PROCESS | 11243 | RSS: Main: 220192768 07:26:40 INFO - PROCESS | 11243 | 07:26:43 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:44 INFO - PROCESS | 11243 | RSS: Main: 221077504 07:26:44 INFO - PROCESS | 11243 | 07:26:46 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:47 INFO - PROCESS | 11243 | RSS: Main: 220000256 07:26:47 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49396/tests/kraken/driver.html?testName=ai-astar) 07:26:49 INFO - PROCESS | 11243 | RSS: Main: 270417920 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | __start_tp_report 07:26:49 INFO - PROCESS | 11243 | _x_x_mozilla_page_load 07:26:49 INFO - PROCESS | 11243 | _x_x_mozilla_page_load_details 07:26:49 INFO - PROCESS | 11243 | |i|pagename|runs| 07:26:49 INFO - PROCESS | 11243 | |0;ai-astar;113;114;128;113;115;113;113;116;115;115 07:26:49 INFO - PROCESS | 11243 | |1;audio-beat-detection;161;123;155;173;123;151;153;131;178;124 07:26:49 INFO - PROCESS | 11243 | |2;audio-dft;162;162;161;162;161;163;162;164;162;162 07:26:49 INFO - PROCESS | 11243 | |3;audio-fft;76;76;76;174;76;76;76;75;161;76 07:26:49 INFO - PROCESS | 11243 | |4;audio-oscillator;86;86;156;88;88;87;139;85;86;145 07:26:49 INFO - PROCESS | 11243 | |5;imaging-gaussian-blur;117;116;117;117;116;117;117;118;117;117 07:26:49 INFO - PROCESS | 11243 | |6;imaging-darkroom;145;147;145;147;147;146;146;146;146;147 07:26:49 INFO - PROCESS | 11243 | |7;imaging-desaturate;95;96;95;96;96;96;95;96;95;94 07:26:49 INFO - PROCESS | 11243 | |8;json-parse-financial;68;66;68;66;66;69;66;66;66;65 07:26:49 INFO - PROCESS | 11243 | |9;json-stringify-tinderbox;65;65;66;66;65;65;66;65;65;66 07:26:49 INFO - PROCESS | 11243 | |10;stanford-crypto-aes;82;83;86;82;85;82;82;82;82;82 07:26:49 INFO - PROCESS | 11243 | |11;stanford-crypto-ccm;135;133;135;135;129;134;134;133;174;145 07:26:49 INFO - PROCESS | 11243 | |12;stanford-crypto-pbkdf2;175;167;170;168;169;169;174;170;169;169 07:26:49 INFO - PROCESS | 11243 | |13;stanford-crypto-sha256-iterative;68;68;69;72;67;67;67;68;68;67 07:26:49 INFO - PROCESS | 11243 | __end_tp_report 07:26:49 INFO - PROCESS | 11243 | __start_cc_report 07:26:49 INFO - PROCESS | 11243 | _x_x_mozilla_cycle_collect,1993 07:26:49 INFO - PROCESS | 11243 | __end_cc_report 07:26:49 INFO - PROCESS | 11243 | __startTimestamp1472135209555__endTimestamp 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | ------- Summary: start ------- 07:26:49 INFO - PROCESS | 11243 | Number of tests: 14 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.00 stddev:4.53 (3.9%) stddev-sans-first:4.71 07:26:49 INFO - PROCESS | 11243 | Values: 113.0 114.0 128.0 113.0 115.0 113.0 113.0 116.0 115.0 115.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:154.00 stddev:20.78 (13.5%) stddev-sans-first:21.43 07:26:49 INFO - PROCESS | 11243 | Values: 161.0 123.0 155.0 173.0 123.0 151.0 153.0 131.0 178.0 124.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 07:26:49 INFO - PROCESS | 11243 | Values: 162.0 162.0 161.0 162.0 161.0 163.0 162.0 164.0 162.0 162.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:38.76 (51.0%) stddev-sans-first:40.54 07:26:49 INFO - PROCESS | 11243 | Values: 76.0 76.0 76.0 174.0 76.0 76.0 76.0 75.0 161.0 76.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:86.00 stddev:29.33 (34.1%) stddev-sans-first:30.32 07:26:49 INFO - PROCESS | 11243 | Values: 86.0 86.0 156.0 88.0 88.0 87.0 139.0 85.0 86.0 145.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:26:49 INFO - PROCESS | 11243 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 07:26:49 INFO - PROCESS | 11243 | Values: 145.0 147.0 145.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 07:26:49 INFO - PROCESS | 11243 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 94.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.24 07:26:49 INFO - PROCESS | 11243 | Values: 68.0 66.0 68.0 66.0 66.0 69.0 66.0 66.0 66.0 65.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:26:49 INFO - PROCESS | 11243 | Values: 65.0 65.0 66.0 66.0 65.0 65.0 66.0 65.0 65.0 66.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.00 stddev:1.48 (1.8%) stddev-sans-first:1.54 07:26:49 INFO - PROCESS | 11243 | Values: 82.0 83.0 86.0 82.0 85.0 82.0 82.0 82.0 82.0 82.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:135.00 stddev:13.04 (9.7%) stddev-sans-first:13.76 07:26:49 INFO - PROCESS | 11243 | Values: 135.0 133.0 135.0 135.0 129.0 134.0 134.0 133.0 174.0 145.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:169.50 stddev:2.54 (1.5%) stddev-sans-first:1.94 07:26:49 INFO - PROCESS | 11243 | Values: 175.0 167.0 170.0 168.0 169.0 169.0 174.0 170.0 169.0 169.0 07:26:49 INFO - PROCESS | 11243 | 07:26:49 INFO - PROCESS | 11243 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.52 (2.2%) stddev-sans-first:1.62 07:26:49 INFO - PROCESS | 11243 | Values: 68.0 68.0 69.0 72.0 67.0 67.0 67.0 68.0 68.0 67.0 07:26:49 INFO - PROCESS | 11243 | -------- Summary: end -------- 07:26:49 INFO - PROCESS | 11243 | 07:26:50 INFO - TEST-INFO | 11243: exit 0 07:26:50 INFO - TEST-OK | kraken | took 64339ms 07:26:50 INFO - SUITE-END | took 1185s 07:26:51 INFO - Completed test suite (00:19:45) 07:26:51 INFO - javascript benchmark 07:26:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2555.718870924199, 2557.0666706652073, 2580.638710580518, 2592.325995241237, 2608.2305719812653, 4440.045390241105, 4493.618042466394, 4548.487709395034, 4647.837325693606, 4710.458297295812, 4553.726776393419, 4569.109023740372, 4582.816687332503, 4584.679072464929, 4595.632349412047, 4205.2220339237265, 4288.849890253841, 4294.871153865373, 4302.741835489865, 4314.762688052156, 4249.872503824875, 4276.700630955835, 4289.120730250307, 4335.024619460612, 4353.281708518107, 4227.577242275764, 4431.512533621299, 4434.35701823237, 4435.068635586531, 4439.600435960763, 4244.596763307481, 4269.060806622538, 4273.4658167729185, 4282.807273672693, 4367.781610919441, 4147.191297696951, 4192.035831758682, 4199.433076534659, 4223.049813791903, 4255.510616279136, 4539.251023581105, 4542.636589072867, 4542.841000564964, 4554.0, 4583.220852455091, 4913.091078150554, 4918.360613120271, 4928.43323017854, 4944.456109827916, 5004.574611158019, 4839.395075615548, 4912.852614421573, 4949.430815456232, 4958.3306253655655, 4960.702357858504, 4637.25803871379, 4640.744759038218, 4642.907141857211, 4693.22561777303, 4700.811967521329, 5100.336956195671, 5105.387353517527, 5106.0, 5118.718470484085, 5120.948790512121, 4741.857744267678, 4781.737004464719, 4783.234682450791, 4787.042591481718, 4892.804287828447, 4931.950680493221, 4932.038252540792, 4948.802047918043, 4950.752462376867, 5008.073506401327, 4858.854234372974, 4890.608751299887, 4895.094407534618, 4898.044881248123, 4957.975210123926, 4773.71357718538, 4825.734584597811, 4829.396325459317, 4908.607311415079, 4925.310456536088, 4217.662586993033, 4231.153769246102, 4247.936280955726, 4262.722923009995, 4272.230998420314, 3699.204670995749, 3739.700823934079, 3776.0937375030344, 3786.7917264550165, 3787.905302367408, 4265.019045619525, 4266.552012038691, 4270.252705776476, 4314.460692413449, 4321.870343889688, 4762.571368576845, 4935.383077115361, 4979.402471703419, 4996.175631020841, 5052.924206136838, 4185.16296740647, 4218.49378074633, 4240.257954857949, 4243.193793179286, 4291.957080429156, 4466.754328511898, 4473.284274516127, 4478.910421791546, 4486.439195100613, 4539.432570928634, 4524.04994951064, 4664.207084795661, 4670.906581868344, 4672.439307283148, 4716.622670186377, 4858.58702010333, 4897.95102048975, 4912.70523768575, 4930.087933732271, 4986.451490335988, 4608.147492713859, 4625.907481850411, 4640.535946405467, 4641.002184530342, 4695.990362072171, 4675.3688252086895, 4851.684640498356, 4862.610991120772, 4863.173260545786, 4918.385201849769, 4762.9523704762505, 4839.782209800497, 4856.028794241095, 4861.465238823797, 4873.415190177059, 4803.471618122074, 4803.567678908915, 4803.855884323476, 4848.151573474698, 4857.319975203403, 4790.712557246577, 4794.376731024944, 4795.448523419851, 4797.976010119927, 4844.612431005582, 4568.063546972796, 4745.549172828576, 4749.643776716829, 4762.880927976828, 4796.784144713426, 4922.827701030446, 4929.2359684248995, 4938.950610493849, 4977.900441991213, 4982.8754281143265, 4643.7213767172725, 4790.932517233212, 4799.808007679654, 4811.687240329367, 4869.707817530818], "value": 4541.115447946587, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9336479622445, 554.0055600197645, 555.8860433611109, 561.8483009587411, 564.2733236296929, 27553.0, 30437.391252174944, 30491.237719057033, 37531.249375012485, 39236.80381598095, 39188.0, 39606.0, 39617.20765584687, 39621.207575848464, 39649.20701585967, 7363.926360736405, 7518.173000969889, 7525.059367579052, 7526.209747976438, 7530.246975302453, 7615.238476152396, 7698.6150692465435, 7708.653110610036, 7710.036245469317, 7712.113106992711, 7695.268949449794, 7726.459147859652, 7734.1105772836, 7740.806479837993, 7742.0, 7662.885056724153, 7674.693012279502, 7706.845863082707, 7710.807229819244, 7721.0, 7553.0, 7612.0, 7615.238476152396, 7620.961895190544, 7631.2368763123795, 37578.24843503142, 37581.62418375836, 37715.434268485995, 37903.0, 37990.81004594987, 3088.320569474712, 3091.6753740857334, 3202.0, 3323.7341012718925, 3381.8140002299865, 28522.286942826388, 28704.712952870414, 28796.568051479244, 29836.254093647833, 30238.697613023807, 3497.475378693191, 3504.789712617251, 3520.9471857922154, 3532.5231093802263, 3608.116011577154, 240424.0, 241385.0, 242080.0, 242311.0, 243403.0, 50387.49612503901, 50802.49197508051, 50815.49184508107, 50843.0, 50868.491315087114, 32030.519542206886, 32859.0, 32896.17759555982, 53149.0, 53264.0, 14528.346224419927, 14741.262936853114, 14741.336639851232, 14765.114093154445, 14783.334749936279, 11301.378424186749, 11453.656390308304, 11454.885451145548, 11461.71345716347, 11464.082873370277, 17595.472135835946, 17667.116644167996, 17671.558211044827, 17685.911570442066, 17714.379996700052, 6533.0, 6702.765403210864, 6709.36261055199, 6718.361755633207, 6806.149231346082, 729.7409419655945, 843.6843206199694, 860.320346925934, 941.6092321686424, 956.9186619137312, 24632.261032169063, 26724.0, 26833.329166770596, 27029.0, 29025.0, 895.6104094718818, 924.4083786376724, 961.33667769239, 988.4217732626494, 1030.5723124903232, 14487.78268325976, 14860.405583776528, 15002.174880381466, 15035.924820375829, 15073.883793264318, 376914.0, 378370.0, 378626.0, 379182.0, 380054.0, 44962.0, 45479.54520454753, 45541.54458455373, 45580.0, 45643.315350269775, 1182.3201659046083, 1185.958491452795, 1206.4872429217723, 1218.3055658274875, 1218.7623413434474, 26044.609330860432, 27038.0, 27451.0, 28126.0, 28172.647197032496, 41573.37639935464, 44832.32751508665, 46693.299600506696, 46694.76652616715, 51108.233376500124, 364750.0, 368080.0, 368933.0, 369668.0, 369773.0, 37314.44028339631, 37866.810665947596, 37900.43149352707, 37961.97703424875, 38697.226055479296, 41274.0, 41543.58456415397, 41699.37450938299, 42244.1551168981, 42374.152516950104, 35226.11934701653, 35406.11484712903, 35466.11334716653, 36020.4596931041, 36123.819380902925, 35067.64932350644, 35114.47328290027, 35237.0, 35975.820120899225, 35977.64022359848, 34499.65500345065, 35175.82412087923, 35499.64500354963, 35573.0, 35859.82070089633, 30552.694473054984, 33168.844025138285, 33188.0, 33433.83283083569, 33598.83200583982, 24685.382865428506, 25167.37081572975, 25178.748212518374, 25651.486970260117, 25848.483030339663], "value": 17392.04379321282, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.0110679030812, 364.8157680371412, 370.5497820148519, 374.47947353179086, 381.07779174397956, 12710.61868143956, 14625.853741462595, 16573.17134143291, 16822.15889205541, 17446.65106697865, 15955.202239887989, 16777.412790552335, 16894.831051689478, 16994.83005169948, 17153.82846171538, 4836.637252206081, 5128.256402821588, 5128.384593848743, 5134.820281290155, 5136.306598609196, 3761.6426439488205, 4777.06847164803, 5021.17150670139, 5100.770465329069, 5109.897802043975, 5970.910436343458, 6044.667543285118, 6049.727762250709, 6052.788152414666, 6060.030395136779, 5903.409659034105, 5979.820605381846, 6014.1580178775, 6048.274207095154, 6058.96970515149, 5289.814856480005, 5303.124984377573, 5327.600429967768, 5341.4658534146665, 5351.438098999588, 19573.80426195734, 21014.789852101436, 21103.366898993056, 21233.46916327089, 21311.68032479514, 2043.5197728533783, 2069.4722845674255, 2073.1914553324214, 2285.8568221501623, 2499.787518060967, 12965.805512917314, 13586.456541738318, 13816.93091534546, 13950.860491395058, 14102.294885255798, 1753.6317373351612, 1810.5473631592101, 1811.2664370929795, 1814.8003719590833, 1820.2627935686069, 67710.32289677138, 67926.66036669834, 70492.64753676199, 70732.6463367685, 72133.639331803, 8586.87119693205, 9068.727938161866, 9173.357864949523, 9662.855057174149, 9840.458774767456, 11655.708607284885, 11693.824592631117, 11732.94133529327, 11756.35340056288, 11774.94112529432, 7048.823779405556, 7316.743913962986, 7329.9267007329245, 7336.376408005272, 7372.299631534996, 6854.246032936373, 7072.186698529632, 7112.182099058571, 7201.927980720126, 7376.557406555624, 3719.088823238324, 3795.9240815183543, 3835.0412396900774, 3962.40563915415, 4124.896877578085, 1820.1536285626983, 1871.466632009898, 1896.985112964585, 1899.088437549956, 1921.6060707555198, 845.8435189489965, 853.6713365354383, 889.7019498467956, 891.1266958380824, 900.6892622045384, 15746.291416886268, 16586.253618587194, 16594.336226550804, 17179.82820171807, 18056.548586285186, 853.1809462915546, 874.5408660453186, 885.4421714320066, 932.7854593443546, 944.4191822029402, 7579.734709285149, 9311.767205819773, 9449.645375891598, 10302.0, 10631.734206644742, 408402.0, 413437.0, 413708.0, 414135.0, 415614.0, 79658.0, 81669.18330816734, 82177.58911205406, 82744.58627706823, 85228.57385713032, 887.6582515731361, 937.990620093804, 940.8071345374182, 947.9289053321029, 952.84754439288, 15587.922060389625, 15690.9215453922, 15989.760153597472, 16311.0, 16479.17604119813, 38558.0, 39412.4822524841, 39556.2088758229, 39724.40413393744, 40277.30571605668, 52150.73924630353, 52523.0, 52945.470545294054, 53111.0, 53121.203181953075, 7553.546787192786, 7565.848683026419, 7773.727919522789, 7797.961010195139, 8260.49802857432, 10048.447335396331, 11053.226274160732, 11513.251638643462, 11731.47208375608, 11930.821037684615, 9766.853497197406, 9992.0, 10057.0, 10205.795884082128, 10262.189466545744, 10111.494425278559, 10181.847272290774, 10506.94746526293, 10589.4705264738, 11151.386673733023, 9028.819423611621, 9708.660196893075, 10201.489925503844, 10298.588056477656, 10330.48347582633, 7167.641617919187, 7455.6644950978425, 7532.54804711719, 7538.660760265691, 7627.694892204249, 8276.875846862422, 9584.808303834025, 9868.062534059252, 9949.900500994898, 10012.599496020077], "value": 8308.012264634932, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1173.0967155290427, 1323.3780123342028, 1338.5114433231868, 1622.148372104644, 1622.6673531925949, 7497.475176737624, 7995.600219989006, 8004.39967002475, 8006.719764808218, 8010.118886922442, 6746.561473504231, 7540.132884718245, 7710.884336734939, 7776.0, 7792.571408572526, 2162.113533451285, 2194.967075493869, 2195.2536137713173, 2196.6375548034634, 2197.571473562656, 2125.213670941746, 2151.515908920488, 2174.0760176924823, 2193.035064571591, 2199.296225207934, 2138.8823614701187, 2150.602138604363, 2160.2763074370105, 2165.891705414731, 2195.6157672407344, 2083.624947509448, 2099.3806826986074, 2103.63186442372, 2111.3876975677035, 2112.598606264805, 2083.3020937985793, 2135.1139277199945, 2138.1661152150673, 2138.871667699943, 2149.1296025109855, 7796.61016949156, 7890.723824666166, 7896.60516974149, 7989.360851131895, 7991.0, 4467.128909862578, 4559.133764584718, 4575.6568257380495, 4578.5650363215445, 4595.448546174447, 2828.292926768308, 2945.5434407666844, 2971.68797276285, 2978.8659510321872, 2990.2823322402683, 861.4142383179435, 912.977175570616, 924.2698268368049, 924.7872989212451, 947.8483442649143, 10091.19270458369, 10151.64469243573, 10843.186760992958, 10869.782604347947, 10939.453027348602, 4046.5953404659886, 4191.97904010478, 4295.334223195409, 4370.431843860278, 4382.276924307454, 9305.953470232605, 9313.301502387212, 9313.975462699098, 9316.44101353921, 9316.534173291308, 4461.754603496839, 4468.955310446854, 4472.971216620195, 4474.306482495218, 4474.664400170001, 3651.4887915691825, 3969.226000929791, 3970.3647416413237, 4111.773852438085, 4169.874903752892, 3597.640235976434, 3655.0862284428895, 3721.3859713147567, 3770.2271034437877, 3795.449659799314, 1185.1289302362757, 1186.5016692988966, 1193.6836738264367, 1195.5994741761608, 1198.2570806100273, 838.6184286149787, 843.8312337532395, 848.7750746052301, 863.210162701134, 886.0430734806394, 5155.690658560498, 5383.138697808332, 5474.42518535556, 5487.259220005249, 5601.663900166003, 413.26026412721495, 413.4893406642794, 416.997915010423, 418.5479681943494, 436.3302330922083, 3678.834452449646, 3704.6480584344445, 3705.055210921198, 3740.1958578905123, 3750.3249415104997, 9347.252219822398, 9806.803863922823, 9815.509224538888, 9835.950820245853, 9914.801703966024, 9479.810403791886, 9503.809923801486, 9504.667336643184, 9513.66702165421, 9515.381500202464, 7353.0441042664115, 7423.962880185564, 7440.10718713747, 7469.327760501581, 7513.624318784039, 5262.736863156751, 5293.417724050274, 5391.05656510117, 5429.728513574384, 5478.506934375925, 8543.145685431407, 8641.222289993932, 8650.567471626267, 8665.43674661145, 8932.151445612657, 8789.736307910773, 8922.509261990654, 8996.190342868911, 9000.279977601645, 9174.541272936192, 6067.0, 6526.836829079311, 6731.0, 6929.861402771816, 7119.964400177966, 7710.190430004769, 7716.344110750424, 7736.497127686907, 7740.496867703581, 7744.806379840549, 6829.351211634887, 6840.965795170992, 6861.588304701534, 6861.862762744817, 7106.289371063059, 6859.862802744017, 6896.620685862325, 6910.689018994258, 6922.58464492132, 6951.443884489127, 6394.104825324552, 6426.196725409324, 6437.903431448438, 6499.2200935887995, 6507.479401647762, 4659.510751371193, 4763.166445872028, 4827.348307978378, 4854.975725121351, 4910.6607506894225, 4731.408573928259, 4839.854804355875, 4855.5387238212315, 4908.092002979461, 5086.669366491166], "value": 4079.998919438445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.6541215953017, 293.9720726530979, 302.73208210733503, 309.9008317338451, 314.20662826363446, 4796.28055791631, 4797.856064318067, 4806.3030860525205, 4821.132196204686, 4824.855254342367, 4518.390017347657, 4527.004059106991, 4635.536446355362, 4647.651426143036, 4758.619310455164, 3760.717946154036, 3764.1342491227033, 3764.736468447203, 3773.471713960034, 3778.244351129785, 3754.1740817020213, 3763.811809409532, 3768.6608205261523, 3782.602826703198, 3783.6405541473514, 3595.442706380502, 3601.3877640801124, 3744.1762812181278, 3745.513083299167, 3751.8874433766896, 3730.123420996064, 3749.081475038633, 3750.1937083527037, 3753.455748916419, 3755.080005398695, 3285.5728755261903, 3316.0714999800093, 3320.2900506239066, 3320.837706802624, 3329.3174899145615, 4414.470263568361, 4635.281531362644, 4643.698159619614, 4648.442186937556, 4654.509837237096, 4218.810153543098, 4226.091390351089, 4226.682998775073, 4235.661147108224, 4242.851500197478, 5000.899982000376, 5016.9715208382195, 5020.322256495363, 5024.824131155428, 5033.798648054073, 3543.7342199334894, 3555.2711694102645, 3561.94657080144, 3565.1265439967374, 3566.964330356689, 4969.329140566014, 5204.42751297357, 5210.895782084375, 5225.947740522584, 5233.2935053768015, 3634.036980200249, 3649.6897763689853, 3649.726270529668, 3650.2699460108083, 3652.4521321801412, 3701.1864186548937, 3702.426123950792, 3703.6851867591017, 3704.962950370462, 3711.7030637548933, 4110.815013324408, 4147.149834283965, 4224.260754367973, 4243.811732714845, 4244.299690551086, 5001.4998500149695, 5020.7740651670765, 5026.170681837456, 5026.899462010812, 5026.974865125651, 1255.1778585026823, 1269.504893091695, 1270.1363073110374, 1272.5355245335386, 1272.8090786381931, 822.5434883639638, 852.8550146475114, 873.4104479476329, 888.6045709659269, 892.2282225874571, 4392.956070439254, 4393.165298593321, 4393.692441529062, 4401.207782599163, 4404.493483249467, 5093.828419463544, 5111.801925172212, 5114.360704911886, 5118.539331460112, 5119.59043276537, 4211.241976444208, 4357.670910372303, 4372.672049596229, 4400.163968845909, 4404.4714634243455, 2707.76983956362, 2739.493193759161, 2744.5608702607487, 2745.3822889850026, 2747.821391609539, 4818.759062046954, 4859.927101093415, 4864.318995340655, 4873.780679869415, 4892.217245240744, 5064.7467626619255, 5254.7635356409055, 5283.260343551906, 5287.23335116406, 5290.470952904679, 4867.488913664085, 4870.82952096682, 4889.193283108319, 4929.165729705505, 4938.76530867276, 5207.895842083061, 5214.217867319932, 5222.216667499905, 5223.373195216598, 5227.353383684127, 4981.750912454435, 5083.5678967288195, 5099.57211980646, 5107.412647545431, 5123.641345105807, 4881.3410189625365, 4882.2432522959, 4920.532549407801, 4941.876453088702, 4950.282209079735, 3767.6797472215167, 3796.46849441084, 3812.4281357796553, 3812.8284227209288, 3816.866409675648, 4914.680545764514, 5075.568576670877, 5132.820351287687, 5141.53726164647, 5159.974200128975, 4928.334674818853, 4957.132501812096, 4961.776720047535, 4967.205247160581, 4968.527989840959, 4959.652824302264, 4993.15116430215, 5026.421961474331, 5040.874657712242, 5057.216131499624, 4787.195202095097, 4794.448638406628, 4826.396700412449, 4864.659473836798, 4956.950430495793, 4732.881677958078, 4909.3126962224605, 4983.978284451606, 5000.774965126505, 5082.186850103965, 4881.463039065629, 4883.755812209446, 4894.486078961801, 4907.582855457326, 4908.705477671351], "value": 3777.6251150259886, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.5725991805735, 627.4415769964733, 656.9146011018566, 664.4983037806459, 691.961942093185, 11878.7624247515, 12891.871081289184, 12895.161814482064, 12920.483180672785, 12936.870631293696, 13592.592222233325, 13797.448102075905, 13808.792868106986, 13816.240106794148, 13822.377992990314, 607.0620890723842, 728.1189760389934, 741.1180694972992, 755.845051764387, 761.5773245848552, 745.5824738146628, 747.3722073458293, 751.7481643649384, 756.7880993321851, 757.893894854718, 798.1778767869075, 798.9760307190764, 799.1329407592768, 799.2087833045273, 800.1238643685156, 629.9433051025384, 768.5196752029981, 789.3645615279697, 790.3242727468019, 794.8132188935596, 587.7149582452507, 587.9000569903127, 587.9147523609053, 588.6350462713145, 588.7027051339089, 11382.317060976367, 11457.14071444645, 11461.255018423775, 11474.368909710047, 11505.0, 12239.816402753966, 12305.384730763515, 12790.808137877939, 12843.29361885096, 13219.744124308272, 10455.529501172465, 10475.738106547322, 10558.208134389952, 10567.68296951085, 11273.661790146309, 4066.1054567994993, 4115.8971025724295, 4129.834806607732, 4228.640565551932, 4274.658027357804, 62559.6872015637, 64041.0, 64045.679771600844, 64066.0, 64200.3579964199, 9833.852492212622, 10256.333338333134, 10493.317934334244, 10691.144708423308, 10709.357438553712, 17280.0, 17571.73642395365, 17612.20745066475, 17615.82384176142, 17657.735133973, 6247.219097612799, 6367.0, 6414.1340918976275, 6575.44108750752, 6611.20665520131, 3513.4202856528896, 3554.3957527220437, 3580.98209508956, 3625.5286812714708, 3696.4455331699924, 2579.484103179334, 2663.3607934096067, 2676.5048466033845, 2677.9598306025423, 2678.076063758, 505.2219581843993, 536.3992328592002, 560.1345920552756, 569.9857503562362, 571.0321005894968, 523.4876747845196, 591.9082542205965, 636.9777057802954, 650.8242774450966, 651.4007113455632, 8769.868451973225, 9102.226310763526, 9108.225800806873, 9143.634254629873, 9243.95378023119, 618.1963447518208, 619.1764952613014, 643.6170478565247, 652.2564276724538, 659.2484567592948, 4205.747655140702, 4230.238557059759, 4253.787310634456, 4286.89282767927, 4326.978365108154, 58975.410245896994, 60380.09429858556, 61759.82899152888, 108794.0, 109361.0, 52582.21126683103, 52649.473505264454, 52948.0, 77680.2231977673, 92379.53810230906, 77204.61397692976, 77511.61244193742, 78344.0, 78369.0, 78533.0, 7573.129090154703, 8086.15095414973, 8094.79763005906, 8317.792055198426, 8321.0, 46054.24321959755, 46886.29670555013, 47387.0, 47535.286970694775, 47808.0, 37578.0, 46562.0, 49160.0, 52739.73630131825, 54519.727401364325, 10930.453477325942, 11078.944605276922, 11195.328280302881, 11211.495482703134, 11396.601118960796, 12207.87792122103, 12926.0, 13179.0, 13385.933070334586, 13996.580102596938, 12205.816912746493, 12362.814557781461, 12595.74808503843, 13056.543020994219, 13099.541516046893, 12070.155089144027, 12142.514299427923, 12497.750044999231, 12708.491660333853, 12941.611751647466, 11681.299122052364, 12010.219335743148, 12299.262044277371, 12306.569270075504, 12437.76618079324, 10072.345297555636, 10096.949515252376, 10198.286119971532, 10590.099841513249, 11073.390963497084, 10473.371597704163, 10510.001549852752, 10751.892481075089, 10861.185411094357, 10894.0], "value": 6512.673620416035, "unit": "score"}], "name": "dromaeo_css", "value": 6355.014898921194, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 128.0, 113.0, 115.0, 113.0, 113.0, 116.0, 115.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 123.0, 155.0, 173.0, 123.0, 151.0, 153.0, 131.0, 178.0, 124.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 163.0, 162.0, 164.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 174.0, 76.0, 76.0, 76.0, 75.0, 161.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 156.0, 88.0, 88.0, 87.0, 139.0, 85.0, 86.0, 145.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 66.0, 66.0, 69.0, 66.0, 66.0, 66.0, 65.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 86.0, 82.0, 85.0, 82.0, 82.0, 82.0, 82.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 135.0, 135.0, 129.0, 134.0, 134.0, 133.0, 174.0, 145.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 167.0, 170.0, 168.0, 169.0, 169.0, 174.0, 170.0, 169.0, 169.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 72.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1573.7, "alertThreshold": 2.0}]} 07:26:51 INFO - Return code: 0 07:26:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:51 INFO - # TBPL SUCCESS # 07:26:51 INFO - Running post-action listener: _resource_record_post_action 07:26:51 INFO - [mozharness: 2016-08-25 14:26:51.352442Z] Finished run-tests step (success) 07:26:51 INFO - Running post-run listener: _resource_record_post_run 07:26:51 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 417751040; Read time: 12; Write time: 253924 07:26:51 INFO - TinderboxPrint: CPU usage
13.0% 07:26:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:26:51 INFO - TinderboxPrint: I/O write bytes / time
417,751,040 / 253,924 07:26:51 INFO - TinderboxPrint: CPU idle
8,340.1 (87.0%) 07:26:51 INFO - TinderboxPrint: CPU user
1,201.7 (12.5%) 07:26:51 INFO - TinderboxPrint: Swap in / out
0 / 0 07:26:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114372608; Read time: 0; Write time: 90268 07:26:51 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292114432; Read time: 0; Write time: 161664 07:26:51 INFO - Running post-run listener: _upload_blobber_files 07:26:51 INFO - Blob upload gear active. 07:26:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:51 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 07:26:51 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'] 07:26:51 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 07:26:52 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:53 INFO - (blobuploader) - INFO - Done attempting. 07:26:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:26:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:53 INFO - (blobuploader) - INFO - Done attempting. 07:26:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:26:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:57 INFO - (blobuploader) - INFO - Done attempting. 07:26:57 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:57 INFO - Return code: 0 07:26:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b474ff1e89b3e2d78d68eabb5d225a3b0e9ab03d820e3e948055401efc134909194f170577761466741ddf35d5d25dfd103842f32ec357047aec778faf3c57b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8efe86b280bc868b662b2616d91e3a90ed535289c800aba93207d145ff905fe5fe323df46396e115571fdeac003b6957461638e273fa9cc0d099f0d4d95f6160", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77b43f78cf9be7bf88784cfbdd222bc47ee3135a08bae0aebc4b7a4f1d3cb2920e3c6f4862a00b9588f3f7d22529a77795823f5d075471eac19c4024e470b9c8"} 07:26:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:57 INFO - Contents: 07:26:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b474ff1e89b3e2d78d68eabb5d225a3b0e9ab03d820e3e948055401efc134909194f170577761466741ddf35d5d25dfd103842f32ec357047aec778faf3c57b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8efe86b280bc868b662b2616d91e3a90ed535289c800aba93207d145ff905fe5fe323df46396e115571fdeac003b6957461638e273fa9cc0d099f0d4d95f6160", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77b43f78cf9be7bf88784cfbdd222bc47ee3135a08bae0aebc4b7a4f1d3cb2920e3c6f4862a00b9588f3f7d22529a77795823f5d075471eac19c4024e470b9c8"} 07:26:57 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:57 INFO - Copying logs to upload dir... 07:26:57 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.103241 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-25 07:26:56.337417) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 07:26:56.341420) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378 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/2b474ff1e89b3e2d78d68eabb5d225a3b0e9ab03d820e3e948055401efc134909194f170577761466741ddf35d5d25dfd103842f32ec357047aec778faf3c57b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8efe86b280bc868b662b2616d91e3a90ed535289c800aba93207d145ff905fe5fe323df46396e115571fdeac003b6957461638e273fa9cc0d099f0d4d95f6160", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77b43f78cf9be7bf88784cfbdd222bc47ee3135a08bae0aebc4b7a4f1d3cb2920e3c6f4862a00b9588f3f7d22529a77795823f5d075471eac19c4024e470b9c8"} 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.011338 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/2b474ff1e89b3e2d78d68eabb5d225a3b0e9ab03d820e3e948055401efc134909194f170577761466741ddf35d5d25dfd103842f32ec357047aec778faf3c57b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8efe86b280bc868b662b2616d91e3a90ed535289c800aba93207d145ff905fe5fe323df46396e115571fdeac003b6957461638e273fa9cc0d099f0d4d95f6160", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77b43f78cf9be7bf88784cfbdd222bc47ee3135a08bae0aebc4b7a4f1d3cb2920e3c6f4862a00b9588f3f7d22529a77795823f5d075471eac19c4024e470b9c8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 07:26:56.370901) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:26:56.371620) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472133683.609311-340396378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:26:56.451235) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 07:26:56.451571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 07:26:56.451917) ========= ========= Total master_lag: 0.18 =========