builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1469223239.5 results: success (0) buildid: 20160722113020 builduid: 2bbdc45cfc9e41a29f3a19d0fdcd2d02 revision: 48cee0fccdb3369df7af58c63329a25fb088832b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 14:33:59.499958) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 14:33:59.500542) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 14:33:59.500882) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 14:33:59.516789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 14:33:59.517137) ========= 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=1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 14:33:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-22 14:34:00 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098480 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 14:33:59.630057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 14:33:59.630441) ========= 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=1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015230 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 14:33:59.680563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 14:33:59.680967) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 48cee0fccdb3369df7af58c63329a25fb088832b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 48cee0fccdb3369df7af58c63329a25fb088832b --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=1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 14:34:00,148 truncating revision to first 12 chars 2016-07-22 14:34:00,148 Setting DEBUG logging. 2016-07-22 14:34:00,148 attempt 1/10 2016-07-22 14:34:00,148 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/48cee0fccdb3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 14:34:00,440 unpacking tar archive at: fx-team-48cee0fccdb3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.713979 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 14:34:00.410778) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 14:34:00.411109) ========= script_repo_revision: 48cee0fccdb3369df7af58c63329a25fb088832b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 14:34:00.411684) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 14:34:00.412145) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 14:34:00.423068) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-22 14:34:00.423477) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:34:00 INFO - MultiFileLogger online at 20160722 14:34:00 in /builds/slave/test 14:34:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:34:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:34:00 INFO - {'append_to_log': False, 14:34:00 INFO - 'base_work_dir': '/builds/slave/test', 14:34:00 INFO - 'blob_upload_branch': 'Fx-Team', 14:34:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:34:00 INFO - 'branch': 'Fx-Team', 14:34:00 INFO - 'buildbot_json_path': 'buildprops.json', 14:34:00 INFO - 'config_files': ('talos/linux_config.py',), 14:34:00 INFO - 'default_actions': ('clobber', 14:34:00 INFO - 'read-buildbot-config', 14:34:00 INFO - 'download-and-extract', 14:34:00 INFO - 'populate-webroot', 14:34:00 INFO - 'create-virtualenv', 14:34:00 INFO - 'install', 14:34:00 INFO - 'run-tests'), 14:34:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:34:00 INFO - 'download_minidump_stackwalk': True, 14:34:00 INFO - 'download_symbols': 'ondemand', 14:34:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:34:00 INFO - 'tooltool.py': '/tools/tooltool.py', 14:34:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:34:00 INFO - '/tools/misc-python/virtualenv.py')}, 14:34:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:34:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:34:00 INFO - 'installer_path': 'installer.exe', 14:34:00 INFO - 'log_level': 'info', 14:34:00 INFO - 'log_name': 'talos', 14:34:00 INFO - 'log_to_console': True, 14:34:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:34:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:34:00 INFO - 'opt_config_files': (), 14:34:00 INFO - 'pip_index': False, 14:34:00 INFO - 'sps_profile': False, 14:34:00 INFO - 'sps_profile_interval': 0, 14:34:00 INFO - 'suite': 'dromaeojs-e10s', 14:34:00 INFO - 'system_bits': '32', 14:34:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:34:00 INFO - 'title': 'talos-linux64-ix-027', 14:34:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:34:00 INFO - 'use_talos_json': True, 14:34:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:34:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:34:00 INFO - 'work_dir': 'build'} 14:34:00 INFO - [mozharness: 2016-07-22 21:34:00.974488Z] Running clobber step. 14:34:00 INFO - Running pre-action listener: _resource_record_pre_action 14:34:00 INFO - Running main action method: clobber 14:34:00 INFO - rmtree: /builds/slave/test/build 14:34:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:34:01 INFO - Running post-action listener: _resource_record_post_action 14:34:01 INFO - [mozharness: 2016-07-22 21:34:01.462283Z] Finished clobber step (success) 14:34:01 INFO - [mozharness: 2016-07-22 21:34:01.462385Z] Running read-buildbot-config step. 14:34:01 INFO - Running pre-action listener: _resource_record_pre_action 14:34:01 INFO - Running main action method: read_buildbot_config 14:34:01 INFO - Using buildbot properties: 14:34:01 INFO - { 14:34:01 INFO - "project": "", 14:34:01 INFO - "product": "firefox", 14:34:01 INFO - "script_repo_revision": "production", 14:34:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:34:01 INFO - "repository": "", 14:34:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:34:01 INFO - "buildid": "20160722113020", 14:34:01 INFO - "pgo_build": "True", 14:34:01 INFO - "basedir": "/builds/slave/test", 14:34:01 INFO - "buildnumber": 969, 14:34:01 INFO - "slavename": "talos-linux64-ix-027", 14:34:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:34:01 INFO - "platform": "ubuntu64_hw", 14:34:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:34:01 INFO - "branch": "fx-team", 14:34:01 INFO - "repo_path": "integration/fx-team", 14:34:01 INFO - "revision": "48cee0fccdb3369df7af58c63329a25fb088832b", 14:34:01 INFO - "stage_platform": "linux64-pgo", 14:34:01 INFO - "builduid": "2bbdc45cfc9e41a29f3a19d0fdcd2d02", 14:34:01 INFO - "slavebuilddir": "test" 14:34:01 INFO - } 14:34:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:34:01 INFO - Running post-action listener: _resource_record_post_action 14:34:01 INFO - [mozharness: 2016-07-22 21:34:01.464818Z] Finished read-buildbot-config step (success) 14:34:01 INFO - [mozharness: 2016-07-22 21:34:01.464907Z] Running download-and-extract step. 14:34:01 INFO - Running pre-action listener: _resource_record_pre_action 14:34:01 INFO - Running main action method: download_and_extract 14:34:01 INFO - mkdir: /builds/slave/test/build/tests 14:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:01 INFO - https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:34:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:34:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:34:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:34:02 INFO - Downloaded 1361 bytes. 14:34:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:34:02 INFO - Using the following test package requirements: 14:34:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:34:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:34:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:34:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:02 INFO - u'jsshell-linux-x86_64.zip'], 14:34:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:34:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:34:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:34:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:34:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:34:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:34:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:02 INFO - https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:34:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:34:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:34:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:34:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:34:03 INFO - Downloaded 24308968 bytes. 14:34:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:34:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:34:04 INFO - Return code: 0 14:34:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:34: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:04 INFO - https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:34:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:34:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:34:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:34:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:34:05 INFO - Downloaded 24308968 bytes. 14:34:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:34:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:34:06 INFO - Return code: 0 14:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:06 INFO - https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:34:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:34:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:34:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:34:07 INFO - Downloaded 14403289 bytes. 14:34:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:34:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:34:08 INFO - Return code: 0 14:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:08 INFO - https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:34:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:34:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:34:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:34:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:34:09 INFO - Downloaded 60860140 bytes. 14:34:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:34:09 INFO - mkdir: /builds/slave/test/properties 14:34:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:34:09 INFO - Writing to file /builds/slave/test/properties/build_url 14:34:09 INFO - Contents: 14:34:09 INFO - build_url:https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:34:10 INFO - Running post-action listener: _resource_record_post_action 14:34:10 INFO - Running post-action listener: set_extra_try_arguments 14:34:10 INFO - [mozharness: 2016-07-22 21:34:10.140137Z] Finished download-and-extract step (success) 14:34:10 INFO - [mozharness: 2016-07-22 21:34:10.140369Z] Running populate-webroot step. 14:34:10 INFO - Running pre-action listener: _resource_record_pre_action 14:34:10 INFO - Running main action method: populate_webroot 14:34:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:34:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:34:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:34:10 INFO - '--tppagecycles', 14:34:10 INFO - '7'], 14:34:10 INFO - 'tests': ['tsvgm']}}, 14:34:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:34:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:34:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:34:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:34:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:10 INFO - 'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:10 INFO - 'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['damp', 'tps']}, 14:34:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:10 INFO - 'tests': ['damp', 'tps']}, 14:34:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['dromaeo_dom']}, 14:34:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:34:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['basic_compositor_video']}, 14:34:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:34:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['a11yr', 14:34:10 INFO - 'ts_paint', 14:34:10 INFO - 'tpaint', 14:34:10 INFO - 'sessionrestore', 14:34:10 INFO - 'sessionrestore_no_auto_restore', 14:34:10 INFO - 'tabpaint']}, 14:34:10 INFO - 'other-e10s': {'tests': ['a11yr', 14:34:10 INFO - 'ts_paint', 14:34:10 INFO - 'tpaint', 14:34:10 INFO - 'sessionrestore', 14:34:10 INFO - 'sessionrestore_no_auto_restore', 14:34:10 INFO - 'tabpaint']}, 14:34:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:34:10 INFO - 'ts_paint', 14:34:10 INFO - 'tpaint', 14:34:10 INFO - 'sessionrestore', 14:34:10 INFO - 'sessionrestore_no_auto_restore', 14:34:10 INFO - 'tabpaint']}, 14:34:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:34:10 INFO - 'ts_paint', 14:34:10 INFO - 'tpaint', 14:34:10 INFO - 'sessionrestore', 14:34:10 INFO - 'sessionrestore_no_auto_restore', 14:34:10 INFO - 'tabpaint']}, 14:34:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['a11yr', 14:34:10 INFO - 'ts_paint', 14:34:10 INFO - 'tpaint', 14:34:10 INFO - 'sessionrestore', 14:34:10 INFO - 'sessionrestore_no_auto_restore', 14:34:10 INFO - 'tabpaint']}, 14:34:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['a11yr', 14:34:10 INFO - 'ts_paint', 14:34:10 INFO - 'tpaint', 14:34:10 INFO - 'sessionrestore', 14:34:10 INFO - 'sessionrestore_no_auto_restore', 14:34:10 INFO - 'tabpaint']}, 14:34:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['tsvgx', 14:34:10 INFO - 'tsvgr_opacity', 14:34:10 INFO - 'tart', 14:34:10 INFO - 'tscrollx', 14:34:10 INFO - 'cart']}, 14:34:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:34:10 INFO - 'tsvgr_opacity', 14:34:10 INFO - 'tart', 14:34:10 INFO - 'tscrollx', 14:34:10 INFO - 'cart']}, 14:34:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:10 INFO - 'talos_options': ['--disable-e10s'], 14:34:10 INFO - 'tests': ['tp5o']}, 14:34:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:10 INFO - 'tests': ['tp5o']}, 14:34:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:10 INFO - 'talos_options': ['--disable-e10s', 14:34:10 INFO - '--xperf_path', 14:34:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:10 INFO - 'tests': ['tp5n']}, 14:34:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:10 INFO - 'talos_options': ['--xperf_path', 14:34:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:10 INFO - 'tests': ['tp5n']}}, 14:34:10 INFO - 'talos.zip': {'path': '', 14:34:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:34:10 INFO - Running post-action listener: _resource_record_post_action 14:34:10 INFO - [mozharness: 2016-07-22 21:34:10.162007Z] Finished populate-webroot step (success) 14:34:10 INFO - [mozharness: 2016-07-22 21:34:10.162096Z] Running create-virtualenv step. 14:34:10 INFO - Running pre-action listener: _resource_record_pre_action 14:34:10 INFO - Running main action method: create_virtualenv 14:34:10 INFO - Creating virtualenv /builds/slave/test/build/venv 14:34:10 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 14:34:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:34:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:34:10 INFO - Using real prefix '/usr' 14:34:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:34:10 INFO - Installing distribute.............................................................................................................................................................................................done. 14:34:12 INFO - Installing pip.................done. 14:34:12 INFO - Return code: 0 14:34:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', '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 14:34:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:34:12 INFO - Using env: {'DISPLAY': ':0', 14:34:12 INFO - 'HOME': '/home/cltbld', 14:34:12 INFO - 'LANG': 'en_US.UTF-8', 14:34:12 INFO - 'LANGUAGE': 'en_US:en', 14:34:12 INFO - 'LOGNAME': 'cltbld', 14:34:12 INFO - 'MAIL': '/var/mail/cltbld', 14:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:12 INFO - 'MOZ_NO_REMOTE': '1', 14:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:12 INFO - 'NO_EM_RESTART': '1', 14:34:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:12 INFO - 'PWD': '/builds/slave/test', 14:34:12 INFO - 'SHELL': '/bin/bash', 14:34:12 INFO - 'SHLVL': '1', 14:34:12 INFO - 'TERM': 'linux', 14:34:12 INFO - 'TMOUT': '86400', 14:34:12 INFO - 'USER': 'cltbld', 14:34:12 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', 14:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:12 INFO - '_': '/tools/buildbot/bin/python'} 14:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:12 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 14:34:12 INFO - Cleaning up... 14:34:13 INFO - Return code: 0 14:34:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:13 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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', '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 14:34:13 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 14:34:13 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 14:34:13 INFO - Using env: {'DISPLAY': ':0', 14:34:13 INFO - 'HOME': '/home/cltbld', 14:34:13 INFO - 'LANG': 'en_US.UTF-8', 14:34:13 INFO - 'LANGUAGE': 'en_US:en', 14:34:13 INFO - 'LOGNAME': 'cltbld', 14:34:13 INFO - 'MAIL': '/var/mail/cltbld', 14:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:13 INFO - 'MOZ_NO_REMOTE': '1', 14:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:13 INFO - 'NO_EM_RESTART': '1', 14:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:13 INFO - 'PWD': '/builds/slave/test', 14:34:13 INFO - 'SHELL': '/bin/bash', 14:34:13 INFO - 'SHLVL': '1', 14:34:13 INFO - 'TERM': 'linux', 14:34:13 INFO - 'TMOUT': '86400', 14:34:13 INFO - 'USER': 'cltbld', 14:34:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', 14:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:13 INFO - '_': '/tools/buildbot/bin/python'} 14:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:13 INFO - Downloading/unpacking psutil>=3.1.1 14:34:13 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 14:34:13 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 14:34:13 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 14:34:13 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 14:34:13 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 14:34:13 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 14:34:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:34:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:34:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:34:15 INFO - Installing collected packages: psutil 14:34:15 INFO - Running setup.py install for psutil 14:34:15 INFO - building 'psutil._psutil_linux' extension 14:34:15 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 14:34:15 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 14:34:15 INFO - building 'psutil._psutil_posix' extension 14:34:15 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 14:34:15 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 14:34:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:34:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:34:15 INFO - Successfully installed psutil 14:34:15 INFO - Cleaning up... 14:34:15 INFO - Return code: 0 14:34:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:15 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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', '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 14:34:15 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 14:34:15 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 14:34:15 INFO - Using env: {'DISPLAY': ':0', 14:34:15 INFO - 'HOME': '/home/cltbld', 14:34:15 INFO - 'LANG': 'en_US.UTF-8', 14:34:15 INFO - 'LANGUAGE': 'en_US:en', 14:34:15 INFO - 'LOGNAME': 'cltbld', 14:34:15 INFO - 'MAIL': '/var/mail/cltbld', 14:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:15 INFO - 'MOZ_NO_REMOTE': '1', 14:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:15 INFO - 'NO_EM_RESTART': '1', 14:34:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:15 INFO - 'PWD': '/builds/slave/test', 14:34:15 INFO - 'SHELL': '/bin/bash', 14:34:15 INFO - 'SHLVL': '1', 14:34:15 INFO - 'TERM': 'linux', 14:34:15 INFO - 'TMOUT': '86400', 14:34:15 INFO - 'USER': 'cltbld', 14:34:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', 14:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:15 INFO - '_': '/tools/buildbot/bin/python'} 14:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:34:15 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 14:34:15 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 14:34:15 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 14:34:15 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 14:34:15 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 14:34:15 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 14:34:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:34:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:34:17 INFO - Installing collected packages: mozsystemmonitor 14:34:17 INFO - Running setup.py install for mozsystemmonitor 14:34:18 INFO - Successfully installed mozsystemmonitor 14:34:18 INFO - Cleaning up... 14:34:18 INFO - Return code: 0 14:34:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:18 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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', '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 14:34:18 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 14:34:18 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 14:34:18 INFO - Using env: {'DISPLAY': ':0', 14:34:18 INFO - 'HOME': '/home/cltbld', 14:34:18 INFO - 'LANG': 'en_US.UTF-8', 14:34:18 INFO - 'LANGUAGE': 'en_US:en', 14:34:18 INFO - 'LOGNAME': 'cltbld', 14:34:18 INFO - 'MAIL': '/var/mail/cltbld', 14:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:18 INFO - 'MOZ_NO_REMOTE': '1', 14:34:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:18 INFO - 'NO_EM_RESTART': '1', 14:34:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:18 INFO - 'PWD': '/builds/slave/test', 14:34:18 INFO - 'SHELL': '/bin/bash', 14:34:18 INFO - 'SHLVL': '1', 14:34:18 INFO - 'TERM': 'linux', 14:34:18 INFO - 'TMOUT': '86400', 14:34:18 INFO - 'USER': 'cltbld', 14:34:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', 14:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:18 INFO - '_': '/tools/buildbot/bin/python'} 14:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:18 INFO - Downloading/unpacking jsonschema==2.5.1 14:34: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 14:34: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 14:34: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 14:34: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 14:34: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 14:34: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 14:34:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:34:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:34:20 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 14:34:20 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 14:34:20 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 14:34:20 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 14:34:20 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 14:34:20 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 14:34:20 INFO - Downloading functools32-3.2.3-2.tar.gz 14:34:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:34:20 INFO - warning: no files found matching '*.txt' 14:34:20 INFO - no previously-included directories found matching 'build' 14:34:20 INFO - no previously-included directories found matching 'dist' 14:34:20 INFO - no previously-included directories found matching '.git*' 14:34:20 INFO - Installing collected packages: jsonschema, functools32 14:34:20 INFO - Running setup.py install for functools32 14:34:20 INFO - warning: no files found matching '*.txt' 14:34:20 INFO - no previously-included directories found matching 'build' 14:34:20 INFO - no previously-included directories found matching 'dist' 14:34:20 INFO - no previously-included directories found matching '.git*' 14:34:20 INFO - Successfully installed jsonschema functools32 14:34:20 INFO - Cleaning up... 14:34:20 INFO - Return code: 0 14:34:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:20 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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', '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 14:34:20 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 14:34:20 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 14:34:20 INFO - Using env: {'DISPLAY': ':0', 14:34:20 INFO - 'HOME': '/home/cltbld', 14:34:20 INFO - 'LANG': 'en_US.UTF-8', 14:34:20 INFO - 'LANGUAGE': 'en_US:en', 14:34:20 INFO - 'LOGNAME': 'cltbld', 14:34:20 INFO - 'MAIL': '/var/mail/cltbld', 14:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:20 INFO - 'MOZ_NO_REMOTE': '1', 14:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:20 INFO - 'NO_EM_RESTART': '1', 14:34:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:20 INFO - 'PWD': '/builds/slave/test', 14:34:20 INFO - 'SHELL': '/bin/bash', 14:34:20 INFO - 'SHLVL': '1', 14:34:20 INFO - 'TERM': 'linux', 14:34:20 INFO - 'TMOUT': '86400', 14:34:20 INFO - 'USER': 'cltbld', 14:34:20 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', 14:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:20 INFO - '_': '/tools/buildbot/bin/python'} 14:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:20 INFO - Downloading/unpacking blobuploader==1.2.4 14:34:20 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 14:34:20 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 14:34:20 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 14:34:20 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 14:34:20 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 14:34:20 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 14:34:22 INFO - Downloading blobuploader-1.2.4.tar.gz 14:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:34:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:34:22 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 14:34:22 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 14:34:22 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 14:34:22 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 14:34:22 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 14:34:22 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 14:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:34:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:34:23 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 14:34:23 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 14:34:23 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 14:34:23 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 14:34:23 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 14:34:23 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 14:34:23 INFO - Downloading docopt-0.6.1.tar.gz 14:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:34:23 INFO - Installing collected packages: blobuploader, requests, docopt 14:34:23 INFO - Running setup.py install for blobuploader 14:34:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:34:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:34:23 INFO - Running setup.py install for requests 14:34:24 INFO - Running setup.py install for docopt 14:34:24 INFO - Successfully installed blobuploader requests docopt 14:34:24 INFO - Cleaning up... 14:34:24 INFO - Return code: 0 14:34:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:24 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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', '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 14:34:24 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 14:34:24 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 14:34:24 INFO - Using env: {'DISPLAY': ':0', 14:34:24 INFO - 'HOME': '/home/cltbld', 14:34:24 INFO - 'LANG': 'en_US.UTF-8', 14:34:24 INFO - 'LANGUAGE': 'en_US:en', 14:34:24 INFO - 'LOGNAME': 'cltbld', 14:34:24 INFO - 'MAIL': '/var/mail/cltbld', 14:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:24 INFO - 'MOZ_NO_REMOTE': '1', 14:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:24 INFO - 'NO_EM_RESTART': '1', 14:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:24 INFO - 'PWD': '/builds/slave/test', 14:34:24 INFO - 'SHELL': '/bin/bash', 14:34:24 INFO - 'SHLVL': '1', 14:34:24 INFO - 'TERM': 'linux', 14:34:24 INFO - 'TMOUT': '86400', 14:34:24 INFO - 'USER': 'cltbld', 14:34:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', 14:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:24 INFO - '_': '/tools/buildbot/bin/python'} 14:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:24 INFO - Running setup.py (path:/tmp/pip-lM07zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:24 INFO - Running setup.py (path:/tmp/pip-EReY07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:24 INFO - Running setup.py (path:/tmp/pip-qy_vFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:24 INFO - Running setup.py (path:/tmp/pip-yYdzwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:24 INFO - Running setup.py (path:/tmp/pip-pqGy3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:24 INFO - Running setup.py (path:/tmp/pip-v9YsXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:24 INFO - Running setup.py (path:/tmp/pip-FhJJ1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:24 INFO - Running setup.py (path:/tmp/pip-bDs8Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:24 INFO - Running setup.py (path:/tmp/pip-tzFM26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:25 INFO - Running setup.py (path:/tmp/pip-cHr9Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:25 INFO - Running setup.py (path:/tmp/pip-_tefEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:25 INFO - Running setup.py (path:/tmp/pip-t1kdLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:25 INFO - Running setup.py (path:/tmp/pip-r4hJo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:25 INFO - Running setup.py (path:/tmp/pip-rtWWK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:25 INFO - Running setup.py (path:/tmp/pip-KOj5Gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:25 INFO - Running setup.py (path:/tmp/pip-RfKc6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:25 INFO - Running setup.py (path:/tmp/pip-u2VESg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:34:25 INFO - Running setup.py install for manifestparser 14:34:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:34:25 INFO - Running setup.py install for mozcrash 14:34:25 INFO - Running setup.py install for mozdebug 14:34:25 INFO - Running setup.py install for mozdevice 14:34:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:34:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:34:26 INFO - Running setup.py install for mozfile 14:34:26 INFO - Running setup.py install for mozhttpd 14:34:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:34:26 INFO - Running setup.py install for mozinfo 14:34:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:34:26 INFO - Running setup.py install for mozInstall 14:34:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:34:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:34:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:34:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:34:26 INFO - Running setup.py install for mozleak 14:34:26 INFO - Running setup.py install for mozlog 14:34:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:34:26 INFO - Running setup.py install for moznetwork 14:34:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:34:26 INFO - Running setup.py install for mozprocess 14:34:26 INFO - Running setup.py install for mozprofile 14:34:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:34:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:34:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:34:27 INFO - Running setup.py install for mozrunner 14:34:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:34:27 INFO - Running setup.py install for mozscreenshot 14:34:27 INFO - Running setup.py install for moztest 14:34:27 INFO - Running setup.py install for mozversion 14:34:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:34:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:34:27 INFO - Cleaning up... 14:34:27 INFO - Return code: 0 14:34:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:27 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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', '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 14:34:27 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 14:34:27 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 14:34:27 INFO - Using env: {'DISPLAY': ':0', 14:34:27 INFO - 'HOME': '/home/cltbld', 14:34:27 INFO - 'LANG': 'en_US.UTF-8', 14:34:27 INFO - 'LANGUAGE': 'en_US:en', 14:34:27 INFO - 'LOGNAME': 'cltbld', 14:34:27 INFO - 'MAIL': '/var/mail/cltbld', 14:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:27 INFO - 'MOZ_NO_REMOTE': '1', 14:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:27 INFO - 'NO_EM_RESTART': '1', 14:34:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:27 INFO - 'PWD': '/builds/slave/test', 14:34:27 INFO - 'SHELL': '/bin/bash', 14:34:27 INFO - 'SHLVL': '1', 14:34:27 INFO - 'TERM': 'linux', 14:34:27 INFO - 'TMOUT': '86400', 14:34:27 INFO - 'USER': 'cltbld', 14:34:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', 14:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:27 INFO - '_': '/tools/buildbot/bin/python'} 14:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:27 INFO - Running setup.py (path:/tmp/pip-glEEci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:27 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)) 14:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:27 INFO - Running setup.py (path:/tmp/pip-WsgZaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:27 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)) 14:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:27 INFO - Running setup.py (path:/tmp/pip-gdBkKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:27 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)) 14:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:27 INFO - Running setup.py (path:/tmp/pip-TPubDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:27 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)) 14:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:27 INFO - Running setup.py (path:/tmp/pip-SnEsCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:28 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)) 14:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:28 INFO - Running setup.py (path:/tmp/pip-2FlUK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:28 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)) 14:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:28 INFO - Running setup.py (path:/tmp/pip-S8_kN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:28 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)) 14:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:28 INFO - Running setup.py (path:/tmp/pip-Mmlt79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:28 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)) 14:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:28 INFO - Running setup.py (path:/tmp/pip-yK8A6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:28 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)) 14:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:28 INFO - Running setup.py (path:/tmp/pip-Pw52Cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:28 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)) 14:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:28 INFO - Running setup.py (path:/tmp/pip-DjgoAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:28 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)) 14:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:28 INFO - Running setup.py (path:/tmp/pip-fBilRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:28 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)) 14:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:28 INFO - Running setup.py (path:/tmp/pip-6uQoRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:28 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)) 14:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:28 INFO - Running setup.py (path:/tmp/pip-PtlEO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:28 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)) 14:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:28 INFO - Running setup.py (path:/tmp/pip-WxmCdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:28 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)) 14:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:28 INFO - Running setup.py (path:/tmp/pip-Eg0VQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:28 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)) 14:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:28 INFO - Running setup.py (path:/tmp/pip-Tg_cXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:28 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)) 14:34:28 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)) 14:34:28 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)) 14:34:28 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)) 14:34:28 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)) 14:34:28 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)) 14:34:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:34:28 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 14:34:28 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 14:34:28 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 14:34:28 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 14:34:28 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 14:34:28 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 14:34:30 INFO - Downloading blessings-1.6.tar.gz 14:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:34:30 INFO - Installing collected packages: blessings 14:34:30 INFO - Running setup.py install for blessings 14:34:30 INFO - Successfully installed blessings 14:34:30 INFO - Cleaning up... 14:34:31 INFO - Return code: 0 14:34:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:34:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:34:31 INFO - Reading from file tmpfile_stdout 14:34:31 INFO - Current package versions: 14:34:31 INFO - argparse == 1.2.1 14:34:31 INFO - blessings == 1.6 14:34:31 INFO - blobuploader == 1.2.4 14:34:31 INFO - docopt == 0.6.1 14:34:31 INFO - functools32 == 3.2.3-2 14:34:31 INFO - jsonschema == 2.5.1 14:34:31 INFO - manifestparser == 1.1 14:34:31 INFO - mozInstall == 1.12 14:34:31 INFO - mozcrash == 0.17 14:34:31 INFO - mozdebug == 0.1 14:34:31 INFO - mozdevice == 0.48 14:34:31 INFO - mozfile == 1.2 14:34:31 INFO - mozhttpd == 0.7 14:34:31 INFO - mozinfo == 0.9 14:34:31 INFO - mozleak == 0.1 14:34:31 INFO - mozlog == 3.3 14:34:31 INFO - moznetwork == 0.27 14:34:31 INFO - mozprocess == 0.23 14:34:31 INFO - mozprofile == 0.28 14:34:31 INFO - mozrunner == 6.12 14:34:31 INFO - mozscreenshot == 0.1 14:34:31 INFO - mozsystemmonitor == 0.3 14:34:31 INFO - moztest == 0.7 14:34:31 INFO - mozversion == 1.4 14:34:31 INFO - psutil == 3.1.1 14:34:31 INFO - requests == 1.2.3 14:34:31 INFO - wsgiref == 0.1.2 14:34:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:31 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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', '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 14:34:31 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 14:34:31 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 14:34:31 INFO - Using env: {'DISPLAY': ':0', 14:34:31 INFO - 'HOME': '/home/cltbld', 14:34:31 INFO - 'LANG': 'en_US.UTF-8', 14:34:31 INFO - 'LANGUAGE': 'en_US:en', 14:34:31 INFO - 'LOGNAME': 'cltbld', 14:34:31 INFO - 'MAIL': '/var/mail/cltbld', 14:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:31 INFO - 'MOZ_NO_REMOTE': '1', 14:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:31 INFO - 'NO_EM_RESTART': '1', 14:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:31 INFO - 'PWD': '/builds/slave/test', 14:34:31 INFO - 'SHELL': '/bin/bash', 14:34:31 INFO - 'SHLVL': '1', 14:34:31 INFO - 'TERM': 'linux', 14:34:31 INFO - 'TMOUT': '86400', 14:34:31 INFO - 'USER': 'cltbld', 14:34:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', 14:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:31 INFO - '_': '/tools/buildbot/bin/python'} 14:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:31 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)) 14:34:31 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)) 14:34:31 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)) 14:34:31 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)) 14:34:31 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)) 14:34:31 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)) 14:34:31 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)) 14:34:31 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)) 14:34:31 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)) 14:34:31 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)) 14:34:31 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)) 14:34:31 INFO - Cleaning up... 14:34:31 INFO - Return code: 0 14:34:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', '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 14:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:34:31 INFO - Using env: {'DISPLAY': ':0', 14:34:31 INFO - 'HOME': '/home/cltbld', 14:34:31 INFO - 'LANG': 'en_US.UTF-8', 14:34:31 INFO - 'LANGUAGE': 'en_US:en', 14:34:31 INFO - 'LOGNAME': 'cltbld', 14:34:31 INFO - 'MAIL': '/var/mail/cltbld', 14:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:31 INFO - 'MOZ_NO_REMOTE': '1', 14:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:31 INFO - 'NO_EM_RESTART': '1', 14:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:31 INFO - 'PWD': '/builds/slave/test', 14:34:31 INFO - 'SHELL': '/bin/bash', 14:34:31 INFO - 'SHLVL': '1', 14:34:31 INFO - 'TERM': 'linux', 14:34:31 INFO - 'TMOUT': '86400', 14:34:31 INFO - 'USER': 'cltbld', 14:34:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', 14:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:31 INFO - '_': '/tools/buildbot/bin/python'} 14:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:34:31 INFO - Cleaning up... 14:34:31 INFO - Return code: 0 14:34:31 INFO - Running post-action listener: _resource_record_post_action 14:34:31 INFO - Running post-action listener: _start_resource_monitoring 14:34:31 INFO - Starting resource monitoring. 14:34:31 INFO - [mozharness: 2016-07-22 21:34:31.733299Z] Finished create-virtualenv step (success) 14:34:31 INFO - [mozharness: 2016-07-22 21:34:31.733828Z] Running install step. 14:34:31 INFO - Running pre-action listener: _resource_record_pre_action 14:34:31 INFO - Running main action method: install 14:34:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:34:31 INFO - Reading from file tmpfile_stdout 14:34:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:34:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:34:32 INFO - Reading from file tmpfile_stdout 14:34:32 INFO - Output received: 14:34:32 INFO - Usage: mozinstall [options] installer 14:34:32 INFO - Options: 14:34:32 INFO - -h, --help show this help message and exit 14:34:32 INFO - -d DEST, --destination=DEST 14:34:32 INFO - Directory to install application into. [default: 14:34:32 INFO - "/builds/slave/test"] 14:34:32 INFO - --app=APP Application being installed. [default: firefox] 14:34:32 INFO - mkdir: /builds/slave/test/build/application 14:34:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:34:49 INFO - Reading from file tmpfile_stdout 14:34:49 INFO - Output received: 14:34:49 INFO - /builds/slave/test/build/application/firefox/firefox 14:34:49 INFO - Running post-action listener: _resource_record_post_action 14:34:49 INFO - [mozharness: 2016-07-22 21:34:49.270118Z] Finished install step (success) 14:34:49 INFO - [mozharness: 2016-07-22 21:34:49.270392Z] Running run-tests step. 14:34:49 INFO - Running pre-action listener: _resource_record_pre_action 14:34:49 INFO - Running main action method: run_tests 14:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:34:49 INFO - Python 2.7.3 14:34:49 INFO - Return code: 0 14:34:49 INFO - grabbing minidump binary from tooltool 14:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:49 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 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:34:49 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 14:34:49 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 14:34:49 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 14:34:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:34:49 INFO - Return code: 0 14:34:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:34:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:34:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:34:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:34:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:34:49 INFO - Using env: {'DISPLAY': ':0', 14:34:49 INFO - 'HOME': '/home/cltbld', 14:34:49 INFO - 'LANG': 'en_US.UTF-8', 14:34:49 INFO - 'LANGUAGE': 'en_US:en', 14:34:49 INFO - 'LOGNAME': 'cltbld', 14:34:49 INFO - 'MAIL': '/var/mail/cltbld', 14:34:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:34:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:49 INFO - 'MOZ_NO_REMOTE': '1', 14:34:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:49 INFO - 'NO_EM_RESTART': '1', 14:34:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:49 INFO - 'PWD': '/builds/slave/test', 14:34:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:34:49 INFO - 'SHELL': '/bin/bash', 14:34:49 INFO - 'SHLVL': '1', 14:34:49 INFO - 'TERM': 'linux', 14:34:49 INFO - 'TMOUT': '86400', 14:34:49 INFO - 'USER': 'cltbld', 14:34:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590', 14:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:49 INFO - '_': '/tools/buildbot/bin/python'} 14:34:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:34:49 INFO - mozversion application_buildid: 20160722113020 14:34:49 INFO - mozversion application_changeset: 48cee0fccdb3369df7af58c63329a25fb088832b 14:34:49 INFO - mozversion application_display_name: Nightly 14:34:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:34:49 INFO - mozversion application_name: Firefox 14:34:49 INFO - mozversion application_remotingname: firefox 14:34:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:34:49 INFO - mozversion application_vendor: Mozilla 14:34:49 INFO - mozversion application_version: 50.0a1 14:34:49 INFO - mozversion platform_buildid: 20160722113020 14:34:49 INFO - mozversion platform_changeset: 48cee0fccdb3369df7af58c63329a25fb088832b 14:34:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:34:49 INFO - mozversion platform_version: 50.0a1 14:34:49 INFO - using testdate: 1469223289 14:34:49 INFO - actual date: 1469223289 14:34:49 INFO - starting webserver on 'localhost:38588' 14:34:49 INFO - SUITE-START | Running 2 tests 14:34:49 INFO - TEST-START | dromaeo_css 14:34:49 INFO - operating with platform_type : linux_ 14:34:49 INFO - Initialising browser for dromaeo_css test... 14:34:49 INFO - TEST-INFO | started process 22214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8SOrNx/profile http://localhost:38588/getInfo.html) 14:34:52 INFO - PROCESS | 22214 | JavaScript error: , line 0: uncaught exception: undefined 14:34:54 INFO - PROCESS | 22214 | __metrics Screen width/height:1600/1200 14:34:54 INFO - PROCESS | 22214 | colorDepth:24 14:34:54 INFO - PROCESS | 22214 | Browser inner width/height: 1024/697 14:34:54 INFO - PROCESS | 22214 | __metrics 14:34:54 ERROR - PROCESS | 22214 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:34:55 INFO - TEST-INFO | 22214: exit 0 14:34:55 INFO - Browser initialized. 14:34:55 INFO - Running cycle 1/1 for dromaeo_css test... 14:34:55 INFO - TEST-INFO | started process 22335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8SOrNx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:07 INFO - PROCESS | 22335 | RSS: Main: 168353792 14:35:07 INFO - PROCESS | 22335 | 14:35:56 INFO - PROCESS | 22335 | 1469223356956 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] 14:38:05 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:38588/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38588/tests/dromaeo/cssquery-ext.html) 14:38:06 INFO - PROCESS | 22335 | RSS: Main: 172736512 14:38:06 INFO - PROCESS | 22335 | 14:41:08 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:38588/tests/dromaeo/cssquery-ext.html (next: http://localhost:38588/tests/dromaeo/cssquery-jquery.html) 14:41:09 INFO - PROCESS | 22335 | RSS: Main: 170070016 14:41:09 INFO - PROCESS | 22335 | 14:44:11 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:38588/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38588/tests/dromaeo/cssquery-mootools.html) 14:44:11 INFO - PROCESS | 22335 | RSS: Main: 174243840 14:44:11 INFO - PROCESS | 22335 | 14:47:13 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:38588/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38588/tests/dromaeo/cssquery-prototype.html) 14:47:14 INFO - PROCESS | 22335 | RSS: Main: 168067072 14:47:14 INFO - PROCESS | 22335 | 14:50:16 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:38588/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38588/tests/dromaeo/cssquery-yui.html) 14:50:17 INFO - PROCESS | 22335 | RSS: Main: 170622976 14:50:17 INFO - PROCESS | 22335 | 14:53:20 INFO - PROCESS | 22335 | Cycle 1(1): loaded http://localhost:38588/tests/dromaeo/cssquery-yui.html (next: http://localhost:38588/tests/dromaeo/cssquery-dojo.html) 14:53:20 INFO - PROCESS | 22335 | RSS: Main: 173424640 14:53:20 INFO - PROCESS | 22335 | 14:53:20 INFO - PROCESS | 22335 | __start_tp_report 14:53:20 INFO - PROCESS | 22335 | _x_x_mozilla_page_load 14:53:20 INFO - PROCESS | 22335 | _x_x_mozilla_page_load_details 14:53:20 INFO - PROCESS | 22335 | |i|pagename|runs| 14:53:20 INFO - PROCESS | 22335 | |0;dojo.html;3078.9384212315754;3090.2428904918293;3091.969080309197;3102.364015376848;3103.1311232854796;5410;5483.451654834519;5485.6434331768405;5512.751926163322;5564.276644036279;5347.59893008024;5443.537299329561;5514.476124768151;5531.585131115173;5570.944290557093;4958.355413796201;5043.041822053798;5053.343065401511;5084.4661310562415;5149.794008239666;5038.319826823368;5095.363079615048;5109;5123.820666276681;5168.664036837612;4759.357486739281;5011.3485246918035;5047.697138171685;5065.442801291855;5086.313347698069;4899.044686286175;4919.385076865392;4938.62960277977;4964.453910069889;4985.401751789808;4865.659403841697;4870.634702397334;4920.6309526785635;4928.7535623219055;4984.22744474607;5274.5780337572905;5403.243545903577;5440.510354068113;5445.237666726662;5451.073317536028;5709.971450142764;5739.028181926918;5766.250387449647;5792.7972520961985;5835.270591176103;5829.766809327622;5840.678762668052;5842.357340692521;5844.561657875676;5853.385394533555;5378.731063446812;5439.918401223985;5441.7279136043435;5443.428440013781;5454.53636440903;5883.852903677443;5908.438698323653;5948.821535353946;5977.402259773988;6030.125631783367;5727.169560413717;5740.311162660508;5746.770129194785;5747.25285712863;5749.798757043483;5611.6352437091455;5814.883702325929;5840.795572154954;5843.970780146072;5847.6783776891825;5766.192733017381;5844.211031510692;5845.649261044351;5852.502537284294;5934.258217722785;5714.457126572969;5724.198612194296;5733.512651424676;5742.48317651405;5753.88492230153;4328.199283132631;4329.761863097497;4335.263005289108;4363.083752411965;4364.41080454141;3900.1224724436775;3913.7064720146104;3950.8419663213726;3951.7036222283446;3999.7800120993625;5560.582956278215;5561.304836895388;5566.582506312043;5579.218909352694;5632.549396048306;5654.74553645087;5880.0591905295805;5891.941080589139;5897.380775018647;5898.557608179318;5530.446955304437;5584.413636568183;5596.804111856066;5629.6903670298525;5645.096784514458;5010.899782004412;5046.9747651261505;5056.544910958031;5068.56917162038;5111.667741596784;5793.768249270066;6035.7283922223605;6040.516758659297;6047.213862197887;6049.516038716892;5819.53443724501;5850.473457388855;5863.325717542537;5907;5945.791897283574;6039.48664363534;6048.395160483917;6049.455549000611;6049.909251361145;6071.878562428638;5647.068233741551;5788.681622510802;5792.82621521355;5796.855078623068;5798.072308430631;5913.704314784158;5939.168516407793;5982.162497250475;6024.186734790747;6036.849078773066;5793.102069179284;5819.854503637273;5819.970900145472;5822.243108395882;5834.299884013945;5638.23883775685;5712.400197979318;5786.623869448473;5818.970905145617;5820.301563812201;5639.436056394327;5720.48515633595;5732.627379220337;5787.421257874179;5789.768409263583;5772.220750198838;5802.50678692299;5802.912956305743;5809.709514524341;5830.416958304136;5509.559235261249;5553.805616803393;5717.17101020358;5719.971400142973;5739.741711623071 14:53:20 INFO - PROCESS | 22335 | |1;ext.html;549.1006354283127;579.1255204640992;594.6283572767018;607.0226934635236;636.4431122767578;39573.406398904;43784.34323485146;43957;43977.78011109948;44245.55754442455;43018.35472467916;43590.42300558435;43607.563924360744;43719;43815;8883.777905552348;8973.057828927966;9052.366334356597;9065.682701105463;9086.727398178033;8939.463632182089;8996.370254082216;8999.595018224163;9020.594073266719;9028.458292502472;9079.228265597432;9081.364304498687;9107.271418286522;9127.406718563305;9136.040715724854;9072.954635226815;9083.81832363349;9095.226905713022;9107.590158442852;9119.589618467186;8870.86693699595;8925.33060020501;8999.5050272235;9006.234470070052;9007.144321289466;41009.794951025055;41012;41259.1748165035;41351.7932410336;41396.1720765586;3285.769996100274;3316.416912428851;3590.9281814363567;3813.9809300953593;3884.242572698325;31866;31899.202519936956;31926.680733192603;32449.351012979845;34293.314133717184;4106.609872062149;4161.542230354658;4163.708540402173;4242.406063151161;4246.150769846043;374121.99999999726;379190;379593;381934;382340;56616;57426.425735742945;57559;57562.42437575654;57587.71206143942;34853.477197842054;36499;36533.45199822005;59757;59794;16434.096124713018;16454;16551.83448165527;16555.08947007902;16572.419965301156;13099.672508187372;13188.340582971005;13212.273324967027;13215.207087574585;13302.534411295752;19468.513287167934;19515.414537563895;19530.089615917575;19557.700763480687;19708.014599270267;7036.155661320674;7075.893861592081;7244.601546914865;7416.25837416254;7426.108866935894;928.4939707859232;937.6155776131753;1023.1150055202196;1081.8269076947652;1101.487808169189;31987.20031999172;32304.192395190308;32326;32489.51265731016;32533.186670332958;1131.801934661431;1136.9829452558217;1170.1984140863535;1170.5610396101463;1213.1023042948332;16812.159392030593;17060.488185354458;17142.142892855307;17151.828481715023;17279.91360043217;581888;591563;591653;595748;595893;60179;60669.39330606726;61286.38713612896;61347.69326153341;61480;1306.8235788168665;1317.7232781116072;1321.200673592482;1367.0772228745557;1393.233721453217;29804.552931706476;31002.844985774926;32010.51984220285;32025.519617206228;32071.358572828878;50464.495355047446;51078.74460627822;51198.23202651889;51323;51383;538239;540046;541117;541588;542636;28275.858620706764;28585.714142858305;28640.14079577616;28670.42659146847;28763.28091797722;47932.5206747928;48012.7599362001;48187.759061204466;48343.75828120837;49329.26006109983;40397.798011010935;40523.797381012904;40555.79722101489;41036.58963410328;41098.383524246565;40642.79678601588;41402.792986034874;41684.58315416928;42688.35967460428;42868.35697464478;41349.586504134575;42694.78652606717;42965.78517107394;42967.355489668305;45092.32361514645;32810.835945820116;36491.270174595826;37565;37991.240175196894;38192.23615527618;27556;27942;28336.43327133487;28613.713862861106;28754 14:53:20 INFO - PROCESS | 22335 | |2;jquery.html;381.1253173965748;383.6815443182159;389.20407766118285;396.9980150099249;410.87057576863305;19239.519012024688;20353.796462035374;20440;20620.48448788781;20899;18785.436436906915;18906;19223.32718354858;19612.117454714535;19695.212191512357;5023.824166154185;5576.9163462548095;5725.770969161229;5765.913511297334;5778.075507918734;5688.118341657029;5711.257536520267;5740.512056475184;5746.0806270996645;5753.539716822645;5541.27963364764;5611.130274807391;5643.8024669136585;5644.068728659766;5710.314762228539;5611.607187496857;5623.522000629951;5750.971245143789;5751.942480575203;5752.597318187729;4948.925766113512;5168.664036837594;5227;5288.735563221823;5298.205269209611;13423;13782.862171378258;13837.584872453743;13854.93072534641;13914.09558378702;2149.4518897681146;2187.3109970359446;2236.105557776886;2284.9756388585133;2296.1733775840685;10054.296199266055;10161.187105031653;10220.642277520252;10272.075513203772;10327.483625818679;1855.1280897977929;1896.6111947050822;1900.2873922279146;1910.3218357483033;1918.2518817661123;87912.80185510927;89387.22868197686;89511.55244223737;90340.54829725875;90677;10979.945100274606;11043.668689939315;11179.217454778087;11205.66383008511;11527.71180720472;15663.530094097196;15738.403163478128;15749.921250393903;15761;15804.604884877741;8360.414770966096;8549.230569248797;8618.525981071101;8626.827463450696;8784.341174411944;8415.200555947175;8448.408611397143;8468.068512463624;8746.56267186638;8782.473051616924;4794.640401969867;4811.422629284508;4816.470188279286;4836.637252206098;4974.751262436864;1998.600279944017;2041.8979051047388;2052.1791283486723;2063.9896800515903;2069.1206237349065;843.4812590256947;930.181440332503;947.9194268487256;949.4161090929167;1056.8943105689523;19710.507237319183;20012.39900807932;20308;20473.283435079702;20640.793592064187;959.8608201810698;980.3627941337983;1001.8747656542932;1030.2479190191202;1040.942748148844;10590.205734569938;11182.552697891993;11196.160287978435;11225.831612525819;11265;479915;482704;510820;516346;522317;92227;93530;95746.42716794934;97644;101834;1031.4997226345217;1045.153425725165;1073.3506228731505;1075.6611667324767;1083.230906056693;15826.366945322057;18125.818741812942;18148.274069037092;18223;18318.725219121457;43724.34413483737;44340.99999999871;44523.332150018425;44938;45320.093598128515;58935;59075.704621476616;61854.38145618666;63149.36850631435;63291.683541581995;7558.13081495635;8035.718749843727;8402.453840500348;8593.785155371166;8608.956955215184;10099.69700908974;13099.93450032782;13514.121582097132;13543.25512096844;13729.244891531062;5954.01758709808;11193.552257909592;11652.242604230698;12114.333711645591;12301.876981230072;11554.248973816675;11886.405679716152;12102.636920892388;12154.209976351509;12685.112042157329;11511.712207194887;11549.249298795552;12178.878211217774;12423.875761242272;12530.624081277576;8099.716509922125;8201.630926608435;8236.34109271245;8373.074192935781;8415.368847336596;11586.826197606873;11988.880111198776;12132.878671213175;12182.634520964386;12255.75488490243 14:53:20 INFO - PROCESS | 22335 | |3;mootools.html;1490.441084593277;1490.9925450372748;1651.7770101036356;1783.7681101456808;1811.2211748947955;7696.730614428496;8425.283850872676;8446;8977.820443591125;8985;8501.659933602665;8806.515641639708;8812.823743525125;8820.77948051299;8834.028256891754;2317.7102862142233;2362.196853069956;2367.171489978511;2367.9052837886466;2371.8221133414977;2277.555876604063;2278.259565641165;2315.6989591353185;2326.3718795925092;2348.3189874936247;2310.3992961829963;2318.8724620145886;2331.2190416210506;2363.6572696959015;2367.479154585997;2242.8766417847014;2264.52444986553;2269.8184145268337;2283.1894677389537;2291.9770802292014;2210.9226177083724;2211.9447013824624;2230.3866436730027;2253.447905263221;2275.590393729128;8788.8681669775;8820.8676869847;8821.691240806605;8854.778630534289;8903.643854245822;5139.640225184238;5258.6318957672975;5260.053190425722;5267.630416091805;5271.103912334874;3191.377681352137;3211.6627754085716;3282.5404443377947;3326.9833650831833;3348.7990720556845;1076.6877605494396;1110.7945030169365;1114.9442527873573;1133.7052366384717;1134.2627292260015;12079.214851034654;12104.455299511455;12109.757804843854;12119.697007574792;12167.817482737766;4364.279893817485;4468.776561171929;4560.4071470708595;4587.7017993830295;4622.168009758276;10105.494725263707;10173.898261017443;10174.694759157237;10184.236182286359;10199.796004079877;5172.172452407672;5172.767225474862;5182.97408512955;5199.350081239845;5208.322918020709;4182.560831112689;4722.409698787652;4778.856634300907;4806.903861922742;4807.879803004953;3884.6892248620043;3965.7620542767527;4001.139754952699;4088.550259471456;4114.938275925863;1263.8357013588175;1276.3554405025402;1277.393238211842;1277.7316763479587;1283.4737757519372;809.668036105194;896.3053633434141;979.9216062714966;984.5175863826817;991.7718924647371;5879.323877754113;5995.730192141364;6078.209832721718;6100.816975490742;6179.5056395488255;450.4931951554501;455.180674785385;458.1295538476921;460.74658937584195;461.4347424405077;4083.1833633273463;4206.74759514424;4217.746935183899;4220.07158425146;4243.427137336482;10605.363678179334;10927.235093543535;10978.231523793258;10982.505787239434;10988.560457581607;10775.784484310427;10892;10902.672919812418;10904.073153782017;10936.179786516042;7755.418343624251;8088.352931765445;8120.715774947967;8289.461185022954;8297.25324720766;6022.698865056817;6156.199694039746;6221.564490485623;6221.813345599639;6284.905726414199;10130.240231982778;10173.745656358355;10207.387556746618;10228.641997530349;10234.130098941674;10236.385816851012;10332.638357657446;10393.220508461744;10428.843567346345;10428.895711042793;7260.709571617076;7715.614219289126;7861.25318094803;7986.520808751494;8154.0622828373125;8298.336133109216;8359.95820020896;8361.080281169188;8368.24685778283;8385.622646981023;7581.469297149147;7638.197989211275;7813.687452501837;7867.960660196892;7913.564753938589;7489.8876516851205;7586.24137586237;7597.316241538067;7625.733099341496;7848.450608457353;6994.475414343843;7110.822229444098;7113.75101871432;7123.608201548965;7142.107236595426;5218.399884013235;5249.842504724865;5283.524482796567;5316.920246196388;5477.096279113902;5387.461253874581;5412.215228791882;5464.098423760035;5482.533984611353;5517.393086760533 14:53:20 INFO - PROCESS | 22335 | |4;prototype.html;331.358424206605;334.4565081742169;345.16297977404787;346.35059263880225;348.5033826796814;5506.339239291291;5520.889582208353;5689.431056894314;5713.285839270091;5759.798407055754;5523.7790488380515;5597.132444471114;5613.547668184068;5617.269754931853;5680.579855036241;4393.165298593273;4396.999999999992;4415.51429342772;4416.3375493675885;4417.403650507189;4141.929035482259;4346.369776382423;4390.538993405694;4395.560443955595;4403.295472724365;4328.285832837578;4355.803988820495;4361.389405483234;4364.148990946766;4371.14762621289;4346.587074227943;4365.126974605092;4368.1918845013615;4370.7159034662645;4382.386465894777;3758.661720445173;3787.6780473659774;3844.5770965193806;3844.730868839182;3853.2678791029894;5449.455054494559;5464.781408743645;5470.316210473691;5478.808241711521;5516.668999860021;4942.530459606368;4950.356453661001;4965.90068198634;4969.906620543475;4994.650374473788;5697.230873832021;5860.824175274706;5863.237779088734;5885.382034886361;5960.403959604048;4158.045718512294;4162.958370416318;4165.812538435777;4168.124693814302;4179.895502612429;6141.477974372184;6144.87710245797;6158.291796443422;6179.918514259986;6180;4184.811683474251;4251.234777739975;4264.0832221072615;4275.456103618342;4296.871093867189;4308.74147551148;4316.136772645484;4334.978325108417;4347.6304514116655;4362.498312694017;4972.78166849117;4992.350994370709;5008.57427118699;5023.547880690755;5040.873978150502;5596.552275817925;5756.597038207369;5876.882462350729;5939.881202375928;5981.461668449861;1481.6369989352463;1505.6160679026777;1507.8492150784834;1510.6676531163127;1512.10785636475;917.8990311065777;955.8375076237056;957.5547370472764;974.4153507895206;975.1467465967279;5030.496950304941;5033.5469807716745;5041.949580504222;5060.797568097309;5078.365204349457;5356.732163391893;5401.4868587484125;5434.809781657623;5488.53347465462;5498.257735205696;5099.903520742984;5131.999260144311;5151.381834179922;5343.225232341289;5782.277215348082;3243.497257925025;3251.1546997780747;3255.886043988449;3267.215868191617;3283.83580820958;6103.755849766048;6181.84545386369;6187.443130118311;6263;6293.590916590407;6190.3190649028575;6210.7515699372425;6221.688915554204;6222.377762223741;6234.688265586702;6264.248290205113;6268.655223962634;6272.5922815016875;6279.309275979638;6284.968575157095;5842.561807864342;6026.849328766816;6036.788712395045;6039.456448919618;6104.69476526163;5945.970270148621;5967.940320596912;5993.250843644544;6003.6397816131175;6032;5935.347111817783;6237.594556353823;6255.24937007562;6259.843503912439;6268.686565671789;4236.555161708099;4259.275923093143;4276.251655960133;4324.56754324565;4327.437433133672;5864.970675146597;5957.76168953237;6167.290761562478;6167.352427994996;6181.690915454119;5815.94184058154;5902.350741418526;5905.616134951214;5928.377520360473;5936.554758393224;5872.794452194153;5937.762489500545;5978.910316345346;6029.909551356821;6039.365866584121;5688.715564221855;5704.771809127588;5785.218995435563;5793.681347525927;5900.262467191601;5992.310884248367;6004.579679422399;6035.849103772441;6039.607425517327;6051.152838602688;5717.742701578356;5847.152162936435;5872.882542349043;5882.941170588239;5889.293284805679 14:53:20 INFO - PROCESS | 22335 | |5;yui.html;740.1968863782793;756.5914406220642;771.3751860992596;829.6142293833366;885.566072624414;15251.466198683049;16045.75359449678;16055.518334449986;16131.112788796612;16148.677026459463;14284.71430571388;14860;15086.245687715626;15139.848601513982;15181.16503592302;660.9603423794588;799.4164260090138;820.2822530285999;820.5035953248289;820.9425340226187;800.5476905548376;817.0848649512554;820.3888103363003;820.4011071917504;822.8683410654296;858.4076986879033;862.3403096631051;862.7886167888876;862.9816816156932;863.4689665855485;855.149126619015;856.6573370651727;862.6549380247889;862.8705694145866;863.3567991846115;619.5663035874906;621.4096608222206;621.4469122480996;622.3527531367373;623.51988968494;14743.11541307525;14792.926035369863;14808.703825923529;14882;14891.478798242119;14644.487442939446;14877.18175500347;14944.850551494455;14998.925005375013;15038.496150384983;12557.816377171215;12636.30500322482;12697.365131743376;12816.42326095328;12922.340890141699;3729.3855872089775;3751.7042985781127;3815.065308999313;3848.4804551385487;3950.6839452843706;69044.6547767263;69486.305136949;69621;69730.95403569001;70255.29744702589;11294.94352528232;11363.886361136283;11401.315921044765;11978;11985.940070299594;22531.0987560499;22536.774632253466;22546.210882619358;22574.887125564597;22609.64342139477;7813.257740514642;8127;8191.713290034821;8218.753437396888;8428.789280268042;4523.36672865799;4554.977225113919;4564.794584243717;4567.611753000966;4716.528347165325;3350.2964377481003;3432.3478539077996;3445.1903802606366;3451.551298331201;3456.4815277708544;540.3758658749151;644.5584774429437;646.3956200952125;652.7780554611455;658.6706646676662;602.6835911146595;642.7429028388589;682.4642655515496;730.8221499930238;732.4762794601885;9789.46157961319;9844.310898237054;9883.654072107442;9944.850827237597;10105.343152695052;600.5945986459122;681.2063945503533;727.8471520980547;729.002533059424;737.5169264132002;4447.533009034069;4659.114768194032;4700.576948074689;4703.823223759766;4716.764161791897;91831.54084229536;118377.46771782731;119191;121754.3912280433;122845;60891;104233.47883260535;104796;105066;107419;89520;89928;90193.54903225442;90350.54824725834;90917.6343559263;8475.74572762818;9002.324825638234;9009.594568244314;9017.188453039258;9121.087891210826;52960.20559691531;53727;54262.72868635789;54486.45513544814;54930.9999999984;72304.27695723186;74755;80325;80448.59775701084;81022;11738.76522469563;11802.645920622395;12319.876801231872;12591.68520786951;12646.304453254792;12905.354732263162;13170.816646352157;13188.868111319147;13313;13685.521006764715;12283;12285.69285767863;12342.259464432163;12855.16441431304;13058.934705326412;12218.694532636755;12480.415148944447;12498.750024999266;12529.436175371948;12682.936585317015;11341.489632966372;11461.369624670722;11540.134489913458;12092.879071209176;12116;10137.847932281169;10253.333533320609;10696.732581685521;10752.516136773707;10823.567057317934;10291.43397113136;10317.329373590992;10337.793244135226;10358.326708763907;10362.792744145225 14:53:20 INFO - PROCESS | 22335 | __end_tp_report 14:53:20 INFO - PROCESS | 22335 | __start_cc_report 14:53:20 INFO - PROCESS | 22335 | _x_x_mozilla_cycle_collect,372 14:53:20 INFO - PROCESS | 22335 | __end_cc_report 14:53:20 INFO - PROCESS | 22335 | __startTimestamp1469224400473__endTimestamp 14:53:20 INFO - PROCESS | 22335 | 14:53:20 INFO - PROCESS | 22335 | ------- Summary: start ------- 14:53:20 INFO - PROCESS | 22335 | Number of tests: 6 14:53:20 INFO - PROCESS | 22335 | 14:53:20 INFO - PROCESS | 22335 | [#0] dojo.html Cycles:165 Average:5435.91 Median:5709.97 stddev:633.41 (11.1%) stddev-sans-first:607.77 14:53:20 INFO - PROCESS | 22335 | Values: 3078.9 3090.2 3092.0 3102.4 3103.1 5410.0 5483.5 5485.6 5512.8 5564.3 5347.6 5443.5 5514.5 5531.6 5570.9 4958.4 5043.0 5053.3 5084.5 5149.8 5038.3 5095.4 5109.0 5123.8 5168.7 4759.4 5011.3 5047.7 5065.4 5086.3 4899.0 4919.4 4938.6 4964.5 4985.4 4865.7 4870.6 4920.6 4928.8 4984.2 5274.6 5403.2 5440.5 5445.2 5451.1 5710.0 5739.0 5766.3 5792.8 5835.3 5829.8 5840.7 5842.4 5844.6 5853.4 5378.7 5439.9 5441.7 5443.4 5454.5 5883.9 5908.4 5948.8 5977.4 6030.1 5727.2 5740.3 5746.8 5747.3 5749.8 5611.6 5814.9 5840.8 5844.0 5847.7 5766.2 5844.2 5845.6 5852.5 5934.3 5714.5 5724.2 5733.5 5742.5 5753.9 4328.2 4329.8 4335.3 4363.1 4364.4 3900.1 3913.7 3950.8 3951.7 3999.8 5560.6 5561.3 5566.6 5579.2 5632.5 5654.7 5880.1 5891.9 5897.4 5898.6 5530.4 5584.4 5596.8 5629.7 5645.1 5010.9 5047.0 5056.5 5068.6 5111.7 5793.8 6035.7 6040.5 6047.2 6049.5 5819.5 5850.5 5863.3 5907.0 5945.8 6039.5 6048.4 6049.5 6049.9 6071.9 5647.1 5788.7 5792.8 5796.9 5798.1 5913.7 5939.2 5982.2 6024.2 6036.8 5793.1 5819.9 5820.0 5822.2 5834.3 5638.2 5712.4 5786.6 5819.0 5820.3 5639.4 5720.5 5732.6 5787.4 5789.8 5772.2 5802.5 5802.9 5809.7 5830.4 5509.6 5553.8 5717.2 5720.0 5739.7 14:53:20 INFO - PROCESS | 22335 | 14:53:20 INFO - PROCESS | 22335 | [#1] ext.html Cycles:180 Average:65237.08 Median:22782.17 stddev:136334.77 (598.4%) stddev-sans-first:136630.71 14:53:20 INFO - PROCESS | 22335 | Values: 549.1 579.1 594.6 607.0 636.4 39573.4 43784.3 43957.0 43977.8 44245.6 43018.4 43590.4 43607.6 43719.0 43815.0 8883.8 8973.1 9052.4 9065.7 9086.7 8939.5 8996.4 8999.6 9020.6 9028.5 9079.2 9081.4 9107.3 9127.4 9136.0 9073.0 9083.8 9095.2 9107.6 9119.6 8870.9 8925.3 8999.5 9006.2 9007.1 41009.8 41012.0 41259.2 41351.8 41396.2 3285.8 3316.4 3590.9 3814.0 3884.2 31866.0 31899.2 31926.7 32449.4 34293.3 4106.6 4161.5 4163.7 4242.4 4246.2 374122.0 379190.0 379593.0 381934.0 382340.0 56616.0 57426.4 57559.0 57562.4 57587.7 34853.5 36499.0 36533.5 59757.0 59794.0 16434.1 16454.0 16551.8 16555.1 16572.4 13099.7 13188.3 13212.3 13215.2 13302.5 19468.5 19515.4 19530.1 19557.7 19708.0 7036.2 7075.9 7244.6 7416.3 7426.1 928.5 937.6 1023.1 1081.8 1101.5 31987.2 32304.2 32326.0 32489.5 32533.2 1131.8 1137.0 1170.2 1170.6 1213.1 16812.2 17060.5 17142.1 17151.8 17279.9 581888.0 591563.0 591653.0 595748.0 595893.0 60179.0 60669.4 61286.4 61347.7 61480.0 1306.8 1317.7 1321.2 1367.1 1393.2 29804.6 31002.8 32010.5 32025.5 32071.4 50464.5 51078.7 51198.2 51323.0 51383.0 538239.0 540046.0 541117.0 541588.0 542636.0 28275.9 28585.7 28640.1 28670.4 28763.3 47932.5 48012.8 48187.8 48343.8 49329.3 40397.8 40523.8 40555.8 41036.6 41098.4 40642.8 41402.8 41684.6 42688.4 42868.4 41349.6 42694.8 42965.8 42967.4 45092.3 32810.8 36491.3 37565.0 37991.2 38192.2 27556.0 27942.0 28336.4 28613.7 28754.0 14:53:20 INFO - PROCESS | 22335 | 14:53:20 INFO - PROCESS | 22335 | [#2] jquery.html Cycles:180 Average:29694.61 Median:2211.71 stddev:83150.47 (3759.6%) stddev-sans-first:83354.60 14:53:20 INFO - PROCESS | 22335 | Values: 381.1 383.7 389.2 397.0 410.9 19239.5 20353.8 20440.0 20620.5 20899.0 18785.4 18906.0 19223.3 19612.1 19695.2 5023.8 5576.9 5725.8 5765.9 5778.1 5688.1 5711.3 5740.5 5746.1 5753.5 5541.3 5611.1 5643.8 5644.1 5710.3 5611.6 5623.5 5751.0 5751.9 5752.6 4948.9 5168.7 5227.0 5288.7 5298.2 13423.0 13782.9 13837.6 13854.9 13914.1 2149.5 2187.3 2236.1 2285.0 2296.2 10054.3 10161.2 10220.6 10272.1 10327.5 1855.1 1896.6 1900.3 1910.3 1918.3 87912.8 89387.2 89511.6 90340.5 90677.0 10979.9 11043.7 11179.2 11205.7 11527.7 15663.5 15738.4 15749.9 15761.0 15804.6 8360.4 8549.2 8618.5 8626.8 8784.3 8415.2 8448.4 8468.1 8746.6 8782.5 4794.6 4811.4 4816.5 4836.6 4974.8 1998.6 2041.9 2052.2 2064.0 2069.1 843.5 930.2 947.9 949.4 1056.9 19710.5 20012.4 20308.0 20473.3 20640.8 959.9 980.4 1001.9 1030.2 1040.9 10590.2 11182.6 11196.2 11225.8 11265.0 479915.0 482704.0 510820.0 516346.0 522317.0 92227.0 93530.0 95746.4 97644.0 101834.0 1031.5 1045.2 1073.4 1075.7 1083.2 15826.4 18125.8 18148.3 18223.0 18318.7 43724.3 44341.0 44523.3 44938.0 45320.1 58935.0 59075.7 61854.4 63149.4 63291.7 7558.1 8035.7 8402.5 8593.8 8609.0 10099.7 13099.9 13514.1 13543.3 13729.2 5954.0 11193.6 11652.2 12114.3 12301.9 11554.2 11886.4 12102.6 12154.2 12685.1 11511.7 11549.2 12178.9 12423.9 12530.6 8099.7 8201.6 8236.3 8373.1 8415.4 11586.8 11988.9 12132.9 12182.6 12255.8 14:53:20 INFO - PROCESS | 22335 | 14:53:20 INFO - PROCESS | 22335 | [#3] mootools.html Cycles:180 Average:5791.16 Median:2509.27 stddev:3304.69 (131.7%) stddev-sans-first:3298.16 14:53:20 INFO - PROCESS | 22335 | Values: 1490.4 1491.0 1651.8 1783.8 1811.2 7696.7 8425.3 8446.0 8977.8 8985.0 8501.7 8806.5 8812.8 8820.8 8834.0 2317.7 2362.2 2367.2 2367.9 2371.8 2277.6 2278.3 2315.7 2326.4 2348.3 2310.4 2318.9 2331.2 2363.7 2367.5 2242.9 2264.5 2269.8 2283.2 2292.0 2210.9 2211.9 2230.4 2253.4 2275.6 8788.9 8820.9 8821.7 8854.8 8903.6 5139.6 5258.6 5260.1 5267.6 5271.1 3191.4 3211.7 3282.5 3327.0 3348.8 1076.7 1110.8 1114.9 1133.7 1134.3 12079.2 12104.5 12109.8 12119.7 12167.8 4364.3 4468.8 4560.4 4587.7 4622.2 10105.5 10173.9 10174.7 10184.2 10199.8 5172.2 5172.8 5183.0 5199.4 5208.3 4182.6 4722.4 4778.9 4806.9 4807.9 3884.7 3965.8 4001.1 4088.6 4114.9 1263.8 1276.4 1277.4 1277.7 1283.5 809.7 896.3 979.9 984.5 991.8 5879.3 5995.7 6078.2 6100.8 6179.5 450.5 455.2 458.1 460.7 461.4 4083.2 4206.7 4217.7 4220.1 4243.4 10605.4 10927.2 10978.2 10982.5 10988.6 10775.8 10892.0 10902.7 10904.1 10936.2 7755.4 8088.4 8120.7 8289.5 8297.3 6022.7 6156.2 6221.6 6221.8 6284.9 10130.2 10173.7 10207.4 10228.6 10234.1 10236.4 10332.6 10393.2 10428.8 10428.9 7260.7 7715.6 7861.3 7986.5 8154.1 8298.3 8360.0 8361.1 8368.2 8385.6 7581.5 7638.2 7813.7 7868.0 7913.6 7489.9 7586.2 7597.3 7625.7 7848.5 6994.5 7110.8 7113.8 7123.6 7142.1 5218.4 5249.8 5283.5 5316.9 5477.1 5387.5 5412.2 5464.1 5482.5 5517.4 14:53:20 INFO - PROCESS | 22335 | 14:53:20 INFO - PROCESS | 22335 | [#4] prototype.html Cycles:180 Average:4921.50 Median:5522.33 stddev:1454.71 (26.3%) stddev-sans-first:1417.41 14:53:20 INFO - PROCESS | 22335 | Values: 331.4 334.5 345.2 346.4 348.5 5506.3 5520.9 5689.4 5713.3 5759.8 5523.8 5597.1 5613.5 5617.3 5680.6 4393.2 4397.0 4415.5 4416.3 4417.4 4141.9 4346.4 4390.5 4395.6 4403.3 4328.3 4355.8 4361.4 4364.1 4371.1 4346.6 4365.1 4368.2 4370.7 4382.4 3758.7 3787.7 3844.6 3844.7 3853.3 5449.5 5464.8 5470.3 5478.8 5516.7 4942.5 4950.4 4965.9 4969.9 4994.7 5697.2 5860.8 5863.2 5885.4 5960.4 4158.0 4163.0 4165.8 4168.1 4179.9 6141.5 6144.9 6158.3 6179.9 6180.0 4184.8 4251.2 4264.1 4275.5 4296.9 4308.7 4316.1 4335.0 4347.6 4362.5 4972.8 4992.4 5008.6 5023.5 5040.9 5596.6 5756.6 5876.9 5939.9 5981.5 1481.6 1505.6 1507.8 1510.7 1512.1 917.9 955.8 957.6 974.4 975.1 5030.5 5033.5 5041.9 5060.8 5078.4 5356.7 5401.5 5434.8 5488.5 5498.3 5099.9 5132.0 5151.4 5343.2 5782.3 3243.5 3251.2 3255.9 3267.2 3283.8 6103.8 6181.8 6187.4 6263.0 6293.6 6190.3 6210.8 6221.7 6222.4 6234.7 6264.2 6268.7 6272.6 6279.3 6285.0 5842.6 6026.8 6036.8 6039.5 6104.7 5946.0 5967.9 5993.3 6003.6 6032.0 5935.3 6237.6 6255.2 6259.8 6268.7 4236.6 4259.3 4276.3 4324.6 4327.4 5865.0 5957.8 6167.3 6167.4 6181.7 5815.9 5902.4 5905.6 5928.4 5936.6 5872.8 5937.8 5978.9 6029.9 6039.4 5688.7 5704.8 5785.2 5793.7 5900.3 5992.3 6004.6 6035.8 6039.6 6051.2 5717.7 5847.2 5872.9 5882.9 5889.3 14:53:20 INFO - PROCESS | 22335 | 14:53:20 INFO - PROCESS | 22335 | [#5] yui.html Cycles:180 Average:20658.29 Median:4539.17 stddev:30166.84 (664.6%) stddev-sans-first:30214.39 14:53:20 INFO - PROCESS | 22335 | Values: 740.2 756.6 771.4 829.6 885.6 15251.5 16045.8 16055.5 16131.1 16148.7 14284.7 14860.0 15086.2 15139.8 15181.2 661.0 799.4 820.3 820.5 820.9 800.5 817.1 820.4 820.4 822.9 858.4 862.3 862.8 863.0 863.5 855.1 856.7 862.7 862.9 863.4 619.6 621.4 621.4 622.4 623.5 14743.1 14792.9 14808.7 14882.0 14891.5 14644.5 14877.2 14944.9 14998.9 15038.5 12557.8 12636.3 12697.4 12816.4 12922.3 3729.4 3751.7 3815.1 3848.5 3950.7 69044.7 69486.3 69621.0 69731.0 70255.3 11294.9 11363.9 11401.3 11978.0 11985.9 22531.1 22536.8 22546.2 22574.9 22609.6 7813.3 8127.0 8191.7 8218.8 8428.8 4523.4 4555.0 4564.8 4567.6 4716.5 3350.3 3432.3 3445.2 3451.6 3456.5 540.4 644.6 646.4 652.8 658.7 602.7 642.7 682.5 730.8 732.5 9789.5 9844.3 9883.7 9944.9 10105.3 600.6 681.2 727.8 729.0 737.5 4447.5 4659.1 4700.6 4703.8 4716.8 91831.5 118377.5 119191.0 121754.4 122845.0 60891.0 104233.5 104796.0 105066.0 107419.0 89520.0 89928.0 90193.5 90350.5 90917.6 8475.7 9002.3 9009.6 9017.2 9121.1 52960.2 53727.0 54262.7 54486.5 54931.0 72304.3 74755.0 80325.0 80448.6 81022.0 11738.8 11802.6 12319.9 12591.7 12646.3 12905.4 13170.8 13188.9 13313.0 13685.5 12283.0 12285.7 12342.3 12855.2 13058.9 12218.7 12480.4 12498.8 12529.4 12682.9 11341.5 11461.4 11540.1 12092.9 12116.0 10137.8 10253.3 10696.7 10752.5 10823.6 10291.4 10317.3 10337.8 10358.3 10362.8 14:53:20 INFO - PROCESS | 22335 | -------- Summary: end -------- 14:53:20 INFO - PROCESS | 22335 | 14:53:21 INFO - TEST-INFO | 22335: exit 0 14:53:21 INFO - TEST-OK | dromaeo_css | took 1111685ms 14:53:21 INFO - TEST-START | kraken 14:53:21 INFO - operating with platform_type : linux_ 14:53:21 INFO - Initialising browser for kraken test... 14:53:21 INFO - TEST-INFO | started process 22574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZGhIHH/profile http://localhost:38588/getInfo.html) 14:53:24 INFO - PROCESS | 22574 | JavaScript error: , line 0: uncaught exception: undefined 14:53:25 INFO - PROCESS | 22574 | __metrics Screen width/height:1600/1200 14:53:25 INFO - PROCESS | 22574 | colorDepth:24 14:53:25 INFO - PROCESS | 22574 | Browser inner width/height: 1024/697 14:53:25 INFO - PROCESS | 22574 | __metrics 14:53:26 ERROR - PROCESS | 22574 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:53:27 INFO - TEST-INFO | 22574: exit 0 14:53:27 INFO - Browser initialized. 14:53:27 INFO - Running cycle 1/1 for kraken test... 14:53:27 INFO - TEST-INFO | started process 22694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZGhIHH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:53:39 INFO - PROCESS | 22694 | RSS: Main: 167653376 14:53:39 INFO - PROCESS | 22694 | 14:53:41 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38588/tests/kraken/driver.html?testName=audio-beat-detection) 14:53:42 INFO - PROCESS | 22694 | RSS: Main: 172748800 14:53:42 INFO - PROCESS | 22694 | 14:53:45 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38588/tests/kraken/driver.html?testName=audio-dft) 14:53:45 INFO - PROCESS | 22694 | RSS: Main: 171413504 14:53:45 INFO - PROCESS | 22694 | 14:53:48 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38588/tests/kraken/driver.html?testName=audio-fft) 14:53:49 INFO - PROCESS | 22694 | RSS: Main: 167997440 14:53:49 INFO - PROCESS | 22694 | 14:53:51 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38588/tests/kraken/driver.html?testName=audio-oscillator) 14:53:52 INFO - PROCESS | 22694 | RSS: Main: 168910848 14:53:52 INFO - PROCESS | 22694 | 14:53:54 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38588/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:53:54 INFO - PROCESS | 22694 | RSS: Main: 169115648 14:53:54 INFO - PROCESS | 22694 | 14:53:57 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38588/tests/kraken/driver.html?testName=imaging-darkroom) 14:53:58 INFO - PROCESS | 22694 | RSS: Main: 169033728 14:53:58 INFO - PROCESS | 22694 | 14:54:01 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38588/tests/kraken/driver.html?testName=imaging-desaturate) 14:54:02 INFO - PROCESS | 22694 | RSS: Main: 166821888 14:54:02 INFO - PROCESS | 22694 | 14:54:05 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38588/tests/kraken/driver.html?testName=json-parse-financial) 14:54:06 INFO - PROCESS | 22694 | RSS: Main: 168198144 14:54:06 INFO - PROCESS | 22694 | 14:54:07 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38588/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:54:08 INFO - PROCESS | 22694 | RSS: Main: 168374272 14:54:08 INFO - PROCESS | 22694 | 14:54:10 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38588/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:54:10 INFO - PROCESS | 22694 | RSS: Main: 168964096 14:54:10 INFO - PROCESS | 22694 | 14:54:12 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38588/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:54:13 INFO - PROCESS | 22694 | RSS: Main: 169660416 14:54:13 INFO - PROCESS | 22694 | 14:54:16 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:54:16 INFO - PROCESS | 22694 | RSS: Main: 169918464 14:54:16 INFO - PROCESS | 22694 | 14:54:19 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:54:20 INFO - PROCESS | 22694 | RSS: Main: 169381888 14:54:20 INFO - PROCESS | 22694 | 14:54:21 INFO - PROCESS | 22694 | Cycle 1(1): loaded http://localhost:38588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38588/tests/kraken/driver.html?testName=ai-astar) 14:54:22 INFO - PROCESS | 22694 | RSS: Main: 170360832 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | __start_tp_report 14:54:22 INFO - PROCESS | 22694 | _x_x_mozilla_page_load 14:54:22 INFO - PROCESS | 22694 | _x_x_mozilla_page_load_details 14:54:22 INFO - PROCESS | 22694 | |i|pagename|runs| 14:54:22 INFO - PROCESS | 22694 | |0;ai-astar;102;113;106;112;110;111;113;112;111;112 14:54:22 INFO - PROCESS | 22694 | |1;audio-beat-detection;146;118;149;195;120;146;146;119;177;120 14:54:22 INFO - PROCESS | 22694 | |2;audio-dft;164;163;162;162;162;164;176;163;163;163 14:54:22 INFO - PROCESS | 22694 | |3;audio-fft;75;76;76;177;76;75;75;76;161;77 14:54:22 INFO - PROCESS | 22694 | |4;audio-oscillator;85;83;154;86;83;84;134;84;85;142 14:54:22 INFO - PROCESS | 22694 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;118;118;118 14:54:22 INFO - PROCESS | 22694 | |6;imaging-darkroom;150;151;149;147;147;147;147;147;147;147 14:54:22 INFO - PROCESS | 22694 | |7;imaging-desaturate;96;96;96;95;95;95;96;98;96;95 14:54:22 INFO - PROCESS | 22694 | |8;json-parse-financial;54;55;55;54;55;56;55;59;54;55 14:54:22 INFO - PROCESS | 22694 | |9;json-stringify-tinderbox;63;63;64;64;65;62;64;64;62;63 14:54:22 INFO - PROCESS | 22694 | |10;stanford-crypto-aes;77;85;77;85;76;81;76;78;81;91 14:54:22 INFO - PROCESS | 22694 | |11;stanford-crypto-ccm;133;140;129;124;134;130;142;121;160;125 14:54:22 INFO - PROCESS | 22694 | |12;stanford-crypto-pbkdf2;166;166;167;169;158;159;170;160;159;160 14:54:22 INFO - PROCESS | 22694 | |13;stanford-crypto-sha256-iterative;65;65;65;65;67;65;63;64;66;65 14:54:22 INFO - PROCESS | 22694 | __end_tp_report 14:54:22 INFO - PROCESS | 22694 | __start_cc_report 14:54:22 INFO - PROCESS | 22694 | _x_x_mozilla_cycle_collect,944 14:54:22 INFO - PROCESS | 22694 | __end_cc_report 14:54:22 INFO - PROCESS | 22694 | __startTimestamp1469224462064__endTimestamp 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | ------- Summary: start ------- 14:54:22 INFO - PROCESS | 22694 | Number of tests: 14 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.52 (3.1%) stddev-sans-first:2.15 14:54:22 INFO - PROCESS | 22694 | Values: 102.0 113.0 106.0 112.0 110.0 111.0 113.0 112.0 111.0 112.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:146.00 stddev:26.20 (17.9%) stddev-sans-first:27.78 14:54:22 INFO - PROCESS | 22694 | Values: 146.0 118.0 149.0 195.0 120.0 146.0 146.0 119.0 177.0 120.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.00 stddev:4.21 (2.6%) stddev-sans-first:4.47 14:54:22 INFO - PROCESS | 22694 | Values: 164.0 163.0 162.0 162.0 162.0 164.0 176.0 163.0 163.0 163.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.00 stddev:39.50 (52.0%) stddev-sans-first:41.27 14:54:22 INFO - PROCESS | 22694 | Values: 75.0 76.0 76.0 177.0 76.0 75.0 75.0 76.0 161.0 77.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:84.00 stddev:28.93 (34.4%) stddev-sans-first:30.02 14:54:22 INFO - PROCESS | 22694 | Values: 85.0 83.0 154.0 86.0 83.0 84.0 134.0 84.0 85.0 142.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:54:22 INFO - PROCESS | 22694 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:147.00 stddev:1.52 (1.0%) stddev-sans-first:1.41 14:54:22 INFO - PROCESS | 22694 | Values: 150.0 151.0 149.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 14:54:22 INFO - PROCESS | 22694 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 98.0 96.0 95.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.48 (2.7%) stddev-sans-first:1.50 14:54:22 INFO - PROCESS | 22694 | Values: 54.0 55.0 55.0 54.0 55.0 56.0 55.0 59.0 54.0 55.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 14:54:22 INFO - PROCESS | 22694 | Values: 63.0 63.0 64.0 64.0 65.0 62.0 64.0 64.0 62.0 63.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:81.00 stddev:4.97 (6.1%) stddev-sans-first:5.09 14:54:22 INFO - PROCESS | 22694 | Values: 77.0 85.0 77.0 85.0 76.0 81.0 76.0 78.0 81.0 91.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:133.50 stddev:11.39 (8.5%) stddev-sans-first:12.08 14:54:22 INFO - PROCESS | 22694 | Values: 133.0 140.0 129.0 124.0 134.0 130.0 142.0 121.0 160.0 125.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:166.00 stddev:4.62 (2.8%) stddev-sans-first:4.81 14:54:22 INFO - PROCESS | 22694 | Values: 166.0 166.0 167.0 169.0 158.0 159.0 170.0 160.0 159.0 160.0 14:54:22 INFO - PROCESS | 22694 | 14:54:22 INFO - PROCESS | 22694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 14:54:22 INFO - PROCESS | 22694 | Values: 65.0 65.0 65.0 65.0 67.0 65.0 63.0 64.0 66.0 65.0 14:54:22 INFO - PROCESS | 22694 | -------- Summary: end -------- 14:54:22 INFO - PROCESS | 22694 | 14:54:23 INFO - TEST-INFO | 22694: exit 0 14:54:23 INFO - TEST-OK | kraken | took 61836ms 14:54:23 INFO - SUITE-END | took 1173s 14:54:23 INFO - Completed test suite (00:19:33) 14:54:23 INFO - javascript benchmark 14:54:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7303.153285602041, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.9384212315754, 3090.2428904918293, 3091.969080309197, 3102.364015376848, 3103.1311232854796, 5410.0, 5483.451654834519, 5485.6434331768405, 5512.751926163322, 5564.276644036279, 5347.59893008024, 5443.537299329561, 5514.476124768151, 5531.585131115173, 5570.944290557093, 4958.355413796201, 5043.041822053798, 5053.343065401511, 5084.4661310562415, 5149.794008239666, 5038.319826823368, 5095.363079615048, 5109.0, 5123.820666276681, 5168.664036837612, 4759.357486739281, 5011.3485246918035, 5047.697138171685, 5065.442801291855, 5086.313347698069, 4899.044686286175, 4919.385076865392, 4938.62960277977, 4964.453910069889, 4985.401751789808, 4865.659403841697, 4870.634702397334, 4920.6309526785635, 4928.7535623219055, 4984.22744474607, 5274.5780337572905, 5403.243545903577, 5440.510354068113, 5445.237666726662, 5451.073317536028, 5709.971450142764, 5739.028181926918, 5766.250387449647, 5792.7972520961985, 5835.270591176103, 5829.766809327622, 5840.678762668052, 5842.357340692521, 5844.561657875676, 5853.385394533555, 5378.731063446812, 5439.918401223985, 5441.7279136043435, 5443.428440013781, 5454.53636440903, 5883.852903677443, 5908.438698323653, 5948.821535353946, 5977.402259773988, 6030.125631783367, 5727.169560413717, 5740.311162660508, 5746.770129194785, 5747.25285712863, 5749.798757043483, 5611.6352437091455, 5814.883702325929, 5840.795572154954, 5843.970780146072, 5847.6783776891825, 5766.192733017381, 5844.211031510692, 5845.649261044351, 5852.502537284294, 5934.258217722785, 5714.457126572969, 5724.198612194296, 5733.512651424676, 5742.48317651405, 5753.88492230153, 4328.199283132631, 4329.761863097497, 4335.263005289108, 4363.083752411965, 4364.41080454141, 3900.1224724436775, 3913.7064720146104, 3950.8419663213726, 3951.7036222283446, 3999.7800120993625, 5560.582956278215, 5561.304836895388, 5566.582506312043, 5579.218909352694, 5632.549396048306, 5654.74553645087, 5880.0591905295805, 5891.941080589139, 5897.380775018647, 5898.557608179318, 5530.446955304437, 5584.413636568183, 5596.804111856066, 5629.6903670298525, 5645.096784514458, 5010.899782004412, 5046.9747651261505, 5056.544910958031, 5068.56917162038, 5111.667741596784, 5793.768249270066, 6035.7283922223605, 6040.516758659297, 6047.213862197887, 6049.516038716892, 5819.53443724501, 5850.473457388855, 5863.325717542537, 5907.0, 5945.791897283574, 6039.48664363534, 6048.395160483917, 6049.455549000611, 6049.909251361145, 6071.878562428638, 5647.068233741551, 5788.681622510802, 5792.82621521355, 5796.855078623068, 5798.072308430631, 5913.704314784158, 5939.168516407793, 5982.162497250475, 6024.186734790747, 6036.849078773066, 5793.102069179284, 5819.854503637273, 5819.970900145472, 5822.243108395882, 5834.299884013945, 5638.23883775685, 5712.400197979318, 5786.623869448473, 5818.970905145617, 5820.301563812201, 5639.436056394327, 5720.48515633595, 5732.627379220337, 5787.421257874179, 5789.768409263583, 5772.220750198838, 5802.50678692299, 5802.912956305743, 5809.709514524341, 5830.416958304136, 5509.559235261249, 5553.805616803393, 5717.17101020358, 5719.971400142973, 5739.741711623071], "value": 5391.4164036372995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.1006354283127, 579.1255204640992, 594.6283572767018, 607.0226934635236, 636.4431122767578, 39573.406398904, 43784.34323485146, 43957.0, 43977.78011109948, 44245.55754442455, 43018.35472467916, 43590.42300558435, 43607.563924360744, 43719.0, 43815.0, 8883.777905552348, 8973.057828927966, 9052.366334356597, 9065.682701105463, 9086.727398178033, 8939.463632182089, 8996.370254082216, 8999.595018224163, 9020.594073266719, 9028.458292502472, 9079.228265597432, 9081.364304498687, 9107.271418286522, 9127.406718563305, 9136.040715724854, 9072.954635226815, 9083.81832363349, 9095.226905713022, 9107.590158442852, 9119.589618467186, 8870.86693699595, 8925.33060020501, 8999.5050272235, 9006.234470070052, 9007.144321289466, 41009.794951025055, 41012.0, 41259.1748165035, 41351.7932410336, 41396.1720765586, 3285.769996100274, 3316.416912428851, 3590.9281814363567, 3813.9809300953593, 3884.242572698325, 31866.0, 31899.202519936956, 31926.680733192603, 32449.351012979845, 34293.314133717184, 4106.609872062149, 4161.542230354658, 4163.708540402173, 4242.406063151161, 4246.150769846043, 374121.99999999726, 379190.0, 379593.0, 381934.0, 382340.0, 56616.0, 57426.425735742945, 57559.0, 57562.42437575654, 57587.71206143942, 34853.477197842054, 36499.0, 36533.45199822005, 59757.0, 59794.0, 16434.096124713018, 16454.0, 16551.83448165527, 16555.08947007902, 16572.419965301156, 13099.672508187372, 13188.340582971005, 13212.273324967027, 13215.207087574585, 13302.534411295752, 19468.513287167934, 19515.414537563895, 19530.089615917575, 19557.700763480687, 19708.014599270267, 7036.155661320674, 7075.893861592081, 7244.601546914865, 7416.25837416254, 7426.108866935894, 928.4939707859232, 937.6155776131753, 1023.1150055202196, 1081.8269076947652, 1101.487808169189, 31987.20031999172, 32304.192395190308, 32326.0, 32489.51265731016, 32533.186670332958, 1131.801934661431, 1136.9829452558217, 1170.1984140863535, 1170.5610396101463, 1213.1023042948332, 16812.159392030593, 17060.488185354458, 17142.142892855307, 17151.828481715023, 17279.91360043217, 581888.0, 591563.0, 591653.0, 595748.0, 595893.0, 60179.0, 60669.39330606726, 61286.38713612896, 61347.69326153341, 61480.0, 1306.8235788168665, 1317.7232781116072, 1321.200673592482, 1367.0772228745557, 1393.233721453217, 29804.552931706476, 31002.844985774926, 32010.51984220285, 32025.519617206228, 32071.358572828878, 50464.495355047446, 51078.74460627822, 51198.23202651889, 51323.0, 51383.0, 538239.0, 540046.0, 541117.0, 541588.0, 542636.0, 28275.858620706764, 28585.714142858305, 28640.14079577616, 28670.42659146847, 28763.28091797722, 47932.5206747928, 48012.7599362001, 48187.759061204466, 48343.75828120837, 49329.26006109983, 40397.798011010935, 40523.797381012904, 40555.79722101489, 41036.58963410328, 41098.383524246565, 40642.79678601588, 41402.792986034874, 41684.58315416928, 42688.35967460428, 42868.35697464478, 41349.586504134575, 42694.78652606717, 42965.78517107394, 42967.355489668305, 45092.32361514645, 32810.835945820116, 36491.270174595826, 37565.0, 37991.240175196894, 38192.23615527618, 27556.0, 27942.0, 28336.43327133487, 28613.713862861106, 28754.0], "value": 20303.99302587103, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.1253173965748, 383.6815443182159, 389.20407766118285, 396.9980150099249, 410.87057576863305, 19239.519012024688, 20353.796462035374, 20440.0, 20620.48448788781, 20899.0, 18785.436436906915, 18906.0, 19223.32718354858, 19612.117454714535, 19695.212191512357, 5023.824166154185, 5576.9163462548095, 5725.770969161229, 5765.913511297334, 5778.075507918734, 5688.118341657029, 5711.257536520267, 5740.512056475184, 5746.0806270996645, 5753.539716822645, 5541.27963364764, 5611.130274807391, 5643.8024669136585, 5644.068728659766, 5710.314762228539, 5611.607187496857, 5623.522000629951, 5750.971245143789, 5751.942480575203, 5752.597318187729, 4948.925766113512, 5168.664036837594, 5227.0, 5288.735563221823, 5298.205269209611, 13423.0, 13782.862171378258, 13837.584872453743, 13854.93072534641, 13914.09558378702, 2149.4518897681146, 2187.3109970359446, 2236.105557776886, 2284.9756388585133, 2296.1733775840685, 10054.296199266055, 10161.187105031653, 10220.642277520252, 10272.075513203772, 10327.483625818679, 1855.1280897977929, 1896.6111947050822, 1900.2873922279146, 1910.3218357483033, 1918.2518817661123, 87912.80185510927, 89387.22868197686, 89511.55244223737, 90340.54829725875, 90677.0, 10979.945100274606, 11043.668689939315, 11179.217454778087, 11205.66383008511, 11527.71180720472, 15663.530094097196, 15738.403163478128, 15749.921250393903, 15761.0, 15804.604884877741, 8360.414770966096, 8549.230569248797, 8618.525981071101, 8626.827463450696, 8784.341174411944, 8415.200555947175, 8448.408611397143, 8468.068512463624, 8746.56267186638, 8782.473051616924, 4794.640401969867, 4811.422629284508, 4816.470188279286, 4836.637252206098, 4974.751262436864, 1998.600279944017, 2041.8979051047388, 2052.1791283486723, 2063.9896800515903, 2069.1206237349065, 843.4812590256947, 930.181440332503, 947.9194268487256, 949.4161090929167, 1056.8943105689523, 19710.507237319183, 20012.39900807932, 20308.0, 20473.283435079702, 20640.793592064187, 959.8608201810698, 980.3627941337983, 1001.8747656542932, 1030.2479190191202, 1040.942748148844, 10590.205734569938, 11182.552697891993, 11196.160287978435, 11225.831612525819, 11265.0, 479915.0, 482704.0, 510820.0, 516346.0, 522317.0, 92227.0, 93530.0, 95746.42716794934, 97644.0, 101834.0, 1031.4997226345217, 1045.153425725165, 1073.3506228731505, 1075.6611667324767, 1083.230906056693, 15826.366945322057, 18125.818741812942, 18148.274069037092, 18223.0, 18318.725219121457, 43724.34413483737, 44340.99999999871, 44523.332150018425, 44938.0, 45320.093598128515, 58935.0, 59075.704621476616, 61854.38145618666, 63149.36850631435, 63291.683541581995, 7558.13081495635, 8035.718749843727, 8402.453840500348, 8593.785155371166, 8608.956955215184, 10099.69700908974, 13099.93450032782, 13514.121582097132, 13543.25512096844, 13729.244891531062, 5954.01758709808, 11193.552257909592, 11652.242604230698, 12114.333711645591, 12301.876981230072, 11554.248973816675, 11886.405679716152, 12102.636920892388, 12154.209976351509, 12685.112042157329, 11511.712207194887, 11549.249298795552, 12178.878211217774, 12423.875761242272, 12530.624081277576, 8099.716509922125, 8201.630926608435, 8236.34109271245, 8373.074192935781, 8415.368847336596, 11586.826197606873, 11988.880111198776, 12132.878671213175, 12182.634520964386, 12255.75488490243], "value": 9191.365856084256, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.441084593277, 1490.9925450372748, 1651.7770101036356, 1783.7681101456808, 1811.2211748947955, 7696.730614428496, 8425.283850872676, 8446.0, 8977.820443591125, 8985.0, 8501.659933602665, 8806.515641639708, 8812.823743525125, 8820.77948051299, 8834.028256891754, 2317.7102862142233, 2362.196853069956, 2367.171489978511, 2367.9052837886466, 2371.8221133414977, 2277.555876604063, 2278.259565641165, 2315.6989591353185, 2326.3718795925092, 2348.3189874936247, 2310.3992961829963, 2318.8724620145886, 2331.2190416210506, 2363.6572696959015, 2367.479154585997, 2242.8766417847014, 2264.52444986553, 2269.8184145268337, 2283.1894677389537, 2291.9770802292014, 2210.9226177083724, 2211.9447013824624, 2230.3866436730027, 2253.447905263221, 2275.590393729128, 8788.8681669775, 8820.8676869847, 8821.691240806605, 8854.778630534289, 8903.643854245822, 5139.640225184238, 5258.6318957672975, 5260.053190425722, 5267.630416091805, 5271.103912334874, 3191.377681352137, 3211.6627754085716, 3282.5404443377947, 3326.9833650831833, 3348.7990720556845, 1076.6877605494396, 1110.7945030169365, 1114.9442527873573, 1133.7052366384717, 1134.2627292260015, 12079.214851034654, 12104.455299511455, 12109.757804843854, 12119.697007574792, 12167.817482737766, 4364.279893817485, 4468.776561171929, 4560.4071470708595, 4587.7017993830295, 4622.168009758276, 10105.494725263707, 10173.898261017443, 10174.694759157237, 10184.236182286359, 10199.796004079877, 5172.172452407672, 5172.767225474862, 5182.97408512955, 5199.350081239845, 5208.322918020709, 4182.560831112689, 4722.409698787652, 4778.856634300907, 4806.903861922742, 4807.879803004953, 3884.6892248620043, 3965.7620542767527, 4001.139754952699, 4088.550259471456, 4114.938275925863, 1263.8357013588175, 1276.3554405025402, 1277.393238211842, 1277.7316763479587, 1283.4737757519372, 809.668036105194, 896.3053633434141, 979.9216062714966, 984.5175863826817, 991.7718924647371, 5879.323877754113, 5995.730192141364, 6078.209832721718, 6100.816975490742, 6179.5056395488255, 450.4931951554501, 455.180674785385, 458.1295538476921, 460.74658937584195, 461.4347424405077, 4083.1833633273463, 4206.74759514424, 4217.746935183899, 4220.07158425146, 4243.427137336482, 10605.363678179334, 10927.235093543535, 10978.231523793258, 10982.505787239434, 10988.560457581607, 10775.784484310427, 10892.0, 10902.672919812418, 10904.073153782017, 10936.179786516042, 7755.418343624251, 8088.352931765445, 8120.715774947967, 8289.461185022954, 8297.25324720766, 6022.698865056817, 6156.199694039746, 6221.564490485623, 6221.813345599639, 6284.905726414199, 10130.240231982778, 10173.745656358355, 10207.387556746618, 10228.641997530349, 10234.130098941674, 10236.385816851012, 10332.638357657446, 10393.220508461744, 10428.843567346345, 10428.895711042793, 7260.709571617076, 7715.614219289126, 7861.25318094803, 7986.520808751494, 8154.0622828373125, 8298.336133109216, 8359.95820020896, 8361.080281169188, 8368.24685778283, 8385.622646981023, 7581.469297149147, 7638.197989211275, 7813.687452501837, 7867.960660196892, 7913.564753938589, 7489.8876516851205, 7586.24137586237, 7597.316241538067, 7625.733099341496, 7848.450608457353, 6994.475414343843, 7110.822229444098, 7113.75101871432, 7123.608201548965, 7142.107236595426, 5218.399884013235, 5249.842504724865, 5283.524482796567, 5316.920246196388, 5477.096279113902, 5387.461253874581, 5412.215228791882, 5464.098423760035, 5482.533984611353, 5517.393086760533], "value": 4552.470633356017, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.358424206605, 334.4565081742169, 345.16297977404787, 346.35059263880225, 348.5033826796814, 5506.339239291291, 5520.889582208353, 5689.431056894314, 5713.285839270091, 5759.798407055754, 5523.7790488380515, 5597.132444471114, 5613.547668184068, 5617.269754931853, 5680.579855036241, 4393.165298593273, 4396.999999999992, 4415.51429342772, 4416.3375493675885, 4417.403650507189, 4141.929035482259, 4346.369776382423, 4390.538993405694, 4395.560443955595, 4403.295472724365, 4328.285832837578, 4355.803988820495, 4361.389405483234, 4364.148990946766, 4371.14762621289, 4346.587074227943, 4365.126974605092, 4368.1918845013615, 4370.7159034662645, 4382.386465894777, 3758.661720445173, 3787.6780473659774, 3844.5770965193806, 3844.730868839182, 3853.2678791029894, 5449.455054494559, 5464.781408743645, 5470.316210473691, 5478.808241711521, 5516.668999860021, 4942.530459606368, 4950.356453661001, 4965.90068198634, 4969.906620543475, 4994.650374473788, 5697.230873832021, 5860.824175274706, 5863.237779088734, 5885.382034886361, 5960.403959604048, 4158.045718512294, 4162.958370416318, 4165.812538435777, 4168.124693814302, 4179.895502612429, 6141.477974372184, 6144.87710245797, 6158.291796443422, 6179.918514259986, 6180.0, 4184.811683474251, 4251.234777739975, 4264.0832221072615, 4275.456103618342, 4296.871093867189, 4308.74147551148, 4316.136772645484, 4334.978325108417, 4347.6304514116655, 4362.498312694017, 4972.78166849117, 4992.350994370709, 5008.57427118699, 5023.547880690755, 5040.873978150502, 5596.552275817925, 5756.597038207369, 5876.882462350729, 5939.881202375928, 5981.461668449861, 1481.6369989352463, 1505.6160679026777, 1507.8492150784834, 1510.6676531163127, 1512.10785636475, 917.8990311065777, 955.8375076237056, 957.5547370472764, 974.4153507895206, 975.1467465967279, 5030.496950304941, 5033.5469807716745, 5041.949580504222, 5060.797568097309, 5078.365204349457, 5356.732163391893, 5401.4868587484125, 5434.809781657623, 5488.53347465462, 5498.257735205696, 5099.903520742984, 5131.999260144311, 5151.381834179922, 5343.225232341289, 5782.277215348082, 3243.497257925025, 3251.1546997780747, 3255.886043988449, 3267.215868191617, 3283.83580820958, 6103.755849766048, 6181.84545386369, 6187.443130118311, 6263.0, 6293.590916590407, 6190.3190649028575, 6210.7515699372425, 6221.688915554204, 6222.377762223741, 6234.688265586702, 6264.248290205113, 6268.655223962634, 6272.5922815016875, 6279.309275979638, 6284.968575157095, 5842.561807864342, 6026.849328766816, 6036.788712395045, 6039.456448919618, 6104.69476526163, 5945.970270148621, 5967.940320596912, 5993.250843644544, 6003.6397816131175, 6032.0, 5935.347111817783, 6237.594556353823, 6255.24937007562, 6259.843503912439, 6268.686565671789, 4236.555161708099, 4259.275923093143, 4276.251655960133, 4324.56754324565, 4327.437433133672, 5864.970675146597, 5957.76168953237, 6167.290761562478, 6167.352427994996, 6181.690915454119, 5815.94184058154, 5902.350741418526, 5905.616134951214, 5928.377520360473, 5936.554758393224, 5872.794452194153, 5937.762489500545, 5978.910316345346, 6029.909551356821, 6039.365866584121, 5688.715564221855, 5704.771809127588, 5785.218995435563, 5793.681347525927, 5900.262467191601, 5992.310884248367, 6004.579679422399, 6035.849103772441, 6039.607425517327, 6051.152838602688, 5717.742701578356, 5847.152162936435, 5872.882542349043, 5882.941170588239, 5889.293284805679], "value": 4453.748412515671, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.1968863782793, 756.5914406220642, 771.3751860992596, 829.6142293833366, 885.566072624414, 15251.466198683049, 16045.75359449678, 16055.518334449986, 16131.112788796612, 16148.677026459463, 14284.71430571388, 14860.0, 15086.245687715626, 15139.848601513982, 15181.16503592302, 660.9603423794588, 799.4164260090138, 820.2822530285999, 820.5035953248289, 820.9425340226187, 800.5476905548376, 817.0848649512554, 820.3888103363003, 820.4011071917504, 822.8683410654296, 858.4076986879033, 862.3403096631051, 862.7886167888876, 862.9816816156932, 863.4689665855485, 855.149126619015, 856.6573370651727, 862.6549380247889, 862.8705694145866, 863.3567991846115, 619.5663035874906, 621.4096608222206, 621.4469122480996, 622.3527531367373, 623.51988968494, 14743.11541307525, 14792.926035369863, 14808.703825923529, 14882.0, 14891.478798242119, 14644.487442939446, 14877.18175500347, 14944.850551494455, 14998.925005375013, 15038.496150384983, 12557.816377171215, 12636.30500322482, 12697.365131743376, 12816.42326095328, 12922.340890141699, 3729.3855872089775, 3751.7042985781127, 3815.065308999313, 3848.4804551385487, 3950.6839452843706, 69044.6547767263, 69486.305136949, 69621.0, 69730.95403569001, 70255.29744702589, 11294.94352528232, 11363.886361136283, 11401.315921044765, 11978.0, 11985.940070299594, 22531.0987560499, 22536.774632253466, 22546.210882619358, 22574.887125564597, 22609.64342139477, 7813.257740514642, 8127.0, 8191.713290034821, 8218.753437396888, 8428.789280268042, 4523.36672865799, 4554.977225113919, 4564.794584243717, 4567.611753000966, 4716.528347165325, 3350.2964377481003, 3432.3478539077996, 3445.1903802606366, 3451.551298331201, 3456.4815277708544, 540.3758658749151, 644.5584774429437, 646.3956200952125, 652.7780554611455, 658.6706646676662, 602.6835911146595, 642.7429028388589, 682.4642655515496, 730.8221499930238, 732.4762794601885, 9789.46157961319, 9844.310898237054, 9883.654072107442, 9944.850827237597, 10105.343152695052, 600.5945986459122, 681.2063945503533, 727.8471520980547, 729.002533059424, 737.5169264132002, 4447.533009034069, 4659.114768194032, 4700.576948074689, 4703.823223759766, 4716.764161791897, 91831.54084229536, 118377.46771782731, 119191.0, 121754.3912280433, 122845.0, 60891.0, 104233.47883260535, 104796.0, 105066.0, 107419.0, 89520.0, 89928.0, 90193.54903225442, 90350.54824725834, 90917.6343559263, 8475.74572762818, 9002.324825638234, 9009.594568244314, 9017.188453039258, 9121.087891210826, 52960.20559691531, 53727.0, 54262.72868635789, 54486.45513544814, 54930.9999999984, 72304.27695723186, 74755.0, 80325.0, 80448.59775701084, 81022.0, 11738.76522469563, 11802.645920622395, 12319.876801231872, 12591.68520786951, 12646.304453254792, 12905.354732263162, 13170.816646352157, 13188.868111319147, 13313.0, 13685.521006764715, 12283.0, 12285.69285767863, 12342.259464432163, 12855.16441431304, 13058.934705326412, 12218.694532636755, 12480.415148944447, 12498.750024999266, 12529.436175371948, 12682.936585317015, 11341.489632966372, 11461.369624670722, 11540.134489913458, 12092.879071209176, 12116.0, 10137.847932281169, 10253.333533320609, 10696.732581685521, 10752.516136773707, 10823.567057317934, 10291.43397113136, 10317.329373590992, 10337.793244135226, 10358.326708763907, 10362.792744145225], "value": 7436.722725849134, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 106.0, 112.0, 110.0, 111.0, 113.0, 112.0, 111.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 149.0, 195.0, 120.0, 146.0, 146.0, 119.0, 177.0, 120.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 162.0, 162.0, 164.0, 176.0, 163.0, 163.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 177.0, 76.0, 75.0, 75.0, 76.0, 161.0, 77.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 154.0, 86.0, 83.0, 84.0, 134.0, 84.0, 85.0, 142.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 98.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 55.0, 56.0, 55.0, 59.0, 54.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 65.0, 62.0, 64.0, 64.0, 62.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 85.0, 77.0, 85.0, 76.0, 81.0, 76.0, 78.0, 81.0, 91.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 140.0, 129.0, 124.0, 134.0, 130.0, 142.0, 121.0, 160.0, 125.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 167.0, 169.0, 158.0, 159.0, 170.0, 160.0, 159.0, 160.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 67.0, 65.0, 63.0, 64.0, 66.0, 65.0], "value": 65.0, "unit": "score"}]}]} 14:54:23 INFO - Return code: 0 14:54:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:54:23 ERROR - # TBPL SUCCESS # 14:54:23 INFO - Running post-action listener: _resource_record_post_action 14:54:23 INFO - [mozharness: 2016-07-22 21:54:23.352215Z] Finished run-tests step (success) 14:54:23 INFO - Running post-run listener: _resource_record_post_run 14:54:23 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555585536; Read time: 212; Write time: 404008 14:54:23 INFO - TinderboxPrint: CPU usage
13.3% 14:54:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 212 14:54:23 INFO - TinderboxPrint: I/O write bytes / time
555,585,536 / 404,008 14:54:23 INFO - TinderboxPrint: CPU idle
8,238.2 (86.7%) 14:54:23 INFO - TinderboxPrint: CPU user
1,208.6 (12.7%) 14:54:23 INFO - TinderboxPrint: Swap in / out
0 / 0 14:54:23 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 263786496; Read time: 0; Write time: 219660 14:54:23 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291799040; Read time: 212; Write time: 184348 14:54:23 INFO - Running post-run listener: _upload_blobber_files 14:54:23 INFO - Blob upload gear active. 14:54:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:54:23 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 14:54:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:54:24 INFO - (blobuploader) - INFO - Open directory for files ... 14:54:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:54:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:54:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:37 INFO - (blobuploader) - INFO - Done attempting. 14:54:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:54:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:54:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:38 INFO - (blobuploader) - INFO - Done attempting. 14:54:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:54:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:54:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:39 INFO - (blobuploader) - INFO - Done attempting. 14:54:39 INFO - (blobuploader) - INFO - Iteration through files over. 14:54:39 INFO - Return code: 0 14:54:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:54:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:54:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d61ce509c52617f4b4a98b666b522c977d30498273440b2d247df559d2ba3cc0fe0a879a0fbef6f2098a0db74a20fa18fb5d0f6b9c9d5632e490a01fb0992a2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/044e1260fef0d711967f8334893e7db86e37e0bc1ded8ba496a14e1de0397b7bd3b2be5171c6b6e27f3eb1673a33afd3e5ce05b6463f53f1e3f2dd9b3aa38f85", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d750773936656ad5cab4daff6160009e42f762aa35ca7372b99fe74406b74fdaa81b53a3dbe2546784634062b7a0c7943fc8b28804db63188816f41a419ccd6e"} 14:54:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:54:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:54:39 INFO - Contents: 14:54:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d61ce509c52617f4b4a98b666b522c977d30498273440b2d247df559d2ba3cc0fe0a879a0fbef6f2098a0db74a20fa18fb5d0f6b9c9d5632e490a01fb0992a2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/044e1260fef0d711967f8334893e7db86e37e0bc1ded8ba496a14e1de0397b7bd3b2be5171c6b6e27f3eb1673a33afd3e5ce05b6463f53f1e3f2dd9b3aa38f85", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d750773936656ad5cab4daff6160009e42f762aa35ca7372b99fe74406b74fdaa81b53a3dbe2546784634062b7a0c7943fc8b28804db63188816f41a419ccd6e"} 14:54:39 INFO - Running post-run listener: copy_logs_to_upload_dir 14:54:39 INFO - Copying logs to upload dir... 14:54:39 INFO - mkdir: /builds/slave/test/build/upload/logs 14:54:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.505613 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-22 14:54:38.959326) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 14:54:38.962680) ========= 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=1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d61ce509c52617f4b4a98b666b522c977d30498273440b2d247df559d2ba3cc0fe0a879a0fbef6f2098a0db74a20fa18fb5d0f6b9c9d5632e490a01fb0992a2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/044e1260fef0d711967f8334893e7db86e37e0bc1ded8ba496a14e1de0397b7bd3b2be5171c6b6e27f3eb1673a33afd3e5ce05b6463f53f1e3f2dd9b3aa38f85", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d750773936656ad5cab4daff6160009e42f762aa35ca7372b99fe74406b74fdaa81b53a3dbe2546784634062b7a0c7943fc8b28804db63188816f41a419ccd6e"} build_url:https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/EIQQ5LOYSbKJiW8SZWepdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d61ce509c52617f4b4a98b666b522c977d30498273440b2d247df559d2ba3cc0fe0a879a0fbef6f2098a0db74a20fa18fb5d0f6b9c9d5632e490a01fb0992a2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/044e1260fef0d711967f8334893e7db86e37e0bc1ded8ba496a14e1de0397b7bd3b2be5171c6b6e27f3eb1673a33afd3e5ce05b6463f53f1e3f2dd9b3aa38f85", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d750773936656ad5cab4daff6160009e42f762aa35ca7372b99fe74406b74fdaa81b53a3dbe2546784634062b7a0c7943fc8b28804db63188816f41a419ccd6e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 14:54:38.987221) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 14:54:38.987517) ========= 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=1f5564757af27664ca02d71f000001b0-1469223239.125723-114444590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 14:54:39.071688) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 14:54:39.071955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 14:54:39.072585) ========= ========= Total master_lag: 0.19 =========