builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1453272354.07 results: success (0) buildid: 20160119173017 builduid: 3b6e9bb44ac94fcc9b640112337f1a0b revision: 6f56cf7e7cbd6df8e765d45a954f6907f5238615 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.071356) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.072088) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.072440) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006226 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.095958) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.096269) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.109242) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.109589) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.161148) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.161842) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.162246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.162581) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 22:45:54-- 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% 218M=0s 2016-01-19 22:45:54 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165011 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.342169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.342554) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019993 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.392794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:54.393218) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 6f56cf7e7cbd6df8e765d45a954f6907f5238615 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 6f56cf7e7cbd6df8e765d45a954f6907f5238615 --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 22:45:54,829 truncating revision to first 12 chars 2016-01-19 22:45:54,829 Setting DEBUG logging. 2016-01-19 22:45:54,829 attempt 1/10 2016-01-19 22:45:54,829 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/6f56cf7e7cbd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 22:45:55,401 unpacking tar archive at: b2g-inbound-6f56cf7e7cbd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.858648 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:55.265526) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:55.265986) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004562 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:55.316725) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:55.317241) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:55.328180) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:55.328482) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 22:45:55.328929) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-19 22:45:55.329250) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:45:55 INFO - MultiFileLogger online at 20160119 22:45:55 in /builds/slave/test-pgo 22:45:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 22:45:55 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:45:55 INFO - {'append_to_log': False, 22:45:55 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:45:55 INFO - 'blob_upload_branch': 'B2G-Inbound', 22:45:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:45:55 INFO - 'branch': 'B2G-Inbound', 22:45:55 INFO - 'buildbot_json_path': 'buildprops.json', 22:45:55 INFO - 'config_files': ('talos/linux_config.py',), 22:45:55 INFO - 'default_actions': ('clobber', 22:45:55 INFO - 'read-buildbot-config', 22:45:55 INFO - 'download-and-extract', 22:45:55 INFO - 'populate-webroot', 22:45:55 INFO - 'create-virtualenv', 22:45:55 INFO - 'install', 22:45:55 INFO - 'run-tests'), 22:45:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:45:55 INFO - 'download_minidump_stackwalk': True, 22:45:55 INFO - 'download_symbols': 'ondemand', 22:45:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:45:55 INFO - 'tooltool.py': '/tools/tooltool.py', 22:45:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:45:55 INFO - '/tools/misc-python/virtualenv.py')}, 22:45:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:45:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:45:55 INFO - 'installer_path': 'installer.exe', 22:45:55 INFO - 'log_level': 'info', 22:45:55 INFO - 'log_name': 'talos', 22:45:55 INFO - 'log_to_console': True, 22:45:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:45:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:45:55 INFO - 'opt_config_files': (), 22:45:55 INFO - 'pip_index': False, 22:45:55 INFO - 'sps_profile': False, 22:45:55 INFO - 'sps_profile_interval': 0, 22:45:55 INFO - 'suite': 'dromaeojs', 22:45:55 INFO - 'system_bits': '32', 22:45:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:45:55 INFO - 'title': 'talos-linux64-ix-049', 22:45:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:45:55 INFO - 'use_talos_json': True, 22:45:55 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:45:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:45:55 INFO - 'work_dir': 'build'} 22:45:55 INFO - ##### 22:45:55 INFO - ##### Running clobber step. 22:45:55 INFO - ##### 22:45:55 INFO - Running pre-action listener: _resource_record_pre_action 22:45:55 INFO - Running main action method: clobber 22:45:55 INFO - rmtree: /builds/slave/test-pgo/build 22:45:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:45:56 INFO - Running post-action listener: _resource_record_post_action 22:45:56 INFO - ##### 22:45:56 INFO - ##### Running read-buildbot-config step. 22:45:56 INFO - ##### 22:45:56 INFO - Running pre-action listener: _resource_record_pre_action 22:45:56 INFO - Running main action method: read_buildbot_config 22:45:56 INFO - Using buildbot properties: 22:45:56 INFO - { 22:45:56 INFO - "project": "", 22:45:56 INFO - "product": "firefox", 22:45:56 INFO - "script_repo_revision": "production", 22:45:56 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 22:45:56 INFO - "repository": "", 22:45:56 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 22:45:56 INFO - "buildid": "20160119173017", 22:45:56 INFO - "pgo_build": "True", 22:45:56 INFO - "basedir": "/builds/slave/test-pgo", 22:45:56 INFO - "buildnumber": 1121, 22:45:56 INFO - "slavename": "talos-linux64-ix-049", 22:45:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:45:56 INFO - "platform": "ubuntu64_hw", 22:45:56 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 22:45:56 INFO - "branch": "b2g-inbound", 22:45:56 INFO - "repo_path": "integration/b2g-inbound", 22:45:56 INFO - "revision": "6f56cf7e7cbd6df8e765d45a954f6907f5238615", 22:45:56 INFO - "stage_platform": "linux64-pgo", 22:45:56 INFO - "builduid": "3b6e9bb44ac94fcc9b640112337f1a0b", 22:45:56 INFO - "slavebuilddir": "test" 22:45:56 INFO - } 22:45:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:45:56 INFO - Running post-action listener: _resource_record_post_action 22:45:56 INFO - ##### 22:45:56 INFO - ##### Running download-and-extract step. 22:45:56 INFO - ##### 22:45:56 INFO - Running pre-action listener: _resource_record_pre_action 22:45:56 INFO - Running main action method: download_and_extract 22:45:56 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:45:56 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')]} 22:45:56 INFO - https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:45:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/test_packages.json 22:45:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/test_packages.json 22:45:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:45:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:45:57 INFO - Downloaded 1448 bytes. 22:45:57 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:45:57 INFO - Using the following test package requirements: 22:45:57 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:45:57 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:45:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:45:57 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:45:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:45:57 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:45:57 INFO - u'jsshell-linux-x86_64.zip'], 22:45:57 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:45:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:45:57 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:45:57 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:45:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:45:57 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:45:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:45:57 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:45:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:45:57 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:45:57 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:45:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:45:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:45:57 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')]} 22:45:57 INFO - https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:45:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:45:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:45:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:45:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:45:58 INFO - Downloaded 22484065 bytes. 22:45:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:45:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:45:59 INFO - Return code: 0 22:45:59 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:45:59 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')]} 22:45:59 INFO - https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:45:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:45:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:45:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:45:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:46:00 INFO - Downloaded 22484065 bytes. 22:46:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:46:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:46:02 INFO - Return code: 0 22:46: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')]} 22:46:02 INFO - https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:46:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:46:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:46:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:46:03 INFO - Downloaded 11132144 bytes. 22:46:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:46:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:46:03 INFO - Return code: 0 22:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:46:03 INFO - https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:46:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:46:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:46:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:46:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:46:04 INFO - Downloaded 55942143 bytes. 22:46:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:46:04 INFO - mkdir: /builds/slave/test-pgo/properties 22:46:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:46:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:46:04 INFO - Contents: 22:46:04 INFO - build_url:https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:46:04 INFO - Running post-action listener: _resource_record_post_action 22:46:04 INFO - Running post-action listener: set_extra_try_arguments 22:46:04 INFO - ##### 22:46:04 INFO - ##### Running populate-webroot step. 22:46:04 INFO - ##### 22:46:04 INFO - Running pre-action listener: _resource_record_pre_action 22:46:04 INFO - Running main action method: populate_webroot 22:46:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:46:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:46:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:46:04 INFO - '--tppagecycles', 22:46:04 INFO - '7'], 22:46:04 INFO - 'tests': ['tsvgm']}}, 22:46:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:46:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:46:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:46:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:46:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:46:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:46:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:46:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:04 INFO - 'talos_options': ['--e10s'], 22:46:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:46:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:04 INFO - 'tests': ['damp', 'tps']}, 22:46:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:04 INFO - 'talos_options': ['--e10s'], 22:46:04 INFO - 'tests': ['damp', 'tps']}, 22:46:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:46:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:46:04 INFO - 'other': {'tests': ['a11yr', 22:46:04 INFO - 'ts_paint', 22:46:04 INFO - 'tpaint', 22:46:04 INFO - 'sessionrestore', 22:46:04 INFO - 'sessionrestore_no_auto_restore']}, 22:46:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:46:04 INFO - 'tests': ['a11yr', 22:46:04 INFO - 'ts_paint', 22:46:04 INFO - 'tpaint', 22:46:04 INFO - 'sessionrestore', 22:46:04 INFO - 'sessionrestore_no_auto_restore']}, 22:46:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:46:04 INFO - 'tests': ['a11yr', 22:46:04 INFO - 'ts_paint', 22:46:04 INFO - 'tpaint', 22:46:04 INFO - 'sessionrestore', 22:46:04 INFO - 'sessionrestore_no_auto_restore']}, 22:46:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:46:04 INFO - 'tests': ['a11yr', 22:46:04 INFO - 'ts_paint', 22:46:04 INFO - 'tpaint', 22:46:04 INFO - 'sessionrestore', 22:46:04 INFO - 'sessionrestore_no_auto_restore']}, 22:46:04 INFO - 'other_l64': {'tests': ['a11yr', 22:46:04 INFO - 'ts_paint', 22:46:04 INFO - 'tpaint', 22:46:04 INFO - 'sessionrestore', 22:46:04 INFO - 'sessionrestore_no_auto_restore']}, 22:46:04 INFO - 'other_nol64': {'tests': ['a11yr', 22:46:04 INFO - 'ts_paint', 22:46:04 INFO - 'tpaint', 22:46:04 INFO - 'sessionrestore', 22:46:04 INFO - 'sessionrestore_no_auto_restore']}, 22:46:04 INFO - 'svgr': {'tests': ['tsvgx', 22:46:04 INFO - 'tsvgr_opacity', 22:46:04 INFO - 'tart', 22:46:04 INFO - 'tscrollx', 22:46:04 INFO - 'cart']}, 22:46:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:46:04 INFO - 'tests': ['tsvgx', 22:46:04 INFO - 'tsvgr_opacity', 22:46:04 INFO - 'tart', 22:46:04 INFO - 'tscrollx', 22:46:04 INFO - 'cart']}, 22:46:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:04 INFO - 'tests': ['tp5o']}, 22:46:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:04 INFO - 'talos_options': ['--e10s'], 22:46:04 INFO - 'tests': ['tp5o']}, 22:46:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:04 INFO - 'talos_options': ['--xperf_path', 22:46:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:46:04 INFO - 'tests': ['tp5n']}, 22:46:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:04 INFO - 'talos_options': ['--e10s', 22:46:04 INFO - '--xperf_path', 22:46:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:46:04 INFO - 'tests': ['tp5n']}}, 22:46:04 INFO - 'talos.zip': {'path': '', 22:46:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:46:04 INFO - Running post-action listener: _resource_record_post_action 22:46:04 INFO - ##### 22:46:04 INFO - ##### Running create-virtualenv step. 22:46:04 INFO - ##### 22:46:04 INFO - Running pre-action listener: _resource_record_pre_action 22:46:04 INFO - Running main action method: create_virtualenv 22:46:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:46:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:46:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:46:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:46:05 INFO - Using real prefix '/usr' 22:46:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:46:05 INFO - Installing distribute.............................................................................................................................................................................................done. 22:46:07 INFO - Installing pip.................done. 22:46:07 INFO - Return code: 0 22:46:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:46:07 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')]} 22:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:07 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')]} 22:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f5f6cbf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1840>, '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 0xd5e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:46:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 22:46:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 22:46:07 INFO - Using env: {'DISPLAY': ':0', 22:46:07 INFO - 'HOME': '/home/cltbld', 22:46:07 INFO - 'LANG': 'en_US.UTF-8', 22:46:07 INFO - 'LANGUAGE': 'en_US:en', 22:46:07 INFO - 'LOGNAME': 'cltbld', 22:46:07 INFO - 'MAIL': '/var/mail/cltbld', 22:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:07 INFO - 'MOZ_NO_REMOTE': '1', 22:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:07 INFO - 'NO_EM_RESTART': '1', 22:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:07 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:07 INFO - 'SHELL': '/bin/bash', 22:46:07 INFO - 'SHLVL': '1', 22:46:07 INFO - 'TERM': 'linux', 22:46:07 INFO - 'TMOUT': '86400', 22:46:07 INFO - 'USER': 'cltbld', 22:46:07 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', 22:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:07 INFO - '_': '/tools/buildbot/bin/python'} 22:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:07 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 22:46:07 INFO - Cleaning up... 22:46:07 INFO - Return code: 0 22:46:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:46:07 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')]} 22:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:07 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')]} 22:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f6cbf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1840>, '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 0xd5e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:46:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test-pgo/build 22:46:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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>=0.7.1 22:46:07 INFO - Using env: {'DISPLAY': ':0', 22:46:07 INFO - 'HOME': '/home/cltbld', 22:46:07 INFO - 'LANG': 'en_US.UTF-8', 22:46:07 INFO - 'LANGUAGE': 'en_US:en', 22:46:07 INFO - 'LOGNAME': 'cltbld', 22:46:07 INFO - 'MAIL': '/var/mail/cltbld', 22:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:07 INFO - 'MOZ_NO_REMOTE': '1', 22:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:07 INFO - 'NO_EM_RESTART': '1', 22:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:07 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:07 INFO - 'SHELL': '/bin/bash', 22:46:07 INFO - 'SHLVL': '1', 22:46:07 INFO - 'TERM': 'linux', 22:46:07 INFO - 'TMOUT': '86400', 22:46:07 INFO - 'USER': 'cltbld', 22:46:07 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', 22:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:07 INFO - '_': '/tools/buildbot/bin/python'} 22:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:08 INFO - Downloading/unpacking psutil>=0.7.1 22:46:08 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 22:46:08 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 22:46:08 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 22:46:08 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 22:46:08 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 22:46:08 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 22:46:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:46:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:46:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:46:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:46:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:46:09 INFO - Installing collected packages: psutil 22:46:09 INFO - Running setup.py install for psutil 22:46:09 INFO - building 'psutil._psutil_linux' extension 22:46:09 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 22:46:10 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 22:46:10 INFO - building 'psutil._psutil_posix' extension 22:46:10 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 22:46:10 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 22:46:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:46:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:46:10 INFO - Successfully installed psutil 22:46:10 INFO - Cleaning up... 22:46:10 INFO - Return code: 0 22:46:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f6cbf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1840>, '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 0xd5e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:46:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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.0.0'] in /builds/slave/test-pgo/build 22:46:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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.0.0 22:46:10 INFO - Using env: {'DISPLAY': ':0', 22:46:10 INFO - 'HOME': '/home/cltbld', 22:46:10 INFO - 'LANG': 'en_US.UTF-8', 22:46:10 INFO - 'LANGUAGE': 'en_US:en', 22:46:10 INFO - 'LOGNAME': 'cltbld', 22:46:10 INFO - 'MAIL': '/var/mail/cltbld', 22:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:10 INFO - 'MOZ_NO_REMOTE': '1', 22:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:10 INFO - 'NO_EM_RESTART': '1', 22:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:10 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:10 INFO - 'SHELL': '/bin/bash', 22:46:10 INFO - 'SHLVL': '1', 22:46:10 INFO - 'TERM': 'linux', 22:46:10 INFO - 'TMOUT': '86400', 22:46:10 INFO - 'USER': 'cltbld', 22:46:10 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', 22:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:10 INFO - '_': '/tools/buildbot/bin/python'} 22:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:46:10 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 22:46:10 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 22:46:10 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 22:46:10 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 22:46:10 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 22:46:10 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 22:46:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:46:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:46:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:46:12 INFO - Installing collected packages: mozsystemmonitor 22:46:12 INFO - Running setup.py install for mozsystemmonitor 22:46:12 INFO - Successfully installed mozsystemmonitor 22:46:12 INFO - Cleaning up... 22:46:12 INFO - Return code: 0 22:46:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:46: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')]} 22:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46: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')]} 22:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f5f6cbf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1840>, '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 0xd5e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:46:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 22:46:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 22:46:12 INFO - Using env: {'DISPLAY': ':0', 22:46:12 INFO - 'HOME': '/home/cltbld', 22:46:12 INFO - 'LANG': 'en_US.UTF-8', 22:46:12 INFO - 'LANGUAGE': 'en_US:en', 22:46:12 INFO - 'LOGNAME': 'cltbld', 22:46:12 INFO - 'MAIL': '/var/mail/cltbld', 22:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:12 INFO - 'MOZ_NO_REMOTE': '1', 22:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:12 INFO - 'NO_EM_RESTART': '1', 22:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:12 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:12 INFO - 'SHELL': '/bin/bash', 22:46:12 INFO - 'SHLVL': '1', 22:46:12 INFO - 'TERM': 'linux', 22:46:12 INFO - 'TMOUT': '86400', 22:46:12 INFO - 'USER': 'cltbld', 22:46:12 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', 22:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:12 INFO - '_': '/tools/buildbot/bin/python'} 22:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:12 INFO - Downloading/unpacking blobuploader==1.2.4 22:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:14 INFO - Downloading blobuploader-1.2.4.tar.gz 22:46:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:46:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:46:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:46:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:46:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:15 INFO - Downloading docopt-0.6.1.tar.gz 22:46:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:46:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:46:15 INFO - Installing collected packages: blobuploader, requests, docopt 22:46:15 INFO - Running setup.py install for blobuploader 22:46:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:46:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:46:15 INFO - Running setup.py install for requests 22:46:15 INFO - Running setup.py install for docopt 22:46:15 INFO - Successfully installed blobuploader requests docopt 22:46:15 INFO - Cleaning up... 22:46:15 INFO - Return code: 0 22:46:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:46: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')]} 22:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46: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')]} 22:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f5f6cbf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1840>, '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 0xd5e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:46:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 22:46:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 22:46:15 INFO - Using env: {'DISPLAY': ':0', 22:46:15 INFO - 'HOME': '/home/cltbld', 22:46:15 INFO - 'LANG': 'en_US.UTF-8', 22:46:15 INFO - 'LANGUAGE': 'en_US:en', 22:46:15 INFO - 'LOGNAME': 'cltbld', 22:46:15 INFO - 'MAIL': '/var/mail/cltbld', 22:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:15 INFO - 'MOZ_NO_REMOTE': '1', 22:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:15 INFO - 'NO_EM_RESTART': '1', 22:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:15 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:15 INFO - 'SHELL': '/bin/bash', 22:46:15 INFO - 'SHLVL': '1', 22:46:15 INFO - 'TERM': 'linux', 22:46:15 INFO - 'TMOUT': '86400', 22:46:15 INFO - 'USER': 'cltbld', 22:46:15 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', 22:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:15 INFO - '_': '/tools/buildbot/bin/python'} 22:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:46:15 INFO - Running setup.py (path:/tmp/pip-8BeuH8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:46:16 INFO - Running setup.py (path:/tmp/pip-l7WDk4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:46:16 INFO - Running setup.py (path:/tmp/pip-peoeND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:46:16 INFO - Running setup.py (path:/tmp/pip-XQy_ta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:46:16 INFO - Running setup.py (path:/tmp/pip-AAKIsB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:46:16 INFO - Running setup.py (path:/tmp/pip-rVdgoB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:46:16 INFO - Running setup.py (path:/tmp/pip-FS2dLt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:46:16 INFO - Running setup.py (path:/tmp/pip-w1a4gP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:46:16 INFO - Running setup.py (path:/tmp/pip-EE8scF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:46:16 INFO - Running setup.py (path:/tmp/pip-9Fkjjd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:46:16 INFO - Running setup.py (path:/tmp/pip-wtuZPU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:46:16 INFO - Running setup.py (path:/tmp/pip-jEaMne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:46:16 INFO - Running setup.py (path:/tmp/pip-49XJqU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:46:16 INFO - Running setup.py (path:/tmp/pip-sGGwbQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:46:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:46:17 INFO - Running setup.py (path:/tmp/pip-21IpmS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:46:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:46:17 INFO - Running setup.py (path:/tmp/pip-Wynh1n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:46:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:46:17 INFO - Running setup.py (path:/tmp/pip-uMMYph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:46:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:46:17 INFO - Running setup.py install for manifestparser 22:46:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:46:17 INFO - Running setup.py install for mozcrash 22:46:17 INFO - Running setup.py install for mozdebug 22:46:17 INFO - Running setup.py install for mozdevice 22:46:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:46:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:46:17 INFO - Running setup.py install for mozfile 22:46:17 INFO - Running setup.py install for mozhttpd 22:46:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:46:17 INFO - Running setup.py install for mozinfo 22:46:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:46:17 INFO - Running setup.py install for mozInstall 22:46:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:46:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:46:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:46:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:46:18 INFO - Running setup.py install for mozleak 22:46:18 INFO - Running setup.py install for mozlog 22:46:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:46:18 INFO - Running setup.py install for moznetwork 22:46:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:46:18 INFO - Running setup.py install for mozprocess 22:46:18 INFO - Running setup.py install for mozprofile 22:46:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:46:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:46:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:46:18 INFO - Running setup.py install for mozrunner 22:46:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:46:18 INFO - Running setup.py install for mozscreenshot 22:46:18 INFO - Running setup.py install for moztest 22:46:18 INFO - Running setup.py install for mozversion 22:46:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:46:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:46:18 INFO - Cleaning up... 22:46:18 INFO - Return code: 0 22:46:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:46: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')]} 22:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46: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')]} 22:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f5f6cbf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1840>, '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 0xd5e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:46:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 22:46:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 22:46:18 INFO - Using env: {'DISPLAY': ':0', 22:46:18 INFO - 'HOME': '/home/cltbld', 22:46:18 INFO - 'LANG': 'en_US.UTF-8', 22:46:18 INFO - 'LANGUAGE': 'en_US:en', 22:46:18 INFO - 'LOGNAME': 'cltbld', 22:46:18 INFO - 'MAIL': '/var/mail/cltbld', 22:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:18 INFO - 'MOZ_NO_REMOTE': '1', 22:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:18 INFO - 'NO_EM_RESTART': '1', 22:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:18 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:18 INFO - 'SHELL': '/bin/bash', 22:46:18 INFO - 'SHLVL': '1', 22:46:18 INFO - 'TERM': 'linux', 22:46:18 INFO - 'TMOUT': '86400', 22:46:18 INFO - 'USER': 'cltbld', 22:46:18 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', 22:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:18 INFO - '_': '/tools/buildbot/bin/python'} 22:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:46:19 INFO - Running setup.py (path:/tmp/pip-PIM5gP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:46:19 INFO - Running setup.py (path:/tmp/pip-AFxDrF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:46:19 INFO - Running setup.py (path:/tmp/pip-blJFH7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:46:19 INFO - Running setup.py (path:/tmp/pip-eKVFoP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:46:19 INFO - Running setup.py (path:/tmp/pip-ut_T1I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:46:19 INFO - Running setup.py (path:/tmp/pip-evrWBz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:46:19 INFO - Running setup.py (path:/tmp/pip-hA0_Ht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:46:19 INFO - Running setup.py (path:/tmp/pip-Xd_Zt0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:46:19 INFO - Running setup.py (path:/tmp/pip-YiLoxn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:46:19 INFO - Running setup.py (path:/tmp/pip-Sr5kHf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:46:19 INFO - Running setup.py (path:/tmp/pip-tAVRP2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:46:19 INFO - Running setup.py (path:/tmp/pip-0jccjl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:46:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:46:20 INFO - Running setup.py (path:/tmp/pip-6n8Bz0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:46:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:46:20 INFO - Running setup.py (path:/tmp/pip-BVcN3B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:46:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:46:20 INFO - Running setup.py (path:/tmp/pip-oDqoT4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:46:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:46:20 INFO - Running setup.py (path:/tmp/pip-WbLyS_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:46:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:46:20 INFO - Running setup.py (path:/tmp/pip-qo1sA1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:46:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:46: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 22:46: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 22:46: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 22:46: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 22:46: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 22:46: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 22:46:23 INFO - Downloading blessings-1.5.1.tar.gz 22:46:23 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:46:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:46:23 INFO - Installing collected packages: blessings 22:46:23 INFO - Running setup.py install for blessings 22:46:23 INFO - Successfully installed blessings 22:46:23 INFO - Cleaning up... 22:46:23 INFO - Return code: 0 22:46:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:46:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:46:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:46:23 INFO - Reading from file tmpfile_stdout 22:46:23 INFO - Current package versions: 22:46:23 INFO - argparse == 1.2.1 22:46:23 INFO - blessings == 1.5.1 22:46:23 INFO - blobuploader == 1.2.4 22:46:23 INFO - docopt == 0.6.1 22:46:23 INFO - manifestparser == 1.1 22:46:23 INFO - mozInstall == 1.12 22:46:23 INFO - mozcrash == 0.16 22:46:23 INFO - mozdebug == 0.1 22:46:23 INFO - mozdevice == 0.48 22:46:23 INFO - mozfile == 1.2 22:46:23 INFO - mozhttpd == 0.7 22:46:23 INFO - mozinfo == 0.9 22:46:23 INFO - mozleak == 0.1 22:46:23 INFO - mozlog == 3.1 22:46:23 INFO - moznetwork == 0.27 22:46:23 INFO - mozprocess == 0.22 22:46:23 INFO - mozprofile == 0.28 22:46:23 INFO - mozrunner == 6.11 22:46:23 INFO - mozscreenshot == 0.1 22:46:23 INFO - mozsystemmonitor == 0.0 22:46:23 INFO - moztest == 0.7 22:46:23 INFO - mozversion == 1.4 22:46:23 INFO - psutil == 3.1.1 22:46:23 INFO - requests == 1.2.3 22:46:23 INFO - wsgiref == 0.1.2 22:46:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f5f6cbf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1840>, '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 0xd5e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:46:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 22:46:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 22:46:23 INFO - Using env: {'DISPLAY': ':0', 22:46:23 INFO - 'HOME': '/home/cltbld', 22:46:23 INFO - 'LANG': 'en_US.UTF-8', 22:46:23 INFO - 'LANGUAGE': 'en_US:en', 22:46:23 INFO - 'LOGNAME': 'cltbld', 22:46:23 INFO - 'MAIL': '/var/mail/cltbld', 22:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:23 INFO - 'MOZ_NO_REMOTE': '1', 22:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:23 INFO - 'NO_EM_RESTART': '1', 22:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:23 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:23 INFO - 'SHELL': '/bin/bash', 22:46:23 INFO - 'SHLVL': '1', 22:46:23 INFO - 'TERM': 'linux', 22:46:23 INFO - 'TMOUT': '86400', 22:46:23 INFO - 'USER': 'cltbld', 22:46:23 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', 22:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:23 INFO - '_': '/tools/buildbot/bin/python'} 22:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:46:23 INFO - Cleaning up... 22:46:23 INFO - Return code: 0 22:46:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f5f6cbf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1840>, '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 0xd5e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:46:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 22:46:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 22:46:23 INFO - Using env: {'DISPLAY': ':0', 22:46:23 INFO - 'HOME': '/home/cltbld', 22:46:23 INFO - 'LANG': 'en_US.UTF-8', 22:46:23 INFO - 'LANGUAGE': 'en_US:en', 22:46:23 INFO - 'LOGNAME': 'cltbld', 22:46:23 INFO - 'MAIL': '/var/mail/cltbld', 22:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:23 INFO - 'MOZ_NO_REMOTE': '1', 22:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:23 INFO - 'NO_EM_RESTART': '1', 22:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:23 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:23 INFO - 'SHELL': '/bin/bash', 22:46:23 INFO - 'SHLVL': '1', 22:46:23 INFO - 'TERM': 'linux', 22:46:23 INFO - 'TMOUT': '86400', 22:46:23 INFO - 'USER': 'cltbld', 22:46:23 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', 22:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:23 INFO - '_': '/tools/buildbot/bin/python'} 22:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:24 INFO - Downloading/unpacking jsonschema 22:46:24 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 22:46:24 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 22:46:24 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 22:46:24 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 22:46:24 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 22:46:24 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 22:46:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:46:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 22:46:25 INFO - Downloading/unpacking functools32 (from jsonschema) 22:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:25 INFO - Downloading functools32-3.2.3-2.tar.gz 22:46:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:46:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:46:25 INFO - warning: no files found matching '*.txt' 22:46:25 INFO - no previously-included directories found matching 'build' 22:46:25 INFO - no previously-included directories found matching 'dist' 22:46:25 INFO - no previously-included directories found matching '.git*' 22:46:26 INFO - Installing collected packages: jsonschema, functools32 22:46:26 INFO - Running setup.py install for functools32 22:46:26 INFO - warning: no files found matching '*.txt' 22:46:26 INFO - no previously-included directories found matching 'build' 22:46:26 INFO - no previously-included directories found matching 'dist' 22:46:26 INFO - no previously-included directories found matching '.git*' 22:46:26 INFO - Successfully installed jsonschema functools32 22:46:26 INFO - Cleaning up... 22:46:26 INFO - Return code: 0 22:46:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f6cbf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1840>, '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 0xd5e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:46:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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', 'flake8'] in /builds/slave/test-pgo/build 22:46:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 flake8 22:46:26 INFO - Using env: {'DISPLAY': ':0', 22:46:26 INFO - 'HOME': '/home/cltbld', 22:46:26 INFO - 'LANG': 'en_US.UTF-8', 22:46:26 INFO - 'LANGUAGE': 'en_US:en', 22:46:26 INFO - 'LOGNAME': 'cltbld', 22:46:26 INFO - 'MAIL': '/var/mail/cltbld', 22:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:26 INFO - 'MOZ_NO_REMOTE': '1', 22:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:26 INFO - 'NO_EM_RESTART': '1', 22:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:26 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:26 INFO - 'SHELL': '/bin/bash', 22:46:26 INFO - 'SHLVL': '1', 22:46:26 INFO - 'TERM': 'linux', 22:46:26 INFO - 'TMOUT': '86400', 22:46:26 INFO - 'USER': 'cltbld', 22:46:26 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', 22:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:26 INFO - '_': '/tools/buildbot/bin/python'} 22:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:26 INFO - Downloading/unpacking flake8 22:46:26 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 22:46:26 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 22:46:26 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 22:46:26 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 22:46:26 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 22:46:26 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 22:46:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:46:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 22:46:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:46: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 22:46: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 22:46: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 22:46: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 22:46: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 22:46: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 22:46:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:46:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 22:46:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:46: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 22:46: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 22:46: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 22:46: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 22:46: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 22:46: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 22:46:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 22:46:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:46: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 22:46: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 22:46: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 22:46: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 22:46: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 22:46: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 22:46:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:46:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:46:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:46:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:46:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:46:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:46:28 INFO - no previously-included directories found matching 'docs/_build' 22:46:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:46:28 INFO - Running setup.py install for pep8 22:46:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:46:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:46:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:46:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:46:28 INFO - no previously-included directories found matching 'docs/_build' 22:46:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:46:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:46:28 INFO - Cleaning up... 22:46:29 INFO - Return code: 0 22:46:29 INFO - Running post-action listener: _resource_record_post_action 22:46:29 INFO - Running post-action listener: _start_resource_monitoring 22:46:29 INFO - Starting resource monitoring. 22:46:29 INFO - ##### 22:46:29 INFO - ##### Running install step. 22:46:29 INFO - ##### 22:46:29 INFO - Running pre-action listener: _resource_record_pre_action 22:46:29 INFO - Running main action method: install 22:46:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:46:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:46:29 INFO - Reading from file tmpfile_stdout 22:46:29 INFO - Detecting whether we're running mozinstall >=1.0... 22:46:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:46:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:46:29 INFO - Reading from file tmpfile_stdout 22:46:29 INFO - Output received: 22:46:29 INFO - Usage: mozinstall [options] installer 22:46:29 INFO - Options: 22:46:29 INFO - -h, --help show this help message and exit 22:46:29 INFO - -d DEST, --destination=DEST 22:46:29 INFO - Directory to install application into. [default: 22:46:29 INFO - "/builds/slave/test-pgo"] 22:46:29 INFO - --app=APP Application being installed. [default: firefox] 22:46:29 INFO - mkdir: /builds/slave/test-pgo/build/application 22:46:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:46:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:46:45 INFO - Reading from file tmpfile_stdout 22:46:45 INFO - Output received: 22:46:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:46:45 INFO - Running post-action listener: _resource_record_post_action 22:46:45 INFO - ##### 22:46:45 INFO - ##### Running run-tests step. 22:46:45 INFO - ##### 22:46:45 INFO - Running pre-action listener: _resource_record_pre_action 22:46:45 INFO - Running main action method: run_tests 22:46:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:46:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:46:45 INFO - Python 2.7.3 22:46:45 INFO - Return code: 0 22:46:45 INFO - grabbing minidump binary from tooltool 22:46:45 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')]} 22:46:45 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-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1840>, '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 0xd5e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:46:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:46:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:46:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:46:45 INFO - Return code: 0 22:46:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:46:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:46:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:46:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:46:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:46:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:46:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:46:46 INFO - Return code: 0 22:46:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:46:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:46:46 INFO - Using env: {'DISPLAY': ':0', 22:46:46 INFO - 'HOME': '/home/cltbld', 22:46:46 INFO - 'LANG': 'en_US.UTF-8', 22:46:46 INFO - 'LANGUAGE': 'en_US:en', 22:46:46 INFO - 'LOGNAME': 'cltbld', 22:46:46 INFO - 'MAIL': '/var/mail/cltbld', 22:46:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:46:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:46 INFO - 'MOZ_NO_REMOTE': '1', 22:46:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:46 INFO - 'NO_EM_RESTART': '1', 22:46:46 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:46 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:46:46 INFO - 'SHELL': '/bin/bash', 22:46:46 INFO - 'SHLVL': '1', 22:46:46 INFO - 'TERM': 'linux', 22:46:46 INFO - 'TMOUT': '86400', 22:46:46 INFO - 'USER': 'cltbld', 22:46:46 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207', 22:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:46 INFO - '_': '/tools/buildbot/bin/python'} 22:46:46 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:46:46 INFO - mozversion application_buildid: 20160119173017 22:46:46 INFO - mozversion application_changeset: 6f56cf7e7cbd6df8e765d45a954f6907f5238615 22:46:46 INFO - mozversion application_display_name: Nightly 22:46:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:46:46 INFO - mozversion application_name: Firefox 22:46:46 INFO - mozversion application_remotingname: firefox 22:46:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:46:46 INFO - mozversion application_vendor: Mozilla 22:46:46 INFO - mozversion application_version: 46.0a1 22:46:46 INFO - mozversion platform_buildid: 20160119173017 22:46:46 INFO - mozversion platform_changeset: 6f56cf7e7cbd6df8e765d45a954f6907f5238615 22:46:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:46:46 INFO - mozversion platform_version: 46.0a1 22:46:46 INFO - using testdate: 1453272406 22:46:46 INFO - actual date: 1453272406 22:46:46 INFO - starting webserver on 'localhost:44774' 22:46:46 INFO - SUITE-START | Running 3 tests 22:46:46 INFO - TEST-START | dromaeo_css 22:46:46 INFO - operating with platform_type : linux_ 22:46:46 INFO - Initialising browser for dromaeo_css test... 22:46:47 INFO - TEST-INFO | started process 6971 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYCr5g6/profile http://localhost:44774/getInfo.html) 22:46:50 INFO - PROCESS | 6971 | __metrics Screen width/height:1600/1200 22:46:50 INFO - PROCESS | 6971 | colorDepth:24 22:46:50 INFO - PROCESS | 6971 | Browser inner width/height: 1024/697 22:46:50 INFO - PROCESS | 6971 | __metrics 22:46:50 INFO - PROCESS | 6971 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:46:50 INFO - PROCESS | 6971 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:46:52 INFO - TEST-INFO | 6971: exit 0 22:46:52 INFO - Browser initialized. 22:46:52 INFO - Running cycle 1/1 for dromaeo_css test... 22:46:52 INFO - TEST-INFO | started process 7061 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYCr5g6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:47:03 INFO - PROCESS | 7061 | RSS: Main: 149164032 22:47:03 INFO - PROCESS | 7061 | 22:47:55 INFO - PROCESS | 7061 | 1453272475401 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] 22:50:02 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:44774/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44774/tests/dromaeo/cssquery-ext.html) 22:50:04 INFO - PROCESS | 7061 | RSS: Main: 332656640 22:50:04 INFO - PROCESS | 7061 | 22:53:07 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:44774/tests/dromaeo/cssquery-ext.html (next: http://localhost:44774/tests/dromaeo/cssquery-jquery.html) 22:53:07 INFO - PROCESS | 7061 | RSS: Main: 239378432 22:53:07 INFO - PROCESS | 7061 | 22:56:09 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:44774/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44774/tests/dromaeo/cssquery-mootools.html) 22:56:10 INFO - PROCESS | 7061 | RSS: Main: 233652224 22:56:10 INFO - PROCESS | 7061 | 22:59:12 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:44774/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44774/tests/dromaeo/cssquery-prototype.html) 22:59:13 INFO - PROCESS | 7061 | RSS: Main: 213344256 22:59:13 INFO - PROCESS | 7061 | 23:02:15 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:44774/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44774/tests/dromaeo/cssquery-yui.html) 23:02:16 INFO - PROCESS | 7061 | RSS: Main: 213037056 23:02:16 INFO - PROCESS | 7061 | 23:05:18 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:44774/tests/dromaeo/cssquery-yui.html (next: http://localhost:44774/tests/dromaeo/cssquery-dojo.html) 23:05:18 INFO - PROCESS | 7061 | RSS: Main: 278761472 23:05:18 INFO - PROCESS | 7061 | 23:05:18 INFO - PROCESS | 7061 | __start_tp_report 23:05:18 INFO - PROCESS | 7061 | _x_x_mozilla_page_load 23:05:18 INFO - PROCESS | 7061 | _x_x_mozilla_page_load_details 23:05:18 INFO - PROCESS | 7061 | |i|pagename|runs| 23:05:18 INFO - PROCESS | 7061 | |0;dojo.html;3132.624085109787;3150.6691797361264;3192.3296107817373;3201.823899685518;3223.306988997365;4923.58149557288;5067.189249720045;5105.591552675786;5130.358705161855;5168.896622067561;5044.82343117991;5074.213496907985;5077.33994580704;5088.414832294287;5133.3839939207255;4631.351610774503;4657.254839225725;4675.462321832982;4694.812207511695;4755.595774359183;4660.883477913046;4675.485696573374;4702.3416721659;4715.669903106784;4727.409073865767;4593.311003349491;4603.654725895572;4657.27812189113;4687.086018226447;4687.835925742583;4683.320918466803;4689.320048592935;4700.106979673851;4706.176419126673;4718.150732868083;4644.071185762828;4645.605123564501;4659.4175728034;4664.370310008139;4694.882627934329;4875.293082503053;4882.829100981484;4934.383202099738;4941.431735350445;4985.800567977277;5450.509454149106;5459.672419654833;5466.535344495723;5469.726513674301;5471.151971444432;5503;5505.091659876116;5525.060739674225;5526.115821468546;5535.197396377503;5042.924356134661;5075.87310317245;5120.052790233819;5121.487851214886;5147.305113809588;5543.057680194376;5546.417626149197;5551.1673249012165;5556.611037227436;5591.776328946797;5358.490943360374;5364.1417373220875;5364.275822763877;5366.463353664681;5369.4362091980565;5337.2794672719465;5401.378841433207;5430.049741295257;5501.064818980783;5553.1670249462095;5430.0768869292315;5440.782368705208;5442.102053161263;5443.59173062014;5451.400345961941;5367.060764366221;5380.91928621071;5430.875255704929;5431.375391829911;5488.835334939959;4244.087521182961;4260.084081922401;4264.232438161161;4272.893177670521;4312.741235525878;3809.961900381016;3814.8664796731982;3821.560520540118;3829.119302560371;3847.8653247136217;5029.446760856303;5071.264666623393;5092.745362731923;5095.643304968691;5140.023395554833;5340.626156169109;5369.221462887937;5418.539424148991;5429.6742195467605;5443.727813609304;5073.568746656501;5083.415407228142;5083.87290317745;5088.313077734459;5098.490150984871;4663.743494107856;4669.766511674403;4672.836450724276;4700.858974230779;4715.504871988461;5509.953108909374;5562.3881373048935;5593.440655934455;5601.355844077902;5674.06377947634;5384.730763461889;5394.298741163623;5416.674999500043;5428;5434.619576629598;5587.441255874543;5602.187682786055;5603.943960560342;5605.131204663284;5659.9151012735665;5346.705931173823;5500.42245564226;5501.229827824028;5504.091824848855;5507.284053073075;5482.862928426821;5496.5053145217125;5521.917171242515;5523.005858945267;5523.254360661259;5387.191921211849;5390.811321603725;5397.86505337354;5400;5404.243405923095;5286.444923283154;5378.462153784591;5385.0037743017665;5390.353157621111;5422.783088676409;5219.869503262449;5220.895582088261;5223.164293712987;5230.189320655304;5232.3459567554055;5282.286891269783;5313.3889602694635;5326.520613144836;5344.25180474726;5367.597430192829;5171.767270472763;5176.637635365639;5219.451957544403;5221.921671175011;5267.631265811357 23:05:18 INFO - PROCESS | 7061 | |1;ext.html;519.7713006277238;537.1942086869695;540.5729473715764;552.4503119396202;554.6173140533033;27331.31671708208;28027.15918522445;28035.85982070092;35907;36155.63844361556;38831.805840970825;39253.411198832044;39345.80327098368;39385.40921886174;39427.40858887112;8317.958410207955;8529.445586036918;8529.701460448885;8530.23227909488;8533.189347012056;8390.83218335633;8508.191721786452;8529.317654587618;8543.658253669877;8546.70086546971;8534.957325213396;8620.525871077089;8629.741107766777;8631.525266110362;8632.913670863274;8495.787605309886;8550.914490855137;8572.099929507374;8578.270846978014;8594.656213751443;8440.28257598105;8582.442141260799;8598.957005214934;8599.785005374853;8603.569821508961;39335;39805.20389592192;39843.60156398457;39849.60150398488;39853.40219896704;3280.803151810899;3443.276911848515;3826.349520581508;3837.2901013312626;3894.2600905827803;30139.246518836986;30271.848640756656;30327;30368.84815575908;31917.8404107978;4038.1318016626565;4038.414429907647;4044.1911617676287;4110.527289361732;4238;266884;267222;267582;269184.999999998;269598;56288;56420.43579564152;56420.71789641026;56608.71695641495;56765.43234567684;54757.72621136869;55509;55509.72245138829;61159.02466339674;61845.38154618396;14368.353424095942;14848.480303189337;15039.924800376148;15060.171690556905;15069.623259418602;11207.103431725442;11257.493412796444;11261.605843795427;11288.153388495732;11288.2662626929;17173.055481948362;17571;19131.713024304645;19435.3197638082;19557.131262230494;7034.472414568928;7174.784756457315;7250.854982900312;7271.091113610799;7322.633868306563;928.4197376639601;966.2415004221652;1012.9746756331151;1038.8857225705167;1043.9716878874303;28094.85952570224;28196.85901570479;28441.43117137646;28470.288242794097;28583.428331433253;1003.9046290602381;1008.5108722269694;1033.8604288420968;1035.052926572178;1089.7493576477455;13722;13941.512047078304;13985.510507132405;14092.718145637029;14139;315382;319470;319472;320743;320745;49352.25971610429;49841.50158498441;49865.50134498681;49870.501294986585;49893.501064989614;1294.449858810002;1324.8542660307357;1326.270551196838;1329.554599209237;1356.572679605921;25305;26353.20940371792;26425.471490570464;26503.60244596294;26511.734882651697;42915.785421072695;42957.785211073744;43050;43244;43273.56726432696;313321;314897;315348;315651;315836;26868.865655671598;29740.405191896472;30963.84518077395;31004.844975774977;31020.379592408477;31057.53413698751;40252.1949561013;40354;40384.59615403926;41324.58675413208;34338.31323373569;35254.64745352514;35327.47008794819;35551.288974220886;35827;31202.375952481278;31773.682263177998;31859.840700796347;31969.200769980005;32032;31624.683753162175;34492.482612761334;34529.165916772174;34563.65436345705;34568.82715586406;28291.2927176814;31125.682405660813;31218.21954451066;31544.36911261716;31580.210494737814;23538.176163834185;23546.175883843982;23709.824521183436;23819.404514887265;23992.40018999539 23:05:18 INFO - PROCESS | 7061 | |2;jquery.html;361.34235691042295;365.50291603419345;366.3972764801901;366.57843479998;373.23673088533945;13466.25935573543;13871.30643467825;14827.258637068144;16163.75754363684;17451.56371090722;15489.457868974589;15564.766528502054;16751.83248167518;16833.494995150133;16838.242279097438;5024.497550244982;5407.351117865842;5412.431694672062;5415.702136382497;5416.404195538487;3913.6673382762356;3999.5800440953717;5270.209468579706;5348.277982472375;5695.943040569603;5827.1550625159325;5838.328592211908;5890.793822216223;5891.263592050994;5891.911621325684;5649.12438572022;5833.649981001154;5845.444682755132;5845.649261044329;5846.415358464141;5067.594592432597;5142.4600416956055;5174.172132458826;5180.585553155738;5203.271541984125;18955.545446819986;19134;19199.424017279503;19798.109085091062;19825.008749562607;2191.1454532732246;2249.347689170139;2297.3337732057685;2476.0838489758726;2491.364702000996;12547.93726031364;12659.810102848372;12869.613911582668;12890.226586404846;12898.161619494796;1696.465613331809;1714.9828501714949;1736.3315123677348;1777.7333399989975;1862.078271255737;53335.466645333436;54951.450485495036;55485.72257138729;55842.44157558413;55842.44157558413;9419.62321507132;9522.14300712939;9731.075547822946;9756.146332197002;9849.852252216222;12538.561150359694;12560.748785024249;12597.93701031489;12630.747385052247;12722.300273485047;6690.698918548677;6976.372126508639;6979.93020069803;6995.825104372431;7041.823954401181;6583.144191255106;6613.5370524062855;6656.101426307483;6662.267150613428;6681.398674119353;4287.6998610097;4300.956990430118;4371.366151907955;4384.8903777405185;4405.933910991338;1705.8550023247915;1727.6890159771363;1745.5636090977255;1770.4246120011048;1805.4854366505483;411.2330503610804;444.739827201091;445.9955400445954;459.59555591079635;846.627483907079;8842.778930526789;10190.439525826003;10270.486475676187;10282.537285822156;10543.42011189392;443.32835753832967;455.19885002396023;464.01628547478884;475.9071980963679;479.7697105389433;5880.500157486576;5913.935491611551;5981.102834574848;6015.0676645120075;6025.66858822769;343615;461612;469524;511487;534008;61597;62660.686696567136;64278;64799;65453.672731636034;1062.8352605346183;1070.347088276151;1076.8869268726828;1102.8786833448314;1103.1340397787699;14480.203588802717;14531.636709082357;14655.120692758468;15102;15853.128077955824;29989.850050749606;30158;31761.84119079482;32310.19224519406;34292.314153717285;38481.42277865778;38969.80515097406;39773.801130995314;39964;40113;6817.454603631797;7135.643217838983;7258.129024517092;7315.780526584211;7385.261473852572;10205;10832.837507437553;11053.778924421627;11130.888691113309;11336.036436902956;8721.825563488821;9317.11487408695;9335.533223338942;9376.156145946898;9379.296552758708;8790.077041910763;9073.50095744714;9166.587503562223;9244.676436324697;9584;3254.9837250813594;3262.5921759780026;7065.258147894397;8770.473771573726;9346.766330841783;8947.418417802823;9735.513224338612;9912.35569687968;9974.501274936369;10342.5345859435;9790.608375665179;9817.31278810505;9909.355891867006;9935.155511781579;10411.739706507095 23:05:18 INFO - PROCESS | 7061 | |3;mootools.html;1319.6041187643705;1408.704172123854;1435.11740279728;1535.9692806143878;1744.8429641332286;6929.480288978321;7543.245675432454;7545.396368290537;7626.466147369686;7657.693692252317;7438.962805185966;7484.101907771062;7521.247875212476;7529.247075292468;7541.622918854063;2023.271622216001;2069.3378119001927;2274.5109801392696;2318.107528601484;2318.988405057972;2295.2081531871477;2348.342464110052;2358.1392791631015;2359.457324815285;2361.197192954395;2305.4236440889777;2309.8960546775434;2331.8367714260007;2341.812654987597;2344.109238489372;2320.5938960681897;2340.941476463085;2344.460774021976;2350.471143992605;2356.2577787996725;2310.1567927706433;2333.719953605578;2344.5779759643256;2345.6598793175067;2359.1624973134462;7721.498102623312;7752.534847909087;7757.612119394008;7764.417668674872;7765.728199513046;4661.207594708873;4755.476897541268;4785.641076919245;4791.592714619262;4795;3050.4814181588963;3061.433634777551;3120.422721796475;3132.3265497918055;3204.3591281743743;985.7042887133831;1012.8278192707257;1018.8420794776821;1046.7644779924533;1062.5802807890839;10265.230107741874;10393;10411.115055220316;10416.947915260374;10428.478576071166;4344.109457561192;4368.584984426474;4393.1872603568445;4481.3726078349055;4540.500544940054;9108.772280692903;9197.080291970884;9228.077192280853;9235.492047937429;9240.537973101318;4983.103041452501;4985.252212168204;4985.302057711923;4985.975070124626;4993.625478089158;4475.373447717322;4526.140033393644;4526.569975852289;4546.704464209815;4549.476810166873;3512.8946131616094;3595.5146055282726;3639.6542328478754;3710.220853620716;3807.904802379963;1206.4028305988593;1207.082617210926;1220.0605533738972;1232.6610182199968;1246.1401632873287;963.8843338799248;979.2508730820928;991.1971303244395;1083.4041277297456;1336.6858788184768;7335.339819416172;7355.485116041933;7376.7786966391095;7387.741429050065;7392.519486233377;1173.4015652017533;1176.647005898227;1204.235310577772;1210.842590463234;1225.3689349984766;5481.12302031681;5561.416051314634;5574.442555744393;5580.19087232349;5581;8992.055834137453;9176.03651616584;9310.441373517611;9314.720558383124;9356.06439356059;9074.773130671654;9124.0419755926;9184.90815091854;9204.585793639302;9206.401583897024;7036.331548502884;7282.526635768764;7391.2239214881665;7392.926070739331;7409.444291678145;7009.719611215494;7069.363757261871;7129.893051604334;7148.499605027599;7157.284271572801;8312.459690120122;8380.16198380157;8464.915350846413;8476.533790641573;8491.83016339682;8617.095205003385;8684.522351270742;8831.955840220759;8834;8846.292296616384;7081.858362832611;7176.569405835667;7203.747868824566;7206.315400036988;7211.6033618151505;6837.965810171117;6981.441484681111;7162.64186790648;7300.598467084362;7317.743878964211;6823.931760682528;6946.131733533309;6994.300569942965;7027.894581581382;7080.4335653148655;6884.93115068863;6899.275576064641;6907.930920690729;6923.861522769617;6928.930710692828;6773.390394864486;6778.288279730557;6783.830404239933;6798;6824.385805277549;6156.384361563808;6372.171617689671;6372.617642941438;6373.458256048288;6396.520260980352;6525;6576.704048317933;6592.044153597797;6702.430293425114;6712.429443497357 23:05:18 INFO - PROCESS | 7061 | |4;prototype.html;332.8964482739718;333.2501870790721;337.5813990651593;340.2259858821182;344.767282084593;5565.2486914266565;5710.828675139742;5739;5753.223314852499;5761.279840019997;5521.917171242435;5629.971850140754;5639.520640745532;5639.7180140993;5648.265725455695;4391.604755571998;4430.734155950653;4436.489803672586;4442.711223770445;4485.573870482299;4264.722793018459;4358.542353052915;4366.737995720267;4476.709013914102;4485.461744590653;4439.356293337464;4451.198784218839;4454.665900057493;4459.44256967879;4470.910581788378;4423.823047078113;4441.75570343631;4447.799849006802;4451.310046942713;4468.463784345883;3908.1597456546697;3941.4679018332445;3947.407888816672;3948.58539853317;3950.0322421007036;5325.147976323769;5445.292112025451;5452.154915988028;5455.536279416255;5463;5151.639385243035;5166.225066240057;5166.302549155891;5168.715720635363;5172.094883395391;5996.940030599725;6037.969810150965;6040.395960403968;6040.939590604082;6046.3349031606485;4366.781660916941;4367.6069153776;4368.060866913629;4371.584699453547;4373.409589705381;5882.823515294548;6030.09548567714;6233.407826256498;6332.335104813974;6337.144485494446;4471.32930060487;4474.082813023322;4474.597286244254;4475.932861007088;4477.574630410106;4531.184386810406;4536.432945881765;4538.909221815546;4539.251023581072;4546.272596384562;5149.871253218625;5164.92252616211;5165.251038599457;5168.198929165986;5169.715665638426;5962.07587823888;6124.6325220486915;6126.050462178369;6128.63228206309;6129.233845769279;1583.2637823411937;1613.9751257951286;1614.507575189555;1615.967680646404;1616.1999810093844;1079.881213066562;1086.163653986442;1088.8693356797235;1091.0998426298336;1097.0510508410168;5775.047117225695;5777.19119323295;5777.88444231113;5779.046457334577;5782.6819524925695;6034.215551978303;6165.075238714228;6234.625922444668;6238.968805156036;6241.812745617639;5679.914801277984;5778.624389414675;5784.334801497882;5801.245838041112;5832;3343.8328083595725;3349.5143204235737;3355.8489867955514;3372.6458721834347;3381.9154521136675;6340.397662222082;6473.579217350857;6481.351864813481;6481.384268494579;6489.545731798823;6470;6470.126532917996;6481.611103333721;6481.805545833632;6484.157059582224;6392.584482008655;6464.967675161688;6475.255345635218;6481.611103333815;6493.967530162319;6150.231221097363;6210.285817130907;6256.655883926428;6261.68691565429;6295.150154729236;6172.783952561639;6192.256929168529;6210.5031597473;6214.067889816383;6229.781957631642;6434;6442.2591401989375;6442.935570644234;6444.033394990789;6449;4508.413906192305;4512.255477846119;4516.751578663205;4517.75152366623;4521.638268938543;6181.998751210772;6226.62640241587;6284.088807123033;6297.874042519215;6310.085037669604;6126.540509461897;6137.508999280136;6138.140660307471;6145.907811382922;6148.661823599745;6063.969680151571;6082.300535438481;6083.057126145454;6085.269767627913;6089.786857459968;5835.591508594358;5950.19672344228;5996.490298324691;6030.487408570145;6045.516358691382;6114.816555503342;6121.632702037892;6171.413715697002;6183.3816618337805;6232.688365581794;5994.790182343597;6021.367756385516;6027.939720602913;6031.939680603138;6037.547183961133 23:05:18 INFO - PROCESS | 7061 | |5;yui.html;756.7767508584968;822.0031752469226;822.1449692319987;837.0708513549962;882.1795729971128;12680.365981700925;12886.677833054155;12926.353682315894;12953.481860725571;12979.091463597551;12474.376281185927;12528.874711252885;12538.749225015494;12551.05867059972;12558.748825023495;646.3245908026124;659.1595715462776;789.1831953927687;803.8432505661399;807.5275963561323;797.1669605262515;818.0960039156736;818.443458448258;818.7912082418975;819.5082950229844;842.0442797424936;846.6740304982565;848.4569875279826;849.049065047145;854.8546747053016;702.1258533126265;712.4976891291627;825.108882406999;844.9227235275043;848.9193526614962;616.3589866538795;618.904069869171;620.5935112501319;621.1273161208509;621.9067139929001;13285;13371.398287077105;13374.531891383853;13384.799228011587;13389.799153012713;11224.158188135842;11264;11354.716132096764;11403.771924561544;11493;9718.951405242928;9996.55015524296;10008.799824003552;10070.546825392876;10332.741681457948;3440.6559344065645;3514.2444374459615;3530.1704099536587;3538.274653695986;3546.060294022086;48182.27726584104;48387.51612483865;49106.263406048936;49145.754271228776;49396;9378.67174648884;9378.859317110113;9452.054794520493;9591.520423978913;9729.075737804897;16991.83008169927;17070.829291706923;17180.140992950302;17198.570035749206;17212.397566085376;6994.510384273154;7214.170370407471;7247.746328878464;7254.492185546961;7323.780286591411;3852.3836186210633;3900.531936167678;3929.7052721046034;3958.148997965394;3958.44581758554;3062.7856050076725;3083.352495975825;3086.8147911125407;3087.428825667259;3090.644575873758;559.2059275828334;571.9542436605145;575.706389741235;575.7294071786254;579.322193034151;518.8183243060867;546.5054126015882;574.8562859285179;585.7569108819793;701.1340993872564;7796.298333150044;8289.958550207331;8315.875261871077;8381.664733410595;8440.493570385797;522.2688236468974;611.7338957553478;620.8478922663976;620.9161763162006;650.5738741124571;3867.2652196082654;4100.897477563025;4198.895027624334;4200;4311.267084595626;53907.19139212836;54021.45978540243;54545.72727136339;55329.723351382985;55402.72298638481;47724;47985.760071199424;48290.27564586534;49052.509474905506;49139.262911056365;43708;43759.78120109379;43772.3434148488;43954.120917582106;44391.55608443939;8224.588770561568;8274.834503310021;8317.667293308199;8429.283510901641;8845.601947912231;31491.685083148874;31945;32701.836490817393;34815.303693926486;34938;41907;41927.58072419237;42767.786161068994;42783.14433711371;43365.34951975786;9947.602095916372;10098.646547370807;10439.112675422673;10713.303635263683;10756.677299681021;11632.917276921791;11911.285322880654;11980.820287695866;12192.817107743214;12216.633500994983;10663.573457061631;10855.348679079281;11000.559977601126;11144.387058711849;11313;11169;11487.36819474937;11704.473298701409;11774.470148843151;11782.469788859693;9086.273098152;10940.12479001662;10974.670759877217;11123.944380278046;11511.654650360502;6152.78465253714;9318.394304370466;9394.530273486162;9722;9790.363626364264;8897.688580899638;9082.40964337316;9300.906990930003;9932.702018939442;10049.346792458467 23:05:18 INFO - PROCESS | 7061 | __end_tp_report 23:05:18 INFO - PROCESS | 7061 | __start_cc_report 23:05:18 INFO - PROCESS | 7061 | _x_x_mozilla_cycle_collect,1535 23:05:18 INFO - PROCESS | 7061 | __end_cc_report 23:05:18 INFO - PROCESS | 7061 | __startTimestamp1453273518930__endTimestamp 23:05:18 INFO - PROCESS | 7061 | 23:05:18 INFO - PROCESS | 7061 | ------- Summary: start ------- 23:05:18 INFO - PROCESS | 7061 | Number of tests: 6 23:05:18 INFO - PROCESS | 7061 | 23:05:18 INFO - PROCESS | 7061 | [#0] dojo.html Cycles:165 Average:5074.01 Median:5230.19 stddev:531.88 (10.2%) stddev-sans-first:511.25 23:05:18 INFO - PROCESS | 7061 | Values: 3132.6 3150.7 3192.3 3201.8 3223.3 4923.6 5067.2 5105.6 5130.4 5168.9 5044.8 5074.2 5077.3 5088.4 5133.4 4631.4 4657.3 4675.5 4694.8 4755.6 4660.9 4675.5 4702.3 4715.7 4727.4 4593.3 4603.7 4657.3 4687.1 4687.8 4683.3 4689.3 4700.1 4706.2 4718.2 4644.1 4645.6 4659.4 4664.4 4694.9 4875.3 4882.8 4934.4 4941.4 4985.8 5450.5 5459.7 5466.5 5469.7 5471.2 5503.0 5505.1 5525.1 5526.1 5535.2 5042.9 5075.9 5120.1 5121.5 5147.3 5543.1 5546.4 5551.2 5556.6 5591.8 5358.5 5364.1 5364.3 5366.5 5369.4 5337.3 5401.4 5430.0 5501.1 5553.2 5430.1 5440.8 5442.1 5443.6 5451.4 5367.1 5380.9 5430.9 5431.4 5488.8 4244.1 4260.1 4264.2 4272.9 4312.7 3810.0 3814.9 3821.6 3829.1 3847.9 5029.4 5071.3 5092.7 5095.6 5140.0 5340.6 5369.2 5418.5 5429.7 5443.7 5073.6 5083.4 5083.9 5088.3 5098.5 4663.7 4669.8 4672.8 4700.9 4715.5 5510.0 5562.4 5593.4 5601.4 5674.1 5384.7 5394.3 5416.7 5428.0 5434.6 5587.4 5602.2 5603.9 5605.1 5659.9 5346.7 5500.4 5501.2 5504.1 5507.3 5482.9 5496.5 5521.9 5523.0 5523.3 5387.2 5390.8 5397.9 5400.0 5404.2 5286.4 5378.5 5385.0 5390.4 5422.8 5219.9 5220.9 5223.2 5230.2 5232.3 5282.3 5313.4 5326.5 5344.3 5367.6 5171.8 5176.6 5219.5 5221.9 5267.6 23:05:18 INFO - PROCESS | 7061 | 23:05:18 INFO - PROCESS | 7061 | [#1] ext.html Cycles:180 Average:45804.45 Median:18967.88 stddev:79015.51 (416.6%) stddev-sans-first:79164.01 23:05:18 INFO - PROCESS | 7061 | Values: 519.8 537.2 540.6 552.5 554.6 27331.3 28027.2 28035.9 35907.0 36155.6 38831.8 39253.4 39345.8 39385.4 39427.4 8318.0 8529.4 8529.7 8530.2 8533.2 8390.8 8508.2 8529.3 8543.7 8546.7 8535.0 8620.5 8629.7 8631.5 8632.9 8495.8 8550.9 8572.1 8578.3 8594.7 8440.3 8582.4 8599.0 8599.8 8603.6 39335.0 39805.2 39843.6 39849.6 39853.4 3280.8 3443.3 3826.3 3837.3 3894.3 30139.2 30271.8 30327.0 30368.8 31917.8 4038.1 4038.4 4044.2 4110.5 4238.0 266884.0 267222.0 267582.0 269185.0 269598.0 56288.0 56420.4 56420.7 56608.7 56765.4 54757.7 55509.0 55509.7 61159.0 61845.4 14368.4 14848.5 15039.9 15060.2 15069.6 11207.1 11257.5 11261.6 11288.2 11288.3 17173.1 17571.0 19131.7 19435.3 19557.1 7034.5 7174.8 7250.9 7271.1 7322.6 928.4 966.2 1013.0 1038.9 1044.0 28094.9 28196.9 28441.4 28470.3 28583.4 1003.9 1008.5 1033.9 1035.1 1089.7 13722.0 13941.5 13985.5 14092.7 14139.0 315382.0 319470.0 319472.0 320743.0 320745.0 49352.3 49841.5 49865.5 49870.5 49893.5 1294.4 1324.9 1326.3 1329.6 1356.6 25305.0 26353.2 26425.5 26503.6 26511.7 42915.8 42957.8 43050.0 43244.0 43273.6 313321.0 314897.0 315348.0 315651.0 315836.0 26868.9 29740.4 30963.8 31004.8 31020.4 31057.5 40252.2 40354.0 40384.6 41324.6 34338.3 35254.6 35327.5 35551.3 35827.0 31202.4 31773.7 31859.8 31969.2 32032.0 31624.7 34492.5 34529.2 34563.7 34568.8 28291.3 31125.7 31218.2 31544.4 31580.2 23538.2 23546.2 23709.8 23819.4 23992.4 23:05:18 INFO - PROCESS | 7061 | 23:05:18 INFO - PROCESS | 7061 | [#2] jquery.html Cycles:180 Average:24629.24 Median:457.40 stddev:76591.53 (16745.1%) stddev-sans-first:76784.71 23:05:18 INFO - PROCESS | 7061 | Values: 361.3 365.5 366.4 366.6 373.2 13466.3 13871.3 14827.3 16163.8 17451.6 15489.5 15564.8 16751.8 16833.5 16838.2 5024.5 5407.4 5412.4 5415.7 5416.4 3913.7 3999.6 5270.2 5348.3 5695.9 5827.2 5838.3 5890.8 5891.3 5891.9 5649.1 5833.6 5845.4 5845.6 5846.4 5067.6 5142.5 5174.2 5180.6 5203.3 18955.5 19134.0 19199.4 19798.1 19825.0 2191.1 2249.3 2297.3 2476.1 2491.4 12547.9 12659.8 12869.6 12890.2 12898.2 1696.5 1715.0 1736.3 1777.7 1862.1 53335.5 54951.5 55485.7 55842.4 55842.4 9419.6 9522.1 9731.1 9756.1 9849.9 12538.6 12560.7 12597.9 12630.7 12722.3 6690.7 6976.4 6979.9 6995.8 7041.8 6583.1 6613.5 6656.1 6662.3 6681.4 4287.7 4301.0 4371.4 4384.9 4405.9 1705.9 1727.7 1745.6 1770.4 1805.5 411.2 444.7 446.0 459.6 846.6 8842.8 10190.4 10270.5 10282.5 10543.4 443.3 455.2 464.0 475.9 479.8 5880.5 5913.9 5981.1 6015.1 6025.7 343615.0 461612.0 469524.0 511487.0 534008.0 61597.0 62660.7 64278.0 64799.0 65453.7 1062.8 1070.3 1076.9 1102.9 1103.1 14480.2 14531.6 14655.1 15102.0 15853.1 29989.9 30158.0 31761.8 32310.2 34292.3 38481.4 38969.8 39773.8 39964.0 40113.0 6817.5 7135.6 7258.1 7315.8 7385.3 10205.0 10832.8 11053.8 11130.9 11336.0 8721.8 9317.1 9335.5 9376.2 9379.3 8790.1 9073.5 9166.6 9244.7 9584.0 3255.0 3262.6 7065.3 8770.5 9346.8 8947.4 9735.5 9912.4 9974.5 10342.5 9790.6 9817.3 9909.4 9935.2 10411.7 23:05:18 INFO - PROCESS | 7061 | 23:05:18 INFO - PROCESS | 7061 | [#3] mootools.html Cycles:180 Average:5448.78 Median:6460.76 stddev:2772.21 (42.9%) stddev-sans-first:2762.61 23:05:18 INFO - PROCESS | 7061 | Values: 1319.6 1408.7 1435.1 1536.0 1744.8 6929.5 7543.2 7545.4 7626.5 7657.7 7439.0 7484.1 7521.2 7529.2 7541.6 2023.3 2069.3 2274.5 2318.1 2319.0 2295.2 2348.3 2358.1 2359.5 2361.2 2305.4 2309.9 2331.8 2341.8 2344.1 2320.6 2340.9 2344.5 2350.5 2356.3 2310.2 2333.7 2344.6 2345.7 2359.2 7721.5 7752.5 7757.6 7764.4 7765.7 4661.2 4755.5 4785.6 4791.6 4795.0 3050.5 3061.4 3120.4 3132.3 3204.4 985.7 1012.8 1018.8 1046.8 1062.6 10265.2 10393.0 10411.1 10416.9 10428.5 4344.1 4368.6 4393.2 4481.4 4540.5 9108.8 9197.1 9228.1 9235.5 9240.5 4983.1 4985.3 4985.3 4986.0 4993.6 4475.4 4526.1 4526.6 4546.7 4549.5 3512.9 3595.5 3639.7 3710.2 3807.9 1206.4 1207.1 1220.1 1232.7 1246.1 963.9 979.3 991.2 1083.4 1336.7 7335.3 7355.5 7376.8 7387.7 7392.5 1173.4 1176.6 1204.2 1210.8 1225.4 5481.1 5561.4 5574.4 5580.2 5581.0 8992.1 9176.0 9310.4 9314.7 9356.1 9074.8 9124.0 9184.9 9204.6 9206.4 7036.3 7282.5 7391.2 7392.9 7409.4 7009.7 7069.4 7129.9 7148.5 7157.3 8312.5 8380.2 8464.9 8476.5 8491.8 8617.1 8684.5 8832.0 8834.0 8846.3 7081.9 7176.6 7203.7 7206.3 7211.6 6838.0 6981.4 7162.6 7300.6 7317.7 6823.9 6946.1 6994.3 7027.9 7080.4 6884.9 6899.3 6907.9 6923.9 6928.9 6773.4 6778.3 6783.8 6798.0 6824.4 6156.4 6372.2 6372.6 6373.5 6396.5 6525.0 6576.7 6592.0 6702.4 6712.4 23:05:18 INFO - PROCESS | 7061 | 23:05:18 INFO - PROCESS | 7061 | [#4] prototype.html Cycles:180 Average:5110.57 Median:5768.16 stddev:1500.73 (26.0%) stddev-sans-first:1461.47 23:05:18 INFO - PROCESS | 7061 | Values: 332.9 333.3 337.6 340.2 344.8 5565.2 5710.8 5739.0 5753.2 5761.3 5521.9 5630.0 5639.5 5639.7 5648.3 4391.6 4430.7 4436.5 4442.7 4485.6 4264.7 4358.5 4366.7 4476.7 4485.5 4439.4 4451.2 4454.7 4459.4 4470.9 4423.8 4441.8 4447.8 4451.3 4468.5 3908.2 3941.5 3947.4 3948.6 3950.0 5325.1 5445.3 5452.2 5455.5 5463.0 5151.6 5166.2 5166.3 5168.7 5172.1 5996.9 6038.0 6040.4 6040.9 6046.3 4366.8 4367.6 4368.1 4371.6 4373.4 5882.8 6030.1 6233.4 6332.3 6337.1 4471.3 4474.1 4474.6 4475.9 4477.6 4531.2 4536.4 4538.9 4539.3 4546.3 5149.9 5164.9 5165.3 5168.2 5169.7 5962.1 6124.6 6126.1 6128.6 6129.2 1583.3 1614.0 1614.5 1616.0 1616.2 1079.9 1086.2 1088.9 1091.1 1097.1 5775.0 5777.2 5777.9 5779.0 5782.7 6034.2 6165.1 6234.6 6239.0 6241.8 5679.9 5778.6 5784.3 5801.2 5832.0 3343.8 3349.5 3355.8 3372.6 3381.9 6340.4 6473.6 6481.4 6481.4 6489.5 6470.0 6470.1 6481.6 6481.8 6484.2 6392.6 6465.0 6475.3 6481.6 6494.0 6150.2 6210.3 6256.7 6261.7 6295.2 6172.8 6192.3 6210.5 6214.1 6229.8 6434.0 6442.3 6442.9 6444.0 6449.0 4508.4 4512.3 4516.8 4517.8 4521.6 6182.0 6226.6 6284.1 6297.9 6310.1 6126.5 6137.5 6138.1 6145.9 6148.7 6064.0 6082.3 6083.1 6085.3 6089.8 5835.6 5950.2 5996.5 6030.5 6045.5 6114.8 6121.6 6171.4 6183.4 6232.7 5994.8 6021.4 6027.9 6031.9 6037.5 23:05:18 INFO - PROCESS | 7061 | 23:05:18 INFO - PROCESS | 7061 | [#5] yui.html Cycles:180 Average:13257.99 Median:48338.90 stddev:15309.55 (31.7%) stddev-sans-first:15323.71 23:05:18 INFO - PROCESS | 7061 | Values: 756.8 822.0 822.1 837.1 882.2 12680.4 12886.7 12926.4 12953.5 12979.1 12474.4 12528.9 12538.7 12551.1 12558.7 646.3 659.2 789.2 803.8 807.5 797.2 818.1 818.4 818.8 819.5 842.0 846.7 848.5 849.0 854.9 702.1 712.5 825.1 844.9 848.9 616.4 618.9 620.6 621.1 621.9 13285.0 13371.4 13374.5 13384.8 13389.8 11224.2 11264.0 11354.7 11403.8 11493.0 9719.0 9996.6 10008.8 10070.5 10332.7 3440.7 3514.2 3530.2 3538.3 3546.1 48182.3 48387.5 49106.3 49145.8 49396.0 9378.7 9378.9 9452.1 9591.5 9729.1 16991.8 17070.8 17180.1 17198.6 17212.4 6994.5 7214.2 7247.7 7254.5 7323.8 3852.4 3900.5 3929.7 3958.1 3958.4 3062.8 3083.4 3086.8 3087.4 3090.6 559.2 572.0 575.7 575.7 579.3 518.8 546.5 574.9 585.8 701.1 7796.3 8290.0 8315.9 8381.7 8440.5 522.3 611.7 620.8 620.9 650.6 3867.3 4100.9 4198.9 4200.0 4311.3 53907.2 54021.5 54545.7 55329.7 55402.7 47724.0 47985.8 48290.3 49052.5 49139.3 43708.0 43759.8 43772.3 43954.1 44391.6 8224.6 8274.8 8317.7 8429.3 8845.6 31491.7 31945.0 32701.8 34815.3 34938.0 41907.0 41927.6 42767.8 42783.1 43365.3 9947.6 10098.6 10439.1 10713.3 10756.7 11632.9 11911.3 11980.8 12192.8 12216.6 10663.6 10855.3 11000.6 11144.4 11313.0 11169.0 11487.4 11704.5 11774.5 11782.5 9086.3 10940.1 10974.7 11123.9 11511.7 6152.8 9318.4 9394.5 9722.0 9790.4 8897.7 9082.4 9300.9 9932.7 10049.3 23:05:18 INFO - PROCESS | 7061 | -------- Summary: end -------- 23:05:18 INFO - PROCESS | 7061 | 23:05:19 INFO - TEST-INFO | 7061: exit 0 23:05:19 INFO - TEST-OK | dromaeo_css | took 1112599ms 23:05:19 INFO - TEST-START | kraken 23:05:19 INFO - operating with platform_type : linux_ 23:05:19 INFO - Initialising browser for kraken test... 23:05:19 INFO - TEST-INFO | started process 7258 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5BKdGj/profile http://localhost:44774/getInfo.html) 23:05:23 INFO - PROCESS | 7258 | __metrics Screen width/height:1600/1200 23:05:23 INFO - PROCESS | 7258 | colorDepth:24 23:05:23 INFO - PROCESS | 7258 | Browser inner width/height: 1024/697 23:05:23 INFO - PROCESS | 7258 | __metrics 23:05:23 INFO - PROCESS | 7258 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:05:23 INFO - PROCESS | 7258 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:05:24 INFO - TEST-INFO | 7258: exit 0 23:05:24 INFO - Browser initialized. 23:05:24 INFO - Running cycle 1/1 for kraken test... 23:05:24 INFO - TEST-INFO | started process 7345 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5BKdGj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:05:36 INFO - PROCESS | 7345 | RSS: Main: 149712896 23:05:36 INFO - PROCESS | 7345 | 23:05:38 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44774/tests/kraken/driver.html?testName=audio-beat-detection) 23:05:39 INFO - PROCESS | 7345 | RSS: Main: 187023360 23:05:39 INFO - PROCESS | 7345 | 23:05:41 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44774/tests/kraken/driver.html?testName=audio-dft) 23:05:42 INFO - PROCESS | 7345 | RSS: Main: 178380800 23:05:42 INFO - PROCESS | 7345 | 23:05:45 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44774/tests/kraken/driver.html?testName=audio-fft) 23:05:45 INFO - PROCESS | 7345 | RSS: Main: 162451456 23:05:45 INFO - PROCESS | 7345 | 23:05:47 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44774/tests/kraken/driver.html?testName=audio-oscillator) 23:05:48 INFO - PROCESS | 7345 | RSS: Main: 164552704 23:05:48 INFO - PROCESS | 7345 | 23:05:50 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44774/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:05:51 INFO - PROCESS | 7345 | RSS: Main: 166244352 23:05:51 INFO - PROCESS | 7345 | 23:05:54 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44774/tests/kraken/driver.html?testName=imaging-darkroom) 23:05:54 INFO - PROCESS | 7345 | RSS: Main: 165257216 23:05:54 INFO - PROCESS | 7345 | 23:05:58 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44774/tests/kraken/driver.html?testName=imaging-desaturate) 23:05:58 INFO - PROCESS | 7345 | RSS: Main: 166645760 23:05:58 INFO - PROCESS | 7345 | 23:06:01 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44774/tests/kraken/driver.html?testName=json-parse-financial) 23:06:02 INFO - PROCESS | 7345 | RSS: Main: 165974016 23:06:02 INFO - PROCESS | 7345 | 23:06:03 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44774/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:06:04 INFO - PROCESS | 7345 | RSS: Main: 177836032 23:06:04 INFO - PROCESS | 7345 | 23:06:05 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44774/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:06:06 INFO - PROCESS | 7345 | RSS: Main: 174661632 23:06:06 INFO - PROCESS | 7345 | 23:06:08 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44774/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:06:09 INFO - PROCESS | 7345 | RSS: Main: 185946112 23:06:09 INFO - PROCESS | 7345 | 23:06:11 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:06:12 INFO - PROCESS | 7345 | RSS: Main: 194379776 23:06:12 INFO - PROCESS | 7345 | 23:06:14 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:06:15 INFO - PROCESS | 7345 | RSS: Main: 190976000 23:06:15 INFO - PROCESS | 7345 | 23:06:16 INFO - PROCESS | 7345 | Cycle 1(1): loaded http://localhost:44774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44774/tests/kraken/driver.html?testName=ai-astar) 23:06:17 INFO - PROCESS | 7345 | RSS: Main: 248700928 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | __start_tp_report 23:06:17 INFO - PROCESS | 7345 | _x_x_mozilla_page_load 23:06:17 INFO - PROCESS | 7345 | _x_x_mozilla_page_load_details 23:06:17 INFO - PROCESS | 7345 | |i|pagename|runs| 23:06:17 INFO - PROCESS | 7345 | |0;ai-astar;112;111;106;110;110;111;112;111;104;111 23:06:17 INFO - PROCESS | 7345 | |1;audio-beat-detection;158;129;150;165;125;156;153;127;165;126 23:06:17 INFO - PROCESS | 7345 | |2;audio-dft;161;161;163;160;160;161;160;159;160;161 23:06:17 INFO - PROCESS | 7345 | |3;audio-fft;76;76;97;98;73;73;73;112;99;74 23:06:17 INFO - PROCESS | 7345 | |4;audio-oscillator;96;96;137;95;95;96;143;96;95;140 23:06:17 INFO - PROCESS | 7345 | |5;imaging-gaussian-blur;109;109;109;109;109;110;110;109;109;109 23:06:17 INFO - PROCESS | 7345 | |6;imaging-darkroom;147;145;145;145;145;146;145;145;146;145 23:06:17 INFO - PROCESS | 7345 | |7;imaging-desaturate;96;96;96;97;96;96;95;96;96;96 23:06:17 INFO - PROCESS | 7345 | |8;json-parse-financial;59;57;57;57;57;58;58;58;56;55 23:06:17 INFO - PROCESS | 7345 | |9;json-stringify-tinderbox;69;70;69;70;69;69;69;68;69;69 23:06:17 INFO - PROCESS | 7345 | |10;stanford-crypto-aes;80;87;82;83;84;81;81;81;81;82 23:06:17 INFO - PROCESS | 7345 | |11;stanford-crypto-ccm;120;116;114;130;112;113;113;123;119;114 23:06:17 INFO - PROCESS | 7345 | |12;stanford-crypto-pbkdf2;144;134;142;142;143;132;144;157;141;153 23:06:17 INFO - PROCESS | 7345 | |13;stanford-crypto-sha256-iterative;67;66;69;67;65;66;68;66;66;68 23:06:17 INFO - PROCESS | 7345 | __end_tp_report 23:06:17 INFO - PROCESS | 7345 | __start_cc_report 23:06:17 INFO - PROCESS | 7345 | _x_x_mozilla_cycle_collect,925 23:06:17 INFO - PROCESS | 7345 | __end_cc_report 23:06:17 INFO - PROCESS | 7345 | __startTimestamp1453273577138__endTimestamp 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | ------- Summary: start ------- 23:06:17 INFO - PROCESS | 7345 | Number of tests: 14 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:2.66 (2.4%) stddev-sans-first:2.70 23:06:17 INFO - PROCESS | 7345 | Values: 112.0 111.0 106.0 110.0 110.0 111.0 112.0 111.0 104.0 111.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:154.50 stddev:16.73 (10.8%) stddev-sans-first:17.11 23:06:17 INFO - PROCESS | 7345 | Values: 158.0 129.0 150.0 165.0 125.0 156.0 153.0 127.0 165.0 126.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 23:06:17 INFO - PROCESS | 7345 | Values: 161.0 161.0 163.0 160.0 160.0 161.0 160.0 159.0 160.0 161.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#3] audio-fft Cycles:10 Average:85.10 Median:76.00 stddev:14.73 (19.4%) stddev-sans-first:15.25 23:06:17 INFO - PROCESS | 7345 | Values: 76.0 76.0 97.0 98.0 73.0 73.0 73.0 112.0 99.0 74.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:95.50 stddev:21.51 (22.5%) stddev-sans-first:22.30 23:06:17 INFO - PROCESS | 7345 | Values: 96.0 96.0 137.0 95.0 95.0 96.0 143.0 96.0 95.0 140.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:06:17 INFO - PROCESS | 7345 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.44 23:06:17 INFO - PROCESS | 7345 | Values: 147.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 23:06:17 INFO - PROCESS | 7345 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 95.0 96.0 96.0 96.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:1.14 (2.0%) stddev-sans-first:1.00 23:06:17 INFO - PROCESS | 7345 | Values: 59.0 57.0 57.0 57.0 57.0 58.0 58.0 58.0 56.0 55.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 23:06:17 INFO - PROCESS | 7345 | Values: 69.0 70.0 69.0 70.0 69.0 69.0 69.0 68.0 69.0 69.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:2.04 (2.5%) stddev-sans-first:2.01 23:06:17 INFO - PROCESS | 7345 | Values: 80.0 87.0 82.0 83.0 84.0 81.0 81.0 81.0 81.0 82.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:117.50 stddev:5.70 (4.9%) stddev-sans-first:5.97 23:06:17 INFO - PROCESS | 7345 | Values: 120.0 116.0 114.0 130.0 112.0 113.0 113.0 123.0 119.0 114.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:143.50 stddev:7.50 (5.2%) stddev-sans-first:7.94 23:06:17 INFO - PROCESS | 7345 | Values: 144.0 134.0 142.0 142.0 143.0 132.0 144.0 157.0 141.0 153.0 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - PROCESS | 7345 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 23:06:17 INFO - PROCESS | 7345 | Values: 67.0 66.0 69.0 67.0 65.0 66.0 68.0 66.0 66.0 68.0 23:06:17 INFO - PROCESS | 7345 | -------- Summary: end -------- 23:06:17 INFO - PROCESS | 7345 | 23:06:17 INFO - TEST-INFO | 7345: exit 0 23:06:18 INFO - TEST-OK | kraken | took 58447ms 23:06:18 INFO - TEST-START | v8_7 23:06:18 INFO - operating with platform_type : linux_ 23:06:18 INFO - Initialising browser for v8_7 test... 23:06:18 INFO - TEST-INFO | started process 7593 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkN8XGx/profile http://localhost:44774/getInfo.html) 23:06:21 INFO - PROCESS | 7593 | __metrics Screen width/height:1600/1200 23:06:21 INFO - PROCESS | 7593 | colorDepth:24 23:06:21 INFO - PROCESS | 7593 | Browser inner width/height: 1024/697 23:06:21 INFO - PROCESS | 7593 | __metrics 23:06:21 INFO - PROCESS | 7593 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:06:21 INFO - PROCESS | 7593 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:06:22 INFO - TEST-INFO | 7593: exit 0 23:06:22 INFO - Browser initialized. 23:06:22 INFO - Running cycle 1/1 for v8_7 test... 23:06:22 INFO - TEST-INFO | started process 7673 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkN8XGx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:06:34 INFO - PROCESS | 7673 | RSS: Main: 149786624 23:06:34 INFO - PROCESS | 7673 | 23:06:56 INFO - PROCESS | 7673 | Cycle 1(1): loaded http://localhost:44774/tests/v8_7/run.html (next: http://localhost:44774/tests/v8_7/run.html) 23:06:57 INFO - PROCESS | 7673 | RSS: Main: 553922560 23:06:57 INFO - PROCESS | 7673 | 23:06:57 INFO - PROCESS | 7673 | __start_tp_report 23:06:57 INFO - PROCESS | 7673 | _x_x_mozilla_page_load 23:06:57 INFO - PROCESS | 7673 | _x_x_mozilla_page_load_details 23:06:57 INFO - PROCESS | 7673 | |i|pagename|runs| 23:06:57 INFO - PROCESS | 7673 | |0;Richards;169.4053870913095 23:06:57 INFO - PROCESS | 7673 | |1;DeltaBlue;189.3939393939394 23:06:57 INFO - PROCESS | 7673 | |2;Encrypt;278.8622420524261 23:06:57 INFO - PROCESS | 7673 | |3;Decrypt;5175.257731958763 23:06:57 INFO - PROCESS | 7673 | |4;RayTrace;1116.0714285714287 23:06:57 INFO - PROCESS | 7673 | |5;Earley;793.0214115781126 23:06:57 INFO - PROCESS | 7673 | |6;Boyer;12048.192771084337 23:06:57 INFO - PROCESS | 7673 | |7;RegExp;43936.17021276596 23:06:57 INFO - PROCESS | 7673 | |8;Splay;586.3477246207701 23:06:57 INFO - PROCESS | 7673 | |9;NavierStokes;4822.115384615385 23:06:57 INFO - PROCESS | 7673 | __end_tp_report 23:06:57 INFO - PROCESS | 7673 | __startTimestamp1453273617207__endTimestamp 23:06:57 INFO - PROCESS | 7673 | 23:06:57 INFO - PROCESS | 7673 | ------- Summary: start ------- 23:06:57 INFO - PROCESS | 7673 | Number of tests: 10 23:06:57 INFO - PROCESS | 7673 | 23:06:57 INFO - PROCESS | 7673 | [#0] Richards Cycles:1 Average:169.41 Median:169.41 stddev:0.00 (0.0%) 23:06:57 INFO - PROCESS | 7673 | Values: 169.4 23:06:57 INFO - PROCESS | 7673 | 23:06:57 INFO - PROCESS | 7673 | [#1] DeltaBlue Cycles:1 Average:189.39 Median:189.39 stddev:0.00 (0.0%) 23:06:57 INFO - PROCESS | 7673 | Values: 189.4 23:06:57 INFO - PROCESS | 7673 | 23:06:57 INFO - PROCESS | 7673 | [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 23:06:57 INFO - PROCESS | 7673 | Values: 278.9 23:06:57 INFO - PROCESS | 7673 | 23:06:57 INFO - PROCESS | 7673 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 23:06:57 INFO - PROCESS | 7673 | Values: 5175.3 23:06:57 INFO - PROCESS | 7673 | 23:06:57 INFO - PROCESS | 7673 | [#4] RayTrace Cycles:1 Average:1116.07 Median:1116.07 stddev:0.00 (0.0%) 23:06:57 INFO - PROCESS | 7673 | Values: 1116.1 23:06:57 INFO - PROCESS | 7673 | 23:06:57 INFO - PROCESS | 7673 | [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 23:06:57 INFO - PROCESS | 7673 | Values: 793.0 23:06:57 INFO - PROCESS | 7673 | 23:06:57 INFO - PROCESS | 7673 | [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 23:06:57 INFO - PROCESS | 7673 | Values: 12048.2 23:06:57 INFO - PROCESS | 7673 | 23:06:57 INFO - PROCESS | 7673 | [#7] RegExp Cycles:1 Average:43936.17 Median:43936.17 stddev:0.00 (0.0%) 23:06:57 INFO - PROCESS | 7673 | Values: 43936.2 23:06:57 INFO - PROCESS | 7673 | 23:06:57 INFO - PROCESS | 7673 | [#8] Splay Cycles:1 Average:586.35 Median:586.35 stddev:0.00 (0.0%) 23:06:57 INFO - PROCESS | 7673 | Values: 586.3 23:06:57 INFO - PROCESS | 7673 | 23:06:57 INFO - PROCESS | 7673 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 23:06:57 INFO - PROCESS | 7673 | Values: 4822.1 23:06:57 INFO - PROCESS | 7673 | -------- Summary: end -------- 23:06:57 INFO - PROCESS | 7673 | 23:06:58 INFO - TEST-INFO | 7673: exit 0 23:06:58 INFO - TEST-OK | v8_7 | took 40065ms 23:06:58 INFO - SUITE-END | took 1211s 23:06:58 INFO - Completed test suite (00:20:11) 23:06:58 INFO - Working with test: dromaeo_css 23:06:58 INFO - Generating results file: dromaeo_css 23:06:58 INFO - Working with test: kraken 23:06:58 INFO - Generating results file: kraken 23:06:58 INFO - javascript benchmark 23:06:58 INFO - Working with test: v8_7 23:06:58 INFO - Generating results file: v8_7 23:06:58 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:06:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:06:58 INFO - process_Request line: dromaeo_css 6639.17 graph.html#tests=[[72,201,35]] 23:06:58 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:06:58 INFO - process_Request line: kraken 1496.30 graph.html#tests=[[232,201,35]] 23:06:58 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:06:58 INFO - process_Request line: v8_7 20017.06 graph.html#tests=[[230,201,35]] 23:06:58 INFO - RETURN: dromaeo_css: 6639.17 23:06:58 INFO - RETURN: kraken: 1496.30 23:06:58 INFO - RETURN: v8_7: 20017.06 23:06:58 INFO - javascript benchmark 23:06:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3132.624085109787, 3150.6691797361264, 3192.3296107817373, 3201.823899685518, 3223.306988997365, 4923.58149557288, 5067.189249720045, 5105.591552675786, 5130.358705161855, 5168.896622067561, 5044.82343117991, 5074.213496907985, 5077.33994580704, 5088.414832294287, 5133.3839939207255, 4631.351610774503, 4657.254839225725, 4675.462321832982, 4694.812207511695, 4755.595774359183, 4660.883477913046, 4675.485696573374, 4702.3416721659, 4715.669903106784, 4727.409073865767, 4593.311003349491, 4603.654725895572, 4657.27812189113, 4687.086018226447, 4687.835925742583, 4683.320918466803, 4689.320048592935, 4700.106979673851, 4706.176419126673, 4718.150732868083, 4644.071185762828, 4645.605123564501, 4659.4175728034, 4664.370310008139, 4694.882627934329, 4875.293082503053, 4882.829100981484, 4934.383202099738, 4941.431735350445, 4985.800567977277, 5450.509454149106, 5459.672419654833, 5466.535344495723, 5469.726513674301, 5471.151971444432, 5503.0, 5505.091659876116, 5525.060739674225, 5526.115821468546, 5535.197396377503, 5042.924356134661, 5075.87310317245, 5120.052790233819, 5121.487851214886, 5147.305113809588, 5543.057680194376, 5546.417626149197, 5551.1673249012165, 5556.611037227436, 5591.776328946797, 5358.490943360374, 5364.1417373220875, 5364.275822763877, 5366.463353664681, 5369.4362091980565, 5337.2794672719465, 5401.378841433207, 5430.049741295257, 5501.064818980783, 5553.1670249462095, 5430.0768869292315, 5440.782368705208, 5442.102053161263, 5443.59173062014, 5451.400345961941, 5367.060764366221, 5380.91928621071, 5430.875255704929, 5431.375391829911, 5488.835334939959, 4244.087521182961, 4260.084081922401, 4264.232438161161, 4272.893177670521, 4312.741235525878, 3809.961900381016, 3814.8664796731982, 3821.560520540118, 3829.119302560371, 3847.8653247136217, 5029.446760856303, 5071.264666623393, 5092.745362731923, 5095.643304968691, 5140.023395554833, 5340.626156169109, 5369.221462887937, 5418.539424148991, 5429.6742195467605, 5443.727813609304, 5073.568746656501, 5083.415407228142, 5083.87290317745, 5088.313077734459, 5098.490150984871, 4663.743494107856, 4669.766511674403, 4672.836450724276, 4700.858974230779, 4715.504871988461, 5509.953108909374, 5562.3881373048935, 5593.440655934455, 5601.355844077902, 5674.06377947634, 5384.730763461889, 5394.298741163623, 5416.674999500043, 5428.0, 5434.619576629598, 5587.441255874543, 5602.187682786055, 5603.943960560342, 5605.131204663284, 5659.9151012735665, 5346.705931173823, 5500.42245564226, 5501.229827824028, 5504.091824848855, 5507.284053073075, 5482.862928426821, 5496.5053145217125, 5521.917171242515, 5523.005858945267, 5523.254360661259, 5387.191921211849, 5390.811321603725, 5397.86505337354, 5400.0, 5404.243405923095, 5286.444923283154, 5378.462153784591, 5385.0037743017665, 5390.353157621111, 5422.783088676409, 5219.869503262449, 5220.895582088261, 5223.164293712987, 5230.189320655304, 5232.3459567554055, 5282.286891269783, 5313.3889602694635, 5326.520613144836, 5344.25180474726, 5367.597430192829, 5171.767270472763, 5176.637635365639, 5219.451957544403, 5221.921671175011, 5267.631265811357], "unit": "score", "name": "dojo.html", "value": 5041.845634117375}, {"lowerIsBetter": false, "replicates": [519.7713006277238, 537.1942086869695, 540.5729473715764, 552.4503119396202, 554.6173140533033, 27331.31671708208, 28027.15918522445, 28035.85982070092, 35907.0, 36155.63844361556, 38831.805840970825, 39253.411198832044, 39345.80327098368, 39385.40921886174, 39427.40858887112, 8317.958410207955, 8529.445586036918, 8529.701460448885, 8530.23227909488, 8533.189347012056, 8390.83218335633, 8508.191721786452, 8529.317654587618, 8543.658253669877, 8546.70086546971, 8534.957325213396, 8620.525871077089, 8629.741107766777, 8631.525266110362, 8632.913670863274, 8495.787605309886, 8550.914490855137, 8572.099929507374, 8578.270846978014, 8594.656213751443, 8440.28257598105, 8582.442141260799, 8598.957005214934, 8599.785005374853, 8603.569821508961, 39335.0, 39805.20389592192, 39843.60156398457, 39849.60150398488, 39853.40219896704, 3280.803151810899, 3443.276911848515, 3826.349520581508, 3837.2901013312626, 3894.2600905827803, 30139.246518836986, 30271.848640756656, 30327.0, 30368.84815575908, 31917.8404107978, 4038.1318016626565, 4038.414429907647, 4044.1911617676287, 4110.527289361732, 4238.0, 266884.0, 267222.0, 267582.0, 269184.999999998, 269598.0, 56288.0, 56420.43579564152, 56420.71789641026, 56608.71695641495, 56765.43234567684, 54757.72621136869, 55509.0, 55509.72245138829, 61159.02466339674, 61845.38154618396, 14368.353424095942, 14848.480303189337, 15039.924800376148, 15060.171690556905, 15069.623259418602, 11207.103431725442, 11257.493412796444, 11261.605843795427, 11288.153388495732, 11288.2662626929, 17173.055481948362, 17571.0, 19131.713024304645, 19435.3197638082, 19557.131262230494, 7034.472414568928, 7174.784756457315, 7250.854982900312, 7271.091113610799, 7322.633868306563, 928.4197376639601, 966.2415004221652, 1012.9746756331151, 1038.8857225705167, 1043.9716878874303, 28094.85952570224, 28196.85901570479, 28441.43117137646, 28470.288242794097, 28583.428331433253, 1003.9046290602381, 1008.5108722269694, 1033.8604288420968, 1035.052926572178, 1089.7493576477455, 13722.0, 13941.512047078304, 13985.510507132405, 14092.718145637029, 14139.0, 315382.0, 319470.0, 319472.0, 320743.0, 320745.0, 49352.25971610429, 49841.50158498441, 49865.50134498681, 49870.501294986585, 49893.501064989614, 1294.449858810002, 1324.8542660307357, 1326.270551196838, 1329.554599209237, 1356.572679605921, 25305.0, 26353.20940371792, 26425.471490570464, 26503.60244596294, 26511.734882651697, 42915.785421072695, 42957.785211073744, 43050.0, 43244.0, 43273.56726432696, 313321.0, 314897.0, 315348.0, 315651.0, 315836.0, 26868.865655671598, 29740.405191896472, 30963.84518077395, 31004.844975774977, 31020.379592408477, 31057.53413698751, 40252.1949561013, 40354.0, 40384.59615403926, 41324.58675413208, 34338.31323373569, 35254.64745352514, 35327.47008794819, 35551.288974220886, 35827.0, 31202.375952481278, 31773.682263177998, 31859.840700796347, 31969.200769980005, 32032.0, 31624.683753162175, 34492.482612761334, 34529.165916772174, 34563.65436345705, 34568.82715586406, 28291.2927176814, 31125.682405660813, 31218.21954451066, 31544.36911261716, 31580.210494737814, 23538.176163834185, 23546.175883843982, 23709.824521183436, 23819.404514887265, 23992.40018999539], "unit": "score", "name": "ext.html", "value": 17812.967600201446}, {"lowerIsBetter": false, "replicates": [361.34235691042295, 365.50291603419345, 366.3972764801901, 366.57843479998, 373.23673088533945, 13466.25935573543, 13871.30643467825, 14827.258637068144, 16163.75754363684, 17451.56371090722, 15489.457868974589, 15564.766528502054, 16751.83248167518, 16833.494995150133, 16838.242279097438, 5024.497550244982, 5407.351117865842, 5412.431694672062, 5415.702136382497, 5416.404195538487, 3913.6673382762356, 3999.5800440953717, 5270.209468579706, 5348.277982472375, 5695.943040569603, 5827.1550625159325, 5838.328592211908, 5890.793822216223, 5891.263592050994, 5891.911621325684, 5649.12438572022, 5833.649981001154, 5845.444682755132, 5845.649261044329, 5846.415358464141, 5067.594592432597, 5142.4600416956055, 5174.172132458826, 5180.585553155738, 5203.271541984125, 18955.545446819986, 19134.0, 19199.424017279503, 19798.109085091062, 19825.008749562607, 2191.1454532732246, 2249.347689170139, 2297.3337732057685, 2476.0838489758726, 2491.364702000996, 12547.93726031364, 12659.810102848372, 12869.613911582668, 12890.226586404846, 12898.161619494796, 1696.465613331809, 1714.9828501714949, 1736.3315123677348, 1777.7333399989975, 1862.078271255737, 53335.466645333436, 54951.450485495036, 55485.72257138729, 55842.44157558413, 55842.44157558413, 9419.62321507132, 9522.14300712939, 9731.075547822946, 9756.146332197002, 9849.852252216222, 12538.561150359694, 12560.748785024249, 12597.93701031489, 12630.747385052247, 12722.300273485047, 6690.698918548677, 6976.372126508639, 6979.93020069803, 6995.825104372431, 7041.823954401181, 6583.144191255106, 6613.5370524062855, 6656.101426307483, 6662.267150613428, 6681.398674119353, 4287.6998610097, 4300.956990430118, 4371.366151907955, 4384.8903777405185, 4405.933910991338, 1705.8550023247915, 1727.6890159771363, 1745.5636090977255, 1770.4246120011048, 1805.4854366505483, 411.2330503610804, 444.739827201091, 445.9955400445954, 459.59555591079635, 846.627483907079, 8842.778930526789, 10190.439525826003, 10270.486475676187, 10282.537285822156, 10543.42011189392, 443.32835753832967, 455.19885002396023, 464.01628547478884, 475.9071980963679, 479.7697105389433, 5880.500157486576, 5913.935491611551, 5981.102834574848, 6015.0676645120075, 6025.66858822769, 343615.0, 461612.0, 469524.0, 511487.0, 534008.0, 61597.0, 62660.686696567136, 64278.0, 64799.0, 65453.672731636034, 1062.8352605346183, 1070.347088276151, 1076.8869268726828, 1102.8786833448314, 1103.1340397787699, 14480.203588802717, 14531.636709082357, 14655.120692758468, 15102.0, 15853.128077955824, 29989.850050749606, 30158.0, 31761.84119079482, 32310.19224519406, 34292.314153717285, 38481.42277865778, 38969.80515097406, 39773.801130995314, 39964.0, 40113.0, 6817.454603631797, 7135.643217838983, 7258.129024517092, 7315.780526584211, 7385.261473852572, 10205.0, 10832.837507437553, 11053.778924421627, 11130.888691113309, 11336.036436902956, 8721.825563488821, 9317.11487408695, 9335.533223338942, 9376.156145946898, 9379.296552758708, 8790.077041910763, 9073.50095744714, 9166.587503562223, 9244.676436324697, 9584.0, 3254.9837250813594, 3262.5921759780026, 7065.258147894397, 8770.473771573726, 9346.766330841783, 8947.418417802823, 9735.513224338612, 9912.35569687968, 9974.501274936369, 10342.5345859435, 9790.608375665179, 9817.31278810505, 9909.355891867006, 9935.155511781579, 10411.739706507095], "unit": "score", "name": "jquery.html", "value": 7521.423082394776}, {"lowerIsBetter": false, "replicates": [1319.6041187643705, 1408.704172123854, 1435.11740279728, 1535.9692806143878, 1744.8429641332286, 6929.480288978321, 7543.245675432454, 7545.396368290537, 7626.466147369686, 7657.693692252317, 7438.962805185966, 7484.101907771062, 7521.247875212476, 7529.247075292468, 7541.622918854063, 2023.271622216001, 2069.3378119001927, 2274.5109801392696, 2318.107528601484, 2318.988405057972, 2295.2081531871477, 2348.342464110052, 2358.1392791631015, 2359.457324815285, 2361.197192954395, 2305.4236440889777, 2309.8960546775434, 2331.8367714260007, 2341.812654987597, 2344.109238489372, 2320.5938960681897, 2340.941476463085, 2344.460774021976, 2350.471143992605, 2356.2577787996725, 2310.1567927706433, 2333.719953605578, 2344.5779759643256, 2345.6598793175067, 2359.1624973134462, 7721.498102623312, 7752.534847909087, 7757.612119394008, 7764.417668674872, 7765.728199513046, 4661.207594708873, 4755.476897541268, 4785.641076919245, 4791.592714619262, 4795.0, 3050.4814181588963, 3061.433634777551, 3120.422721796475, 3132.3265497918055, 3204.3591281743743, 985.7042887133831, 1012.8278192707257, 1018.8420794776821, 1046.7644779924533, 1062.5802807890839, 10265.230107741874, 10393.0, 10411.115055220316, 10416.947915260374, 10428.478576071166, 4344.109457561192, 4368.584984426474, 4393.1872603568445, 4481.3726078349055, 4540.500544940054, 9108.772280692903, 9197.080291970884, 9228.077192280853, 9235.492047937429, 9240.537973101318, 4983.103041452501, 4985.252212168204, 4985.302057711923, 4985.975070124626, 4993.625478089158, 4475.373447717322, 4526.140033393644, 4526.569975852289, 4546.704464209815, 4549.476810166873, 3512.8946131616094, 3595.5146055282726, 3639.6542328478754, 3710.220853620716, 3807.904802379963, 1206.4028305988593, 1207.082617210926, 1220.0605533738972, 1232.6610182199968, 1246.1401632873287, 963.8843338799248, 979.2508730820928, 991.1971303244395, 1083.4041277297456, 1336.6858788184768, 7335.339819416172, 7355.485116041933, 7376.7786966391095, 7387.741429050065, 7392.519486233377, 1173.4015652017533, 1176.647005898227, 1204.235310577772, 1210.842590463234, 1225.3689349984766, 5481.12302031681, 5561.416051314634, 5574.442555744393, 5580.19087232349, 5581.0, 8992.055834137453, 9176.03651616584, 9310.441373517611, 9314.720558383124, 9356.06439356059, 9074.773130671654, 9124.0419755926, 9184.90815091854, 9204.585793639302, 9206.401583897024, 7036.331548502884, 7282.526635768764, 7391.2239214881665, 7392.926070739331, 7409.444291678145, 7009.719611215494, 7069.363757261871, 7129.893051604334, 7148.499605027599, 7157.284271572801, 8312.459690120122, 8380.16198380157, 8464.915350846413, 8476.533790641573, 8491.83016339682, 8617.095205003385, 8684.522351270742, 8831.955840220759, 8834.0, 8846.292296616384, 7081.858362832611, 7176.569405835667, 7203.747868824566, 7206.315400036988, 7211.6033618151505, 6837.965810171117, 6981.441484681111, 7162.64186790648, 7300.598467084362, 7317.743878964211, 6823.931760682528, 6946.131733533309, 6994.300569942965, 7027.894581581382, 7080.4335653148655, 6884.93115068863, 6899.275576064641, 6907.930920690729, 6923.861522769617, 6928.930710692828, 6773.390394864486, 6778.288279730557, 6783.830404239933, 6798.0, 6824.385805277549, 6156.384361563808, 6372.171617689671, 6372.617642941438, 6373.458256048288, 6396.520260980352, 6525.0, 6576.704048317933, 6592.044153597797, 6702.430293425114, 6712.429443497357], "unit": "score", "name": "mootools.html", "value": 4500.381074676314}, {"lowerIsBetter": false, "replicates": [332.8964482739718, 333.2501870790721, 337.5813990651593, 340.2259858821182, 344.767282084593, 5565.2486914266565, 5710.828675139742, 5739.0, 5753.223314852499, 5761.279840019997, 5521.917171242435, 5629.971850140754, 5639.520640745532, 5639.7180140993, 5648.265725455695, 4391.604755571998, 4430.734155950653, 4436.489803672586, 4442.711223770445, 4485.573870482299, 4264.722793018459, 4358.542353052915, 4366.737995720267, 4476.709013914102, 4485.461744590653, 4439.356293337464, 4451.198784218839, 4454.665900057493, 4459.44256967879, 4470.910581788378, 4423.823047078113, 4441.75570343631, 4447.799849006802, 4451.310046942713, 4468.463784345883, 3908.1597456546697, 3941.4679018332445, 3947.407888816672, 3948.58539853317, 3950.0322421007036, 5325.147976323769, 5445.292112025451, 5452.154915988028, 5455.536279416255, 5463.0, 5151.639385243035, 5166.225066240057, 5166.302549155891, 5168.715720635363, 5172.094883395391, 5996.940030599725, 6037.969810150965, 6040.395960403968, 6040.939590604082, 6046.3349031606485, 4366.781660916941, 4367.6069153776, 4368.060866913629, 4371.584699453547, 4373.409589705381, 5882.823515294548, 6030.09548567714, 6233.407826256498, 6332.335104813974, 6337.144485494446, 4471.32930060487, 4474.082813023322, 4474.597286244254, 4475.932861007088, 4477.574630410106, 4531.184386810406, 4536.432945881765, 4538.909221815546, 4539.251023581072, 4546.272596384562, 5149.871253218625, 5164.92252616211, 5165.251038599457, 5168.198929165986, 5169.715665638426, 5962.07587823888, 6124.6325220486915, 6126.050462178369, 6128.63228206309, 6129.233845769279, 1583.2637823411937, 1613.9751257951286, 1614.507575189555, 1615.967680646404, 1616.1999810093844, 1079.881213066562, 1086.163653986442, 1088.8693356797235, 1091.0998426298336, 1097.0510508410168, 5775.047117225695, 5777.19119323295, 5777.88444231113, 5779.046457334577, 5782.6819524925695, 6034.215551978303, 6165.075238714228, 6234.625922444668, 6238.968805156036, 6241.812745617639, 5679.914801277984, 5778.624389414675, 5784.334801497882, 5801.245838041112, 5832.0, 3343.8328083595725, 3349.5143204235737, 3355.8489867955514, 3372.6458721834347, 3381.9154521136675, 6340.397662222082, 6473.579217350857, 6481.351864813481, 6481.384268494579, 6489.545731798823, 6470.0, 6470.126532917996, 6481.611103333721, 6481.805545833632, 6484.157059582224, 6392.584482008655, 6464.967675161688, 6475.255345635218, 6481.611103333815, 6493.967530162319, 6150.231221097363, 6210.285817130907, 6256.655883926428, 6261.68691565429, 6295.150154729236, 6172.783952561639, 6192.256929168529, 6210.5031597473, 6214.067889816383, 6229.781957631642, 6434.0, 6442.2591401989375, 6442.935570644234, 6444.033394990789, 6449.0, 4508.413906192305, 4512.255477846119, 4516.751578663205, 4517.75152366623, 4521.638268938543, 6181.998751210772, 6226.62640241587, 6284.088807123033, 6297.874042519215, 6310.085037669604, 6126.540509461897, 6137.508999280136, 6138.140660307471, 6145.907811382922, 6148.661823599745, 6063.969680151571, 6082.300535438481, 6083.057126145454, 6085.269767627913, 6089.786857459968, 5835.591508594358, 5950.19672344228, 5996.490298324691, 6030.487408570145, 6045.516358691382, 6114.816555503342, 6121.632702037892, 6171.413715697002, 6183.3816618337805, 6232.688365581794, 5994.790182343597, 6021.367756385516, 6027.939720602913, 6031.939680603138, 6037.547183961133], "unit": "score", "name": "prototype.html", "value": 4630.657750593696}, {"lowerIsBetter": false, "replicates": [756.7767508584968, 822.0031752469226, 822.1449692319987, 837.0708513549962, 882.1795729971128, 12680.365981700925, 12886.677833054155, 12926.353682315894, 12953.481860725571, 12979.091463597551, 12474.376281185927, 12528.874711252885, 12538.749225015494, 12551.05867059972, 12558.748825023495, 646.3245908026124, 659.1595715462776, 789.1831953927687, 803.8432505661399, 807.5275963561323, 797.1669605262515, 818.0960039156736, 818.443458448258, 818.7912082418975, 819.5082950229844, 842.0442797424936, 846.6740304982565, 848.4569875279826, 849.049065047145, 854.8546747053016, 702.1258533126265, 712.4976891291627, 825.108882406999, 844.9227235275043, 848.9193526614962, 616.3589866538795, 618.904069869171, 620.5935112501319, 621.1273161208509, 621.9067139929001, 13285.0, 13371.398287077105, 13374.531891383853, 13384.799228011587, 13389.799153012713, 11224.158188135842, 11264.0, 11354.716132096764, 11403.771924561544, 11493.0, 9718.951405242928, 9996.55015524296, 10008.799824003552, 10070.546825392876, 10332.741681457948, 3440.6559344065645, 3514.2444374459615, 3530.1704099536587, 3538.274653695986, 3546.060294022086, 48182.27726584104, 48387.51612483865, 49106.263406048936, 49145.754271228776, 49396.0, 9378.67174648884, 9378.859317110113, 9452.054794520493, 9591.520423978913, 9729.075737804897, 16991.83008169927, 17070.829291706923, 17180.140992950302, 17198.570035749206, 17212.397566085376, 6994.510384273154, 7214.170370407471, 7247.746328878464, 7254.492185546961, 7323.780286591411, 3852.3836186210633, 3900.531936167678, 3929.7052721046034, 3958.148997965394, 3958.44581758554, 3062.7856050076725, 3083.352495975825, 3086.8147911125407, 3087.428825667259, 3090.644575873758, 559.2059275828334, 571.9542436605145, 575.706389741235, 575.7294071786254, 579.322193034151, 518.8183243060867, 546.5054126015882, 574.8562859285179, 585.7569108819793, 701.1340993872564, 7796.298333150044, 8289.958550207331, 8315.875261871077, 8381.664733410595, 8440.493570385797, 522.2688236468974, 611.7338957553478, 620.8478922663976, 620.9161763162006, 650.5738741124571, 3867.2652196082654, 4100.897477563025, 4198.895027624334, 4200.0, 4311.267084595626, 53907.19139212836, 54021.45978540243, 54545.72727136339, 55329.723351382985, 55402.72298638481, 47724.0, 47985.760071199424, 48290.27564586534, 49052.509474905506, 49139.262911056365, 43708.0, 43759.78120109379, 43772.3434148488, 43954.120917582106, 44391.55608443939, 8224.588770561568, 8274.834503310021, 8317.667293308199, 8429.283510901641, 8845.601947912231, 31491.685083148874, 31945.0, 32701.836490817393, 34815.303693926486, 34938.0, 41907.0, 41927.58072419237, 42767.786161068994, 42783.14433711371, 43365.34951975786, 9947.602095916372, 10098.646547370807, 10439.112675422673, 10713.303635263683, 10756.677299681021, 11632.917276921791, 11911.285322880654, 11980.820287695866, 12192.817107743214, 12216.633500994983, 10663.573457061631, 10855.348679079281, 11000.559977601126, 11144.387058711849, 11313.0, 11169.0, 11487.36819474937, 11704.473298701409, 11774.470148843151, 11782.469788859693, 9086.273098152, 10940.12479001662, 10974.670759877217, 11123.944380278046, 11511.654650360502, 6152.78465253714, 9318.394304370466, 9394.530273486162, 9722.0, 9790.363626364264, 8897.688580899638, 9082.40964337316, 9300.906990930003, 9932.702018939442, 10049.346792458467], "unit": "score", "name": "yui.html", "value": 6083.130551392218}], "name": "dromaeo_css", "value": 6639.169144474589}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 106.0, 110.0, 110.0, 111.0, 112.0, 111.0, 104.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [158.0, 129.0, 150.0, 165.0, 125.0, 156.0, 153.0, 127.0, 165.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 160.0, 160.0, 161.0, 160.0, 159.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 97.0, 98.0, 73.0, 73.0, 73.0, 112.0, 99.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 137.0, 95.0, 95.0, 96.0, 143.0, 96.0, 95.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 57.0, 57.0, 57.0, 58.0, 58.0, 58.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 70.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [80.0, 87.0, 82.0, 83.0, 84.0, 81.0, 81.0, 81.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 114.0, 130.0, 112.0, 113.0, 113.0, 123.0, 119.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.4}, {"lowerIsBetter": true, "replicates": [144.0, 134.0, 142.0, 142.0, 143.0, 132.0, 144.0, 157.0, 141.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 69.0, 67.0, 65.0, 66.0, 68.0, 66.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1496.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.4053870913095], "unit": "score", "name": "Richards", "value": 208.38770599999992}, {"lowerIsBetter": false, "replicates": [189.3939393939394], "unit": "score", "name": "DeltaBlue", "value": 349.1030400000001}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1116.0714285714287], "unit": "score", "name": "RayTrace", "value": 663.0301440000001}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [43936.17021276596], "unit": "score", "name": "RegExp", "value": 20.734283292978194}, {"lowerIsBetter": false, "replicates": [586.3477246207701], "unit": "score", "name": "Splay", "value": 138.98067064676613}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20017.064583195646}]} 23:06:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20017.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1496.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6639.17"}}} 23:06:58 INFO - Return code: 0 23:06:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:06:58 INFO - # TBPL SUCCESS # 23:06:58 INFO - Running post-action listener: _resource_record_post_action 23:06:58 INFO - Running post-run listener: _resource_record_post_run 23:06:59 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 561229824; Read time: 0; Write time: 596368 23:06:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 237608960; Read time: 0; Write time: 308624 23:06:59 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 302784512; Read time: 0; Write time: 241268 23:06:59 INFO - Running post-run listener: _upload_blobber_files 23:06:59 INFO - Blob upload gear active. 23:06:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:06:59 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:06:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:06:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:07:00 INFO - (blobuploader) - INFO - Open directory for files ... 23:07:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:07:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:07:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:07:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:07:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:07:01 INFO - (blobuploader) - INFO - Done attempting. 23:07:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:07:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:07:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:07:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:07:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:07:01 INFO - (blobuploader) - INFO - Done attempting. 23:07:01 INFO - (blobuploader) - INFO - Iteration through files over. 23:07:01 INFO - Return code: 0 23:07:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:07:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:07:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e1d567b845d928e8b2b0297a462e710330da39bf75e00b34aef4925365a7334b8a6efd64f3843bd4c652b1a0d8d198f7078b338ea55f65343e64fd5d745227e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/471c272d940f8a80ac808d86f0826faf967fdf433c73dfd12872e6a01ca4459b1d149f7e95265d1878fbcf925baa456f73107cb8c04f4ee3b8406c3d9380ea7b"} 23:07:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:07:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:07:01 INFO - Contents: 23:07:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e1d567b845d928e8b2b0297a462e710330da39bf75e00b34aef4925365a7334b8a6efd64f3843bd4c652b1a0d8d198f7078b338ea55f65343e64fd5d745227e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/471c272d940f8a80ac808d86f0826faf967fdf433c73dfd12872e6a01ca4459b1d149f7e95265d1878fbcf925baa456f73107cb8c04f4ee3b8406c3d9380ea7b"} 23:07:01 INFO - Running post-run listener: copy_logs_to_upload_dir 23:07:01 INFO - Copying logs to upload dir... 23:07:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:07:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.171111 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-19 23:07:01.969957) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 23:07:01.973917) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e1d567b845d928e8b2b0297a462e710330da39bf75e00b34aef4925365a7334b8a6efd64f3843bd4c652b1a0d8d198f7078b338ea55f65343e64fd5d745227e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/471c272d940f8a80ac808d86f0826faf967fdf433c73dfd12872e6a01ca4459b1d149f7e95265d1878fbcf925baa456f73107cb8c04f4ee3b8406c3d9380ea7b"} build_url:https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/SS3M8sZ6QAyTfruUzIK-WQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e1d567b845d928e8b2b0297a462e710330da39bf75e00b34aef4925365a7334b8a6efd64f3843bd4c652b1a0d8d198f7078b338ea55f65343e64fd5d745227e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/471c272d940f8a80ac808d86f0826faf967fdf433c73dfd12872e6a01ca4459b1d149f7e95265d1878fbcf925baa456f73107cb8c04f4ee3b8406c3d9380ea7b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 23:07:02.000732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 23:07:02.001070) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1453272353.783526-1778314207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004802 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 23:07:02.052035) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 23:07:02.052399) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 23:07:02.052710) ========= ========= Total master_lag: 0.70 =========