builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1472049349.6 results: success (0) buildid: 20160824060437 builduid: 7d125245b1724493a9e2d0ae89a3944a revision: 8bcfd9dda91cd024bdebba5c599b8710e55ee829 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 07:35:49.600268) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 07:35:49.600644) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 07:35:49.600939) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 07:35:49.938620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:35:49.938921) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 07:35:50-- 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% 40.2M=0s 2016-08-24 07:35:51 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144024 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:35:50.099394) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:35:50.099715) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019832 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:35:50.150235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 07:35:50.150615) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8bcfd9dda91cd024bdebba5c599b8710e55ee829 --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 8bcfd9dda91cd024bdebba5c599b8710e55ee829 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 07:35:51,235 truncating revision to first 12 chars 2016-08-24 07:35:51,235 Setting DEBUG logging. 2016-08-24 07:35:51,235 attempt 1/10 2016-08-24 07:35:51,235 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8bcfd9dda91c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 07:35:52,138 unpacking tar archive at: mozilla-central-8bcfd9dda91c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.193234 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 07:35:51.358536) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 07:35:51.358852) ========= script_repo_revision: 8bcfd9dda91cd024bdebba5c599b8710e55ee829 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 07:35:51.359278) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 07:35:51.359541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 07:35:51.367605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-24 07:35:51.367908) ========= /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=6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:35:52 INFO - MultiFileLogger online at 20160824 07:35:52 in /builds/slave/test 07:35:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:35:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:52 INFO - {'append_to_log': False, 07:35:52 INFO - 'base_work_dir': '/builds/slave/test', 07:35:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:35:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:52 INFO - 'branch': 'Firefox-Non-PGO', 07:35:52 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:52 INFO - 'config_files': ('talos/linux_config.py',), 07:35:52 INFO - 'default_actions': ('clobber', 07:35:52 INFO - 'read-buildbot-config', 07:35:52 INFO - 'download-and-extract', 07:35:52 INFO - 'populate-webroot', 07:35:52 INFO - 'create-virtualenv', 07:35:52 INFO - 'install', 07:35:52 INFO - 'run-tests'), 07:35:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:52 INFO - 'download_minidump_stackwalk': True, 07:35:52 INFO - 'download_symbols': 'ondemand', 07:35:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:52 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:52 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:52 INFO - 'installer_path': 'installer.exe', 07:35:52 INFO - 'log_level': 'info', 07:35:52 INFO - 'log_name': 'talos', 07:35:52 INFO - 'log_to_console': True, 07:35:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:35:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:35:52 INFO - 'opt_config_files': (), 07:35:52 INFO - 'pip_index': False, 07:35:52 INFO - 'sps_profile': False, 07:35:52 INFO - 'sps_profile_interval': 0, 07:35:52 INFO - 'suite': 'dromaeojs', 07:35:52 INFO - 'system_bits': '32', 07:35:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:52 INFO - 'title': 'talos-linux64-ix-023', 07:35:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:52 INFO - 'use_talos_json': True, 07:35:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:52 INFO - 'work_dir': 'build'} 07:35:52 INFO - [mozharness: 2016-08-24 14:35:52.545464Z] Running clobber step. 07:35:52 INFO - Running pre-action listener: _resource_record_pre_action 07:35:52 INFO - Running main action method: clobber 07:35:52 INFO - rmtree: /builds/slave/test/build 07:35:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:53 INFO - Running post-action listener: _resource_record_post_action 07:35:53 INFO - [mozharness: 2016-08-24 14:35:53.002991Z] Finished clobber step (success) 07:35:53 INFO - [mozharness: 2016-08-24 14:35:53.003093Z] Running read-buildbot-config step. 07:35:53 INFO - Running pre-action listener: _resource_record_pre_action 07:35:53 INFO - Running main action method: read_buildbot_config 07:35:53 INFO - Using buildbot properties: 07:35:53 INFO - { 07:35:53 INFO - "project": "", 07:35:53 INFO - "product": "firefox", 07:35:53 INFO - "script_repo_revision": "production", 07:35:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:35:53 INFO - "repository": "", 07:35:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:35:53 INFO - "buildid": "20160824060437", 07:35:53 INFO - "pgo_build": "False", 07:35:53 INFO - "basedir": "/builds/slave/test", 07:35:53 INFO - "buildnumber": 609, 07:35:53 INFO - "slavename": "talos-linux64-ix-023", 07:35:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:35:53 INFO - "platform": "ubuntu64_hw", 07:35:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:35:53 INFO - "branch": "mozilla-central", 07:35:53 INFO - "repo_path": "mozilla-central", 07:35:53 INFO - "revision": "8bcfd9dda91cd024bdebba5c599b8710e55ee829", 07:35:53 INFO - "stage_platform": "linux64", 07:35:53 INFO - "builduid": "7d125245b1724493a9e2d0ae89a3944a", 07:35:53 INFO - "slavebuilddir": "test" 07:35:53 INFO - } 07:35:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:35:53 INFO - Running post-action listener: _resource_record_post_action 07:35:53 INFO - [mozharness: 2016-08-24 14:35:53.005834Z] Finished read-buildbot-config step (success) 07:35:53 INFO - [mozharness: 2016-08-24 14:35:53.005924Z] Running download-and-extract step. 07:35:53 INFO - Running pre-action listener: _resource_record_pre_action 07:35:53 INFO - Running main action method: download_and_extract 07:35:53 INFO - mkdir: /builds/slave/test/build/tests 07:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:53 INFO - trying https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:35:53 INFO - Downloading https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/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:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/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:35:53 INFO - Downloaded 1361 bytes. 07:35:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:35:53 INFO - Using the following test package requirements: 07:35:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:35:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:35:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:35:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:53 INFO - u'jsshell-linux-x86_64.zip'], 07:35:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:35:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:35:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:35:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:35:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:35:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:35:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:53 INFO - trying https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:35:53 INFO - Downloading https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/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:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/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:35:54 INFO - Downloaded 20324482 bytes. 07:35:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:35:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:58 INFO - trying https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:35:58 INFO - Downloading https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/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:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/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:35:59 INFO - Downloaded 20324482 bytes. 07:35:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:36: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:36:04 INFO - trying https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:36:04 INFO - Downloading https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/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:36:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/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:36:05 INFO - Downloaded 14413981 bytes. 07:36:05 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:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:05 INFO - trying https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:36:05 INFO - Downloading https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/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:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/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:36:08 INFO - Downloaded 55752343 bytes. 07:36:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:36:08 INFO - mkdir: /builds/slave/test/properties 07:36:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:08 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:08 INFO - Contents: 07:36:08 INFO - build_url:https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:36:08 INFO - Running post-action listener: _resource_record_post_action 07:36:08 INFO - Running post-action listener: set_extra_try_arguments 07:36:08 INFO - [mozharness: 2016-08-24 14:36:08.681770Z] Finished download-and-extract step (success) 07:36:08 INFO - [mozharness: 2016-08-24 14:36:08.681998Z] Running populate-webroot step. 07:36:08 INFO - Running pre-action listener: _resource_record_pre_action 07:36:08 INFO - Running main action method: populate_webroot 07:36:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:08 INFO - '--tppagecycles', 07:36:08 INFO - '7'], 07:36:08 INFO - 'tests': ['tsvgm']}}, 07:36:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:36:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:36:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:36:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:36:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:36:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:08 INFO - 'talos_options': ['--disable-e10s'], 07:36:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:08 INFO - 'talos_options': ['--disable-e10s'], 07:36:08 INFO - 'tests': ['damp', 'tps']}, 07:36:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:08 INFO - 'tests': ['damp', 'tps']}, 07:36:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:36:08 INFO - 'tests': ['dromaeo_dom']}, 07:36:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:36:08 INFO - 'tests': ['basic_compositor_video']}, 07:36:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:36:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:36:08 INFO - 'tests': ['a11yr', 07:36:08 INFO - 'ts_paint', 07:36:08 INFO - 'tpaint', 07:36:08 INFO - 'sessionrestore', 07:36:08 INFO - 'sessionrestore_no_auto_restore', 07:36:08 INFO - 'tabpaint']}, 07:36:08 INFO - 'other-e10s': {'tests': ['a11yr', 07:36:08 INFO - 'ts_paint', 07:36:08 INFO - 'tpaint', 07:36:08 INFO - 'sessionrestore', 07:36:08 INFO - 'sessionrestore_no_auto_restore', 07:36:08 INFO - 'tabpaint']}, 07:36:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:36:08 INFO - 'ts_paint', 07:36:08 INFO - 'tpaint', 07:36:08 INFO - 'sessionrestore', 07:36:08 INFO - 'sessionrestore_no_auto_restore', 07:36:08 INFO - 'tabpaint']}, 07:36:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:36:08 INFO - 'ts_paint', 07:36:08 INFO - 'tpaint', 07:36:08 INFO - 'sessionrestore', 07:36:08 INFO - 'sessionrestore_no_auto_restore', 07:36:08 INFO - 'tabpaint']}, 07:36:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:36:08 INFO - 'tests': ['a11yr', 07:36:08 INFO - 'ts_paint', 07:36:08 INFO - 'tpaint', 07:36:08 INFO - 'sessionrestore', 07:36:08 INFO - 'sessionrestore_no_auto_restore', 07:36:08 INFO - 'tabpaint']}, 07:36:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:36:08 INFO - 'tests': ['a11yr', 07:36:08 INFO - 'ts_paint', 07:36:08 INFO - 'tpaint', 07:36:08 INFO - 'sessionrestore', 07:36:08 INFO - 'sessionrestore_no_auto_restore', 07:36:08 INFO - 'tabpaint']}, 07:36:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:36:08 INFO - 'tests': ['tsvgx', 07:36:08 INFO - 'tsvgr_opacity', 07:36:08 INFO - 'tart', 07:36:08 INFO - 'tscrollx', 07:36:08 INFO - 'cart']}, 07:36:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:36:08 INFO - 'tsvgr_opacity', 07:36:08 INFO - 'tart', 07:36:08 INFO - 'tscrollx', 07:36:08 INFO - 'cart']}, 07:36:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:08 INFO - 'talos_options': ['--disable-e10s'], 07:36:08 INFO - 'tests': ['tp5o']}, 07:36:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:08 INFO - 'tests': ['tp5o']}, 07:36:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:08 INFO - 'talos_options': ['--disable-e10s', 07:36:08 INFO - '--xperf_path', 07:36:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:08 INFO - 'tests': ['tp5n']}, 07:36:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:08 INFO - 'talos_options': ['--xperf_path', 07:36:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:08 INFO - 'tests': ['tp5n']}}, 07:36:08 INFO - 'talos.zip': {'path': '', 07:36:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:08 INFO - Running post-action listener: _resource_record_post_action 07:36:08 INFO - [mozharness: 2016-08-24 14:36:08.703879Z] Finished populate-webroot step (success) 07:36:08 INFO - [mozharness: 2016-08-24 14:36:08.703969Z] Running create-virtualenv step. 07:36:08 INFO - Running pre-action listener: _resource_record_pre_action 07:36:08 INFO - Running main action method: create_virtualenv 07:36:08 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:08 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:36:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:08 INFO - Using real prefix '/usr' 07:36:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:09 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:11 INFO - Installing pip.................done. 07:36:11 INFO - Return code: 0 07:36:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36: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:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:11 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 0x7f1976337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c4090>, '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 0x20c79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c7e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', '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:36:11 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:36:11 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:36:11 INFO - Using env: {'DISPLAY': ':0', 07:36:11 INFO - 'HOME': '/home/cltbld', 07:36:11 INFO - 'LANG': 'en_US.UTF-8', 07:36:11 INFO - 'LANGUAGE': 'en_US:en', 07:36:11 INFO - 'LOGNAME': 'cltbld', 07:36:11 INFO - 'MAIL': '/var/mail/cltbld', 07:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:11 INFO - 'MOZ_NO_REMOTE': '1', 07:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:11 INFO - 'NO_EM_RESTART': '1', 07:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:11 INFO - 'PWD': '/builds/slave/test', 07:36:11 INFO - 'SHELL': '/bin/bash', 07:36:11 INFO - 'SHLVL': '1', 07:36:11 INFO - 'TERM': 'linux', 07:36:11 INFO - 'TMOUT': '86400', 07:36:11 INFO - 'USER': 'cltbld', 07:36:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', 07:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:11 INFO - '_': '/tools/buildbot/bin/python'} 07:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:11 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:36:11 INFO - Cleaning up... 07:36:11 INFO - Return code: 0 07:36:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:36: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:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:11 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 0x7f1976337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c4090>, '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 0x20c79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c7e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', '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:36:11 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:36:11 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:36:11 INFO - Using env: {'DISPLAY': ':0', 07:36:11 INFO - 'HOME': '/home/cltbld', 07:36:11 INFO - 'LANG': 'en_US.UTF-8', 07:36:11 INFO - 'LANGUAGE': 'en_US:en', 07:36:11 INFO - 'LOGNAME': 'cltbld', 07:36:11 INFO - 'MAIL': '/var/mail/cltbld', 07:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:11 INFO - 'MOZ_NO_REMOTE': '1', 07:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:11 INFO - 'NO_EM_RESTART': '1', 07:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:11 INFO - 'PWD': '/builds/slave/test', 07:36:11 INFO - 'SHELL': '/bin/bash', 07:36:11 INFO - 'SHLVL': '1', 07:36:11 INFO - 'TERM': 'linux', 07:36:11 INFO - 'TMOUT': '86400', 07:36:11 INFO - 'USER': 'cltbld', 07:36:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', 07:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:11 INFO - '_': '/tools/buildbot/bin/python'} 07:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:11 INFO - Downloading/unpacking psutil>=3.1.1 07:36:11 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:36:11 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:36:11 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:36:11 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:36:11 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:36:11 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:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:13 INFO - Installing collected packages: psutil 07:36:13 INFO - Running setup.py install for psutil 07:36:13 INFO - building 'psutil._psutil_linux' extension 07:36:13 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:36:13 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:36:13 INFO - building 'psutil._psutil_posix' extension 07:36:13 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:36:14 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:36:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:14 INFO - Successfully installed psutil 07:36:14 INFO - Cleaning up... 07:36:14 INFO - Return code: 0 07:36:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1976337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c4090>, '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 0x20c79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c7e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', '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:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:36:14 INFO - Using env: {'DISPLAY': ':0', 07:36:14 INFO - 'HOME': '/home/cltbld', 07:36:14 INFO - 'LANG': 'en_US.UTF-8', 07:36:14 INFO - 'LANGUAGE': 'en_US:en', 07:36:14 INFO - 'LOGNAME': 'cltbld', 07:36:14 INFO - 'MAIL': '/var/mail/cltbld', 07:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:14 INFO - 'MOZ_NO_REMOTE': '1', 07:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:14 INFO - 'NO_EM_RESTART': '1', 07:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:14 INFO - 'PWD': '/builds/slave/test', 07:36:14 INFO - 'SHELL': '/bin/bash', 07:36:14 INFO - 'SHLVL': '1', 07:36:14 INFO - 'TERM': 'linux', 07:36:14 INFO - 'TMOUT': '86400', 07:36:14 INFO - 'USER': 'cltbld', 07:36:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', 07:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:14 INFO - '_': '/tools/buildbot/bin/python'} 07:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:16 INFO - Installing collected packages: mozsystemmonitor 07:36:16 INFO - Running setup.py install for mozsystemmonitor 07:36:16 INFO - Successfully installed mozsystemmonitor 07:36:16 INFO - Cleaning up... 07:36:16 INFO - Return code: 0 07:36:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36: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:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1976337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c4090>, '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 0x20c79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c7e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', '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:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:36:16 INFO - Using env: {'DISPLAY': ':0', 07:36:16 INFO - 'HOME': '/home/cltbld', 07:36:16 INFO - 'LANG': 'en_US.UTF-8', 07:36:16 INFO - 'LANGUAGE': 'en_US:en', 07:36:16 INFO - 'LOGNAME': 'cltbld', 07:36:16 INFO - 'MAIL': '/var/mail/cltbld', 07:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:16 INFO - 'MOZ_NO_REMOTE': '1', 07:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:16 INFO - 'NO_EM_RESTART': '1', 07:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:16 INFO - 'PWD': '/builds/slave/test', 07:36:16 INFO - 'SHELL': '/bin/bash', 07:36:16 INFO - 'SHLVL': '1', 07:36:16 INFO - 'TERM': 'linux', 07:36:16 INFO - 'TMOUT': '86400', 07:36:16 INFO - 'USER': 'cltbld', 07:36:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', 07:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:16 INFO - '_': '/tools/buildbot/bin/python'} 07:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:16 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:18 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:36:18 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:36:18 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:36:18 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:36:18 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:36:18 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:36:18 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:18 INFO - warning: no files found matching '*.txt' 07:36:18 INFO - no previously-included directories found matching 'build' 07:36:18 INFO - no previously-included directories found matching 'dist' 07:36:18 INFO - no previously-included directories found matching '.git*' 07:36:18 INFO - Installing collected packages: jsonschema, functools32 07:36:18 INFO - Running setup.py install for functools32 07:36:19 INFO - warning: no files found matching '*.txt' 07:36:19 INFO - no previously-included directories found matching 'build' 07:36:19 INFO - no previously-included directories found matching 'dist' 07:36:19 INFO - no previously-included directories found matching '.git*' 07:36:19 INFO - Successfully installed jsonschema functools32 07:36:19 INFO - Cleaning up... 07:36:19 INFO - Return code: 0 07:36:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:19 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 0x7f1976337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c4090>, '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 0x20c79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c7e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', '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:36:19 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:36:19 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:36:19 INFO - Using env: {'DISPLAY': ':0', 07:36:19 INFO - 'HOME': '/home/cltbld', 07:36:19 INFO - 'LANG': 'en_US.UTF-8', 07:36:19 INFO - 'LANGUAGE': 'en_US:en', 07:36:19 INFO - 'LOGNAME': 'cltbld', 07:36:19 INFO - 'MAIL': '/var/mail/cltbld', 07:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:19 INFO - 'MOZ_NO_REMOTE': '1', 07:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:19 INFO - 'NO_EM_RESTART': '1', 07:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:19 INFO - 'PWD': '/builds/slave/test', 07:36:19 INFO - 'SHELL': '/bin/bash', 07:36:19 INFO - 'SHLVL': '1', 07:36:19 INFO - 'TERM': 'linux', 07:36:19 INFO - 'TMOUT': '86400', 07:36:19 INFO - 'USER': 'cltbld', 07:36:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', 07:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:19 INFO - '_': '/tools/buildbot/bin/python'} 07:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:19 INFO - Cleaning up... 07:36:19 INFO - Return code: 0 07:36:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:19 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 0x7f1976337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c4090>, '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 0x20c79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c7e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', '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:36:19 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:36:19 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:36:19 INFO - Using env: {'DISPLAY': ':0', 07:36:19 INFO - 'HOME': '/home/cltbld', 07:36:19 INFO - 'LANG': 'en_US.UTF-8', 07:36:19 INFO - 'LANGUAGE': 'en_US:en', 07:36:19 INFO - 'LOGNAME': 'cltbld', 07:36:19 INFO - 'MAIL': '/var/mail/cltbld', 07:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:19 INFO - 'MOZ_NO_REMOTE': '1', 07:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:19 INFO - 'NO_EM_RESTART': '1', 07:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:19 INFO - 'PWD': '/builds/slave/test', 07:36:19 INFO - 'SHELL': '/bin/bash', 07:36:19 INFO - 'SHLVL': '1', 07:36:19 INFO - 'TERM': 'linux', 07:36:19 INFO - 'TMOUT': '86400', 07:36:19 INFO - 'USER': 'cltbld', 07:36:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', 07:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:19 INFO - '_': '/tools/buildbot/bin/python'} 07:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:19 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:21 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:21 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:36:22 INFO - Downloading docopt-0.6.1.tar.gz 07:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:22 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:22 INFO - Running setup.py install for blobuploader 07:36:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:22 INFO - Running setup.py install for requests 07:36:22 INFO - Running setup.py install for docopt 07:36:22 INFO - Successfully installed blobuploader requests docopt 07:36:22 INFO - Cleaning up... 07:36:22 INFO - Return code: 0 07:36:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:22 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 0x7f1976337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c4090>, '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 0x20c79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c7e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', '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:36:22 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:36:22 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:36:22 INFO - Using env: {'DISPLAY': ':0', 07:36:22 INFO - 'HOME': '/home/cltbld', 07:36:22 INFO - 'LANG': 'en_US.UTF-8', 07:36:22 INFO - 'LANGUAGE': 'en_US:en', 07:36:22 INFO - 'LOGNAME': 'cltbld', 07:36:22 INFO - 'MAIL': '/var/mail/cltbld', 07:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:22 INFO - 'MOZ_NO_REMOTE': '1', 07:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:22 INFO - 'NO_EM_RESTART': '1', 07:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:22 INFO - 'PWD': '/builds/slave/test', 07:36:22 INFO - 'SHELL': '/bin/bash', 07:36:22 INFO - 'SHLVL': '1', 07:36:22 INFO - 'TERM': 'linux', 07:36:22 INFO - 'TMOUT': '86400', 07:36:22 INFO - 'USER': 'cltbld', 07:36:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', 07:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:22 INFO - '_': '/tools/buildbot/bin/python'} 07:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:23 INFO - Running setup.py (path:/tmp/pip-_SnEDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:23 INFO - Running setup.py (path:/tmp/pip-kwc9vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:23 INFO - Running setup.py (path:/tmp/pip-P9F4dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:23 INFO - Running setup.py (path:/tmp/pip-TqfzUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:23 INFO - Running setup.py (path:/tmp/pip-bh8wgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:23 INFO - Running setup.py (path:/tmp/pip-yayLNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:23 INFO - Running setup.py (path:/tmp/pip-TcL8x5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:23 INFO - Running setup.py (path:/tmp/pip-AXw3gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:23 INFO - Running setup.py (path:/tmp/pip-Kjq6Tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:23 INFO - Running setup.py (path:/tmp/pip-Ks6owp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:23 INFO - Running setup.py (path:/tmp/pip-Ts2h2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:23 INFO - Running setup.py (path:/tmp/pip-zmwxqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:23 INFO - Running setup.py (path:/tmp/pip-Uj2adS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:23 INFO - Running setup.py (path:/tmp/pip-e8D8ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:24 INFO - Running setup.py (path:/tmp/pip-0nvaNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:24 INFO - Running setup.py (path:/tmp/pip-tswJkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:24 INFO - Running setup.py (path:/tmp/pip-NLvx17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:24 INFO - Running setup.py install for manifestparser 07:36:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:24 INFO - Running setup.py install for mozcrash 07:36:24 INFO - Running setup.py install for mozdebug 07:36:24 INFO - Running setup.py install for mozdevice 07:36:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:24 INFO - Running setup.py install for mozfile 07:36:24 INFO - Running setup.py install for mozhttpd 07:36:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:24 INFO - Running setup.py install for mozinfo 07:36:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:24 INFO - Running setup.py install for mozInstall 07:36:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Running setup.py install for mozleak 07:36:25 INFO - Running setup.py install for mozlog 07:36:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Running setup.py install for moznetwork 07:36:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Running setup.py install for mozprocess 07:36:25 INFO - Running setup.py install for mozprofile 07:36:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Running setup.py install for mozrunner 07:36:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Running setup.py install for mozscreenshot 07:36:25 INFO - Running setup.py install for moztest 07:36:25 INFO - Running setup.py install for mozversion 07:36:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:26 INFO - Cleaning up... 07:36:26 INFO - Return code: 0 07:36:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:26 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:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:26 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:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:26 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 0x7f1976337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c4090>, '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 0x20c79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c7e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', '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:36:26 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:36:26 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:36:26 INFO - Using env: {'DISPLAY': ':0', 07:36:26 INFO - 'HOME': '/home/cltbld', 07:36:26 INFO - 'LANG': 'en_US.UTF-8', 07:36:26 INFO - 'LANGUAGE': 'en_US:en', 07:36:26 INFO - 'LOGNAME': 'cltbld', 07:36:26 INFO - 'MAIL': '/var/mail/cltbld', 07:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:26 INFO - 'MOZ_NO_REMOTE': '1', 07:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:26 INFO - 'NO_EM_RESTART': '1', 07:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:26 INFO - 'PWD': '/builds/slave/test', 07:36:26 INFO - 'SHELL': '/bin/bash', 07:36:26 INFO - 'SHLVL': '1', 07:36:26 INFO - 'TERM': 'linux', 07:36:26 INFO - 'TMOUT': '86400', 07:36:26 INFO - 'USER': 'cltbld', 07:36:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', 07:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:26 INFO - '_': '/tools/buildbot/bin/python'} 07:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:26 INFO - Running setup.py (path:/tmp/pip-nJH3Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:26 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:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:26 INFO - Running setup.py (path:/tmp/pip-DCO68V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:26 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:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:26 INFO - Running setup.py (path:/tmp/pip-rlW7dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:26 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:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:26 INFO - Running setup.py (path:/tmp/pip-BpfATi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:26 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:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:26 INFO - Running setup.py (path:/tmp/pip-n06wj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:26 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:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:26 INFO - Running setup.py (path:/tmp/pip-qGwcIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:26 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:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:26 INFO - Running setup.py (path:/tmp/pip-A3l401-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:26 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:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:26 INFO - Running setup.py (path:/tmp/pip-kt3mUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:26 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:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:26 INFO - Running setup.py (path:/tmp/pip-_X7FuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:26 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:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:26 INFO - Running setup.py (path:/tmp/pip-Zsh6CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:26 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:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:26 INFO - Running setup.py (path:/tmp/pip-ETE4BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:27 INFO - Running setup.py (path:/tmp/pip-j8E5tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:27 INFO - Running setup.py (path:/tmp/pip-5c9EQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:27 INFO - Running setup.py (path:/tmp/pip-3bezFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:27 INFO - Running setup.py (path:/tmp/pip-HTdFrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:27 INFO - Running setup.py (path:/tmp/pip-D6qrCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:27 INFO - Running setup.py (path:/tmp/pip-mW8wPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:27 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:36:27 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:36:27 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:36:27 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:36:27 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:36:27 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:36:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:27 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:36:27 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:36:27 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:36:27 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:36:27 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:36:27 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:36:29 INFO - Downloading blessings-1.6.tar.gz 07:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:29 INFO - Installing collected packages: blessings 07:36:29 INFO - Running setup.py install for blessings 07:36:29 INFO - Successfully installed blessings 07:36:29 INFO - Cleaning up... 07:36:29 INFO - Return code: 0 07:36:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:29 INFO - Reading from file tmpfile_stdout 07:36:29 INFO - Current package versions: 07:36:29 INFO - argparse == 1.2.1 07:36:29 INFO - blessings == 1.6 07:36:29 INFO - blobuploader == 1.2.4 07:36:29 INFO - docopt == 0.6.1 07:36:29 INFO - functools32 == 3.2.3-2 07:36:29 INFO - jsonschema == 2.5.1 07:36:29 INFO - manifestparser == 1.1 07:36:29 INFO - mozInstall == 1.12 07:36:29 INFO - mozcrash == 0.17 07:36:29 INFO - mozdebug == 0.1 07:36:29 INFO - mozdevice == 0.48 07:36:29 INFO - mozfile == 1.2 07:36:29 INFO - mozhttpd == 0.7 07:36:29 INFO - mozinfo == 0.9 07:36:29 INFO - mozleak == 0.1 07:36:29 INFO - mozlog == 3.3 07:36:29 INFO - moznetwork == 0.27 07:36:29 INFO - mozprocess == 0.23 07:36:29 INFO - mozprofile == 0.28 07:36:29 INFO - mozrunner == 6.12 07:36:29 INFO - mozscreenshot == 0.1 07:36:29 INFO - mozsystemmonitor == 0.3 07:36:29 INFO - moztest == 0.7 07:36:29 INFO - mozversion == 1.4 07:36:29 INFO - psutil == 3.1.1 07:36:29 INFO - requests == 1.2.3 07:36:29 INFO - wsgiref == 0.1.2 07:36:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:29 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 0x7f1976337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c4090>, '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 0x20c79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c7e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', '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:36:29 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:36:29 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:36:29 INFO - Using env: {'DISPLAY': ':0', 07:36:29 INFO - 'HOME': '/home/cltbld', 07:36:29 INFO - 'LANG': 'en_US.UTF-8', 07:36:29 INFO - 'LANGUAGE': 'en_US:en', 07:36:29 INFO - 'LOGNAME': 'cltbld', 07:36:29 INFO - 'MAIL': '/var/mail/cltbld', 07:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:29 INFO - 'MOZ_NO_REMOTE': '1', 07:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:29 INFO - 'NO_EM_RESTART': '1', 07:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:29 INFO - 'PWD': '/builds/slave/test', 07:36:29 INFO - 'SHELL': '/bin/bash', 07:36:29 INFO - 'SHLVL': '1', 07:36:29 INFO - 'TERM': 'linux', 07:36:29 INFO - 'TMOUT': '86400', 07:36:29 INFO - 'USER': 'cltbld', 07:36:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', 07:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:29 INFO - '_': '/tools/buildbot/bin/python'} 07:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 INFO - Cleaning up... 07:36:30 INFO - Return code: 0 07:36:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:30 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 0x7f1976337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c4090>, '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 0x20c79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c7e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', '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:36:30 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:36:30 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:36:30 INFO - Using env: {'DISPLAY': ':0', 07:36:30 INFO - 'HOME': '/home/cltbld', 07:36:30 INFO - 'LANG': 'en_US.UTF-8', 07:36:30 INFO - 'LANGUAGE': 'en_US:en', 07:36:30 INFO - 'LOGNAME': 'cltbld', 07:36:30 INFO - 'MAIL': '/var/mail/cltbld', 07:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:30 INFO - 'MOZ_NO_REMOTE': '1', 07:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:30 INFO - 'NO_EM_RESTART': '1', 07:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:30 INFO - 'PWD': '/builds/slave/test', 07:36:30 INFO - 'SHELL': '/bin/bash', 07:36:30 INFO - 'SHLVL': '1', 07:36:30 INFO - 'TERM': 'linux', 07:36:30 INFO - 'TMOUT': '86400', 07:36:30 INFO - 'USER': 'cltbld', 07:36:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', 07:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:30 INFO - '_': '/tools/buildbot/bin/python'} 07:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:30 INFO - Cleaning up... 07:36:30 INFO - Return code: 0 07:36:30 INFO - Running post-action listener: _resource_record_post_action 07:36:30 INFO - Running post-action listener: _start_resource_monitoring 07:36:30 INFO - Starting resource monitoring. 07:36:30 INFO - [mozharness: 2016-08-24 14:36:30.332955Z] Finished create-virtualenv step (success) 07:36:30 INFO - [mozharness: 2016-08-24 14:36:30.333424Z] Running install step. 07:36:30 INFO - Running pre-action listener: _resource_record_pre_action 07:36:30 INFO - Running main action method: install 07:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:30 INFO - Reading from file tmpfile_stdout 07:36:30 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:30 INFO - Reading from file tmpfile_stdout 07:36:30 INFO - Output received: 07:36:30 INFO - Usage: mozinstall [options] installer 07:36:30 INFO - Options: 07:36:30 INFO - -h, --help show this help message and exit 07:36:30 INFO - -d DEST, --destination=DEST 07:36:30 INFO - Directory to install application into. [default: 07:36:30 INFO - "/builds/slave/test"] 07:36:30 INFO - --app=APP Application being installed. [default: firefox] 07:36:30 INFO - mkdir: /builds/slave/test/build/application 07:36:30 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:36:30 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:36:46 INFO - Reading from file tmpfile_stdout 07:36:46 INFO - Output received: 07:36:46 INFO - /builds/slave/test/build/application/firefox/firefox 07:36:46 INFO - Running post-action listener: _resource_record_post_action 07:36:46 INFO - [mozharness: 2016-08-24 14:36:46.752933Z] Finished install step (success) 07:36:46 INFO - [mozharness: 2016-08-24 14:36:46.753182Z] Running run-tests step. 07:36:46 INFO - Running pre-action listener: _resource_record_pre_action 07:36:46 INFO - Running main action method: run_tests 07:36:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:46 INFO - Python 2.7.3 07:36:46 INFO - Return code: 0 07:36:46 INFO - grabbing minidump binary from tooltool 07:36:46 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:36:46 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 0x20c4090>, '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 0x20c79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c7e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:46 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:36:46 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:36:46 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:36:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:46 INFO - Return code: 0 07:36:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:36:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:36:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:46 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/JYNu2-UAQ7WqDFVlVE7Jng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:36:46 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/JYNu2-UAQ7WqDFVlVE7Jng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:36:46 INFO - Using env: {'DISPLAY': ':0', 07:36:46 INFO - 'HOME': '/home/cltbld', 07:36:46 INFO - 'LANG': 'en_US.UTF-8', 07:36:46 INFO - 'LANGUAGE': 'en_US:en', 07:36:46 INFO - 'LOGNAME': 'cltbld', 07:36:46 INFO - 'MAIL': '/var/mail/cltbld', 07:36:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:46 INFO - 'MOZ_NO_REMOTE': '1', 07:36:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:46 INFO - 'NO_EM_RESTART': '1', 07:36:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:46 INFO - 'PWD': '/builds/slave/test', 07:36:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:46 INFO - 'SHELL': '/bin/bash', 07:36:46 INFO - 'SHLVL': '1', 07:36:46 INFO - 'TERM': 'linux', 07:36:46 INFO - 'TMOUT': '86400', 07:36:46 INFO - 'USER': 'cltbld', 07:36:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518', 07:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:46 INFO - '_': '/tools/buildbot/bin/python'} 07:36:46 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/JYNu2-UAQ7WqDFVlVE7Jng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:36:47 INFO - mozversion application_buildid: 20160824060437 07:36:47 INFO - mozversion application_changeset: 8bcfd9dda91cd024bdebba5c599b8710e55ee829 07:36:47 INFO - mozversion application_display_name: Nightly 07:36:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:47 INFO - mozversion application_name: Firefox 07:36:47 INFO - mozversion application_remotingname: firefox 07:36:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:36:47 INFO - mozversion application_vendor: Mozilla 07:36:47 INFO - mozversion application_version: 51.0a1 07:36:47 INFO - mozversion platform_buildid: 20160824060437 07:36:47 INFO - mozversion platform_changeset: 8bcfd9dda91cd024bdebba5c599b8710e55ee829 07:36:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:36:47 INFO - mozversion platform_version: 51.0a1 07:36:47 INFO - using testdate: 1472049407 07:36:47 INFO - actual date: 1472049407 07:36:47 INFO - starting webserver on 'localhost:44663' 07:36:47 INFO - SUITE-START | Running 2 tests 07:36:47 INFO - TEST-START | dromaeo_css 07:36:47 INFO - operating with platform_type : linux_ 07:36:47 INFO - Initialising browser for dromaeo_css test... 07:36:47 INFO - TEST-INFO | started process 4573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgKBA_b/profile http://localhost:44663/getInfo.html) 07:36:51 INFO - PROCESS | 4573 | __metrics Screen width/height:1600/1200 07:36:51 INFO - PROCESS | 4573 | colorDepth:24 07:36:51 INFO - PROCESS | 4573 | Browser inner width/height: 1024/697 07:36:51 INFO - PROCESS | 4573 | __metrics 07:36:52 INFO - PROCESS | 4573 | 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:36:52 INFO - PROCESS | 4573 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:52 INFO - PROCESS | 4573 | console.error: PushService: 07:36:52 INFO - PROCESS | 4573 | stateChangeProcessEnqueue: Error transitioning state 07:36:52 INFO - PROCESS | 4573 | UnknownError 07:36:53 INFO - TEST-INFO | 4573: exit 0 07:36:53 INFO - Browser initialized. 07:36:53 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:53 INFO - TEST-INFO | started process 4654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgKBA_b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:05 INFO - PROCESS | 4654 | RSS: Main: 182652928 07:37:05 INFO - PROCESS | 4654 | 07:37:56 INFO - PROCESS | 4654 | 1472049476474 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:40:09 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:44663/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44663/tests/dromaeo/cssquery-ext.html) 07:40:10 INFO - PROCESS | 4654 | RSS: Main: 273223680 07:40:10 INFO - PROCESS | 4654 | 07:43:13 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:44663/tests/dromaeo/cssquery-ext.html (next: http://localhost:44663/tests/dromaeo/cssquery-jquery.html) 07:43:14 INFO - PROCESS | 4654 | RSS: Main: 275529728 07:43:14 INFO - PROCESS | 4654 | 07:46:16 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:44663/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44663/tests/dromaeo/cssquery-mootools.html) 07:46:17 INFO - PROCESS | 4654 | RSS: Main: 220405760 07:46:17 INFO - PROCESS | 4654 | 07:49:19 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:44663/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44663/tests/dromaeo/cssquery-prototype.html) 07:49:20 INFO - PROCESS | 4654 | RSS: Main: 250634240 07:49:20 INFO - PROCESS | 4654 | 07:52:23 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:44663/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44663/tests/dromaeo/cssquery-yui.html) 07:52:23 INFO - PROCESS | 4654 | RSS: Main: 219930624 07:52:23 INFO - PROCESS | 4654 | 07:55:26 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:44663/tests/dromaeo/cssquery-yui.html (next: http://localhost:44663/tests/dromaeo/cssquery-dojo.html) 07:55:27 INFO - PROCESS | 4654 | RSS: Main: 312963072 07:55:27 INFO - PROCESS | 4654 | 07:55:27 INFO - PROCESS | 4654 | __start_tp_report 07:55:27 INFO - PROCESS | 4654 | _x_x_mozilla_page_load 07:55:27 INFO - PROCESS | 4654 | _x_x_mozilla_page_load_details 07:55:27 INFO - PROCESS | 4654 | |i|pagename|runs| 07:55:27 INFO - PROCESS | 4654 | |0;dojo.html;2582.4015940263466;2591.313301974976;2595.1565741134114;2629.7764690001336;2647.3381654586356;4658.580727734503;4659.860204193876;4731.172044892143;4752.976235118828;4794.400699912511;4705.082508910764;4737.73942433166;4738.810447582093;4752.786124624383;4803.423589169296;4383.167198232341;4392.670549708769;4396.626286765629;4404.669649776263;4518.954810451886;4455.732656040632;4456.153330867141;4460.955390446103;4462.553744625544;4482.417285752847;4279.315309550489;4327.82688692455;4331.371951067078;4336.3278691802825;4337.219300525904;4265.786710664485;4303.978480107611;4321.027768752037;4351.782410879475;4400.207962566737;4275.358696195595;4282.5503322151035;4286.357046443059;4294.484661840568;4340;4686.367340409035;4751.857444276678;4751.928721069186;4757.548032936866;4801.255805350142;5012.72430016349;5066.36670416198;5072.34059572257;5105.514976077304;5106.719130447824;5134.17853143499;5135.6148288878485;5139.254808052811;5144.871378215537;5146.6911985281;4752.667313288071;4802.831900883452;4808;4820.8794780130775;4856.927146092811;5062.772175252123;5087.033463641897;5123.052235336475;5128.051310507568;5134.024535338273;4914.606831453475;4919.385076865392;4920.581750551171;4922.163232250526;4955.4548999610015;4998.300237966688;5004.724740139254;5004.799808007639;5008.198688209869;5050.595952323805;4952.182889823211;4959.553640172402;4988.451270360258;5003.74981250936;5013.1227035268685;4996.850094497171;4998.4251811042195;4998.725070121178;5002.624803139779;5049.747512624427;4238.919075635693;4239.427677263591;4240.088380998039;4281.657467402601;4284.100338928797;3644.2164934538673;3659.5059666945153;3661.3226553087766;3690.9630903691154;3703.9444408333898;4360.738355698605;4383.232934236496;4426.070525189682;4433.556644335541;4438.201123797748;5069.5690866276045;5073.061483625467;5076.416212135578;5083.262926875583;5084.0340335336905;4300.763458009839;4350.456192975878;4358.019445624709;4366.214081465303;4409.867703968886;4549.431321084864;4559.726416415026;4566.360709500673;4623.006053698471;4631.258998560214;4816.060868130751;4822.228443449031;4824.710517368829;4826;4887.755612219375;4919.2129259318335;4954.4797796232315;5041.42023667283;5059.74413116383;5141.126008578476;4794.376731024944;4802.687825291345;4804.039192161512;4832.371791667061;4858.514148585114;4967.751612419437;4970.5029497051455;4970.950290497193;4971.726555039508;5028.9245661315845;5001.274815151855;5019.121653710659;5059.898802023865;5065.189569668835;5131.846044618667;4906.55840974314;4948.505149485167;4951.133551628523;4987.875303117451;5006.749662516787;4929.309896614549;4939.259111133359;4939.703617782944;4941.629377796751;5006.07387633289;4709.670323077352;4764.475907650087;4857.441394239567;4866.6350023747655;4957.281194226889;4907.852764417074;4942.110420124268;4954.752262386794;4970.502949705001;5006.324146240357;4830.492798256132;4839.908434164687;4840.515948405131;4843.539863712942;4908.312836203006 07:55:27 INFO - PROCESS | 4654 | |1;ext.html;564.4553006348873;572.45616664169;577.2611057845957;587.4507335641176;592.5851903667434;36248.275034499326;38671.61328386719;38772.47978881374;43073.35389969153;43088;39444;39911.401328980086;39917.60082399182;39930.60069399305;39934.400983985266;5579.107342825148;7529.360004399633;7723.11184213817;7732.381409487256;7747.922520774777;7379.852402951938;7631.313181813635;7633.694652213905;10018;10339.12117470016;9897.703068907944;9970.700878973643;9979.800403991916;9981.351212171186;9983.600655973753;9904.50477476127;9949.850752238686;9958.203343732484;9967.601295948154;9971.40171589707;9787.510624468749;9881.505924703735;9884.456354900478;9888.258380621483;9894.30739848211;37076.81461592702;37300.81349593234;37367.25265494702;37386.813065934766;37458.62541374579;2528.4690215054675;2743.9588406173925;2746.1761471558452;2748.7800975921878;2750.436160587095;28267.434651307063;28634.14097577076;28837.71162288371;28896.27759306013;29033.419331613462;3290.851911663957;3378.8986330410125;3418.67522585354;3466.878659246914;3470.0977745786026;244534;247880;249458;249499;249963;45706;45943;46037.539624603996;46038;46100.538994610295;31562.526562101586;32149.517757233192;32150.678493215237;33742.493862592084;33909;12252.326122063194;12410.689732756573;12411.937940310241;12420.62738117858;12424.316662583644;10136.189104871593;10417.687469375931;10418.479076046167;10423.061924426838;10423.42671153094;14799.556013319618;15176.924115379352;15184.924075379773;15730.134842583768;17029.148542573068;6015.639061656315;6383.71273292703;6558.147440832661;6591.901121483182;6638.402543771083;718.2350796401815;780.4770803561628;836.8117173635883;888.1207604471526;943.3585162089845;27120.186394407803;27574.172774816787;27586.310342241606;27947.161585152073;28064.29839254035;902.228594551662;905.8958219804807;936.8782058332373;959.8608201810698;1000.6397696829135;14256.144631322153;14453.78319325211;14721.92639036798;14978.251087445584;15049;387166.3100641855;390369;392506;392993;393125.61869431316;41877.581224187365;46262.537374626496;47273.763631182315;47413;47781.522184778405;1096.4791723931228;1103.1175059952006;1122.7361570030873;1128;1131.8302254661703;26741.331466713487;27710.44579108447;28079.859600701864;28368.290792730346;28983.710162898944;41288;41711.1657766849;41722.37416438695;41770;41774.791126044176;389747;398986;399503;574407;575807;36943.261134776614;36993.81503092467;37063.81106645126;37255.441168381956;37482.625173749;40736.1852762949;40759.59240407558;41022.38466422947;41216.96957575965;41325.1734965305;34659.65340346564;34919.88901942201;35096.824515877255;35346.46980295349;35501.467477988364;35216.64783352134;35238.295234094665;35517.64482355143;35657.46513802243;36081;34630;35326.646733533365;35413.822930886214;35610;36238.27523449569;30441.543376849808;32552.34895302128;32818.34363312768;32910;33389.66610333963;23767.643485347387;24097.51804963856;24341.29610927218;24380.6342904853;24496.38759030967 07:55:27 INFO - PROCESS | 4654 | |2;jquery.html;341.0569774573304;362.60476081071624;367.5038697758027;370.6830659785884;387.55431254057845;12508.4996600136;14755.336009879555;17177.055261960617;17283.567910802238;17303.913480432613;14425.855741442583;15226.238688065609;15295.617609559766;16856.24146913389;17354.913225433855;4678.625709943213;5070.138076527;5095.949040509603;5096.4648711885275;5100.897982040357;3640.4175331946894;5002.424721157077;5093;5663.5186009189265;5986.042233242661;5986.73059712314;6025.1564780930485;6026.126211699301;6029.216201893748;6031.728572214239;6024.337322894478;6551.4103730664465;6842.897356539606;6870.416014638762;7016.894746578805;6478.255000674889;6673.0991316172185;6761;6767.932320676779;6770.289119642416;22466.88766556173;22964.540709185723;22971.540569188524;23225;23575.17486887968;1792.0770803036446;1827.5613852675262;1950.414875537333;1992.412238389664;2023.3828682251908;13929.442822287197;14313.928430357886;14386.92806535971;14546.490872819506;15229.695406091816;1787.6067265201634;1802.7656404667441;1841.2634946021565;1882.275324000256;1958.2362878477404;71889;84590.57704711438;85357.57321213416;85754;85786.57106714489;14914.552563423114;16402.917985409997;16483.423080192377;16927.830721692873;17604.41560259583;28772.834988151288;28774.424511509653;28855.711442885302;28912.855435722686;28955.855220724185;7967.56178410193;8003.4797738146835;8154;8197.098319184885;8221.54781487024;6407.647579383179;6416.069669897839;6642.86714265712;6687.030380594787;6687.297833727389;7993.640286187136;8323;8344.666213351398;8408.663653453794;8426.630877251915;3039.8872783415313;3100.6589275179713;3184.952225716616;3201.423743726105;3305.1241421023446;781.2265856801839;802.5706247157742;856.871469279613;871.7864123289835;872.2019352292581;16086.517404477885;16775.748363774554;17286.740698889527;17672.469825905242;17840.286388544573;805.2470939671426;809.0938149272852;810.740563019828;817;851.4082712514867;9214.539273036322;9791.412515249107;9932.304738668225;9934.354266972769;9966.451845148586;380710;387582;388284.11300926364;388653;396768;75801.62099189468;78352.6082369596;79512;80520.59739701264;83014.58492707497;842.2461896602629;869.387082107113;904.6426661468684;906.6735975048977;920.346553946692;15377.231138443256;15409.922950385177;15713.214339282762;16083.195840208176;16337.264823083227;27426.451470970867;37436.2512749738;38953.220935581696;39468.2106357877;40135.79932100321;50908.745456273966;51907;51916.22125668042;52132;52477;4980.5019498049905;7237.819054523679;7641.586306533309;7829.8825517618425;7968.402369822171;10212.744681383025;11721.824172637247;11929.28424294545;11948.880511194777;12088.697782555506;10044.397336159855;10196.4391958443;10290.501229581978;10527.578896844041;10575.312604680672;10655.413952232391;10746.516406761872;10884.564617415215;10896.78206435851;10901.454927253764;10675;10932.672019839418;10970.670879873616;11159.163062770162;11306.717332066764;7714.498557593738;7893.17121702236;8016.438849280495;8023.518588884685;8075.273225409506;9082.818343632958;10419.114375278186;10665.306755060896;10852.457377130953;10990.670279891616 07:55:27 INFO - PROCESS | 4654 | |3;mootools.html;1213.2962881528715;1278.6100239426971;1321.273299685173;1323.0275747325718;1575.09432076556;6263.091851681504;7325.194228634852;7598.886016709754;7605.581693006876;7768.456208065438;7620.390368770499;7668.846623067535;7677.270659287373;7683.692652293916;7686.26980436859;2150.5376344086017;2180.1606381543143;2180.3458962311324;2180.6183917814396;2185.0495034659893;2034.8677335973114;2084.687296905461;2099.3911765588036;2099.863508871926;2103.5897999890026;2050.682144267641;2091.3098677436487;2101.0440249686358;2102.936911892638;2106.8419868509845;2086.488810241485;2086.6869969504546;2089.6656534954336;2091.2471510256296;2096.2453516733963;1982;2064.7315848939693;2065.6281869263526;2067.235123004483;2077.989610051955;7338.302861228175;7352.4485663574915;7428.071491063617;7436.590987495686;7536.0956685198125;4113.300738874398;4261.957380426218;4269.701120921537;4270.295401258789;4271.700980931336;2694.703582605912;2782.916512504628;2837.815541989785;2838.5316422790215;2850.885964561415;890.7060669978891;900.3157600223811;901.324006994754;913.7532866126176;914.7850255190025;10336;10400.739981500446;10410.167186625053;10420.583176673;10421.583136674524;3745.3071181830906;3846.8845934622004;3991.92016159681;3998.320285551405;4018.537868145142;7760.379169666413;7765.456418050682;7767;7770.339521140766;7783.260590243918;4328.956710432918;4338.262495375794;4348.9997300621035;4350.303951367766;4354.368616550646;3523.436250199956;3771.773693578394;3908.785016824102;4052.2705912935953;4072.1244932339096;3278.3115545735664;3293.505974103856;3421.8118003510044;3440.6043305019743;3442.5524681791208;1019.3068713274896;1019.5564929255797;1045.0594464981425;1048.6906362623045;1053.1416895230363;619.3496828330235;777.3276116159482;787.7872974297022;805.1787177079464;810.5096416667949;4735.573798358096;4832.34763306949;4889.046635905964;5209.661372010807;5247.897941432266;829.1501211258387;881.9470831750116;881.9514926679094;882.0826340605698;886.6276164011131;3186.553882456458;3281.9671803281663;3282.179455136216;3363.747718921091;3463.3419650266874;9209.21721653667;9297.67458138962;9405.20055795265;9417.76455588602;9523;9067.68263110788;9252.028537003653;9302.395344302598;9352.625894964125;9400;6937.7571784988295;7083.433325333961;7095;7095.538789978738;7099.82250443743;4674.649401294849;4747.762611869462;4811.975940120277;5157.355330583677;5206.323177986837;8187.222213889671;8388.664453421794;8398.370122240734;8445.619947102272;8596.527191004554;8402.32781377476;8728.956355218183;8736;8742.038375778786;8838.690645827364;5815.76736930518;6346.650934198663;6577.112089867806;6734.6295953721055;6739.427148692416;7190.676419561028;7276.163241227327;7348.375388092072;7355.8896616551865;7387.187409385071;6239.0953311770445;6398.424141827258;6440.8389790255615;6537.444317233088;6684.197896252481;6056.606320589148;6064.605800622945;6093.360197179232;6104.603200791934;6121.47967422774;6130.448259656652;6222.688865556614;6225.252969643671;6235.314115447207;6239.656818875005;4137.793110344411;4141.8964525887095;4150.605692459211;4267.039916018871;4281.657467402538;4391.451068616423;4451.910961780682;4459.264221403432;4480.708753930984;4555.612772914207 07:55:27 INFO - PROCESS | 4654 | |4;prototype.html;287.9150650558084;297.9076486289251;299.7182648310588;299.84108422536036;306.01920843695956;4577.908441831161;4755.405574303212;4772.141014617368;4836.274558816175;4886.975565122174;4576.336431217472;4697.2954056891485;4728.250547297504;4733.360996265503;4751.671680876363;3743.681787048104;3750.0999760057525;3755.7558758680666;3758.5489741230954;3762.7930463824478;3587.8959659873467;3775.0751065988734;3783.716221283401;3798.5631652359916;3806.885793426188;3374.460086386179;3650.653187947141;3736.607656196101;3741.850325986957;3755.192633583779;3705.166337574024;3728.2357116791127;3744.8876533703897;3748.175401411685;3765.830537625786;3303.933921321584;3307.2889328794427;3309.2057906102605;3314.751393645486;3327.5674162358737;4525.52481989393;4655.162070827249;4706.647001474903;4711.528847115295;4734.218853889104;4251.043515209084;4253.32040814285;4261.74429534229;4264.296391095466;4281.507626622947;4989.55094041538;5053.140966035783;5053.393592768891;5058.140116180258;5065.848024559232;3376;3633.400488919325;3645.781253124821;3648.8506120571933;3662.8717994870317;5137.922931156036;5208.869778255536;5222.817201397933;5230.712310822903;5231.3460817397445;3644.4715516249994;3645.179834537261;3654.104744337654;3665.486831843544;3665.651763082556;3717.498137751423;3724.646158614927;3725.1059745661387;3727.459518369821;3736.271427071695;4137.524184718735;4167.4790651168605;4204.285271503852;4219.493660760729;4267;5015.498450155028;5027.622928280393;5028.924566131511;5040.59675225981;5045.369328833895;1206.85517737872;1241.2986662535639;1247.0397793698983;1265.7722009650624;1293.224065560656;819.7827575692446;834.328365665645;838.061371264188;856.178069053703;859.8925134358205;4429.313456414261;4435.6229720473475;4438;4478.2386994211065;4485.372047913294;5223.3209682741;5228.764705588258;5229.111051121318;5237.790488380499;5241.580673546107;4286.207051695446;4534.183846907588;4536.455625324982;4544.818207271672;4554.521775213621;2771.9307017324727;2772.348498102944;2783.9443211135663;2795.55271156614;2810.550311950078;4787.760611969387;4967.230079337708;4984.925226121611;5020.196768517019;5025.698458092526;5281.841544753664;5307.575393968474;5314.92027619586;5337.5463085637375;5375.75809088592;4939.259111133287;4950.3069570260195;4967.726775027336;4968;4998.150314446625;5050.823221187241;5189.76646050921;5197.66215196011;5205.375354957429;5222.8955420892125;5082.373640435173;5092.363454568179;5095.388553373619;5098.872528186825;5126.359205099363;4930.654854160318;4945.777440015136;4954.9752251238515;4998.625652814884;5018.623603229846;3465.653434656514;3668.137987572865;3685.1708365617524;3700.389435743072;3705.9444108337857;5146.330976972969;5151.304573882478;5152.407473140487;5160.251763494347;5184.507471790174;5030.220315850903;5041.269015992734;5050.671706339076;5105.642605017613;5120.539151476385;4979.97910428354;5036.471170527042;5100.591952643854;5129.358605246285;5134.691918484903;4761.309610106446;4823.1800593898415;4933.531314525115;4946.307516947558;4984.2025275955675;5113.974430127825;5119.513646203604;5124.7950081996305;5139.6145289102715;5141.691498510101;5021.769666431747;5037.5214354636255;5040.697558146523;5042.243663450512;5045.217991211368 07:55:27 INFO - PROCESS | 4654 | |5;yui.html;568.5508448325822;590.4508806809666;603.5111559636697;637.2480473041811;637.4358692557089;12387.38063096845;13247.536336228222;13265.40305686244;13265.40305686244;13278.601641950745;12151.574694885681;12338.136330456871;12347.444365003574;12354.258744475315;12359.196652217599;715.6064164709402;736.9852602947938;743.438703778649;743.9293267139614;744.4639859301321;739.9741009064684;740.0564280542325;741.8182545276414;742.0798210219316;742.1205871042831;777.2577188784725;778.2956424435895;779.2480256552426;779.4426984705934;779.4855395439012;775.1124961918628;776;776.3827756933251;776.603931994684;776.8873513340591;563.2705646188197;565.5532129617598;565.6069032022746;566.2751677852356;566.5750686984761;12748;12904;12932.935335323264;12936.159149655243;12936.741265174738;13292.184733473778;13338.933305333509;13844.377003034788;13863.514776982858;14103.78844317336;9826.06652368024;9955.751106222402;10024;10030.147437467824;10419.11437527811;3112.719855213019;3234.741220702338;3247.902562923116;3261.8369081546066;3266.5426840242385;66102.66948665274;67606;67613.32386676119;68092.6595367025;69242.99999999949;9696.17582505495;9714.174295184846;9732.41605503658;9828.606855725691;9970.700878973643;16680.58298542522;17172.22724977379;20265.29071482491;20323.491912702302;20329.18683252683;6910.896336554955;6914.377706006484;6939.479539034593;6995.26549712283;7019.157701075904;3592.4431713084514;3665.8533658653355;3672.981635091807;3710.6660400563537;3716.646918542734;2942.146777434563;3046.299351149248;3067.7852550321263;3069.8925537606524;3090.5364195370876;521.7599904044106;526.2632314759368;526.6445149524056;529.042433195909;541.6262778682697;441.0165331311194;469.4765336649611;501.2331133365956;517.7023211653315;529.3774580909577;7691.423143264277;7927.762167134995;7977.806400475554;8022.324726931434;8195.7951051223;474.9645772216532;484.530005894282;521.015281118686;522.5897670328774;552.5689961829779;3581.767185132958;3634.7819130851703;3655.9601640187743;3677.282929828658;3815.37046387343;102246;103966.48016759868;105080.47459762653;107164.46417767862;107197;91927.5403622991;92808.53595731978;93188.6130248281;93476;94465;48617.513824862006;79516.60241698755;80377.59811201024;80571.19428805637;81249;7088.610126443095;7140.464465165237;7178.497505174588;7347.7508823499065;7478.962605187157;38260.42609360806;38511.6148838508;38660.61339386683;41751.1649767009;48822.267665985746;38604.274916749615;43980.78009609931;58961.70519147377;62795;62800.685996571556;10496.127904071946;10562.735931601772;10658.946705266424;10854.240203185702;10987.505562249558;11787.941060294643;12057.216280941711;12299.139060265696;12687.936560317139;13099.476020959055;10629.627963021258;10799.40603266828;11204.551817927191;11206.159538034843;11359.318440893572;10663.466826658481;10786.406747628957;11179.944100279447;11181.552737890719;11916.821247681464;10860.131189504662;10928.781424371628;11454.140939429743;11684.415779211175;11705.297682139098;9124.45253284805;9135.31485138604;9308.48803315797;9580.425174489554;9729.9027009729;9432.481213533321;9786.41281523111;9800.656977006056;9875.464711692606;9969.601215951281 07:55:27 INFO - PROCESS | 4654 | __end_tp_report 07:55:27 INFO - PROCESS | 4654 | __start_cc_report 07:55:27 INFO - PROCESS | 4654 | _x_x_mozilla_cycle_collect,1041 07:55:27 INFO - PROCESS | 4654 | __end_cc_report 07:55:27 INFO - PROCESS | 4654 | __startTimestamp1472050527142__endTimestamp 07:55:27 INFO - PROCESS | 4654 | 07:55:27 INFO - PROCESS | 4654 | ------- Summary: start ------- 07:55:27 INFO - PROCESS | 4654 | Number of tests: 6 07:55:27 INFO - PROCESS | 4654 | 07:55:27 INFO - PROCESS | 4654 | [#0] dojo.html Cycles:165 Average:4676.95 Median:4826.00 stddev:494.04 (10.2%) stddev-sans-first:467.43 07:55:27 INFO - PROCESS | 4654 | Values: 2582.4 2591.3 2595.2 2629.8 2647.3 4658.6 4659.9 4731.2 4753.0 4794.4 4705.1 4737.7 4738.8 4752.8 4803.4 4383.2 4392.7 4396.6 4404.7 4519.0 4455.7 4456.2 4461.0 4462.6 4482.4 4279.3 4327.8 4331.4 4336.3 4337.2 4265.8 4304.0 4321.0 4351.8 4400.2 4275.4 4282.6 4286.4 4294.5 4340.0 4686.4 4751.9 4751.9 4757.5 4801.3 5012.7 5066.4 5072.3 5105.5 5106.7 5134.2 5135.6 5139.3 5144.9 5146.7 4752.7 4802.8 4808.0 4820.9 4856.9 5062.8 5087.0 5123.1 5128.1 5134.0 4914.6 4919.4 4920.6 4922.2 4955.5 4998.3 5004.7 5004.8 5008.2 5050.6 4952.2 4959.6 4988.5 5003.7 5013.1 4996.9 4998.4 4998.7 5002.6 5049.7 4238.9 4239.4 4240.1 4281.7 4284.1 3644.2 3659.5 3661.3 3691.0 3703.9 4360.7 4383.2 4426.1 4433.6 4438.2 5069.6 5073.1 5076.4 5083.3 5084.0 4300.8 4350.5 4358.0 4366.2 4409.9 4549.4 4559.7 4566.4 4623.0 4631.3 4816.1 4822.2 4824.7 4826.0 4887.8 4919.2 4954.5 5041.4 5059.7 5141.1 4794.4 4802.7 4804.0 4832.4 4858.5 4967.8 4970.5 4971.0 4971.7 5028.9 5001.3 5019.1 5059.9 5065.2 5131.8 4906.6 4948.5 4951.1 4987.9 5006.7 4929.3 4939.3 4939.7 4941.6 5006.1 4709.7 4764.5 4857.4 4866.6 4957.3 4907.9 4942.1 4954.8 4970.5 5006.3 4830.5 4839.9 4840.5 4843.5 4908.3 07:55:27 INFO - PROCESS | 4654 | 07:55:27 INFO - PROCESS | 4654 | [#1] ext.html Cycles:180 Average:50852.48 Median:37028.81 stddev:101898.33 (275.2%) stddev-sans-first:102114.23 07:55:27 INFO - PROCESS | 4654 | Values: 564.5 572.5 577.3 587.5 592.6 36248.3 38671.6 38772.5 43073.4 43088.0 39444.0 39911.4 39917.6 39930.6 39934.4 5579.1 7529.4 7723.1 7732.4 7747.9 7379.9 7631.3 7633.7 10018.0 10339.1 9897.7 9970.7 9979.8 9981.4 9983.6 9904.5 9949.9 9958.2 9967.6 9971.4 9787.5 9881.5 9884.5 9888.3 9894.3 37076.8 37300.8 37367.3 37386.8 37458.6 2528.5 2744.0 2746.2 2748.8 2750.4 28267.4 28634.1 28837.7 28896.3 29033.4 3290.9 3378.9 3418.7 3466.9 3470.1 244534.0 247880.0 249458.0 249499.0 249963.0 45706.0 45943.0 46037.5 46038.0 46100.5 31562.5 32149.5 32150.7 33742.5 33909.0 12252.3 12410.7 12411.9 12420.6 12424.3 10136.2 10417.7 10418.5 10423.1 10423.4 14799.6 15176.9 15184.9 15730.1 17029.1 6015.6 6383.7 6558.1 6591.9 6638.4 718.2 780.5 836.8 888.1 943.4 27120.2 27574.2 27586.3 27947.2 28064.3 902.2 905.9 936.9 959.9 1000.6 14256.1 14453.8 14721.9 14978.3 15049.0 387166.3 390369.0 392506.0 392993.0 393125.6 41877.6 46262.5 47273.8 47413.0 47781.5 1096.5 1103.1 1122.7 1128.0 1131.8 26741.3 27710.4 28079.9 28368.3 28983.7 41288.0 41711.2 41722.4 41770.0 41774.8 389747.0 398986.0 399503.0 574407.0 575807.0 36943.3 36993.8 37063.8 37255.4 37482.6 40736.2 40759.6 41022.4 41217.0 41325.2 34659.7 34919.9 35096.8 35346.5 35501.5 35216.6 35238.3 35517.6 35657.5 36081.0 34630.0 35326.6 35413.8 35610.0 36238.3 30441.5 32552.3 32818.3 32910.0 33389.7 23767.6 24097.5 24341.3 24380.6 24496.4 07:55:27 INFO - PROCESS | 4654 | 07:55:27 INFO - PROCESS | 4654 | [#2] jquery.html Cycles:180 Average:25770.12 Median:213803.11 stddev:64357.40 (30.1%) stddev-sans-first:64509.62 07:55:27 INFO - PROCESS | 4654 | Values: 341.1 362.6 367.5 370.7 387.6 12508.5 14755.3 17177.1 17283.6 17303.9 14425.9 15226.2 15295.6 16856.2 17354.9 4678.6 5070.1 5095.9 5096.5 5100.9 3640.4 5002.4 5093.0 5663.5 5986.0 5986.7 6025.2 6026.1 6029.2 6031.7 6024.3 6551.4 6842.9 6870.4 7016.9 6478.3 6673.1 6761.0 6767.9 6770.3 22466.9 22964.5 22971.5 23225.0 23575.2 1792.1 1827.6 1950.4 1992.4 2023.4 13929.4 14313.9 14386.9 14546.5 15229.7 1787.6 1802.8 1841.3 1882.3 1958.2 71889.0 84590.6 85357.6 85754.0 85786.6 14914.6 16402.9 16483.4 16927.8 17604.4 28772.8 28774.4 28855.7 28912.9 28955.9 7967.6 8003.5 8154.0 8197.1 8221.5 6407.6 6416.1 6642.9 6687.0 6687.3 7993.6 8323.0 8344.7 8408.7 8426.6 3039.9 3100.7 3185.0 3201.4 3305.1 781.2 802.6 856.9 871.8 872.2 16086.5 16775.7 17286.7 17672.5 17840.3 805.2 809.1 810.7 817.0 851.4 9214.5 9791.4 9932.3 9934.4 9966.5 380710.0 387582.0 388284.1 388653.0 396768.0 75801.6 78352.6 79512.0 80520.6 83014.6 842.2 869.4 904.6 906.7 920.3 15377.2 15409.9 15713.2 16083.2 16337.3 27426.5 37436.3 38953.2 39468.2 40135.8 50908.7 51907.0 51916.2 52132.0 52477.0 4980.5 7237.8 7641.6 7829.9 7968.4 10212.7 11721.8 11929.3 11948.9 12088.7 10044.4 10196.4 10290.5 10527.6 10575.3 10655.4 10746.5 10884.6 10896.8 10901.5 10675.0 10932.7 10970.7 11159.2 11306.7 7714.5 7893.2 8016.4 8023.5 8075.3 9082.8 10419.1 10665.3 10852.5 10990.7 07:55:27 INFO - PROCESS | 4654 | 07:55:27 INFO - PROCESS | 4654 | [#3] mootools.html Cycles:180 Average:4880.89 Median:5023.20 stddev:2756.61 (54.9%) stddev-sans-first:2750.57 07:55:27 INFO - PROCESS | 4654 | Values: 1213.3 1278.6 1321.3 1323.0 1575.1 6263.1 7325.2 7598.9 7605.6 7768.5 7620.4 7668.8 7677.3 7683.7 7686.3 2150.5 2180.2 2180.3 2180.6 2185.0 2034.9 2084.7 2099.4 2099.9 2103.6 2050.7 2091.3 2101.0 2102.9 2106.8 2086.5 2086.7 2089.7 2091.2 2096.2 1982.0 2064.7 2065.6 2067.2 2078.0 7338.3 7352.4 7428.1 7436.6 7536.1 4113.3 4262.0 4269.7 4270.3 4271.7 2694.7 2782.9 2837.8 2838.5 2850.9 890.7 900.3 901.3 913.8 914.8 10336.0 10400.7 10410.2 10420.6 10421.6 3745.3 3846.9 3991.9 3998.3 4018.5 7760.4 7765.5 7767.0 7770.3 7783.3 4329.0 4338.3 4349.0 4350.3 4354.4 3523.4 3771.8 3908.8 4052.3 4072.1 3278.3 3293.5 3421.8 3440.6 3442.6 1019.3 1019.6 1045.1 1048.7 1053.1 619.3 777.3 787.8 805.2 810.5 4735.6 4832.3 4889.0 5209.7 5247.9 829.2 881.9 882.0 882.1 886.6 3186.6 3282.0 3282.2 3363.7 3463.3 9209.2 9297.7 9405.2 9417.8 9523.0 9067.7 9252.0 9302.4 9352.6 9400.0 6937.8 7083.4 7095.0 7095.5 7099.8 4674.6 4747.8 4812.0 5157.4 5206.3 8187.2 8388.7 8398.4 8445.6 8596.5 8402.3 8729.0 8736.0 8742.0 8838.7 5815.8 6346.7 6577.1 6734.6 6739.4 7190.7 7276.2 7348.4 7355.9 7387.2 6239.1 6398.4 6440.8 6537.4 6684.2 6056.6 6064.6 6093.4 6104.6 6121.5 6130.4 6222.7 6225.3 6235.3 6239.7 4137.8 4141.9 4150.6 4267.0 4281.7 4391.5 4451.9 4459.3 4480.7 4555.6 07:55:27 INFO - PROCESS | 4654 | 07:55:27 INFO - PROCESS | 4654 | [#4] prototype.html Cycles:180 Average:4191.72 Median:4753.54 stddev:1226.75 (25.8%) stddev-sans-first:1194.68 07:55:27 INFO - PROCESS | 4654 | Values: 287.9 297.9 299.7 299.8 306.0 4577.9 4755.4 4772.1 4836.3 4887.0 4576.3 4697.3 4728.3 4733.4 4751.7 3743.7 3750.1 3755.8 3758.5 3762.8 3587.9 3775.1 3783.7 3798.6 3806.9 3374.5 3650.7 3736.6 3741.9 3755.2 3705.2 3728.2 3744.9 3748.2 3765.8 3303.9 3307.3 3309.2 3314.8 3327.6 4525.5 4655.2 4706.6 4711.5 4734.2 4251.0 4253.3 4261.7 4264.3 4281.5 4989.6 5053.1 5053.4 5058.1 5065.8 3376.0 3633.4 3645.8 3648.9 3662.9 5137.9 5208.9 5222.8 5230.7 5231.3 3644.5 3645.2 3654.1 3665.5 3665.7 3717.5 3724.6 3725.1 3727.5 3736.3 4137.5 4167.5 4204.3 4219.5 4267.0 5015.5 5027.6 5028.9 5040.6 5045.4 1206.9 1241.3 1247.0 1265.8 1293.2 819.8 834.3 838.1 856.2 859.9 4429.3 4435.6 4438.0 4478.2 4485.4 5223.3 5228.8 5229.1 5237.8 5241.6 4286.2 4534.2 4536.5 4544.8 4554.5 2771.9 2772.3 2783.9 2795.6 2810.6 4787.8 4967.2 4984.9 5020.2 5025.7 5281.8 5307.6 5314.9 5337.5 5375.8 4939.3 4950.3 4967.7 4968.0 4998.2 5050.8 5189.8 5197.7 5205.4 5222.9 5082.4 5092.4 5095.4 5098.9 5126.4 4930.7 4945.8 4955.0 4998.6 5018.6 3465.7 3668.1 3685.2 3700.4 3705.9 5146.3 5151.3 5152.4 5160.3 5184.5 5030.2 5041.3 5050.7 5105.6 5120.5 4980.0 5036.5 5100.6 5129.4 5134.7 4761.3 4823.2 4933.5 4946.3 4984.2 5114.0 5119.5 5124.8 5139.6 5141.7 5021.8 5037.5 5040.7 5042.2 5045.2 07:55:27 INFO - PROCESS | 4654 | 07:55:27 INFO - PROCESS | 4654 | [#5] yui.html Cycles:180 Average:17854.99 Median:509.47 stddev:26660.62 (5233.0%) stddev-sans-first:26703.82 07:55:27 INFO - PROCESS | 4654 | Values: 568.6 590.5 603.5 637.2 637.4 12387.4 13247.5 13265.4 13265.4 13278.6 12151.6 12338.1 12347.4 12354.3 12359.2 715.6 737.0 743.4 743.9 744.5 740.0 740.1 741.8 742.1 742.1 777.3 778.3 779.2 779.4 779.5 775.1 776.0 776.4 776.6 776.9 563.3 565.6 565.6 566.3 566.6 12748.0 12904.0 12932.9 12936.2 12936.7 13292.2 13338.9 13844.4 13863.5 14103.8 9826.1 9955.8 10024.0 10030.1 10419.1 3112.7 3234.7 3247.9 3261.8 3266.5 66102.7 67606.0 67613.3 68092.7 69243.0 9696.2 9714.2 9732.4 9828.6 9970.7 16680.6 17172.2 20265.3 20323.5 20329.2 6910.9 6914.4 6939.5 6995.3 7019.2 3592.4 3665.9 3673.0 3710.7 3716.6 2942.1 3046.3 3067.8 3069.9 3090.5 521.8 526.3 526.6 529.0 541.6 441.0 469.5 501.2 517.7 529.4 7691.4 7927.8 7977.8 8022.3 8195.8 475.0 484.5 521.0 522.6 552.6 3581.8 3634.8 3656.0 3677.3 3815.4 102246.0 103966.5 105080.5 107164.5 107197.0 91927.5 92808.5 93188.6 93476.0 94465.0 48617.5 79516.6 80377.6 80571.2 81249.0 7088.6 7140.5 7178.5 7347.8 7479.0 38260.4 38511.6 38660.6 41751.2 48822.3 38604.3 43980.8 58961.7 62795.0 62800.7 10496.1 10562.7 10658.9 10854.2 10987.5 11787.9 12057.2 12299.1 12687.9 13099.5 10629.6 10799.4 11204.6 11206.2 11359.3 10663.5 10786.4 11179.9 11181.6 11916.8 10860.1 10928.8 11454.1 11684.4 11705.3 9124.5 9135.3 9308.5 9580.4 9729.9 9432.5 9786.4 9800.7 9875.5 9969.6 07:55:27 INFO - PROCESS | 4654 | -------- Summary: end -------- 07:55:27 INFO - PROCESS | 4654 | 07:55:28 INFO - TEST-INFO | 4654: exit 0 07:55:28 INFO - TEST-OK | dromaeo_css | took 1121151ms 07:55:28 INFO - TEST-START | kraken 07:55:28 INFO - operating with platform_type : linux_ 07:55:28 INFO - Initialising browser for kraken test... 07:55:28 INFO - TEST-INFO | started process 4958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNcz9Zs/profile http://localhost:44663/getInfo.html) 07:55:32 INFO - PROCESS | 4958 | __metrics Screen width/height:1600/1200 07:55:32 INFO - PROCESS | 4958 | colorDepth:24 07:55:32 INFO - PROCESS | 4958 | Browser inner width/height: 1024/697 07:55:32 INFO - PROCESS | 4958 | __metrics 07:55:33 INFO - PROCESS | 4958 | 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:55:33 INFO - PROCESS | 4958 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:33 INFO - PROCESS | 4958 | console.error: PushService: 07:55:33 INFO - PROCESS | 4958 | stateChangeProcessEnqueue: Error transitioning state 07:55:33 INFO - PROCESS | 4958 | UnknownError 07:55:34 INFO - TEST-INFO | 4958: exit 0 07:55:34 INFO - Browser initialized. 07:55:34 INFO - Running cycle 1/1 for kraken test... 07:55:34 INFO - TEST-INFO | started process 5038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNcz9Zs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:46 INFO - PROCESS | 5038 | RSS: Main: 183123968 07:55:46 INFO - PROCESS | 5038 | 07:55:49 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44663/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:50 INFO - PROCESS | 5038 | RSS: Main: 237129728 07:55:50 INFO - PROCESS | 5038 | 07:55:53 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44663/tests/kraken/driver.html?testName=audio-dft) 07:55:53 INFO - PROCESS | 5038 | RSS: Main: 227340288 07:55:53 INFO - PROCESS | 5038 | 07:55:57 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44663/tests/kraken/driver.html?testName=audio-fft) 07:55:57 INFO - PROCESS | 5038 | RSS: Main: 304652288 07:55:57 INFO - PROCESS | 5038 | 07:55:59 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44663/tests/kraken/driver.html?testName=audio-oscillator) 07:56:00 INFO - PROCESS | 5038 | RSS: Main: 215433216 07:56:00 INFO - PROCESS | 5038 | 07:56:02 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44663/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:03 INFO - PROCESS | 5038 | RSS: Main: 216715264 07:56:03 INFO - PROCESS | 5038 | 07:56:06 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44663/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:07 INFO - PROCESS | 5038 | RSS: Main: 255062016 07:56:07 INFO - PROCESS | 5038 | 07:56:10 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44663/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:11 INFO - PROCESS | 5038 | RSS: Main: 249208832 07:56:11 INFO - PROCESS | 5038 | 07:56:14 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44663/tests/kraken/driver.html?testName=json-parse-financial) 07:56:14 INFO - PROCESS | 5038 | RSS: Main: 252596224 07:56:14 INFO - PROCESS | 5038 | 07:56:16 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44663/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:17 INFO - PROCESS | 5038 | RSS: Main: 216756224 07:56:17 INFO - PROCESS | 5038 | 07:56:19 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44663/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:19 INFO - PROCESS | 5038 | RSS: Main: 223690752 07:56:19 INFO - PROCESS | 5038 | 07:56:21 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44663/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:22 INFO - PROCESS | 5038 | RSS: Main: 224337920 07:56:22 INFO - PROCESS | 5038 | 07:56:25 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:26 INFO - PROCESS | 5038 | RSS: Main: 219484160 07:56:26 INFO - PROCESS | 5038 | 07:56:28 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:29 INFO - PROCESS | 5038 | RSS: Main: 222543872 07:56:29 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | Cycle 1(1): loaded http://localhost:44663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44663/tests/kraken/driver.html?testName=ai-astar) 07:56:31 INFO - PROCESS | 5038 | RSS: Main: 274452480 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | __start_tp_report 07:56:31 INFO - PROCESS | 5038 | _x_x_mozilla_page_load 07:56:31 INFO - PROCESS | 5038 | _x_x_mozilla_page_load_details 07:56:31 INFO - PROCESS | 5038 | |i|pagename|runs| 07:56:31 INFO - PROCESS | 5038 | |0;ai-astar;116;117;128;115;114;116;115;115;112;114 07:56:31 INFO - PROCESS | 5038 | |1;audio-beat-detection;157;128;155;191;123;144;148;129;188;122 07:56:31 INFO - PROCESS | 5038 | |2;audio-dft;162;162;162;162;162;165;165;164;163;163 07:56:31 INFO - PROCESS | 5038 | |3;audio-fft;77;76;76;162;76;77;75;76;162;77 07:56:31 INFO - PROCESS | 5038 | |4;audio-oscillator;87;88;161;87;88;88;141;87;86;137 07:56:31 INFO - PROCESS | 5038 | |5;imaging-gaussian-blur;118;117;117;118;117;119;118;117;117;117 07:56:31 INFO - PROCESS | 5038 | |6;imaging-darkroom;146;147;146;145;146;146;146;148;147;147 07:56:31 INFO - PROCESS | 5038 | |7;imaging-desaturate;95;95;94;94;95;96;95;95;94;95 07:56:31 INFO - PROCESS | 5038 | |8;json-parse-financial;66;67;67;69;69;69;67;68;67;67 07:56:31 INFO - PROCESS | 5038 | |9;json-stringify-tinderbox;65;66;65;67;66;65;65;67;66;66 07:56:31 INFO - PROCESS | 5038 | |10;stanford-crypto-aes;84;87;83;84;89;82;86;83;91;86 07:56:31 INFO - PROCESS | 5038 | |11;stanford-crypto-ccm;136;147;140;135;140;134;135;134;156;132 07:56:31 INFO - PROCESS | 5038 | |12;stanford-crypto-pbkdf2;173;179;172;172;172;174;174;174;172;172 07:56:31 INFO - PROCESS | 5038 | |13;stanford-crypto-sha256-iterative;69;74;70;69;70;71;69;67;67;68 07:56:31 INFO - PROCESS | 5038 | __end_tp_report 07:56:31 INFO - PROCESS | 5038 | __start_cc_report 07:56:31 INFO - PROCESS | 5038 | _x_x_mozilla_cycle_collect,2034 07:56:31 INFO - PROCESS | 5038 | __end_cc_report 07:56:31 INFO - PROCESS | 5038 | __startTimestamp1472050591631__endTimestamp 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | ------- Summary: start ------- 07:56:31 INFO - PROCESS | 5038 | Number of tests: 14 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#0] ai-astar Cycles:10 Average:116.20 Median:115.50 stddev:4.37 (3.8%) stddev-sans-first:4.63 07:56:31 INFO - PROCESS | 5038 | Values: 116.0 117.0 128.0 115.0 114.0 116.0 115.0 115.0 112.0 114.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:151.50 stddev:25.07 (16.5%) stddev-sans-first:26.40 07:56:31 INFO - PROCESS | 5038 | Values: 157.0 128.0 155.0 191.0 123.0 144.0 148.0 129.0 188.0 122.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 07:56:31 INFO - PROCESS | 5038 | Values: 162.0 162.0 162.0 162.0 162.0 165.0 165.0 164.0 163.0 163.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:36.16 (47.6%) stddev-sans-first:37.86 07:56:31 INFO - PROCESS | 5038 | Values: 77.0 76.0 76.0 162.0 76.0 77.0 75.0 76.0 162.0 77.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:87.00 stddev:29.17 (33.5%) stddev-sans-first:30.20 07:56:31 INFO - PROCESS | 5038 | Values: 87.0 88.0 161.0 87.0 88.0 88.0 141.0 87.0 86.0 137.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 07:56:31 INFO - PROCESS | 5038 | Values: 118.0 117.0 117.0 118.0 117.0 119.0 118.0 117.0 117.0 117.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 07:56:31 INFO - PROCESS | 5038 | Values: 146.0 147.0 146.0 145.0 146.0 146.0 146.0 148.0 147.0 147.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:56:31 INFO - PROCESS | 5038 | Values: 95.0 95.0 94.0 94.0 95.0 96.0 95.0 95.0 94.0 95.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:67.50 stddev:1.07 (1.6%) stddev-sans-first:0.97 07:56:31 INFO - PROCESS | 5038 | Values: 66.0 67.0 67.0 69.0 69.0 69.0 67.0 68.0 67.0 67.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 07:56:31 INFO - PROCESS | 5038 | Values: 65.0 66.0 65.0 67.0 66.0 65.0 65.0 67.0 66.0 66.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:2.88 (3.3%) stddev-sans-first:3.00 07:56:31 INFO - PROCESS | 5038 | Values: 84.0 87.0 83.0 84.0 89.0 82.0 86.0 83.0 91.0 86.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:138.00 stddev:7.42 (5.4%) stddev-sans-first:7.79 07:56:31 INFO - PROCESS | 5038 | Values: 136.0 147.0 140.0 135.0 140.0 134.0 135.0 134.0 156.0 132.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:173.50 stddev:2.17 (1.3%) stddev-sans-first:2.30 07:56:31 INFO - PROCESS | 5038 | Values: 173.0 179.0 172.0 172.0 172.0 174.0 174.0 174.0 172.0 172.0 07:56:31 INFO - PROCESS | 5038 | 07:56:31 INFO - PROCESS | 5038 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:2.07 (3.0%) stddev-sans-first:2.19 07:56:31 INFO - PROCESS | 5038 | Values: 69.0 74.0 70.0 69.0 70.0 71.0 69.0 67.0 67.0 68.0 07:56:31 INFO - PROCESS | 5038 | -------- Summary: end -------- 07:56:31 INFO - PROCESS | 5038 | 07:56:32 INFO - TEST-INFO | 5038: exit 0 07:56:32 INFO - TEST-OK | kraken | took 64673ms 07:56:32 INFO - SUITE-END | took 1185s 07:56:33 INFO - Completed test suite (00:19:46) 07:56:33 INFO - javascript benchmark 07:56:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.4015940263466, 2591.313301974976, 2595.1565741134114, 2629.7764690001336, 2647.3381654586356, 4658.580727734503, 4659.860204193876, 4731.172044892143, 4752.976235118828, 4794.400699912511, 4705.082508910764, 4737.73942433166, 4738.810447582093, 4752.786124624383, 4803.423589169296, 4383.167198232341, 4392.670549708769, 4396.626286765629, 4404.669649776263, 4518.954810451886, 4455.732656040632, 4456.153330867141, 4460.955390446103, 4462.553744625544, 4482.417285752847, 4279.315309550489, 4327.82688692455, 4331.371951067078, 4336.3278691802825, 4337.219300525904, 4265.786710664485, 4303.978480107611, 4321.027768752037, 4351.782410879475, 4400.207962566737, 4275.358696195595, 4282.5503322151035, 4286.357046443059, 4294.484661840568, 4340.0, 4686.367340409035, 4751.857444276678, 4751.928721069186, 4757.548032936866, 4801.255805350142, 5012.72430016349, 5066.36670416198, 5072.34059572257, 5105.514976077304, 5106.719130447824, 5134.17853143499, 5135.6148288878485, 5139.254808052811, 5144.871378215537, 5146.6911985281, 4752.667313288071, 4802.831900883452, 4808.0, 4820.8794780130775, 4856.927146092811, 5062.772175252123, 5087.033463641897, 5123.052235336475, 5128.051310507568, 5134.024535338273, 4914.606831453475, 4919.385076865392, 4920.581750551171, 4922.163232250526, 4955.4548999610015, 4998.300237966688, 5004.724740139254, 5004.799808007639, 5008.198688209869, 5050.595952323805, 4952.182889823211, 4959.553640172402, 4988.451270360258, 5003.74981250936, 5013.1227035268685, 4996.850094497171, 4998.4251811042195, 4998.725070121178, 5002.624803139779, 5049.747512624427, 4238.919075635693, 4239.427677263591, 4240.088380998039, 4281.657467402601, 4284.100338928797, 3644.2164934538673, 3659.5059666945153, 3661.3226553087766, 3690.9630903691154, 3703.9444408333898, 4360.738355698605, 4383.232934236496, 4426.070525189682, 4433.556644335541, 4438.201123797748, 5069.5690866276045, 5073.061483625467, 5076.416212135578, 5083.262926875583, 5084.0340335336905, 4300.763458009839, 4350.456192975878, 4358.019445624709, 4366.214081465303, 4409.867703968886, 4549.431321084864, 4559.726416415026, 4566.360709500673, 4623.006053698471, 4631.258998560214, 4816.060868130751, 4822.228443449031, 4824.710517368829, 4826.0, 4887.755612219375, 4919.2129259318335, 4954.4797796232315, 5041.42023667283, 5059.74413116383, 5141.126008578476, 4794.376731024944, 4802.687825291345, 4804.039192161512, 4832.371791667061, 4858.514148585114, 4967.751612419437, 4970.5029497051455, 4970.950290497193, 4971.726555039508, 5028.9245661315845, 5001.274815151855, 5019.121653710659, 5059.898802023865, 5065.189569668835, 5131.846044618667, 4906.55840974314, 4948.505149485167, 4951.133551628523, 4987.875303117451, 5006.749662516787, 4929.309896614549, 4939.259111133359, 4939.703617782944, 4941.629377796751, 5006.07387633289, 4709.670323077352, 4764.475907650087, 4857.441394239567, 4866.6350023747655, 4957.281194226889, 4907.852764417074, 4942.110420124268, 4954.752262386794, 4970.502949705001, 5006.324146240357, 4830.492798256132, 4839.908434164687, 4840.515948405131, 4843.539863712942, 4908.312836203006], "value": 4644.635854073678, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.4553006348873, 572.45616664169, 577.2611057845957, 587.4507335641176, 592.5851903667434, 36248.275034499326, 38671.61328386719, 38772.47978881374, 43073.35389969153, 43088.0, 39444.0, 39911.401328980086, 39917.60082399182, 39930.60069399305, 39934.400983985266, 5579.107342825148, 7529.360004399633, 7723.11184213817, 7732.381409487256, 7747.922520774777, 7379.852402951938, 7631.313181813635, 7633.694652213905, 10018.0, 10339.12117470016, 9897.703068907944, 9970.700878973643, 9979.800403991916, 9981.351212171186, 9983.600655973753, 9904.50477476127, 9949.850752238686, 9958.203343732484, 9967.601295948154, 9971.40171589707, 9787.510624468749, 9881.505924703735, 9884.456354900478, 9888.258380621483, 9894.30739848211, 37076.81461592702, 37300.81349593234, 37367.25265494702, 37386.813065934766, 37458.62541374579, 2528.4690215054675, 2743.9588406173925, 2746.1761471558452, 2748.7800975921878, 2750.436160587095, 28267.434651307063, 28634.14097577076, 28837.71162288371, 28896.27759306013, 29033.419331613462, 3290.851911663957, 3378.8986330410125, 3418.67522585354, 3466.878659246914, 3470.0977745786026, 244534.0, 247880.0, 249458.0, 249499.0, 249963.0, 45706.0, 45943.0, 46037.539624603996, 46038.0, 46100.538994610295, 31562.526562101586, 32149.517757233192, 32150.678493215237, 33742.493862592084, 33909.0, 12252.326122063194, 12410.689732756573, 12411.937940310241, 12420.62738117858, 12424.316662583644, 10136.189104871593, 10417.687469375931, 10418.479076046167, 10423.061924426838, 10423.42671153094, 14799.556013319618, 15176.924115379352, 15184.924075379773, 15730.134842583768, 17029.148542573068, 6015.639061656315, 6383.71273292703, 6558.147440832661, 6591.901121483182, 6638.402543771083, 718.2350796401815, 780.4770803561628, 836.8117173635883, 888.1207604471526, 943.3585162089845, 27120.186394407803, 27574.172774816787, 27586.310342241606, 27947.161585152073, 28064.29839254035, 902.228594551662, 905.8958219804807, 936.8782058332373, 959.8608201810698, 1000.6397696829135, 14256.144631322153, 14453.78319325211, 14721.92639036798, 14978.251087445584, 15049.0, 387166.3100641855, 390369.0, 392506.0, 392993.0, 393125.61869431316, 41877.581224187365, 46262.537374626496, 47273.763631182315, 47413.0, 47781.522184778405, 1096.4791723931228, 1103.1175059952006, 1122.7361570030873, 1128.0, 1131.8302254661703, 26741.331466713487, 27710.44579108447, 28079.859600701864, 28368.290792730346, 28983.710162898944, 41288.0, 41711.1657766849, 41722.37416438695, 41770.0, 41774.791126044176, 389747.0, 398986.0, 399503.0, 574407.0, 575807.0, 36943.261134776614, 36993.81503092467, 37063.81106645126, 37255.441168381956, 37482.625173749, 40736.1852762949, 40759.59240407558, 41022.38466422947, 41216.96957575965, 41325.1734965305, 34659.65340346564, 34919.88901942201, 35096.824515877255, 35346.46980295349, 35501.467477988364, 35216.64783352134, 35238.295234094665, 35517.64482355143, 35657.46513802243, 36081.0, 34630.0, 35326.646733533365, 35413.822930886214, 35610.0, 36238.27523449569, 30441.543376849808, 32552.34895302128, 32818.34363312768, 32910.0, 33389.66610333963, 23767.643485347387, 24097.51804963856, 24341.29610927218, 24380.6342904853, 24496.38759030967], "value": 17440.55979982668, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.0569774573304, 362.60476081071624, 367.5038697758027, 370.6830659785884, 387.55431254057845, 12508.4996600136, 14755.336009879555, 17177.055261960617, 17283.567910802238, 17303.913480432613, 14425.855741442583, 15226.238688065609, 15295.617609559766, 16856.24146913389, 17354.913225433855, 4678.625709943213, 5070.138076527, 5095.949040509603, 5096.4648711885275, 5100.897982040357, 3640.4175331946894, 5002.424721157077, 5093.0, 5663.5186009189265, 5986.042233242661, 5986.73059712314, 6025.1564780930485, 6026.126211699301, 6029.216201893748, 6031.728572214239, 6024.337322894478, 6551.4103730664465, 6842.897356539606, 6870.416014638762, 7016.894746578805, 6478.255000674889, 6673.0991316172185, 6761.0, 6767.932320676779, 6770.289119642416, 22466.88766556173, 22964.540709185723, 22971.540569188524, 23225.0, 23575.17486887968, 1792.0770803036446, 1827.5613852675262, 1950.414875537333, 1992.412238389664, 2023.3828682251908, 13929.442822287197, 14313.928430357886, 14386.92806535971, 14546.490872819506, 15229.695406091816, 1787.6067265201634, 1802.7656404667441, 1841.2634946021565, 1882.275324000256, 1958.2362878477404, 71889.0, 84590.57704711438, 85357.57321213416, 85754.0, 85786.57106714489, 14914.552563423114, 16402.917985409997, 16483.423080192377, 16927.830721692873, 17604.41560259583, 28772.834988151288, 28774.424511509653, 28855.711442885302, 28912.855435722686, 28955.855220724185, 7967.56178410193, 8003.4797738146835, 8154.0, 8197.098319184885, 8221.54781487024, 6407.647579383179, 6416.069669897839, 6642.86714265712, 6687.030380594787, 6687.297833727389, 7993.640286187136, 8323.0, 8344.666213351398, 8408.663653453794, 8426.630877251915, 3039.8872783415313, 3100.6589275179713, 3184.952225716616, 3201.423743726105, 3305.1241421023446, 781.2265856801839, 802.5706247157742, 856.871469279613, 871.7864123289835, 872.2019352292581, 16086.517404477885, 16775.748363774554, 17286.740698889527, 17672.469825905242, 17840.286388544573, 805.2470939671426, 809.0938149272852, 810.740563019828, 817.0, 851.4082712514867, 9214.539273036322, 9791.412515249107, 9932.304738668225, 9934.354266972769, 9966.451845148586, 380710.0, 387582.0, 388284.11300926364, 388653.0, 396768.0, 75801.62099189468, 78352.6082369596, 79512.0, 80520.59739701264, 83014.58492707497, 842.2461896602629, 869.387082107113, 904.6426661468684, 906.6735975048977, 920.346553946692, 15377.231138443256, 15409.922950385177, 15713.214339282762, 16083.195840208176, 16337.264823083227, 27426.451470970867, 37436.2512749738, 38953.220935581696, 39468.2106357877, 40135.79932100321, 50908.745456273966, 51907.0, 51916.22125668042, 52132.0, 52477.0, 4980.5019498049905, 7237.819054523679, 7641.586306533309, 7829.8825517618425, 7968.402369822171, 10212.744681383025, 11721.824172637247, 11929.28424294545, 11948.880511194777, 12088.697782555506, 10044.397336159855, 10196.4391958443, 10290.501229581978, 10527.578896844041, 10575.312604680672, 10655.413952232391, 10746.516406761872, 10884.564617415215, 10896.78206435851, 10901.454927253764, 10675.0, 10932.672019839418, 10970.670879873616, 11159.163062770162, 11306.717332066764, 7714.498557593738, 7893.17121702236, 8016.438849280495, 8023.518588884685, 8075.273225409506, 9082.818343632958, 10419.114375278186, 10665.306755060896, 10852.457377130953, 10990.670279891616], "value": 9091.95990422127, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1213.2962881528715, 1278.6100239426971, 1321.273299685173, 1323.0275747325718, 1575.09432076556, 6263.091851681504, 7325.194228634852, 7598.886016709754, 7605.581693006876, 7768.456208065438, 7620.390368770499, 7668.846623067535, 7677.270659287373, 7683.692652293916, 7686.26980436859, 2150.5376344086017, 2180.1606381543143, 2180.3458962311324, 2180.6183917814396, 2185.0495034659893, 2034.8677335973114, 2084.687296905461, 2099.3911765588036, 2099.863508871926, 2103.5897999890026, 2050.682144267641, 2091.3098677436487, 2101.0440249686358, 2102.936911892638, 2106.8419868509845, 2086.488810241485, 2086.6869969504546, 2089.6656534954336, 2091.2471510256296, 2096.2453516733963, 1982.0, 2064.7315848939693, 2065.6281869263526, 2067.235123004483, 2077.989610051955, 7338.302861228175, 7352.4485663574915, 7428.071491063617, 7436.590987495686, 7536.0956685198125, 4113.300738874398, 4261.957380426218, 4269.701120921537, 4270.295401258789, 4271.700980931336, 2694.703582605912, 2782.916512504628, 2837.815541989785, 2838.5316422790215, 2850.885964561415, 890.7060669978891, 900.3157600223811, 901.324006994754, 913.7532866126176, 914.7850255190025, 10336.0, 10400.739981500446, 10410.167186625053, 10420.583176673, 10421.583136674524, 3745.3071181830906, 3846.8845934622004, 3991.92016159681, 3998.320285551405, 4018.537868145142, 7760.379169666413, 7765.456418050682, 7767.0, 7770.339521140766, 7783.260590243918, 4328.956710432918, 4338.262495375794, 4348.9997300621035, 4350.303951367766, 4354.368616550646, 3523.436250199956, 3771.773693578394, 3908.785016824102, 4052.2705912935953, 4072.1244932339096, 3278.3115545735664, 3293.505974103856, 3421.8118003510044, 3440.6043305019743, 3442.5524681791208, 1019.3068713274896, 1019.5564929255797, 1045.0594464981425, 1048.6906362623045, 1053.1416895230363, 619.3496828330235, 777.3276116159482, 787.7872974297022, 805.1787177079464, 810.5096416667949, 4735.573798358096, 4832.34763306949, 4889.046635905964, 5209.661372010807, 5247.897941432266, 829.1501211258387, 881.9470831750116, 881.9514926679094, 882.0826340605698, 886.6276164011131, 3186.553882456458, 3281.9671803281663, 3282.179455136216, 3363.747718921091, 3463.3419650266874, 9209.21721653667, 9297.67458138962, 9405.20055795265, 9417.76455588602, 9523.0, 9067.68263110788, 9252.028537003653, 9302.395344302598, 9352.625894964125, 9400.0, 6937.7571784988295, 7083.433325333961, 7095.0, 7095.538789978738, 7099.82250443743, 4674.649401294849, 4747.762611869462, 4811.975940120277, 5157.355330583677, 5206.323177986837, 8187.222213889671, 8388.664453421794, 8398.370122240734, 8445.619947102272, 8596.527191004554, 8402.32781377476, 8728.956355218183, 8736.0, 8742.038375778786, 8838.690645827364, 5815.76736930518, 6346.650934198663, 6577.112089867806, 6734.6295953721055, 6739.427148692416, 7190.676419561028, 7276.163241227327, 7348.375388092072, 7355.8896616551865, 7387.187409385071, 6239.0953311770445, 6398.424141827258, 6440.8389790255615, 6537.444317233088, 6684.197896252481, 6056.606320589148, 6064.605800622945, 6093.360197179232, 6104.603200791934, 6121.47967422774, 6130.448259656652, 6222.688865556614, 6225.252969643671, 6235.314115447207, 6239.656818875005, 4137.793110344411, 4141.8964525887095, 4150.605692459211, 4267.039916018871, 4281.657467402538, 4391.451068616423, 4451.910961780682, 4459.264221403432, 4480.708753930984, 4555.612772914207], "value": 3924.109337720909, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.9150650558084, 297.9076486289251, 299.7182648310588, 299.84108422536036, 306.01920843695956, 4577.908441831161, 4755.405574303212, 4772.141014617368, 4836.274558816175, 4886.975565122174, 4576.336431217472, 4697.2954056891485, 4728.250547297504, 4733.360996265503, 4751.671680876363, 3743.681787048104, 3750.0999760057525, 3755.7558758680666, 3758.5489741230954, 3762.7930463824478, 3587.8959659873467, 3775.0751065988734, 3783.716221283401, 3798.5631652359916, 3806.885793426188, 3374.460086386179, 3650.653187947141, 3736.607656196101, 3741.850325986957, 3755.192633583779, 3705.166337574024, 3728.2357116791127, 3744.8876533703897, 3748.175401411685, 3765.830537625786, 3303.933921321584, 3307.2889328794427, 3309.2057906102605, 3314.751393645486, 3327.5674162358737, 4525.52481989393, 4655.162070827249, 4706.647001474903, 4711.528847115295, 4734.218853889104, 4251.043515209084, 4253.32040814285, 4261.74429534229, 4264.296391095466, 4281.507626622947, 4989.55094041538, 5053.140966035783, 5053.393592768891, 5058.140116180258, 5065.848024559232, 3376.0, 3633.400488919325, 3645.781253124821, 3648.8506120571933, 3662.8717994870317, 5137.922931156036, 5208.869778255536, 5222.817201397933, 5230.712310822903, 5231.3460817397445, 3644.4715516249994, 3645.179834537261, 3654.104744337654, 3665.486831843544, 3665.651763082556, 3717.498137751423, 3724.646158614927, 3725.1059745661387, 3727.459518369821, 3736.271427071695, 4137.524184718735, 4167.4790651168605, 4204.285271503852, 4219.493660760729, 4267.0, 5015.498450155028, 5027.622928280393, 5028.924566131511, 5040.59675225981, 5045.369328833895, 1206.85517737872, 1241.2986662535639, 1247.0397793698983, 1265.7722009650624, 1293.224065560656, 819.7827575692446, 834.328365665645, 838.061371264188, 856.178069053703, 859.8925134358205, 4429.313456414261, 4435.6229720473475, 4438.0, 4478.2386994211065, 4485.372047913294, 5223.3209682741, 5228.764705588258, 5229.111051121318, 5237.790488380499, 5241.580673546107, 4286.207051695446, 4534.183846907588, 4536.455625324982, 4544.818207271672, 4554.521775213621, 2771.9307017324727, 2772.348498102944, 2783.9443211135663, 2795.55271156614, 2810.550311950078, 4787.760611969387, 4967.230079337708, 4984.925226121611, 5020.196768517019, 5025.698458092526, 5281.841544753664, 5307.575393968474, 5314.92027619586, 5337.5463085637375, 5375.75809088592, 4939.259111133287, 4950.3069570260195, 4967.726775027336, 4968.0, 4998.150314446625, 5050.823221187241, 5189.76646050921, 5197.66215196011, 5205.375354957429, 5222.8955420892125, 5082.373640435173, 5092.363454568179, 5095.388553373619, 5098.872528186825, 5126.359205099363, 4930.654854160318, 4945.777440015136, 4954.9752251238515, 4998.625652814884, 5018.623603229846, 3465.653434656514, 3668.137987572865, 3685.1708365617524, 3700.389435743072, 3705.9444108337857, 5146.330976972969, 5151.304573882478, 5152.407473140487, 5160.251763494347, 5184.507471790174, 5030.220315850903, 5041.269015992734, 5050.671706339076, 5105.642605017613, 5120.539151476385, 4979.97910428354, 5036.471170527042, 5100.591952643854, 5129.358605246285, 5134.691918484903, 4761.309610106446, 4823.1800593898415, 4933.531314525115, 4946.307516947558, 4984.2025275955675, 5113.974430127825, 5119.513646203604, 5124.7950081996305, 5139.6145289102715, 5141.691498510101, 5021.769666431747, 5037.5214354636255, 5040.697558146523, 5042.243663450512, 5045.217991211368], "value": 3799.6664477006525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.5508448325822, 590.4508806809666, 603.5111559636697, 637.2480473041811, 637.4358692557089, 12387.38063096845, 13247.536336228222, 13265.40305686244, 13265.40305686244, 13278.601641950745, 12151.574694885681, 12338.136330456871, 12347.444365003574, 12354.258744475315, 12359.196652217599, 715.6064164709402, 736.9852602947938, 743.438703778649, 743.9293267139614, 744.4639859301321, 739.9741009064684, 740.0564280542325, 741.8182545276414, 742.0798210219316, 742.1205871042831, 777.2577188784725, 778.2956424435895, 779.2480256552426, 779.4426984705934, 779.4855395439012, 775.1124961918628, 776.0, 776.3827756933251, 776.603931994684, 776.8873513340591, 563.2705646188197, 565.5532129617598, 565.6069032022746, 566.2751677852356, 566.5750686984761, 12748.0, 12904.0, 12932.935335323264, 12936.159149655243, 12936.741265174738, 13292.184733473778, 13338.933305333509, 13844.377003034788, 13863.514776982858, 14103.78844317336, 9826.06652368024, 9955.751106222402, 10024.0, 10030.147437467824, 10419.11437527811, 3112.719855213019, 3234.741220702338, 3247.902562923116, 3261.8369081546066, 3266.5426840242385, 66102.66948665274, 67606.0, 67613.32386676119, 68092.6595367025, 69242.99999999949, 9696.17582505495, 9714.174295184846, 9732.41605503658, 9828.606855725691, 9970.700878973643, 16680.58298542522, 17172.22724977379, 20265.29071482491, 20323.491912702302, 20329.18683252683, 6910.896336554955, 6914.377706006484, 6939.479539034593, 6995.26549712283, 7019.157701075904, 3592.4431713084514, 3665.8533658653355, 3672.981635091807, 3710.6660400563537, 3716.646918542734, 2942.146777434563, 3046.299351149248, 3067.7852550321263, 3069.8925537606524, 3090.5364195370876, 521.7599904044106, 526.2632314759368, 526.6445149524056, 529.042433195909, 541.6262778682697, 441.0165331311194, 469.4765336649611, 501.2331133365956, 517.7023211653315, 529.3774580909577, 7691.423143264277, 7927.762167134995, 7977.806400475554, 8022.324726931434, 8195.7951051223, 474.9645772216532, 484.530005894282, 521.015281118686, 522.5897670328774, 552.5689961829779, 3581.767185132958, 3634.7819130851703, 3655.9601640187743, 3677.282929828658, 3815.37046387343, 102246.0, 103966.48016759868, 105080.47459762653, 107164.46417767862, 107197.0, 91927.5403622991, 92808.53595731978, 93188.6130248281, 93476.0, 94465.0, 48617.513824862006, 79516.60241698755, 80377.59811201024, 80571.19428805637, 81249.0, 7088.610126443095, 7140.464465165237, 7178.497505174588, 7347.7508823499065, 7478.962605187157, 38260.42609360806, 38511.6148838508, 38660.61339386683, 41751.1649767009, 48822.267665985746, 38604.274916749615, 43980.78009609931, 58961.70519147377, 62795.0, 62800.685996571556, 10496.127904071946, 10562.735931601772, 10658.946705266424, 10854.240203185702, 10987.505562249558, 11787.941060294643, 12057.216280941711, 12299.139060265696, 12687.936560317139, 13099.476020959055, 10629.627963021258, 10799.40603266828, 11204.551817927191, 11206.159538034843, 11359.318440893572, 10663.466826658481, 10786.406747628957, 11179.944100279447, 11181.552737890719, 11916.821247681464, 10860.131189504662, 10928.781424371628, 11454.140939429743, 11684.415779211175, 11705.297682139098, 9124.45253284805, 9135.31485138604, 9308.48803315797, 9580.425174489554, 9729.9027009729, 9432.481213533321, 9786.41281523111, 9800.656977006056, 9875.464711692606, 9969.601215951281], "value": 6348.605276398118, "unit": "score"}], "name": "dromaeo_css", "value": 6415.511855714105, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 128.0, 115.0, 114.0, 116.0, 115.0, 115.0, 112.0, 114.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 155.0, 191.0, 123.0, 144.0, 148.0, 129.0, 188.0, 122.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 165.0, 165.0, 164.0, 163.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 162.0, 76.0, 77.0, 75.0, 76.0, 162.0, 77.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 161.0, 87.0, 88.0, 88.0, 141.0, 87.0, 86.0, 137.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 119.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 148.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 69.0, 69.0, 69.0, 67.0, 68.0, 67.0, 67.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 67.0, 66.0, 65.0, 65.0, 67.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 83.0, 84.0, 89.0, 82.0, 86.0, 83.0, 91.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 147.0, 140.0, 135.0, 140.0, 134.0, 135.0, 134.0, 156.0, 132.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 179.0, 172.0, 172.0, 172.0, 174.0, 174.0, 174.0, 172.0, 172.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 70.0, 69.0, 70.0, 71.0, 69.0, 67.0, 67.0, 68.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1585.4, "alertThreshold": 2.0}]} 07:56:33 INFO - Return code: 0 07:56:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:33 INFO - # TBPL SUCCESS # 07:56:33 INFO - Running post-action listener: _resource_record_post_action 07:56:33 INFO - [mozharness: 2016-08-24 14:56:33.455001Z] Finished run-tests step (success) 07:56:33 INFO - Running post-run listener: _resource_record_post_run 07:56:33 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 406675456; Read time: 388; Write time: 364152 07:56:33 INFO - TinderboxPrint: CPU usage
13.0% 07:56:33 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 388 07:56:33 INFO - TinderboxPrint: I/O write bytes / time
406,675,456 / 364,152 07:56:33 INFO - TinderboxPrint: CPU idle
8,349.0 (87.0%) 07:56:33 INFO - TinderboxPrint: CPU user
1,201.2 (12.5%) 07:56:33 INFO - TinderboxPrint: Swap in / out
0 / 0 07:56:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 114208768; Read time: 156; Write time: 132260 07:56:33 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292466688; Read time: 220; Write time: 231892 07:56:34 INFO - Running post-run listener: _upload_blobber_files 07:56:34 INFO - Blob upload gear active. 07:56:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:34 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:56:34 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:56:34 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:56:34 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:56:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:56:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:35 INFO - (blobuploader) - INFO - Done attempting. 07:56:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:56:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:56:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:36 INFO - (blobuploader) - INFO - Done attempting. 07:56:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:39 INFO - (blobuploader) - INFO - Done attempting. 07:56:39 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:39 INFO - Return code: 0 07:56:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d811aa8c321577ae22095edd7221285e3645c60a73e19a76508e65795c737b4f3754bfe1471ddd763d84e08db9e2ad167bbd7635e9703ef02c5870832b1d6e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fd62e0685e6fad74e1392630ea55f962667b3eb14f226cf794a32906596c7dd7761025ad683e34e8ef024acb013e4f5bdac9c26848545252bb40da8a4ff8999", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b485e2e9d7fc55b629d7599209fd63fccdde173ba324a60c6e837475cdc6fb04958a87a95ec7e280a7c3ad73740d74d9c9fcdf54dfd8c8da13904f7d2165ac7d"} 07:56:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:39 INFO - Contents: 07:56:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d811aa8c321577ae22095edd7221285e3645c60a73e19a76508e65795c737b4f3754bfe1471ddd763d84e08db9e2ad167bbd7635e9703ef02c5870832b1d6e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fd62e0685e6fad74e1392630ea55f962667b3eb14f226cf794a32906596c7dd7761025ad683e34e8ef024acb013e4f5bdac9c26848545252bb40da8a4ff8999", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b485e2e9d7fc55b629d7599209fd63fccdde173ba324a60c6e837475cdc6fb04958a87a95ec7e280a7c3ad73740d74d9c9fcdf54dfd8c8da13904f7d2165ac7d"} 07:56:39 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:39 INFO - Copying logs to upload dir... 07:56:39 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.327825 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-24 07:56:38.700106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 07:56:38.703393) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518 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/7d811aa8c321577ae22095edd7221285e3645c60a73e19a76508e65795c737b4f3754bfe1471ddd763d84e08db9e2ad167bbd7635e9703ef02c5870832b1d6e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fd62e0685e6fad74e1392630ea55f962667b3eb14f226cf794a32906596c7dd7761025ad683e34e8ef024acb013e4f5bdac9c26848545252bb40da8a4ff8999", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b485e2e9d7fc55b629d7599209fd63fccdde173ba324a60c6e837475cdc6fb04958a87a95ec7e280a7c3ad73740d74d9c9fcdf54dfd8c8da13904f7d2165ac7d"} build_url:https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/JYNu2-UAQ7WqDFVlVE7Jng/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/7d811aa8c321577ae22095edd7221285e3645c60a73e19a76508e65795c737b4f3754bfe1471ddd763d84e08db9e2ad167bbd7635e9703ef02c5870832b1d6e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fd62e0685e6fad74e1392630ea55f962667b3eb14f226cf794a32906596c7dd7761025ad683e34e8ef024acb013e4f5bdac9c26848545252bb40da8a4ff8999", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b485e2e9d7fc55b629d7599209fd63fccdde173ba324a60c6e837475cdc6fb04958a87a95ec7e280a7c3ad73740d74d9c9fcdf54dfd8c8da13904f7d2165ac7d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 07:56:38.728493) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:56:38.728817) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1472049332.924129-1444698518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:56:38.814834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 07:56:38.815167) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 07:56:38.815453) ========= ========= Total master_lag: 0.16 =========