builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1453474333.47 results: success (0) buildid: 20160122043024 builduid: b90f6424649147c18bfd317b4c10a4ba revision: 7104d650a97d895cbbc64d53462bf86a04658abe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.466315) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.466752) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.467291) ========= 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=920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006338 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.489873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.490176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.514923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.515288) ========= 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=920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.563920) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.564194) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.564549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.564817) ========= 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=920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 06:52:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.1M=0s 2016-01-22 06:52:14 (84.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152999 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.730780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.731068) ========= 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=920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021976 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.779634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:13.779934) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7104d650a97d895cbbc64d53462bf86a04658abe --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7104d650a97d895cbbc64d53462bf86a04658abe --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=920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 06:52:14,950 truncating revision to first 12 chars 2016-01-22 06:52:14,950 Setting DEBUG logging. 2016-01-22 06:52:14,950 attempt 1/10 2016-01-22 06:52:14,950 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7104d650a97d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 06:52:15,270 unpacking tar archive at: mozilla-central-7104d650a97d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.604629 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:14.396838) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:14.397154) ========= echo 7104d650a97d895cbbc64d53462bf86a04658abe in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7104d650a97d895cbbc64d53462bf86a04658abe'] 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=920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7104d650a97d895cbbc64d53462bf86a04658abe program finished with exit code 0 elapsedTime=0.003850 script_repo_revision: '7104d650a97d895cbbc64d53462bf86a04658abe' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:14.444777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:14.445086) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 06:52:14.455697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-22 06:52:14.455999) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:52:15 INFO - MultiFileLogger online at 20160122 06:52:15 in /builds/slave/test-pgo 06:52:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:52:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:52:15 INFO - {'append_to_log': False, 06:52:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:52:15 INFO - 'blob_upload_branch': 'Firefox', 06:52:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:52:15 INFO - 'branch': 'Firefox', 06:52:15 INFO - 'buildbot_json_path': 'buildprops.json', 06:52:15 INFO - 'config_files': ('talos/linux_config.py',), 06:52:15 INFO - 'default_actions': ('clobber', 06:52:15 INFO - 'read-buildbot-config', 06:52:15 INFO - 'download-and-extract', 06:52:15 INFO - 'populate-webroot', 06:52:15 INFO - 'create-virtualenv', 06:52:15 INFO - 'install', 06:52:15 INFO - 'run-tests'), 06:52:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:52:15 INFO - 'download_minidump_stackwalk': True, 06:52:15 INFO - 'download_symbols': 'ondemand', 06:52:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:52:15 INFO - 'tooltool.py': '/tools/tooltool.py', 06:52:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:52:15 INFO - '/tools/misc-python/virtualenv.py')}, 06:52:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:52:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:52:15 INFO - 'installer_path': 'installer.exe', 06:52:15 INFO - 'log_level': 'info', 06:52:15 INFO - 'log_name': 'talos', 06:52:15 INFO - 'log_to_console': True, 06:52:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:52:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:52:15 INFO - 'opt_config_files': (), 06:52:15 INFO - 'pip_index': False, 06:52:15 INFO - 'sps_profile': False, 06:52:15 INFO - 'sps_profile_interval': 0, 06:52:15 INFO - 'suite': 'dromaeojs-e10s', 06:52:15 INFO - 'system_bits': '32', 06:52:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:52:15 INFO - 'title': 'talos-linux64-ix-053', 06:52:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:52:15 INFO - 'use_talos_json': True, 06:52:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:52:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:52:15 INFO - 'work_dir': 'build'} 06:52:15 INFO - ##### 06:52:15 INFO - ##### Running clobber step. 06:52:15 INFO - ##### 06:52:15 INFO - Running pre-action listener: _resource_record_pre_action 06:52:15 INFO - Running main action method: clobber 06:52:15 INFO - rmtree: /builds/slave/test-pgo/build 06:52:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:52:16 INFO - Running post-action listener: _resource_record_post_action 06:52:16 INFO - ##### 06:52:16 INFO - ##### Running read-buildbot-config step. 06:52:16 INFO - ##### 06:52:16 INFO - Running pre-action listener: _resource_record_pre_action 06:52:16 INFO - Running main action method: read_buildbot_config 06:52:16 INFO - Using buildbot properties: 06:52:16 INFO - { 06:52:16 INFO - "project": "", 06:52:16 INFO - "product": "firefox", 06:52:16 INFO - "script_repo_revision": "production", 06:52:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:52:16 INFO - "repository": "", 06:52:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:52:16 INFO - "buildid": "20160122043024", 06:52:16 INFO - "pgo_build": "True", 06:52:16 INFO - "basedir": "/builds/slave/test-pgo", 06:52:16 INFO - "buildnumber": 315, 06:52:16 INFO - "slavename": "talos-linux64-ix-053", 06:52:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:52:16 INFO - "platform": "ubuntu64_hw", 06:52:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:52:16 INFO - "branch": "mozilla-central", 06:52:16 INFO - "repo_path": "mozilla-central", 06:52:16 INFO - "revision": "7104d650a97d895cbbc64d53462bf86a04658abe", 06:52:16 INFO - "stage_platform": "linux64-pgo", 06:52:16 INFO - "builduid": "b90f6424649147c18bfd317b4c10a4ba", 06:52:16 INFO - "slavebuilddir": "test" 06:52:16 INFO - } 06:52:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:52:16 INFO - Running post-action listener: _resource_record_post_action 06:52:16 INFO - ##### 06:52:16 INFO - ##### Running download-and-extract step. 06:52:16 INFO - ##### 06:52:16 INFO - Running pre-action listener: _resource_record_pre_action 06:52:16 INFO - Running main action method: download_and_extract 06:52:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:52:16 INFO - https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:52:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/test_packages.json 06:52:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/test_packages.json 06:52:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:52:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:52:24 INFO - Downloaded 1448 bytes. 06:52:24 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:52:24 INFO - Using the following test package requirements: 06:52:24 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:52:24 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:52:24 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:52:24 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:24 INFO - u'jsshell-linux-x86_64.zip'], 06:52:24 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:52:24 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:52:24 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:52:24 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:52:24 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:52:24 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:52:24 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:52:24 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:24 INFO - https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:52:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/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 06:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/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 06:52:36 INFO - Downloaded 22488755 bytes. 06:52:36 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'] 06:52:36 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 06:52:37 INFO - Return code: 0 06:52:37 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 06:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:52:37 INFO - https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/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 06:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/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 06:52:39 INFO - Downloaded 22488755 bytes. 06:52:39 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'] 06:52:39 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 06:52:40 INFO - Return code: 0 06:52:40 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')]} 06:52:40 INFO - https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/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 06:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/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 06:52:41 INFO - Downloaded 10706572 bytes. 06:52:41 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'] 06:52:41 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 06:52:42 INFO - Return code: 0 06:52:42 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')]} 06:52:42 INFO - https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/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 06:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/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 06:52:43 INFO - Downloaded 55959875 bytes. 06:52:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:43 INFO - mkdir: /builds/slave/test-pgo/properties 06:52:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:52:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:52:43 INFO - Contents: 06:52:43 INFO - build_url:https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:43 INFO - Running post-action listener: _resource_record_post_action 06:52:43 INFO - Running post-action listener: set_extra_try_arguments 06:52:43 INFO - ##### 06:52:43 INFO - ##### Running populate-webroot step. 06:52:43 INFO - ##### 06:52:43 INFO - Running pre-action listener: _resource_record_pre_action 06:52:43 INFO - Running main action method: populate_webroot 06:52:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:52:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:52:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:52:43 INFO - '--tppagecycles', 06:52:43 INFO - '7'], 06:52:43 INFO - 'tests': ['tsvgm']}}, 06:52:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:52:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:52:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:52:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:52:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:52:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:52:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:43 INFO - 'talos_options': ['--e10s'], 06:52:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:43 INFO - 'tests': ['damp', 'tps']}, 06:52:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:43 INFO - 'talos_options': ['--e10s'], 06:52:43 INFO - 'tests': ['damp', 'tps']}, 06:52:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:52:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:52:43 INFO - 'other': {'tests': ['a11yr', 06:52:43 INFO - 'ts_paint', 06:52:43 INFO - 'tpaint', 06:52:43 INFO - 'sessionrestore', 06:52:43 INFO - 'sessionrestore_no_auto_restore']}, 06:52:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:52:43 INFO - 'tests': ['a11yr', 06:52:43 INFO - 'ts_paint', 06:52:43 INFO - 'tpaint', 06:52:43 INFO - 'sessionrestore', 06:52:43 INFO - 'sessionrestore_no_auto_restore']}, 06:52:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:52:43 INFO - 'tests': ['a11yr', 06:52:43 INFO - 'ts_paint', 06:52:43 INFO - 'tpaint', 06:52:43 INFO - 'sessionrestore', 06:52:43 INFO - 'sessionrestore_no_auto_restore']}, 06:52:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:52:43 INFO - 'tests': ['a11yr', 06:52:43 INFO - 'ts_paint', 06:52:43 INFO - 'tpaint', 06:52:43 INFO - 'sessionrestore', 06:52:43 INFO - 'sessionrestore_no_auto_restore']}, 06:52:43 INFO - 'other_l64': {'tests': ['a11yr', 06:52:43 INFO - 'ts_paint', 06:52:43 INFO - 'tpaint', 06:52:43 INFO - 'sessionrestore', 06:52:43 INFO - 'sessionrestore_no_auto_restore']}, 06:52:43 INFO - 'other_nol64': {'tests': ['a11yr', 06:52:43 INFO - 'ts_paint', 06:52:43 INFO - 'tpaint', 06:52:43 INFO - 'sessionrestore', 06:52:43 INFO - 'sessionrestore_no_auto_restore']}, 06:52:43 INFO - 'svgr': {'tests': ['tsvgx', 06:52:43 INFO - 'tsvgr_opacity', 06:52:43 INFO - 'tart', 06:52:43 INFO - 'tscrollx', 06:52:43 INFO - 'cart']}, 06:52:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:52:43 INFO - 'tests': ['tsvgx', 06:52:43 INFO - 'tsvgr_opacity', 06:52:43 INFO - 'tart', 06:52:43 INFO - 'tscrollx', 06:52:43 INFO - 'cart']}, 06:52:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:43 INFO - 'tests': ['tp5o']}, 06:52:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:43 INFO - 'talos_options': ['--e10s'], 06:52:43 INFO - 'tests': ['tp5o']}, 06:52:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:43 INFO - 'talos_options': ['--xperf_path', 06:52:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:43 INFO - 'tests': ['tp5n']}, 06:52:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:43 INFO - 'talos_options': ['--e10s', 06:52:43 INFO - '--xperf_path', 06:52:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:43 INFO - 'tests': ['tp5n']}}, 06:52:43 INFO - 'talos.zip': {'path': '', 06:52:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:52:43 INFO - Running post-action listener: _resource_record_post_action 06:52:43 INFO - ##### 06:52:43 INFO - ##### Running create-virtualenv step. 06:52:43 INFO - ##### 06:52:43 INFO - Running pre-action listener: _resource_record_pre_action 06:52:43 INFO - Running main action method: create_virtualenv 06:52:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:52:43 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 06:52:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:52:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:52:43 INFO - Using real prefix '/usr' 06:52:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:52:44 INFO - Installing distribute.............................................................................................................................................................................................done. 06:52:45 INFO - Installing pip.................done. 06:52:45 INFO - Return code: 0 06:52:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89950cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1926850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19253f0>, '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 0x19b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b7a10>, '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': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', '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 06:52:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:52:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:52:45 INFO - Using env: {'DISPLAY': ':0', 06:52:45 INFO - 'HOME': '/home/cltbld', 06:52:45 INFO - 'LANG': 'en_US.UTF-8', 06:52:45 INFO - 'LANGUAGE': 'en_US:en', 06:52:45 INFO - 'LOGNAME': 'cltbld', 06:52:45 INFO - 'MAIL': '/var/mail/cltbld', 06:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:45 INFO - 'MOZ_NO_REMOTE': '1', 06:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:45 INFO - 'NO_EM_RESTART': '1', 06:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:45 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:45 INFO - 'SHELL': '/bin/bash', 06:52:45 INFO - 'SHLVL': '1', 06:52:45 INFO - 'TERM': 'linux', 06:52:45 INFO - 'TMOUT': '86400', 06:52:45 INFO - 'USER': 'cltbld', 06:52:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', 06:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:45 INFO - '_': '/tools/buildbot/bin/python'} 06:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:46 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 06:52:46 INFO - Cleaning up... 06:52:46 INFO - Return code: 0 06:52:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89950cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1926850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19253f0>, '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 0x19b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b7a10>, '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': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', '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 06:52:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:52:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:52:46 INFO - Using env: {'DISPLAY': ':0', 06:52:46 INFO - 'HOME': '/home/cltbld', 06:52:46 INFO - 'LANG': 'en_US.UTF-8', 06:52:46 INFO - 'LANGUAGE': 'en_US:en', 06:52:46 INFO - 'LOGNAME': 'cltbld', 06:52:46 INFO - 'MAIL': '/var/mail/cltbld', 06:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:46 INFO - 'MOZ_NO_REMOTE': '1', 06:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:46 INFO - 'NO_EM_RESTART': '1', 06:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:46 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:46 INFO - 'SHELL': '/bin/bash', 06:52:46 INFO - 'SHLVL': '1', 06:52:46 INFO - 'TERM': 'linux', 06:52:46 INFO - 'TMOUT': '86400', 06:52:46 INFO - 'USER': 'cltbld', 06:52:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', 06:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:46 INFO - '_': '/tools/buildbot/bin/python'} 06:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:46 INFO - Downloading/unpacking psutil>=0.7.1 06:52:46 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 06:52:46 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 06:52:46 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 06:52:46 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 06:52:46 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 06:52:46 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 06:52:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:52:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:48 INFO - Installing collected packages: psutil 06:52:48 INFO - Running setup.py install for psutil 06:52:48 INFO - building 'psutil._psutil_linux' extension 06:52:48 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 06:52:48 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 06:52:48 INFO - building 'psutil._psutil_posix' extension 06:52:48 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 06:52:48 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 06:52:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:48 INFO - Successfully installed psutil 06:52:48 INFO - Cleaning up... 06:52:48 INFO - Return code: 0 06:52:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89950cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1926850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19253f0>, '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 0x19b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b7a10>, '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': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', '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 06:52:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:52:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:52:48 INFO - Using env: {'DISPLAY': ':0', 06:52:48 INFO - 'HOME': '/home/cltbld', 06:52:48 INFO - 'LANG': 'en_US.UTF-8', 06:52:48 INFO - 'LANGUAGE': 'en_US:en', 06:52:48 INFO - 'LOGNAME': 'cltbld', 06:52:48 INFO - 'MAIL': '/var/mail/cltbld', 06:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:48 INFO - 'MOZ_NO_REMOTE': '1', 06:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:48 INFO - 'NO_EM_RESTART': '1', 06:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:48 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:48 INFO - 'SHELL': '/bin/bash', 06:52:48 INFO - 'SHLVL': '1', 06:52:48 INFO - 'TERM': 'linux', 06:52:48 INFO - 'TMOUT': '86400', 06:52:48 INFO - 'USER': 'cltbld', 06:52:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', 06:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:48 INFO - '_': '/tools/buildbot/bin/python'} 06:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:52:49 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 06:52:49 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 06:52:49 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 06:52:49 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 06:52:49 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 06:52:49 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 06:52:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:52:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:52:50 INFO - Installing collected packages: mozsystemmonitor 06:52:50 INFO - Running setup.py install for mozsystemmonitor 06:52:50 INFO - Successfully installed mozsystemmonitor 06:52:50 INFO - Cleaning up... 06:52:51 INFO - Return code: 0 06:52:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:52:51 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')]} 06:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:51 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')]} 06:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89950cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1926850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19253f0>, '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 0x19b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b7a10>, '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': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', '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 06:52:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:52:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:52:51 INFO - Using env: {'DISPLAY': ':0', 06:52:51 INFO - 'HOME': '/home/cltbld', 06:52:51 INFO - 'LANG': 'en_US.UTF-8', 06:52:51 INFO - 'LANGUAGE': 'en_US:en', 06:52:51 INFO - 'LOGNAME': 'cltbld', 06:52:51 INFO - 'MAIL': '/var/mail/cltbld', 06:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:51 INFO - 'MOZ_NO_REMOTE': '1', 06:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:51 INFO - 'NO_EM_RESTART': '1', 06:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:51 INFO - 'SHELL': '/bin/bash', 06:52:51 INFO - 'SHLVL': '1', 06:52:51 INFO - 'TERM': 'linux', 06:52:51 INFO - 'TMOUT': '86400', 06:52:51 INFO - 'USER': 'cltbld', 06:52:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', 06:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:51 INFO - '_': '/tools/buildbot/bin/python'} 06:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:51 INFO - Downloading/unpacking blobuploader==1.2.4 06:52:51 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 06:52:51 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 06:52:51 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 06:52:51 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 06:52:51 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 06:52:51 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 06:52:52 INFO - Downloading blobuploader-1.2.4.tar.gz 06:52:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:52:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:52:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 INFO - Downloading docopt-0.6.1.tar.gz 06:52:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:52:53 INFO - Installing collected packages: blobuploader, requests, docopt 06:52:53 INFO - Running setup.py install for blobuploader 06:52:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:52:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:52:53 INFO - Running setup.py install for requests 06:52:54 INFO - Running setup.py install for docopt 06:52:54 INFO - Successfully installed blobuploader requests docopt 06:52:54 INFO - Cleaning up... 06:52:54 INFO - Return code: 0 06:52:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52:54 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')]} 06:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:54 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')]} 06:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fc89950cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1926850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19253f0>, '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 0x19b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b7a10>, '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': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', '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 06:52:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 06:52:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 06:52:54 INFO - Using env: {'DISPLAY': ':0', 06:52:54 INFO - 'HOME': '/home/cltbld', 06:52:54 INFO - 'LANG': 'en_US.UTF-8', 06:52:54 INFO - 'LANGUAGE': 'en_US:en', 06:52:54 INFO - 'LOGNAME': 'cltbld', 06:52:54 INFO - 'MAIL': '/var/mail/cltbld', 06:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:54 INFO - 'MOZ_NO_REMOTE': '1', 06:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:54 INFO - 'NO_EM_RESTART': '1', 06:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:54 INFO - 'SHELL': '/bin/bash', 06:52:54 INFO - 'SHLVL': '1', 06:52:54 INFO - 'TERM': 'linux', 06:52:54 INFO - 'TMOUT': '86400', 06:52:54 INFO - 'USER': 'cltbld', 06:52:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', 06:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:54 INFO - '_': '/tools/buildbot/bin/python'} 06:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:54 INFO - Running setup.py (path:/tmp/pip-CkMv4U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:54 INFO - Running setup.py (path:/tmp/pip-j7rDrH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:54 INFO - Running setup.py (path:/tmp/pip-yGUGPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:54 INFO - Running setup.py (path:/tmp/pip-neNFMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:54 INFO - Running setup.py (path:/tmp/pip-gGjGx1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:54 INFO - Running setup.py (path:/tmp/pip-VyueZu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:55 INFO - Running setup.py (path:/tmp/pip-3tBDZf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:55 INFO - Running setup.py (path:/tmp/pip-XWUZDY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:55 INFO - Running setup.py (path:/tmp/pip-lzaSUb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:55 INFO - Running setup.py (path:/tmp/pip-XpXVkg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:55 INFO - Running setup.py (path:/tmp/pip-6_NrkP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:55 INFO - Running setup.py (path:/tmp/pip-twt71o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:55 INFO - Running setup.py (path:/tmp/pip-Thbg3n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:55 INFO - Running setup.py (path:/tmp/pip-FoTBKo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:55 INFO - Running setup.py (path:/tmp/pip-Jb_cGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:55 INFO - Running setup.py (path:/tmp/pip-4adhjZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:55 INFO - Running setup.py (path:/tmp/pip-R4FE3n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:52:55 INFO - Running setup.py install for manifestparser 06:52:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:52:55 INFO - Running setup.py install for mozcrash 06:52:55 INFO - Running setup.py install for mozdebug 06:52:56 INFO - Running setup.py install for mozdevice 06:52:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Running setup.py install for mozfile 06:52:56 INFO - Running setup.py install for mozhttpd 06:52:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Running setup.py install for mozinfo 06:52:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Running setup.py install for mozInstall 06:52:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Running setup.py install for mozleak 06:52:56 INFO - Running setup.py install for mozlog 06:52:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Running setup.py install for moznetwork 06:52:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Running setup.py install for mozprocess 06:52:56 INFO - Running setup.py install for mozprofile 06:52:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:52:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:52:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:52:57 INFO - Running setup.py install for mozrunner 06:52:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:52:57 INFO - Running setup.py install for mozscreenshot 06:52:57 INFO - Running setup.py install for moztest 06:52:57 INFO - Running setup.py install for mozversion 06:52:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:52:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:52:57 INFO - Cleaning up... 06:52:57 INFO - Return code: 0 06:52:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fc89950cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1926850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19253f0>, '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 0x19b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b7a10>, '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': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', '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 06:52:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 06:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 06:52:57 INFO - Using env: {'DISPLAY': ':0', 06:52:57 INFO - 'HOME': '/home/cltbld', 06:52:57 INFO - 'LANG': 'en_US.UTF-8', 06:52:57 INFO - 'LANGUAGE': 'en_US:en', 06:52:57 INFO - 'LOGNAME': 'cltbld', 06:52:57 INFO - 'MAIL': '/var/mail/cltbld', 06:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:57 INFO - 'MOZ_NO_REMOTE': '1', 06:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:57 INFO - 'NO_EM_RESTART': '1', 06:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:57 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:57 INFO - 'SHELL': '/bin/bash', 06:52:57 INFO - 'SHLVL': '1', 06:52:57 INFO - 'TERM': 'linux', 06:52:57 INFO - 'TMOUT': '86400', 06:52:57 INFO - 'USER': 'cltbld', 06:52:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', 06:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:57 INFO - '_': '/tools/buildbot/bin/python'} 06:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:57 INFO - Running setup.py (path:/tmp/pip-tvEkOo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:57 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)) 06:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:57 INFO - Running setup.py (path:/tmp/pip-GYAsP6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:57 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)) 06:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:57 INFO - Running setup.py (path:/tmp/pip-jXYb9j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:57 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)) 06:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:57 INFO - Running setup.py (path:/tmp/pip-oThoF3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:58 INFO - Running setup.py (path:/tmp/pip-KBNo1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:58 INFO - Running setup.py (path:/tmp/pip-y0w4NB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:58 INFO - Running setup.py (path:/tmp/pip-hQHaUc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:58 INFO - Running setup.py (path:/tmp/pip-dTGSvM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:58 INFO - Running setup.py (path:/tmp/pip-9ICNv8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:58 INFO - Running setup.py (path:/tmp/pip-VP8rLA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:58 INFO - Running setup.py (path:/tmp/pip-eDAA5G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:58 INFO - Running setup.py (path:/tmp/pip-L8gXbr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:58 INFO - Running setup.py (path:/tmp/pip-IO1l1b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:58 INFO - Running setup.py (path:/tmp/pip-zR6Nry-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:58 INFO - Running setup.py (path:/tmp/pip-hMebkS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:58 INFO - Running setup.py (path:/tmp/pip-WQz8mH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:58 INFO - Running setup.py (path:/tmp/pip-coWYvQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:58 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)) 06:52:58 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)) 06:52:58 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)) 06:52:58 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)) 06:52:58 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)) 06:52:58 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)) 06:52:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:52:58 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 06:52:58 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 06:52:58 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 06:52:58 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 06:52:58 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 06:52:58 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 06:53:00 INFO - Downloading blessings-1.6.tar.gz 06:53:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:53:00 INFO - Installing collected packages: blessings 06:53:00 INFO - Running setup.py install for blessings 06:53:00 INFO - Successfully installed blessings 06:53:00 INFO - Cleaning up... 06:53:00 INFO - Return code: 0 06:53:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:53:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:53:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:53:01 INFO - Reading from file tmpfile_stdout 06:53:01 INFO - Current package versions: 06:53:01 INFO - argparse == 1.2.1 06:53:01 INFO - blessings == 1.6 06:53:01 INFO - blobuploader == 1.2.4 06:53:01 INFO - docopt == 0.6.1 06:53:01 INFO - manifestparser == 1.1 06:53:01 INFO - mozInstall == 1.12 06:53:01 INFO - mozcrash == 0.16 06:53:01 INFO - mozdebug == 0.1 06:53:01 INFO - mozdevice == 0.48 06:53:01 INFO - mozfile == 1.2 06:53:01 INFO - mozhttpd == 0.7 06:53:01 INFO - mozinfo == 0.9 06:53:01 INFO - mozleak == 0.1 06:53:01 INFO - mozlog == 3.1 06:53:01 INFO - moznetwork == 0.27 06:53:01 INFO - mozprocess == 0.22 06:53:01 INFO - mozprofile == 0.28 06:53:01 INFO - mozrunner == 6.11 06:53:01 INFO - mozscreenshot == 0.1 06:53:01 INFO - mozsystemmonitor == 0.0 06:53:01 INFO - moztest == 0.7 06:53:01 INFO - mozversion == 1.4 06:53:01 INFO - psutil == 3.1.1 06:53:01 INFO - requests == 1.2.3 06:53:01 INFO - wsgiref == 0.1.2 06:53:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fc89950cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1926850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19253f0>, '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 0x19b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b7a10>, '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': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', '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 06:53:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 06:53:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 06:53:01 INFO - Using env: {'DISPLAY': ':0', 06:53:01 INFO - 'HOME': '/home/cltbld', 06:53:01 INFO - 'LANG': 'en_US.UTF-8', 06:53:01 INFO - 'LANGUAGE': 'en_US:en', 06:53:01 INFO - 'LOGNAME': 'cltbld', 06:53:01 INFO - 'MAIL': '/var/mail/cltbld', 06:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:01 INFO - 'MOZ_NO_REMOTE': '1', 06:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:01 INFO - 'NO_EM_RESTART': '1', 06:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:01 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:01 INFO - 'SHELL': '/bin/bash', 06:53:01 INFO - 'SHLVL': '1', 06:53:01 INFO - 'TERM': 'linux', 06:53:01 INFO - 'TMOUT': '86400', 06:53:01 INFO - 'USER': 'cltbld', 06:53:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', 06:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:01 INFO - '_': '/tools/buildbot/bin/python'} 06:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 INFO - Cleaning up... 06:53:01 INFO - Return code: 0 06:53:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89950cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1926850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19253f0>, '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 0x19b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b7a10>, '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': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', '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 06:53:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 06:53:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:53:01 INFO - Using env: {'DISPLAY': ':0', 06:53:01 INFO - 'HOME': '/home/cltbld', 06:53:01 INFO - 'LANG': 'en_US.UTF-8', 06:53:01 INFO - 'LANGUAGE': 'en_US:en', 06:53:01 INFO - 'LOGNAME': 'cltbld', 06:53:01 INFO - 'MAIL': '/var/mail/cltbld', 06:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:01 INFO - 'MOZ_NO_REMOTE': '1', 06:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:01 INFO - 'NO_EM_RESTART': '1', 06:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:01 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:01 INFO - 'SHELL': '/bin/bash', 06:53:01 INFO - 'SHLVL': '1', 06:53:01 INFO - 'TERM': 'linux', 06:53:01 INFO - 'TMOUT': '86400', 06:53:01 INFO - 'USER': 'cltbld', 06:53:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', 06:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:01 INFO - '_': '/tools/buildbot/bin/python'} 06:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:01 INFO - Downloading/unpacking jsonschema 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:01 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 06:53:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:53:03 INFO - Downloading/unpacking functools32 (from jsonschema) 06:53:03 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 06:53:03 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 06:53:03 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 06:53:03 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 06:53:03 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 06:53:03 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 06:53:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:53:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:53:03 INFO - warning: no files found matching '*.txt' 06:53:03 INFO - no previously-included directories found matching 'build' 06:53:03 INFO - no previously-included directories found matching 'dist' 06:53:03 INFO - no previously-included directories found matching '.git*' 06:53:03 INFO - Installing collected packages: jsonschema, functools32 06:53:03 INFO - Running setup.py install for functools32 06:53:03 INFO - warning: no files found matching '*.txt' 06:53:03 INFO - no previously-included directories found matching 'build' 06:53:03 INFO - no previously-included directories found matching 'dist' 06:53:03 INFO - no previously-included directories found matching '.git*' 06:53:03 INFO - Successfully installed jsonschema functools32 06:53:03 INFO - Cleaning up... 06:53:03 INFO - Return code: 0 06:53:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:53: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')]} 06:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89950cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1926850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19253f0>, '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 0x19b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b7a10>, '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': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', '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 06:53:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 06:53:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:53:03 INFO - Using env: {'DISPLAY': ':0', 06:53:03 INFO - 'HOME': '/home/cltbld', 06:53:03 INFO - 'LANG': 'en_US.UTF-8', 06:53:03 INFO - 'LANGUAGE': 'en_US:en', 06:53:03 INFO - 'LOGNAME': 'cltbld', 06:53:03 INFO - 'MAIL': '/var/mail/cltbld', 06:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:03 INFO - 'MOZ_NO_REMOTE': '1', 06:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:03 INFO - 'NO_EM_RESTART': '1', 06:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:03 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:03 INFO - 'SHELL': '/bin/bash', 06:53:03 INFO - 'SHLVL': '1', 06:53:03 INFO - 'TERM': 'linux', 06:53:03 INFO - 'TMOUT': '86400', 06:53:03 INFO - 'USER': 'cltbld', 06:53:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', 06:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:03 INFO - '_': '/tools/buildbot/bin/python'} 06:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:04 INFO - Downloading/unpacking flake8 06:53:04 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 06:53:04 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 06:53:04 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 06:53:04 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 06:53:04 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 06:53:04 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 06:53:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:53:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:53:05 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 06:53:05 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 06:53:05 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 06:53:05 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 06:53:05 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 06:53:05 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 06:53:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:53:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:53:06 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 06:53:06 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 06:53:06 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 06:53:06 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 06:53:06 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 06:53:06 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 06:53:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:53:06 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 06:53:06 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 06:53:06 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 06:53:06 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 06:53:06 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 06:53:06 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 06:53:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:53:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:53:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:53:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:53:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:53:06 INFO - no previously-included directories found matching 'docs/_build' 06:53:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:53:06 INFO - Running setup.py install for pep8 06:53:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:53:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:53:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:53:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:53:06 INFO - no previously-included directories found matching 'docs/_build' 06:53:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:53:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:53:06 INFO - Cleaning up... 06:53:06 INFO - Return code: 0 06:53:06 INFO - Running post-action listener: _resource_record_post_action 06:53:06 INFO - Running post-action listener: _start_resource_monitoring 06:53:06 INFO - Starting resource monitoring. 06:53:06 INFO - ##### 06:53:06 INFO - ##### Running install step. 06:53:06 INFO - ##### 06:53:06 INFO - Running pre-action listener: _resource_record_pre_action 06:53:06 INFO - Running main action method: install 06:53:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:53:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:53:07 INFO - Reading from file tmpfile_stdout 06:53:07 INFO - Detecting whether we're running mozinstall >=1.0... 06:53:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:53:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:53:07 INFO - Reading from file tmpfile_stdout 06:53:07 INFO - Output received: 06:53:07 INFO - Usage: mozinstall [options] installer 06:53:07 INFO - Options: 06:53:07 INFO - -h, --help show this help message and exit 06:53:07 INFO - -d DEST, --destination=DEST 06:53:07 INFO - Directory to install application into. [default: 06:53:07 INFO - "/builds/slave/test-pgo"] 06:53:07 INFO - --app=APP Application being installed. [default: firefox] 06:53:07 INFO - mkdir: /builds/slave/test-pgo/build/application 06:53:07 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'] 06:53:07 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 06:53:23 INFO - Reading from file tmpfile_stdout 06:53:23 INFO - Output received: 06:53:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:53:23 INFO - Running post-action listener: _resource_record_post_action 06:53:23 INFO - ##### 06:53:23 INFO - ##### Running run-tests step. 06:53:23 INFO - ##### 06:53:23 INFO - Running pre-action listener: _resource_record_pre_action 06:53:23 INFO - Running main action method: run_tests 06:53:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:53:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:53:23 INFO - Python 2.7.3 06:53:23 INFO - Return code: 0 06:53:23 INFO - grabbing minidump binary from tooltool 06:53: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')]} 06:53:23 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 0x19253f0>, '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 0x19b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b7a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:53:23 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 06:53:23 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 06:53:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:53:23 INFO - Return code: 0 06:53:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:53:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:53:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:53:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:53:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:53:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:53:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:53:24 INFO - Return code: 0 06:53:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 06:53:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:53:24 INFO - Using env: {'DISPLAY': ':0', 06:53:24 INFO - 'HOME': '/home/cltbld', 06:53:24 INFO - 'LANG': 'en_US.UTF-8', 06:53:24 INFO - 'LANGUAGE': 'en_US:en', 06:53:24 INFO - 'LOGNAME': 'cltbld', 06:53:24 INFO - 'MAIL': '/var/mail/cltbld', 06:53:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:53:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:24 INFO - 'MOZ_NO_REMOTE': '1', 06:53:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:24 INFO - 'NO_EM_RESTART': '1', 06:53:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:24 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:53:24 INFO - 'SHELL': '/bin/bash', 06:53:24 INFO - 'SHLVL': '1', 06:53:24 INFO - 'TERM': 'linux', 06:53:24 INFO - 'TMOUT': '86400', 06:53:24 INFO - 'USER': 'cltbld', 06:53:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537', 06:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:24 INFO - '_': '/tools/buildbot/bin/python'} 06:53:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:53:24 INFO - mozversion application_buildid: 20160122043024 06:53:24 INFO - mozversion application_changeset: 7104d650a97d895cbbc64d53462bf86a04658abe 06:53:24 INFO - mozversion application_display_name: Nightly 06:53:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:53:24 INFO - mozversion application_name: Firefox 06:53:24 INFO - mozversion application_remotingname: firefox 06:53:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:53:24 INFO - mozversion application_vendor: Mozilla 06:53:24 INFO - mozversion application_version: 46.0a1 06:53:24 INFO - mozversion platform_buildid: 20160122043024 06:53:24 INFO - mozversion platform_changeset: 7104d650a97d895cbbc64d53462bf86a04658abe 06:53:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:53:24 INFO - mozversion platform_version: 46.0a1 06:53:24 INFO - using testdate: 1453474404 06:53:24 INFO - actual date: 1453474404 06:53:24 INFO - starting webserver on 'localhost:55875' 06:53:24 INFO - SUITE-START | Running 3 tests 06:53:24 INFO - TEST-START | dromaeo_css 06:53:24 INFO - operating with platform_type : linux_ 06:53:24 INFO - Initialising browser for dromaeo_css test... 06:53:24 INFO - TEST-INFO | started process 10554 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphyybJe/profile http://localhost:55875/getInfo.html) 06:53:28 INFO - PROCESS | 10554 | 06:53:28 INFO - PROCESS | 10554 | (process:10634): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:53:29 INFO - PROCESS | 10554 | __metrics Screen width/height:1600/1200 06:53:29 INFO - PROCESS | 10554 | colorDepth:24 06:53:29 INFO - PROCESS | 10554 | Browser inner width/height: 1024/697 06:53:29 INFO - PROCESS | 10554 | __metrics 06:53:29 INFO - PROCESS | 10554 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:53:30 INFO - TEST-INFO | 10554: exit 0 06:53:30 INFO - Browser initialized. 06:53:30 INFO - Running cycle 1/1 for dromaeo_css test... 06:53:30 INFO - TEST-INFO | started process 10683 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphyybJe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:53:31 INFO - PROCESS | 10683 | 06:53:31 INFO - PROCESS | 10683 | (process:10743): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:53:41 INFO - PROCESS | 10683 | RSS: Main: 152043520 06:53:41 INFO - PROCESS | 10683 | 06:54:31 INFO - PROCESS | 10683 | 1453474471600 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] 06:56:40 INFO - PROCESS | 10683 | Cycle 1(1): loaded http://localhost:55875/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55875/tests/dromaeo/cssquery-ext.html) 06:56:41 INFO - PROCESS | 10683 | RSS: Main: 160014336 06:56:41 INFO - PROCESS | 10683 | 06:59:43 INFO - PROCESS | 10683 | Cycle 1(1): loaded http://localhost:55875/tests/dromaeo/cssquery-ext.html (next: http://localhost:55875/tests/dromaeo/cssquery-jquery.html) 06:59:44 INFO - PROCESS | 10683 | RSS: Main: 154832896 06:59:44 INFO - PROCESS | 10683 | 07:02:45 INFO - PROCESS | 10683 | Cycle 1(1): loaded http://localhost:55875/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55875/tests/dromaeo/cssquery-mootools.html) 07:02:46 INFO - PROCESS | 10683 | RSS: Main: 156684288 07:02:46 INFO - PROCESS | 10683 | 07:05:48 INFO - PROCESS | 10683 | Cycle 1(1): loaded http://localhost:55875/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55875/tests/dromaeo/cssquery-prototype.html) 07:05:48 INFO - PROCESS | 10683 | RSS: Main: 154562560 07:05:48 INFO - PROCESS | 10683 | 07:08:51 INFO - PROCESS | 10683 | Cycle 1(1): loaded http://localhost:55875/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55875/tests/dromaeo/cssquery-yui.html) 07:08:51 INFO - PROCESS | 10683 | RSS: Main: 155713536 07:08:51 INFO - PROCESS | 10683 | 07:11:54 INFO - PROCESS | 10683 | Cycle 1(1): loaded http://localhost:55875/tests/dromaeo/cssquery-yui.html (next: http://localhost:55875/tests/dromaeo/cssquery-dojo.html) 07:11:54 INFO - PROCESS | 10683 | RSS: Main: 158744576 07:11:54 INFO - PROCESS | 10683 | 07:11:54 INFO - PROCESS | 10683 | __start_tp_report 07:11:54 INFO - PROCESS | 10683 | _x_x_mozilla_page_load 07:11:54 INFO - PROCESS | 10683 | _x_x_mozilla_page_load_details 07:11:54 INFO - PROCESS | 10683 | |i|pagename|runs| 07:11:54 INFO - PROCESS | 10683 | |0;dojo.html;3182.8408579571023;3209.5025271082977;3238.789478683887;3251.219707270255;3260.2827377976837;5250.238715386266;5319.414864364921;5335.7865685372535;5341.145416733323;5357.65175263608;5253.080710875591;5328.200769884519;5362.4637536246355;5377.139657654776;5386.138217885139;4784.521547845214;4815.301781241717;4823.903521929559;4920.089783390066;4960.107180707471;4565.931511027337;4915.9754201229125;4938.629602779788;5019.64862459628;5046.798128074873;4743.667943243974;4802.30366596845;4810.230363141898;4862.3922009748785;4886.071646387175;4829.492903245179;4871.902561948741;4873.049755297719;4881.8779530511665;4902.632302577321;4614.607758340545;4857.222844344888;4861.927071093901;4876.097921884463;4892.6575139740235;5105.693658380472;5159.793608255665;5182.144946083891;5192.091384007784;5215.58275337972;5713.314402271754;5740.9712951435395;5741.741621627037;5750.338711048241;5751.309842818847;5432.29380180574;5565.499105080522;5760.510356619692;5775.913361299584;5781.508571771405;5234.293370394986;5242.842714718565;5243.292155558989;5256.974889896472;5271.604629652791;5830.533557315404;5881.529477641864;5892.764289428461;5899.882002359929;5948.286205655262;5663.575231857627;5704.429557044263;5708.229389032511;5723.427657234327;5725.5133313667975;5598.664080155122;5709.942900570941;5718.942810571841;5780.797672081457;5806.274215723035;5698.116791897262;5719.227904232958;5721.713914304268;5733.655980641175;5769.365369809318;5741.569382296345;5767.192593036978;5790.073588225863;5794.652320860761;5822.301323841166;4341.023269764278;4399.076193999232;4431.8670439886855;4493.59557639814;4524;3965.504311961005;3978.224246272007;3979.144483935968;3993.9600603994168;4013.1572369802084;5379.838604841861;5409.43200963901;5412;5422.0511410503;5464.617476776667;5597.860053498695;5672.943270567324;5686.886262274731;5695.629784064023;5800.59395842287;5267.341582302212;5272.92090618641;5286.577073834084;5297.867553311198;5445.918311225335;4928.088303663833;4952.133376659071;4959.504049595012;4967.081089998362;4990.825321113816;5948.048312270016;5984.311804142492;5986.640801551921;6038.32818383218;6072.848178795565;5573.693446860299;5656.60403771732;5742.5118864895285;5798.6810725410505;5834.854128646648;5927.881442371042;5953.047512397996;5953.315368732651;5969.462748352669;5987.9401205989125;5620.3536593290655;5668.291463567054;5672.177534257592;5675.489205971482;5685.51673107774;5554.944450555443;5643.266375371176;5682.976045391898;5758.452946970031;5850.12248162779;5609.4390560943575;5633.6619802811965;5636.436356364495;5650.745716442852;5651.971740141273;5614.606977511535;5615.634983726045;5623.3814280428305;5643.435656434323;5650.350209725934;5411.0801163803035;5473.917891231715;5481.3970463248215;5521;5566.721663916869;5642.6614403135945;5647.971760141173;5651.208830763779;5676.7445464955;5682.204491371294;5376.946230537801;5485.6982865942755;5520.06158952971;5544.306961629796;5557.722113894209 07:11:54 INFO - PROCESS | 10683 | |1;ext.html;513.3788116379184;528.2973645052078;530.9150535914255;543.5461389739568;547.285792041386;34914.65085349146;34963.65036349636;35305.47041794372;35474.82262588683;35492.290154196904;39364.606353936455;39822.80088599553;39938.20123597526;39966;40007.399889001616;8653.870191947126;8915.68795092172;8920.152585504367;8933.419327743708;8956.059613740561;8546.70086546971;8633.438826476291;8681.21869031787;8687.30501559877;8689.695860644879;8580.442271252348;8652.524111173914;8677.045524992245;8693.304535637166;8742.956285218565;8612.698555550556;8665.43674661145;8687.522186279752;8695.304375649934;8697.21725044749;8499.192576705203;8561.95719021407;8572.228499435018;8599.355048371335;8621.827563448758;38362.232755345016;38673.22653546942;38919.61080389188;38972.22055558901;39050.41424378636;2816.5634326679397;3322.2026713588807;3464.9826750866337;3474.1314671332166;3610.422332426799;27885.442291154268;28205.576916346272;28667.283317917012;28878.422431551462;29460.116196513925;3239;3327.517509961042;3603.3694103531775;3616.7468277220605;3752.549694036733;212904;213500;213655;214129;214580;54887.45112548903;55216;55248.447515525135;55321;55634;52939;53054.469455304956;53091.20363194555;53166.468335316924;53240.73379633077;15689.843101568838;15958.521244362688;15987.200639968187;16032.679346413006;16099.436519721754;12196.878031219574;12225.327606981702;12253.387330633612;12314.322712250732;12359.814602780965;18812.85391971485;19453.902730486257;19494.61010779805;19504.60990780205;19538.413847584594;7907.525548467111;8019.954911497531;8049.798755031054;8090.514569125871;8138.389620778347;866.151171851589;920.9263258939269;1009.914157296638;1033.7002269341806;1038.6209033702644;24971.500569988497;25143;25159.496810063698;25435.61846572303;26064;1029.9897001029894;1031.9896801031894;1077.7521170130915;1102.4542851288663;1167.3404526442532;13377.130486518345;13429.932850335881;13453.93273033648;13591.932040339932;13894.901004203784;306507;307491;310802;311154;311385;50148;50232.246516302286;50347.24479132816;50611;50619.49380506148;1298.4286913758106;1318.5253308808822;1340.4102195034154;1360.1227208450493;1395.1350162899068;24330.51338973246;26211.344716382242;26567;26582.601260981486;26625.733742663102;42155.57844421516;42469.57530424656;42655.36016959686;42693;42698.14603707971;287135;287824;288421;288861;289347;29935.850320749127;30840;30977.535336970413;31025.224369390944;31083.22291942629;41815.1636967265;42134.578654213066;42679.78660106679;43186.78406607947;44100.11799764051;32996.83501582573;35594.28811423809;36094.639053610175;36545.71088602039;36973.44539831851;32876.50685239676;33285;33442.83278583591;33454.49818252777;33801.323973520884;32085.197870053435;32380.190495237806;32544.51183232206;35221.647783522865;35524;27931.720682793726;29073.563896541993;29983.70016299809;31792.68207317897;32829.34341313208;23245.186418475274;23406.414839628465;24005.27984160478;24305.14931977372;24605.87697061503 07:11:54 INFO - PROCESS | 10683 | |2;jquery.html;357.97136229101676;363.5219686112763;370.1763576043304;372.2201986837574;372.7614326830828;15411.383544658214;16587.585310367216;16753.497395078135;17123.91438042808;17782.288708451677;11204.775904481905;11217.15871309653;16356.182190890439;16368.508944731677;16370.181490925466;4580.90838183237;5264.894702105956;5296.788128474856;5324.65389749667;5327.387350454708;5104.183330667094;5159.303494028314;5202;5244.056069907415;5258.658187217838;5019.397672279331;5196.558292545138;5213.400458947212;5215.6349055566125;5223.686578805265;5078.238264260372;5117.334746482933;5118.436971933084;5145.81989630363;5150.587952963754;5151.974240128776;5167.844964651066;5192.169252919514;5208.791648334062;5212.348456442945;11882.465289061927;15452.381904723798;19277;19982.500437489034;20020.1991920323;2037.2564014134734;2111.809937105668;2113.830893528514;2197.615417301966;2260.785225403584;8668.00317963436;8747.956260218722;8753.824923501494;8775.824483510358;9009.099090091004;1682;1763.4621440460655;1772.6100257943233;1814.945551633453;1874.297138573035;38812.22375552501;39557;52538.47461525374;54184.91630167414;54824.45175548273;9152.405093668891;9693.369930954465;10308.948455257825;10362.378257304586;10447.84328235077;13395.263260520765;13441.647711650423;13443.193408395528;13517.121387109806;13582.117162384413;6982.1970473395195;7122.2521635228595;7130.2869713028285;7384.667689953965;7475.9252407476315;6731.730730770714;6785.050092986986;6973.546719463218;7053.89419158713;7126.821829454305;4166.979165104216;4470.865874023784;4501.707389019703;4522.728636281768;4566.109608626286;1729.5589624645636;1815.2285278756476;1827.798942116366;1875.2873907915177;1933.6036112596885;799.7680672604996;859.2009431228892;879.7140929198036;895.2721247991439;986.1706534378768;14461.349239284258;15989.28048237832;16056;16285.185740712917;16701.83298167027;823.5552801487249;921.447131720962;922.9123233292827;925.4817302310593;964.2671569607149;9303.116203960613;9457.38526995757;9514.812537799777;9578.9042109578;9684.854727179098;459444;461372;465122;467263;473001;66921.66539167272;68254;68772.3122768776;69451.65274173698;69601.30398695948;1103.3119327429047;1109.589451902801;1124.1231839165464;1125.6791814332876;1141.3038046791617;14676;14706.779398309249;14784.926075369554;14860.554183374516;14901.329440175;32585.837070814494;32819;33387;33462.33075338431;33516.329673405904;41088.38367424551;42193.36709949415;42267;42377.36433953555;42401.57598423976;6715.697793599397;7099.503034787515;7134.607596582237;7138.250483699137;7310.0685755953255;10358.637447689294;10819.945900270763;10916.617918372818;11044.944775276072;11120.888791111985;7605.847883042197;8070;8784.736457906272;9686.895251327402;9807.264455166034;8975.371723979259;9027.187553119988;9679.66121185755;9762.219022478042;10250.897491024994;9388.996957454128;9442.10300021497;9783.706488805346;9788.412695238309;10137;6569.37590928861;7116.3951064158055;7152.356287934111;7187.496875218684;7197.100362454693;8967.327450441113;9358.859617105612;9419.387739796892;9724.70825875225;9853.408795472295 07:11:54 INFO - PROCESS | 10683 | |3;mootools.html;1463.0490181382102;1497.6705124872528;1665.8750593705474;1794.8923064616115;1815.8002619711829;7511.62441877906;7596.6961321547205;7614.695412183513;7669.309762121401;7699.307062364386;7887.21127887211;7908.7231946881875;7930.801729956754;7984.960075199616;8004;2339.1695947938533;2369.644553316999;2371.039728909794;2379.2862141357523;2382.5830479666074;2348.7064116985375;2357.787799098081;2369.0286982337243;2376.2514807835564;2376.4534157143867;2163.9783602163934;2179.596774596697;2283.4633861042644;2326.2555982085655;2344.19125401737;2310.988445057764;2311.768823117683;2321.3964369264113;2329.4409341758023;2340.520193360357;2223.310773660154;2225.5326381459913;2240.3502984134743;2240.764719704424;2245.8989345479495;7474.925250747478;7477.513961592534;7506.43701722373;7514.8121296967465;7532.6233688315915;4822.469528351879;4865.124277630025;4882.267659851015;4908.214685650314;4922.753862306906;2996.5654980027775;3072.2319420144963;3126.0621813455873;3130.5460708197184;3154.779165458419;971.2666936462996;972.8394814855541;988.9752756181081;990.9851352229722;1006.5571148694551;10685.252032357737;10727.731806704816;10733.83899241512;10746.73133171677;10783.191260655482;4168.312228482328;4224.577542245751;4248.362745588187;4283.336082907154;4315.352697095398;8432.283255923316;8441.788955276168;8456.788580285542;8468.364872634576;8482.957585212158;4672.392588963413;4690.850741568338;4695.553922377437;4726.8109275628585;4732.71603703772;4293.527711951683;4333.068390296102;4336.111097225062;4348.934765978513;4366.585174408426;3555.928881422357;3558.3061303046175;3594.51474051005;3601.7118630509494;3609.242059167552;1027.1833892055834;1052.1057101463696;1074.9193810464246;1081.432248069754;1083.9891601084046;914.6250037484599;1015.9441230732381;1066.9199810014125;1112.1825458288151;1275.7002104505434;6985.720571177198;7044.471664625174;7053.89419158713;7064.611446370396;7093.538919970186;622.757124721359;629.7071861584385;631.7599312261311;631.905214217871;769.6998170713426;5545.362283337387;5573.916391254134;5592.2730045094695;5600.383957764642;5655.519280861173;8924.598393072327;9028.909710902939;9079;9153.450792952444;9177.90822091784;8794.560271986504;8926.821463570823;8994.145556172152;9007.054259302678;9063.682771103111;7383.704651813975;7502.137254215726;7561.6597253122645;7630.389568834591;7642.847143057108;7152.713891444492;7179.210286868336;7180.676869540987;7197.496175267681;7208.531445456028;7950.642221099949;8070.878936815835;8136.593170341341;8262.256396924306;8334.62494187751;8220.63007164691;8261.876071858807;8320.292775114183;8326.875096873431;8337.66649334044;6681.164854393201;6900.861982760216;6913.3777959983845;6948.687309071003;6948.756793512202;7441.4418918582405;7445.143808462096;7446.14369347532;7515.962420188082;7602.771916842504;6262.248530176225;6987.1266091738535;7110.964445177741;7246.311600397954;7260.528065675714;6799.898001529882;6805.863882722417;6868.553544019623;6893.20728116273;6999.090118284794;6704.363085506869;6817.420519255918;6848.760293389708;6864.931350686429;6891.655417229219;6186.5360097993735;6201.627902325875;6229.937700622936;6247.468965138014;6249.312575616769;6293.402126797947;6381.361863813767;6503.674816259263;6514.697060587807;6601.53789234749 07:11:54 INFO - PROCESS | 10683 | |4;prototype.html;344.3612099555325;348.5712573534552;352.4536967700065;352.6508756331233;357.1286062008697;6216.285127210366;6233.844153896143;6260.342664020281;6328.557001009931;6364.459020983222;6252.874942501147;6275.341089185638;6295.874082518347;6304.684765761705;6346.11154438379;4770.0459908018365;4773.6897101688455;4776.976115119428;4779.187538118528;4781.258904869734;4755.738434386125;4759.928601070987;4766;4779.426468823746;4780;4634.698744581591;4704.788284527204;4736.668433209677;4739.857804265877;4753.643476739241;4699.859004229878;4713.740744259065;4714.198586240347;4747.335373047776;4749.382580264578;4064.2481140988716;4084.9591504084874;4104.4048612950955;4109.198706252282;4110.835566577333;6006.519478441714;6010.819675409701;6011.879762404727;6017.638941663514;6022.247219097613;5399.892002159935;5502.284702988586;5516.475934786189;5516.503514683657;5517.806876759294;6611.966940165316;6643.435307998826;6678;6684.665766711645;6692.698828552727;4550.226461501553;4556.931646025279;4558.111168322179;4567.885802854922;4567.977160114178;6795.490338224653;6847;6892.138482689664;6931;6943.444524438083;4647.744374059459;4653.348531205634;4661.3707149534375;4673.766311684471;4674.69614475058;4715.24556071027;4717.9292310615365;4735.621150307967;4747.359106520645;4752.7623618818925;5494;5495.53287970519;5499.725013749377;5500;5502.669839809624;6552.180977377828;6625.569337993015;6668.966655166693;6690.13028306317;6707.295733947963;1624.910629915366;1626.5770899566198;1671.431713217512;1673.4059408909905;1678.0602862397097;1107.451811353369;1108.4790148630132;1113.209621168979;1114.7268919114706;1117.1565468071717;6187.84530386744;6216.098665693539;6225.408586184305;6255.40573645503;6282.811515654537;6757.797266082025;6777.830554236183;6806.897896531556;6810.693518791567;6811.659417029129;6077.24034495688;6193.907091393633;6200.3799620038535;6217.626942383471;6264.248290205113;3682.521272234646;3688.4098544232793;3693.261347730465;3700.8527356519567;3704.7777133371546;7037.472189585802;7075.2217256101785;7101.715931362791;7125.2874712529365;7149.53528020677;6892.448604111659;6957.79126626202;6979.651017449209;6982.79051628452;7009.614471204132;7263.89104163438;7306.159791624032;7307.525010874276;7309.086364204474;7335;6910.308969103251;6948.131483564554;6957.4086202671315;6999.720011199699;7021.192562855337;6796.932030679828;6837.863242735217;6899.965500172467;6905.482088843256;6913.0667359905765;7235.602041887747;7242.13094428672;7267.527610705287;7271.527350722397;7291.927080729125;4674.111918735565;4690.179218636793;4712.458067322164;4719.764011799465;4733.384659994179;6879.552829066095;6964.164300283998;6968.965155174192;6989.33601307875;6996.265392133956;6697.196336439659;6702.798916032527;6706.161729783777;6707.865842683216;6748.527603067934;6665.900011499734;6721.462283017249;6735.326467353226;6737.797866064026;6740.764073257413;6356.968215158895;6551.377619126175;6560.475161987125;6606.8678626426245;6614.239362473377;6730.394264516217;6764.0868482754195;6768.052472653931;6773.288804675438;6786.491013174131;6631.966840165768;6640.701168447528;6641.435477984425;6649.936010238339;6650.6342151180215 07:11:54 INFO - PROCESS | 10683 | |5;yui.html;716.9928300716995;722.5520177489957;768.5696010234269;798.253632853282;818.8812622169786;13123.1469954453;13271.20372777634;13303.93348033261;13336.666583335409;13344.33278336083;12690.111692181528;12726.68183295418;12752.426140823662;12759.489620415172;12797.744045119116;675.2605896543278;684.3635419060272;819.4264015189361;825.3314814999854;831.5883637599367;821.9219174178473;822.0382152881143;823.8311146215011;826.8883700700419;831.733845169546;872.2847265242503;875.711015364928;877.4735158904638;878.2403221213636;882.4043770454949;868.4181598329135;869.7260362985703;871.0418539606383;871.5250188647202;875.3959767760257;640.6028262477294;642.0337392224718;643.0579201469823;644.7485480662546;647.5402464250341;13179.538716144985;13187.670308242275;13206.933965330112;13246.66883327915;13298.069135160446;12916.87083129166;13153.342332883318;13251.668708282274;13269;13601.523946661919;10172.643957461527;10221;10262.589496420134;10272.28094033418;10850.29473084247;3350.3466823969334;3350.664933506654;3365.1082463147286;3629.383004889175;3823.8279277432584;45330;47149;47210.5278947213;47229.76385118053;47538.76230618825;9252.121048500381;9765.804683906425;10009.599616015423;10128.898711012796;10268.948655256676;17227;17242.913785430992;18221.271149154152;18368.35710750144;18436.631267374847;7558.58427786477;7586.165521792598;7590.506617069873;7601.201873803171;7619.619019049025;4185.727927684691;4236.301010333322;4258.254805409041;4341.761203133795;4369.300911854088;3036.3927214557175;3056.419280336729;3057.6942305769244;3083.9691603083684;3097.0399176255432;576.1703147467717;608.4128815692877;610.4322979628988;616.5006344860677;618.1932577985772;529.6742503360406;559.420999265758;608.7869245763948;727.5234721257585;739.7706710919632;8381.748547543584;8405.621747021398;9524.142827145452;9586.808263834824;9702.466364350028;576.850018995056;578.4851482180862;598.5361344957605;653.8263816449485;674.5379415100672;4099.344104943195;4155;4281.207976524353;4403.9559604404185;4439.178751930838;54319.72840135774;58294;58318.7084064577;58337;58599.41400586025;49600.255996160085;49889.50110498921;49912.500874991514;50013.24980125301;50274.245886311735;44335.99999999935;44543;44880;45142.097158056655;45176;9201.861972070557;9245.58394872219;9410.670626528312;9446.38598491096;9456.858147127936;32484.350312993134;32574.185645359055;32664.183395415304;32826.83586582052;33115.17212069718;38861;38956.6104338953;43012.13975720405;43225.13549729051;43978.56021439745;10439.425831579336;10512;10527.210459215436;10562.155027597928;10581.62964296246;12028.879711202775;12150.331731754484;12364.938175309426;12644.620661380173;12697.735981875825;11726.94136529312;11923.880761192277;12004.879951200377;12254.938725306316;12296.508139674313;10992.450377480935;11129;11810.940945295219;11852;12273.263604183778;11283;11283.887161128283;11444.027257682857;11545.422728863356;11681.824772628248;9436.9769717789;9486.28852836054;9540.85688714656;9840.852387214341;9875.506224688594;9705.272104592043;10164.085232329126;10193.490325483845;10232.283740138118;10398.740031499274 07:11:54 INFO - PROCESS | 10683 | __end_tp_report 07:11:54 INFO - PROCESS | 10683 | __start_cc_report 07:11:54 INFO - PROCESS | 10683 | _x_x_mozilla_cycle_collect,318 07:11:54 INFO - PROCESS | 10683 | __end_cc_report 07:11:54 INFO - PROCESS | 10683 | __startTimestamp1453475514782__endTimestamp 07:11:54 INFO - PROCESS | 10683 | 07:11:54 INFO - PROCESS | 10683 | ------- Summary: start ------- 07:11:54 INFO - PROCESS | 10683 | Number of tests: 6 07:11:54 INFO - PROCESS | 10683 | 07:11:54 INFO - PROCESS | 10683 | [#0] dojo.html Cycles:165 Average:5320.72 Median:5521.00 stddev:590.47 (10.7%) stddev-sans-first:567.97 07:11:54 INFO - PROCESS | 10683 | Values: 3182.8 3209.5 3238.8 3251.2 3260.3 5250.2 5319.4 5335.8 5341.1 5357.7 5253.1 5328.2 5362.5 5377.1 5386.1 4784.5 4815.3 4823.9 4920.1 4960.1 4565.9 4916.0 4938.6 5019.6 5046.8 4743.7 4802.3 4810.2 4862.4 4886.1 4829.5 4871.9 4873.0 4881.9 4902.6 4614.6 4857.2 4861.9 4876.1 4892.7 5105.7 5159.8 5182.1 5192.1 5215.6 5713.3 5741.0 5741.7 5750.3 5751.3 5432.3 5565.5 5760.5 5775.9 5781.5 5234.3 5242.8 5243.3 5257.0 5271.6 5830.5 5881.5 5892.8 5899.9 5948.3 5663.6 5704.4 5708.2 5723.4 5725.5 5598.7 5709.9 5718.9 5780.8 5806.3 5698.1 5719.2 5721.7 5733.7 5769.4 5741.6 5767.2 5790.1 5794.7 5822.3 4341.0 4399.1 4431.9 4493.6 4524.0 3965.5 3978.2 3979.1 3994.0 4013.2 5379.8 5409.4 5412.0 5422.1 5464.6 5597.9 5672.9 5686.9 5695.6 5800.6 5267.3 5272.9 5286.6 5297.9 5445.9 4928.1 4952.1 4959.5 4967.1 4990.8 5948.0 5984.3 5986.6 6038.3 6072.8 5573.7 5656.6 5742.5 5798.7 5834.9 5927.9 5953.0 5953.3 5969.5 5987.9 5620.4 5668.3 5672.2 5675.5 5685.5 5554.9 5643.3 5683.0 5758.5 5850.1 5609.4 5633.7 5636.4 5650.7 5652.0 5614.6 5615.6 5623.4 5643.4 5650.4 5411.1 5473.9 5481.4 5521.0 5566.7 5642.7 5648.0 5651.2 5676.7 5682.2 5376.9 5485.7 5520.1 5544.3 5557.7 07:11:54 INFO - PROCESS | 10683 | 07:11:54 INFO - PROCESS | 10683 | [#1] ext.html Cycles:180 Average:43345.84 Median:18633.15 stddev:71471.13 (383.6%) stddev-sans-first:71599.27 07:11:54 INFO - PROCESS | 10683 | Values: 513.4 528.3 530.9 543.5 547.3 34914.7 34963.7 35305.5 35474.8 35492.3 39364.6 39822.8 39938.2 39966.0 40007.4 8653.9 8915.7 8920.2 8933.4 8956.1 8546.7 8633.4 8681.2 8687.3 8689.7 8580.4 8652.5 8677.0 8693.3 8743.0 8612.7 8665.4 8687.5 8695.3 8697.2 8499.2 8562.0 8572.2 8599.4 8621.8 38362.2 38673.2 38919.6 38972.2 39050.4 2816.6 3322.2 3465.0 3474.1 3610.4 27885.4 28205.6 28667.3 28878.4 29460.1 3239.0 3327.5 3603.4 3616.7 3752.5 212904.0 213500.0 213655.0 214129.0 214580.0 54887.5 55216.0 55248.4 55321.0 55634.0 52939.0 53054.5 53091.2 53166.5 53240.7 15689.8 15958.5 15987.2 16032.7 16099.4 12196.9 12225.3 12253.4 12314.3 12359.8 18812.9 19453.9 19494.6 19504.6 19538.4 7907.5 8020.0 8049.8 8090.5 8138.4 866.2 920.9 1009.9 1033.7 1038.6 24971.5 25143.0 25159.5 25435.6 26064.0 1030.0 1032.0 1077.8 1102.5 1167.3 13377.1 13429.9 13453.9 13591.9 13894.9 306507.0 307491.0 310802.0 311154.0 311385.0 50148.0 50232.2 50347.2 50611.0 50619.5 1298.4 1318.5 1340.4 1360.1 1395.1 24330.5 26211.3 26567.0 26582.6 26625.7 42155.6 42469.6 42655.4 42693.0 42698.1 287135.0 287824.0 288421.0 288861.0 289347.0 29935.9 30840.0 30977.5 31025.2 31083.2 41815.2 42134.6 42679.8 43186.8 44100.1 32996.8 35594.3 36094.6 36545.7 36973.4 32876.5 33285.0 33442.8 33454.5 33801.3 32085.2 32380.2 32544.5 35221.6 35524.0 27931.7 29073.6 29983.7 31792.7 32829.3 23245.2 23406.4 24005.3 24305.1 24605.9 07:11:54 INFO - PROCESS | 10683 | 07:11:54 INFO - PROCESS | 10683 | [#2] jquery.html Cycles:180 Average:24828.13 Median:5110.76 stddev:75998.41 (1487.0%) stddev-sans-first:76189.39 07:11:54 INFO - PROCESS | 10683 | Values: 358.0 363.5 370.2 372.2 372.8 15411.4 16587.6 16753.5 17123.9 17782.3 11204.8 11217.2 16356.2 16368.5 16370.2 4580.9 5264.9 5296.8 5324.7 5327.4 5104.2 5159.3 5202.0 5244.1 5258.7 5019.4 5196.6 5213.4 5215.6 5223.7 5078.2 5117.3 5118.4 5145.8 5150.6 5152.0 5167.8 5192.2 5208.8 5212.3 11882.5 15452.4 19277.0 19982.5 20020.2 2037.3 2111.8 2113.8 2197.6 2260.8 8668.0 8748.0 8753.8 8775.8 9009.1 1682.0 1763.5 1772.6 1814.9 1874.3 38812.2 39557.0 52538.5 54184.9 54824.5 9152.4 9693.4 10308.9 10362.4 10447.8 13395.3 13441.6 13443.2 13517.1 13582.1 6982.2 7122.3 7130.3 7384.7 7475.9 6731.7 6785.1 6973.5 7053.9 7126.8 4167.0 4470.9 4501.7 4522.7 4566.1 1729.6 1815.2 1827.8 1875.3 1933.6 799.8 859.2 879.7 895.3 986.2 14461.3 15989.3 16056.0 16285.2 16701.8 823.6 921.4 922.9 925.5 964.3 9303.1 9457.4 9514.8 9578.9 9684.9 459444.0 461372.0 465122.0 467263.0 473001.0 66921.7 68254.0 68772.3 69451.7 69601.3 1103.3 1109.6 1124.1 1125.7 1141.3 14676.0 14706.8 14784.9 14860.6 14901.3 32585.8 32819.0 33387.0 33462.3 33516.3 41088.4 42193.4 42267.0 42377.4 42401.6 6715.7 7099.5 7134.6 7138.3 7310.1 10358.6 10819.9 10916.6 11044.9 11120.9 7605.8 8070.0 8784.7 9686.9 9807.3 8975.4 9027.2 9679.7 9762.2 10250.9 9389.0 9442.1 9783.7 9788.4 10137.0 6569.4 7116.4 7152.4 7187.5 7197.1 8967.3 9358.9 9419.4 9724.7 9853.4 07:11:54 INFO - PROCESS | 10683 | 07:11:54 INFO - PROCESS | 10683 | [#3] mootools.html Cycles:180 Average:5379.23 Median:3506.63 stddev:2769.77 (79.0%) stddev-sans-first:2761.90 07:11:54 INFO - PROCESS | 10683 | Values: 1463.0 1497.7 1665.9 1794.9 1815.8 7511.6 7596.7 7614.7 7669.3 7699.3 7887.2 7908.7 7930.8 7985.0 8004.0 2339.2 2369.6 2371.0 2379.3 2382.6 2348.7 2357.8 2369.0 2376.3 2376.5 2164.0 2179.6 2283.5 2326.3 2344.2 2311.0 2311.8 2321.4 2329.4 2340.5 2223.3 2225.5 2240.4 2240.8 2245.9 7474.9 7477.5 7506.4 7514.8 7532.6 4822.5 4865.1 4882.3 4908.2 4922.8 2996.6 3072.2 3126.1 3130.5 3154.8 971.3 972.8 989.0 991.0 1006.6 10685.3 10727.7 10733.8 10746.7 10783.2 4168.3 4224.6 4248.4 4283.3 4315.4 8432.3 8441.8 8456.8 8468.4 8483.0 4672.4 4690.9 4695.6 4726.8 4732.7 4293.5 4333.1 4336.1 4348.9 4366.6 3555.9 3558.3 3594.5 3601.7 3609.2 1027.2 1052.1 1074.9 1081.4 1084.0 914.6 1015.9 1066.9 1112.2 1275.7 6985.7 7044.5 7053.9 7064.6 7093.5 622.8 629.7 631.8 631.9 769.7 5545.4 5573.9 5592.3 5600.4 5655.5 8924.6 9028.9 9079.0 9153.5 9177.9 8794.6 8926.8 8994.1 9007.1 9063.7 7383.7 7502.1 7561.7 7630.4 7642.8 7152.7 7179.2 7180.7 7197.5 7208.5 7950.6 8070.9 8136.6 8262.3 8334.6 8220.6 8261.9 8320.3 8326.9 8337.7 6681.2 6900.9 6913.4 6948.7 6948.8 7441.4 7445.1 7446.1 7516.0 7602.8 6262.2 6987.1 7111.0 7246.3 7260.5 6799.9 6805.9 6868.6 6893.2 6999.1 6704.4 6817.4 6848.8 6864.9 6891.7 6186.5 6201.6 6229.9 6247.5 6249.3 6293.4 6381.4 6503.7 6514.7 6601.5 07:11:54 INFO - PROCESS | 10683 | 07:11:54 INFO - PROCESS | 10683 | [#4] prototype.html Cycles:180 Average:5565.14 Median:6257.87 stddev:1701.87 (27.2%) stddev-sans-first:1660.92 07:11:54 INFO - PROCESS | 10683 | Values: 344.4 348.6 352.5 352.7 357.1 6216.3 6233.8 6260.3 6328.6 6364.5 6252.9 6275.3 6295.9 6304.7 6346.1 4770.0 4773.7 4777.0 4779.2 4781.3 4755.7 4759.9 4766.0 4779.4 4780.0 4634.7 4704.8 4736.7 4739.9 4753.6 4699.9 4713.7 4714.2 4747.3 4749.4 4064.2 4085.0 4104.4 4109.2 4110.8 6006.5 6010.8 6011.9 6017.6 6022.2 5399.9 5502.3 5516.5 5516.5 5517.8 6612.0 6643.4 6678.0 6684.7 6692.7 4550.2 4556.9 4558.1 4567.9 4568.0 6795.5 6847.0 6892.1 6931.0 6943.4 4647.7 4653.3 4661.4 4673.8 4674.7 4715.2 4717.9 4735.6 4747.4 4752.8 5494.0 5495.5 5499.7 5500.0 5502.7 6552.2 6625.6 6669.0 6690.1 6707.3 1624.9 1626.6 1671.4 1673.4 1678.1 1107.5 1108.5 1113.2 1114.7 1117.2 6187.8 6216.1 6225.4 6255.4 6282.8 6757.8 6777.8 6806.9 6810.7 6811.7 6077.2 6193.9 6200.4 6217.6 6264.2 3682.5 3688.4 3693.3 3700.9 3704.8 7037.5 7075.2 7101.7 7125.3 7149.5 6892.4 6957.8 6979.7 6982.8 7009.6 7263.9 7306.2 7307.5 7309.1 7335.0 6910.3 6948.1 6957.4 6999.7 7021.2 6796.9 6837.9 6900.0 6905.5 6913.1 7235.6 7242.1 7267.5 7271.5 7291.9 4674.1 4690.2 4712.5 4719.8 4733.4 6879.6 6964.2 6969.0 6989.3 6996.3 6697.2 6702.8 6706.2 6707.9 6748.5 6665.9 6721.5 6735.3 6737.8 6740.8 6357.0 6551.4 6560.5 6606.9 6614.2 6730.4 6764.1 6768.1 6773.3 6786.5 6632.0 6640.7 6641.4 6649.9 6650.6 07:11:54 INFO - PROCESS | 10683 | 07:11:54 INFO - PROCESS | 10683 | [#5] yui.html Cycles:180 Average:13604.22 Median:24369.98 stddev:15446.49 (63.4%) stddev-sans-first:15459.50 07:11:54 INFO - PROCESS | 10683 | Values: 717.0 722.6 768.6 798.3 818.9 13123.1 13271.2 13303.9 13336.7 13344.3 12690.1 12726.7 12752.4 12759.5 12797.7 675.3 684.4 819.4 825.3 831.6 821.9 822.0 823.8 826.9 831.7 872.3 875.7 877.5 878.2 882.4 868.4 869.7 871.0 871.5 875.4 640.6 642.0 643.1 644.7 647.5 13179.5 13187.7 13206.9 13246.7 13298.1 12916.9 13153.3 13251.7 13269.0 13601.5 10172.6 10221.0 10262.6 10272.3 10850.3 3350.3 3350.7 3365.1 3629.4 3823.8 45330.0 47149.0 47210.5 47229.8 47538.8 9252.1 9765.8 10009.6 10128.9 10268.9 17227.0 17242.9 18221.3 18368.4 18436.6 7558.6 7586.2 7590.5 7601.2 7619.6 4185.7 4236.3 4258.3 4341.8 4369.3 3036.4 3056.4 3057.7 3084.0 3097.0 576.2 608.4 610.4 616.5 618.2 529.7 559.4 608.8 727.5 739.8 8381.7 8405.6 9524.1 9586.8 9702.5 576.9 578.5 598.5 653.8 674.5 4099.3 4155.0 4281.2 4404.0 4439.2 54319.7 58294.0 58318.7 58337.0 58599.4 49600.3 49889.5 49912.5 50013.2 50274.2 44336.0 44543.0 44880.0 45142.1 45176.0 9201.9 9245.6 9410.7 9446.4 9456.9 32484.4 32574.2 32664.2 32826.8 33115.2 38861.0 38956.6 43012.1 43225.1 43978.6 10439.4 10512.0 10527.2 10562.2 10581.6 12028.9 12150.3 12364.9 12644.6 12697.7 11726.9 11923.9 12004.9 12254.9 12296.5 10992.5 11129.0 11810.9 11852.0 12273.3 11283.0 11283.9 11444.0 11545.4 11681.8 9437.0 9486.3 9540.9 9840.9 9875.5 9705.3 10164.1 10193.5 10232.3 10398.7 07:11:54 INFO - PROCESS | 10683 | -------- Summary: end -------- 07:11:54 INFO - PROCESS | 10683 | 07:11:55 INFO - TEST-INFO | 10683: exit 0 07:11:55 INFO - TEST-OK | dromaeo_css | took 1110930ms 07:11:55 INFO - TEST-START | kraken 07:11:55 INFO - operating with platform_type : linux_ 07:11:55 INFO - Initialising browser for kraken test... 07:11:55 INFO - TEST-INFO | started process 10925 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpchD0lB/profile http://localhost:55875/getInfo.html) 07:11:59 INFO - PROCESS | 10925 | 07:11:59 INFO - PROCESS | 10925 | (process:10994): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:12:00 INFO - PROCESS | 10925 | __metrics Screen width/height:1600/1200 07:12:00 INFO - PROCESS | 10925 | colorDepth:24 07:12:00 INFO - PROCESS | 10925 | Browser inner width/height: 1024/697 07:12:00 INFO - PROCESS | 10925 | __metrics 07:12:00 INFO - PROCESS | 10925 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:12:01 INFO - TEST-INFO | 10925: exit 0 07:12:01 INFO - Browser initialized. 07:12:01 INFO - Running cycle 1/1 for kraken test... 07:12:01 INFO - TEST-INFO | started process 11043 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpchD0lB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:02 INFO - PROCESS | 11043 | 07:12:02 INFO - PROCESS | 11043 | (process:11104): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:12:12 INFO - PROCESS | 11043 | RSS: Main: 151961600 07:12:12 INFO - PROCESS | 11043 | 07:12:15 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55875/tests/kraken/driver.html?testName=audio-beat-detection) 07:12:16 INFO - PROCESS | 11043 | RSS: Main: 154906624 07:12:16 INFO - PROCESS | 11043 | 07:12:18 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55875/tests/kraken/driver.html?testName=audio-dft) 07:12:19 INFO - PROCESS | 11043 | RSS: Main: 157683712 07:12:19 INFO - PROCESS | 11043 | 07:12:22 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55875/tests/kraken/driver.html?testName=audio-fft) 07:12:22 INFO - PROCESS | 11043 | RSS: Main: 152330240 07:12:22 INFO - PROCESS | 11043 | 07:12:24 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55875/tests/kraken/driver.html?testName=audio-oscillator) 07:12:25 INFO - PROCESS | 11043 | RSS: Main: 151552000 07:12:25 INFO - PROCESS | 11043 | 07:12:27 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55875/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:12:28 INFO - PROCESS | 11043 | RSS: Main: 153145344 07:12:28 INFO - PROCESS | 11043 | 07:12:31 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55875/tests/kraken/driver.html?testName=imaging-darkroom) 07:12:31 INFO - PROCESS | 11043 | RSS: Main: 152190976 07:12:31 INFO - PROCESS | 11043 | 07:12:35 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55875/tests/kraken/driver.html?testName=imaging-desaturate) 07:12:35 INFO - PROCESS | 11043 | RSS: Main: 152940544 07:12:35 INFO - PROCESS | 11043 | 07:12:38 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55875/tests/kraken/driver.html?testName=json-parse-financial) 07:12:39 INFO - PROCESS | 11043 | RSS: Main: 155070464 07:12:39 INFO - PROCESS | 11043 | 07:12:40 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55875/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:12:41 INFO - PROCESS | 11043 | RSS: Main: 155746304 07:12:41 INFO - PROCESS | 11043 | 07:12:43 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55875/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:12:43 INFO - PROCESS | 11043 | RSS: Main: 155504640 07:12:43 INFO - PROCESS | 11043 | 07:12:45 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55875/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:12:46 INFO - PROCESS | 11043 | RSS: Main: 155496448 07:12:46 INFO - PROCESS | 11043 | 07:12:48 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55875/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:12:49 INFO - PROCESS | 11043 | RSS: Main: 154914816 07:12:49 INFO - PROCESS | 11043 | 07:12:52 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55875/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:12:52 INFO - PROCESS | 11043 | RSS: Main: 154202112 07:12:52 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | Cycle 1(1): loaded http://localhost:55875/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55875/tests/kraken/driver.html?testName=ai-astar) 07:12:54 INFO - PROCESS | 11043 | RSS: Main: 156418048 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | __start_tp_report 07:12:54 INFO - PROCESS | 11043 | _x_x_mozilla_page_load 07:12:54 INFO - PROCESS | 11043 | _x_x_mozilla_page_load_details 07:12:54 INFO - PROCESS | 11043 | |i|pagename|runs| 07:12:54 INFO - PROCESS | 11043 | |0;ai-astar;112;109;111;112;113;124;113;113;114;111 07:12:54 INFO - PROCESS | 11043 | |1;audio-beat-detection;166;126;154;183;130;157;154;135;161;130 07:12:54 INFO - PROCESS | 11043 | |2;audio-dft;163;162;163;162;161;163;161;165;166;162 07:12:54 INFO - PROCESS | 11043 | |3;audio-fft;74;77;72;73;73;73;146;74;75;72 07:12:54 INFO - PROCESS | 11043 | |4;audio-oscillator;97;97;136;96;96;99;150;97;97;144 07:12:54 INFO - PROCESS | 11043 | |5;imaging-gaussian-blur;110;111;110;110;109;110;110;110;111;110 07:12:54 INFO - PROCESS | 11043 | |6;imaging-darkroom;148;146;148;147;147;147;147;147;147;148 07:12:54 INFO - PROCESS | 11043 | |7;imaging-desaturate;98;96;97;96;97;97;97;97;97;96 07:12:54 INFO - PROCESS | 11043 | |8;json-parse-financial;59;60;60;61;60;59;61;61;67;58 07:12:54 INFO - PROCESS | 11043 | |9;json-stringify-tinderbox;66;67;66;68;67;67;68;68;67;69 07:12:54 INFO - PROCESS | 11043 | |10;stanford-crypto-aes;82;81;85;81;91;83;81;82;82;84 07:12:54 INFO - PROCESS | 11043 | |11;stanford-crypto-ccm;124;120;121;115;118;129;115;120;115;115 07:12:54 INFO - PROCESS | 11043 | |12;stanford-crypto-pbkdf2;136;138;145;142;146;151;144;144;144;143 07:12:54 INFO - PROCESS | 11043 | |13;stanford-crypto-sha256-iterative;66;67;66;67;67;65;68;65;66;66 07:12:54 INFO - PROCESS | 11043 | __end_tp_report 07:12:54 INFO - PROCESS | 11043 | __start_cc_report 07:12:54 INFO - PROCESS | 11043 | _x_x_mozilla_cycle_collect,735 07:12:54 INFO - PROCESS | 11043 | __end_cc_report 07:12:54 INFO - PROCESS | 11043 | __startTimestamp1453475574560__endTimestamp 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | ------- Summary: start ------- 07:12:54 INFO - PROCESS | 11043 | Number of tests: 14 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:4.05 (3.6%) stddev-sans-first:4.27 07:12:54 INFO - PROCESS | 11043 | Values: 112.0 109.0 111.0 112.0 113.0 124.0 113.0 113.0 114.0 111.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:155.50 stddev:18.70 (12.0%) stddev-sans-first:18.87 07:12:54 INFO - PROCESS | 11043 | Values: 166.0 126.0 154.0 183.0 130.0 157.0 154.0 135.0 161.0 130.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.62 (1.0%) stddev-sans-first:1.72 07:12:54 INFO - PROCESS | 11043 | Values: 163.0 162.0 163.0 162.0 161.0 163.0 161.0 165.0 166.0 162.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#3] audio-fft Cycles:10 Average:80.90 Median:73.50 stddev:22.92 (31.2%) stddev-sans-first:24.18 07:12:54 INFO - PROCESS | 11043 | Values: 74.0 77.0 72.0 73.0 73.0 73.0 146.0 74.0 75.0 72.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:97.00 stddev:22.64 (23.3%) stddev-sans-first:23.45 07:12:54 INFO - PROCESS | 11043 | Values: 97.0 97.0 136.0 96.0 96.0 99.0 150.0 97.0 97.0 144.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:12:54 INFO - PROCESS | 11043 | Values: 110.0 111.0 110.0 110.0 109.0 110.0 110.0 110.0 111.0 110.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 07:12:54 INFO - PROCESS | 11043 | Values: 148.0 146.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 07:12:54 INFO - PROCESS | 11043 | Values: 98.0 96.0 97.0 96.0 97.0 97.0 97.0 97.0 97.0 96.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.50 stddev:2.46 (4.1%) stddev-sans-first:2.54 07:12:54 INFO - PROCESS | 11043 | Values: 59.0 60.0 60.0 61.0 60.0 59.0 61.0 61.0 67.0 58.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:0.95 (1.4%) stddev-sans-first:0.88 07:12:54 INFO - PROCESS | 11043 | Values: 66.0 67.0 66.0 68.0 67.0 67.0 68.0 68.0 67.0 69.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:82.50 stddev:3.05 (3.7%) stddev-sans-first:3.20 07:12:54 INFO - PROCESS | 11043 | Values: 82.0 81.0 85.0 81.0 91.0 83.0 81.0 82.0 82.0 84.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:120.00 stddev:4.66 (3.9%) stddev-sans-first:4.61 07:12:54 INFO - PROCESS | 11043 | Values: 124.0 120.0 121.0 115.0 118.0 129.0 115.0 120.0 115.0 115.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:144.00 stddev:4.14 (2.9%) stddev-sans-first:3.44 07:12:54 INFO - PROCESS | 11043 | Values: 136.0 138.0 145.0 142.0 146.0 151.0 144.0 144.0 144.0 143.0 07:12:54 INFO - PROCESS | 11043 | 07:12:54 INFO - PROCESS | 11043 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 07:12:54 INFO - PROCESS | 11043 | Values: 66.0 67.0 66.0 67.0 67.0 65.0 68.0 65.0 66.0 66.0 07:12:54 INFO - PROCESS | 11043 | -------- Summary: end -------- 07:12:54 INFO - PROCESS | 11043 | 07:12:55 INFO - TEST-INFO | 11043: exit 0 07:12:55 INFO - TEST-OK | kraken | took 60021ms 07:12:55 INFO - TEST-START | v8_7 07:12:55 INFO - operating with platform_type : linux_ 07:12:55 INFO - Initialising browser for v8_7 test... 07:12:55 INFO - TEST-INFO | started process 11332 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjR__lC/profile http://localhost:55875/getInfo.html) 07:12:59 INFO - PROCESS | 11332 | 07:12:59 INFO - PROCESS | 11332 | (process:11401): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:13:00 INFO - PROCESS | 11332 | __metrics Screen width/height:1600/1200 07:13:00 INFO - PROCESS | 11332 | colorDepth:24 07:13:00 INFO - PROCESS | 11332 | Browser inner width/height: 1024/697 07:13:00 INFO - PROCESS | 11332 | __metrics 07:13:00 INFO - PROCESS | 11332 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:13:01 INFO - TEST-INFO | 11332: exit 0 07:13:01 INFO - Browser initialized. 07:13:01 INFO - Running cycle 1/1 for v8_7 test... 07:13:01 INFO - TEST-INFO | started process 11450 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjR__lC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:02 INFO - PROCESS | 11450 | 07:13:02 INFO - PROCESS | 11450 | (process:11509): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:13:13 INFO - PROCESS | 11450 | RSS: Main: 150515712 07:13:13 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | Cycle 1(1): loaded http://localhost:55875/tests/v8_7/run.html (next: http://localhost:55875/tests/v8_7/run.html) 07:13:35 INFO - PROCESS | 11450 | RSS: Main: 151912448 07:13:35 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | __start_tp_report 07:13:35 INFO - PROCESS | 11450 | _x_x_mozilla_page_load 07:13:35 INFO - PROCESS | 11450 | _x_x_mozilla_page_load_details 07:13:35 INFO - PROCESS | 11450 | |i|pagename|runs| 07:13:35 INFO - PROCESS | 11450 | |0;Richards;167.44809109176154 07:13:35 INFO - PROCESS | 11450 | |1;DeltaBlue;191.0949742021785 07:13:35 INFO - PROCESS | 11450 | |2;Encrypt;281.135788585887 07:13:35 INFO - PROCESS | 11450 | |3;Decrypt;5196.891191709845 07:13:35 INFO - PROCESS | 11450 | |4;RayTrace;1100.1100110011 07:13:35 INFO - PROCESS | 11450 | |5;Earley;686.3417982155113 07:13:35 INFO - PROCESS | 11450 | |6;Boyer;12304.878048780487 07:13:35 INFO - PROCESS | 11450 | |7;RegExp;42122.448979591834 07:13:35 INFO - PROCESS | 11450 | |8;Splay;631.3131313131313 07:13:35 INFO - PROCESS | 11450 | |9;NavierStokes;4822.115384615385 07:13:35 INFO - PROCESS | 11450 | __end_tp_report 07:13:35 INFO - PROCESS | 11450 | __startTimestamp1453475615663__endTimestamp 07:13:35 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | ------- Summary: start ------- 07:13:35 INFO - PROCESS | 11450 | Number of tests: 10 07:13:35 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | [#0] Richards Cycles:1 Average:167.45 Median:167.45 stddev:0.00 (0.0%) 07:13:35 INFO - PROCESS | 11450 | Values: 167.4 07:13:35 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | [#1] DeltaBlue Cycles:1 Average:191.09 Median:191.09 stddev:0.00 (0.0%) 07:13:35 INFO - PROCESS | 11450 | Values: 191.1 07:13:35 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | [#2] Encrypt Cycles:1 Average:281.14 Median:281.14 stddev:0.00 (0.0%) 07:13:35 INFO - PROCESS | 11450 | Values: 281.1 07:13:35 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 07:13:35 INFO - PROCESS | 11450 | Values: 5196.9 07:13:35 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | [#4] RayTrace Cycles:1 Average:1100.11 Median:1100.11 stddev:0.00 (0.0%) 07:13:35 INFO - PROCESS | 11450 | Values: 1100.1 07:13:35 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | [#5] Earley Cycles:1 Average:686.34 Median:686.34 stddev:0.00 (0.0%) 07:13:35 INFO - PROCESS | 11450 | Values: 686.3 07:13:35 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 07:13:35 INFO - PROCESS | 11450 | Values: 12304.9 07:13:35 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | [#7] RegExp Cycles:1 Average:42122.45 Median:42122.45 stddev:0.00 (0.0%) 07:13:35 INFO - PROCESS | 11450 | Values: 42122.4 07:13:35 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | [#8] Splay Cycles:1 Average:631.31 Median:631.31 stddev:0.00 (0.0%) 07:13:35 INFO - PROCESS | 11450 | Values: 631.3 07:13:35 INFO - PROCESS | 11450 | 07:13:35 INFO - PROCESS | 11450 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 07:13:35 INFO - PROCESS | 11450 | Values: 4822.1 07:13:35 INFO - PROCESS | 11450 | -------- Summary: end -------- 07:13:35 INFO - PROCESS | 11450 | 07:13:36 INFO - TEST-INFO | 11450: exit 0 07:13:36 INFO - TEST-OK | v8_7 | took 41089ms 07:13:36 INFO - SUITE-END | took 1212s 07:13:36 INFO - Completed test suite (00:20:12) 07:13:36 INFO - Working with test: dromaeo_css 07:13:36 INFO - Generating results file: dromaeo_css 07:13:36 INFO - Working with test: kraken 07:13:36 INFO - Generating results file: kraken 07:13:36 INFO - javascript benchmark 07:13:36 INFO - Working with test: v8_7 07:13:36 INFO - Generating results file: v8_7 07:13:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:13:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:13:36 INFO - process_Request line: dromaeo_css 6837.21 graph.html#tests=[[72,1,43]] 07:13:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:13:36 INFO - process_Request line: kraken 1511.40 graph.html#tests=[[232,1,43]] 07:13:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:13:36 INFO - process_Request line: v8_7 20209.81 graph.html#tests=[[230,1,43]] 07:13:36 INFO - RETURN: dromaeo_css: 6837.21 07:13:36 INFO - RETURN: kraken: 1511.40 07:13:36 INFO - RETURN: v8_7: 20209.81 07:13:36 INFO - javascript benchmark 07:13:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3182.8408579571023, 3209.5025271082977, 3238.789478683887, 3251.219707270255, 3260.2827377976837, 5250.238715386266, 5319.414864364921, 5335.7865685372535, 5341.145416733323, 5357.65175263608, 5253.080710875591, 5328.200769884519, 5362.4637536246355, 5377.139657654776, 5386.138217885139, 4784.521547845214, 4815.301781241717, 4823.903521929559, 4920.089783390066, 4960.107180707471, 4565.931511027337, 4915.9754201229125, 4938.629602779788, 5019.64862459628, 5046.798128074873, 4743.667943243974, 4802.30366596845, 4810.230363141898, 4862.3922009748785, 4886.071646387175, 4829.492903245179, 4871.902561948741, 4873.049755297719, 4881.8779530511665, 4902.632302577321, 4614.607758340545, 4857.222844344888, 4861.927071093901, 4876.097921884463, 4892.6575139740235, 5105.693658380472, 5159.793608255665, 5182.144946083891, 5192.091384007784, 5215.58275337972, 5713.314402271754, 5740.9712951435395, 5741.741621627037, 5750.338711048241, 5751.309842818847, 5432.29380180574, 5565.499105080522, 5760.510356619692, 5775.913361299584, 5781.508571771405, 5234.293370394986, 5242.842714718565, 5243.292155558989, 5256.974889896472, 5271.604629652791, 5830.533557315404, 5881.529477641864, 5892.764289428461, 5899.882002359929, 5948.286205655262, 5663.575231857627, 5704.429557044263, 5708.229389032511, 5723.427657234327, 5725.5133313667975, 5598.664080155122, 5709.942900570941, 5718.942810571841, 5780.797672081457, 5806.274215723035, 5698.116791897262, 5719.227904232958, 5721.713914304268, 5733.655980641175, 5769.365369809318, 5741.569382296345, 5767.192593036978, 5790.073588225863, 5794.652320860761, 5822.301323841166, 4341.023269764278, 4399.076193999232, 4431.8670439886855, 4493.59557639814, 4524.0, 3965.504311961005, 3978.224246272007, 3979.144483935968, 3993.9600603994168, 4013.1572369802084, 5379.838604841861, 5409.43200963901, 5412.0, 5422.0511410503, 5464.617476776667, 5597.860053498695, 5672.943270567324, 5686.886262274731, 5695.629784064023, 5800.59395842287, 5267.341582302212, 5272.92090618641, 5286.577073834084, 5297.867553311198, 5445.918311225335, 4928.088303663833, 4952.133376659071, 4959.504049595012, 4967.081089998362, 4990.825321113816, 5948.048312270016, 5984.311804142492, 5986.640801551921, 6038.32818383218, 6072.848178795565, 5573.693446860299, 5656.60403771732, 5742.5118864895285, 5798.6810725410505, 5834.854128646648, 5927.881442371042, 5953.047512397996, 5953.315368732651, 5969.462748352669, 5987.9401205989125, 5620.3536593290655, 5668.291463567054, 5672.177534257592, 5675.489205971482, 5685.51673107774, 5554.944450555443, 5643.266375371176, 5682.976045391898, 5758.452946970031, 5850.12248162779, 5609.4390560943575, 5633.6619802811965, 5636.436356364495, 5650.745716442852, 5651.971740141273, 5614.606977511535, 5615.634983726045, 5623.3814280428305, 5643.435656434323, 5650.350209725934, 5411.0801163803035, 5473.917891231715, 5481.3970463248215, 5521.0, 5566.721663916869, 5642.6614403135945, 5647.971760141173, 5651.208830763779, 5676.7445464955, 5682.204491371294, 5376.946230537801, 5485.6982865942755, 5520.06158952971, 5544.306961629796, 5557.722113894209], "unit": "score", "name": "dojo.html", "value": 5282.919764274973}, {"lowerIsBetter": false, "replicates": [513.3788116379184, 528.2973645052078, 530.9150535914255, 543.5461389739568, 547.285792041386, 34914.65085349146, 34963.65036349636, 35305.47041794372, 35474.82262588683, 35492.290154196904, 39364.606353936455, 39822.80088599553, 39938.20123597526, 39966.0, 40007.399889001616, 8653.870191947126, 8915.68795092172, 8920.152585504367, 8933.419327743708, 8956.059613740561, 8546.70086546971, 8633.438826476291, 8681.21869031787, 8687.30501559877, 8689.695860644879, 8580.442271252348, 8652.524111173914, 8677.045524992245, 8693.304535637166, 8742.956285218565, 8612.698555550556, 8665.43674661145, 8687.522186279752, 8695.304375649934, 8697.21725044749, 8499.192576705203, 8561.95719021407, 8572.228499435018, 8599.355048371335, 8621.827563448758, 38362.232755345016, 38673.22653546942, 38919.61080389188, 38972.22055558901, 39050.41424378636, 2816.5634326679397, 3322.2026713588807, 3464.9826750866337, 3474.1314671332166, 3610.422332426799, 27885.442291154268, 28205.576916346272, 28667.283317917012, 28878.422431551462, 29460.116196513925, 3239.0, 3327.517509961042, 3603.3694103531775, 3616.7468277220605, 3752.549694036733, 212904.0, 213500.0, 213655.0, 214129.0, 214580.0, 54887.45112548903, 55216.0, 55248.447515525135, 55321.0, 55634.0, 52939.0, 53054.469455304956, 53091.20363194555, 53166.468335316924, 53240.73379633077, 15689.843101568838, 15958.521244362688, 15987.200639968187, 16032.679346413006, 16099.436519721754, 12196.878031219574, 12225.327606981702, 12253.387330633612, 12314.322712250732, 12359.814602780965, 18812.85391971485, 19453.902730486257, 19494.61010779805, 19504.60990780205, 19538.413847584594, 7907.525548467111, 8019.954911497531, 8049.798755031054, 8090.514569125871, 8138.389620778347, 866.151171851589, 920.9263258939269, 1009.914157296638, 1033.7002269341806, 1038.6209033702644, 24971.500569988497, 25143.0, 25159.496810063698, 25435.61846572303, 26064.0, 1029.9897001029894, 1031.9896801031894, 1077.7521170130915, 1102.4542851288663, 1167.3404526442532, 13377.130486518345, 13429.932850335881, 13453.93273033648, 13591.932040339932, 13894.901004203784, 306507.0, 307491.0, 310802.0, 311154.0, 311385.0, 50148.0, 50232.246516302286, 50347.24479132816, 50611.0, 50619.49380506148, 1298.4286913758106, 1318.5253308808822, 1340.4102195034154, 1360.1227208450493, 1395.1350162899068, 24330.51338973246, 26211.344716382242, 26567.0, 26582.601260981486, 26625.733742663102, 42155.57844421516, 42469.57530424656, 42655.36016959686, 42693.0, 42698.14603707971, 287135.0, 287824.0, 288421.0, 288861.0, 289347.0, 29935.850320749127, 30840.0, 30977.535336970413, 31025.224369390944, 31083.22291942629, 41815.1636967265, 42134.578654213066, 42679.78660106679, 43186.78406607947, 44100.11799764051, 32996.83501582573, 35594.28811423809, 36094.639053610175, 36545.71088602039, 36973.44539831851, 32876.50685239676, 33285.0, 33442.83278583591, 33454.49818252777, 33801.323973520884, 32085.197870053435, 32380.190495237806, 32544.51183232206, 35221.647783522865, 35524.0, 27931.720682793726, 29073.563896541993, 29983.70016299809, 31792.68207317897, 32829.34341313208, 23245.186418475274, 23406.414839628465, 24005.27984160478, 24305.14931977372, 24605.87697061503], "unit": "score", "name": "ext.html", "value": 17703.437417639016}, {"lowerIsBetter": false, "replicates": [357.97136229101676, 363.5219686112763, 370.1763576043304, 372.2201986837574, 372.7614326830828, 15411.383544658214, 16587.585310367216, 16753.497395078135, 17123.91438042808, 17782.288708451677, 11204.775904481905, 11217.15871309653, 16356.182190890439, 16368.508944731677, 16370.181490925466, 4580.90838183237, 5264.894702105956, 5296.788128474856, 5324.65389749667, 5327.387350454708, 5104.183330667094, 5159.303494028314, 5202.0, 5244.056069907415, 5258.658187217838, 5019.397672279331, 5196.558292545138, 5213.400458947212, 5215.6349055566125, 5223.686578805265, 5078.238264260372, 5117.334746482933, 5118.436971933084, 5145.81989630363, 5150.587952963754, 5151.974240128776, 5167.844964651066, 5192.169252919514, 5208.791648334062, 5212.348456442945, 11882.465289061927, 15452.381904723798, 19277.0, 19982.500437489034, 20020.1991920323, 2037.2564014134734, 2111.809937105668, 2113.830893528514, 2197.615417301966, 2260.785225403584, 8668.00317963436, 8747.956260218722, 8753.824923501494, 8775.824483510358, 9009.099090091004, 1682.0, 1763.4621440460655, 1772.6100257943233, 1814.945551633453, 1874.297138573035, 38812.22375552501, 39557.0, 52538.47461525374, 54184.91630167414, 54824.45175548273, 9152.405093668891, 9693.369930954465, 10308.948455257825, 10362.378257304586, 10447.84328235077, 13395.263260520765, 13441.647711650423, 13443.193408395528, 13517.121387109806, 13582.117162384413, 6982.1970473395195, 7122.2521635228595, 7130.2869713028285, 7384.667689953965, 7475.9252407476315, 6731.730730770714, 6785.050092986986, 6973.546719463218, 7053.89419158713, 7126.821829454305, 4166.979165104216, 4470.865874023784, 4501.707389019703, 4522.728636281768, 4566.109608626286, 1729.5589624645636, 1815.2285278756476, 1827.798942116366, 1875.2873907915177, 1933.6036112596885, 799.7680672604996, 859.2009431228892, 879.7140929198036, 895.2721247991439, 986.1706534378768, 14461.349239284258, 15989.28048237832, 16056.0, 16285.185740712917, 16701.83298167027, 823.5552801487249, 921.447131720962, 922.9123233292827, 925.4817302310593, 964.2671569607149, 9303.116203960613, 9457.38526995757, 9514.812537799777, 9578.9042109578, 9684.854727179098, 459444.0, 461372.0, 465122.0, 467263.0, 473001.0, 66921.66539167272, 68254.0, 68772.3122768776, 69451.65274173698, 69601.30398695948, 1103.3119327429047, 1109.589451902801, 1124.1231839165464, 1125.6791814332876, 1141.3038046791617, 14676.0, 14706.779398309249, 14784.926075369554, 14860.554183374516, 14901.329440175, 32585.837070814494, 32819.0, 33387.0, 33462.33075338431, 33516.329673405904, 41088.38367424551, 42193.36709949415, 42267.0, 42377.36433953555, 42401.57598423976, 6715.697793599397, 7099.503034787515, 7134.607596582237, 7138.250483699137, 7310.0685755953255, 10358.637447689294, 10819.945900270763, 10916.617918372818, 11044.944775276072, 11120.888791111985, 7605.847883042197, 8070.0, 8784.736457906272, 9686.895251327402, 9807.264455166034, 8975.371723979259, 9027.187553119988, 9679.66121185755, 9762.219022478042, 10250.897491024994, 9388.996957454128, 9442.10300021497, 9783.706488805346, 9788.412695238309, 10137.0, 6569.37590928861, 7116.3951064158055, 7152.356287934111, 7187.496875218684, 7197.100362454693, 8967.327450441113, 9358.859617105612, 9419.387739796892, 9724.70825875225, 9853.408795472295], "unit": "score", "name": "jquery.html", "value": 7878.956404619773}, {"lowerIsBetter": false, "replicates": [1463.0490181382102, 1497.6705124872528, 1665.8750593705474, 1794.8923064616115, 1815.8002619711829, 7511.62441877906, 7596.6961321547205, 7614.695412183513, 7669.309762121401, 7699.307062364386, 7887.21127887211, 7908.7231946881875, 7930.801729956754, 7984.960075199616, 8004.0, 2339.1695947938533, 2369.644553316999, 2371.039728909794, 2379.2862141357523, 2382.5830479666074, 2348.7064116985375, 2357.787799098081, 2369.0286982337243, 2376.2514807835564, 2376.4534157143867, 2163.9783602163934, 2179.596774596697, 2283.4633861042644, 2326.2555982085655, 2344.19125401737, 2310.988445057764, 2311.768823117683, 2321.3964369264113, 2329.4409341758023, 2340.520193360357, 2223.310773660154, 2225.5326381459913, 2240.3502984134743, 2240.764719704424, 2245.8989345479495, 7474.925250747478, 7477.513961592534, 7506.43701722373, 7514.8121296967465, 7532.6233688315915, 4822.469528351879, 4865.124277630025, 4882.267659851015, 4908.214685650314, 4922.753862306906, 2996.5654980027775, 3072.2319420144963, 3126.0621813455873, 3130.5460708197184, 3154.779165458419, 971.2666936462996, 972.8394814855541, 988.9752756181081, 990.9851352229722, 1006.5571148694551, 10685.252032357737, 10727.731806704816, 10733.83899241512, 10746.73133171677, 10783.191260655482, 4168.312228482328, 4224.577542245751, 4248.362745588187, 4283.336082907154, 4315.352697095398, 8432.283255923316, 8441.788955276168, 8456.788580285542, 8468.364872634576, 8482.957585212158, 4672.392588963413, 4690.850741568338, 4695.553922377437, 4726.8109275628585, 4732.71603703772, 4293.527711951683, 4333.068390296102, 4336.111097225062, 4348.934765978513, 4366.585174408426, 3555.928881422357, 3558.3061303046175, 3594.51474051005, 3601.7118630509494, 3609.242059167552, 1027.1833892055834, 1052.1057101463696, 1074.9193810464246, 1081.432248069754, 1083.9891601084046, 914.6250037484599, 1015.9441230732381, 1066.9199810014125, 1112.1825458288151, 1275.7002104505434, 6985.720571177198, 7044.471664625174, 7053.89419158713, 7064.611446370396, 7093.538919970186, 622.757124721359, 629.7071861584385, 631.7599312261311, 631.905214217871, 769.6998170713426, 5545.362283337387, 5573.916391254134, 5592.2730045094695, 5600.383957764642, 5655.519280861173, 8924.598393072327, 9028.909710902939, 9079.0, 9153.450792952444, 9177.90822091784, 8794.560271986504, 8926.821463570823, 8994.145556172152, 9007.054259302678, 9063.682771103111, 7383.704651813975, 7502.137254215726, 7561.6597253122645, 7630.389568834591, 7642.847143057108, 7152.713891444492, 7179.210286868336, 7180.676869540987, 7197.496175267681, 7208.531445456028, 7950.642221099949, 8070.878936815835, 8136.593170341341, 8262.256396924306, 8334.62494187751, 8220.63007164691, 8261.876071858807, 8320.292775114183, 8326.875096873431, 8337.66649334044, 6681.164854393201, 6900.861982760216, 6913.3777959983845, 6948.687309071003, 6948.756793512202, 7441.4418918582405, 7445.143808462096, 7446.14369347532, 7515.962420188082, 7602.771916842504, 6262.248530176225, 6987.1266091738535, 7110.964445177741, 7246.311600397954, 7260.528065675714, 6799.898001529882, 6805.863882722417, 6868.553544019623, 6893.20728116273, 6999.090118284794, 6704.363085506869, 6817.420519255918, 6848.760293389708, 6864.931350686429, 6891.655417229219, 6186.5360097993735, 6201.627902325875, 6229.937700622936, 6247.468965138014, 6249.312575616769, 6293.402126797947, 6381.361863813767, 6503.674816259263, 6514.697060587807, 6601.53789234749], "unit": "score", "name": "mootools.html", "value": 4380.102239720584}, {"lowerIsBetter": false, "replicates": [344.3612099555325, 348.5712573534552, 352.4536967700065, 352.6508756331233, 357.1286062008697, 6216.285127210366, 6233.844153896143, 6260.342664020281, 6328.557001009931, 6364.459020983222, 6252.874942501147, 6275.341089185638, 6295.874082518347, 6304.684765761705, 6346.11154438379, 4770.0459908018365, 4773.6897101688455, 4776.976115119428, 4779.187538118528, 4781.258904869734, 4755.738434386125, 4759.928601070987, 4766.0, 4779.426468823746, 4780.0, 4634.698744581591, 4704.788284527204, 4736.668433209677, 4739.857804265877, 4753.643476739241, 4699.859004229878, 4713.740744259065, 4714.198586240347, 4747.335373047776, 4749.382580264578, 4064.2481140988716, 4084.9591504084874, 4104.4048612950955, 4109.198706252282, 4110.835566577333, 6006.519478441714, 6010.819675409701, 6011.879762404727, 6017.638941663514, 6022.247219097613, 5399.892002159935, 5502.284702988586, 5516.475934786189, 5516.503514683657, 5517.806876759294, 6611.966940165316, 6643.435307998826, 6678.0, 6684.665766711645, 6692.698828552727, 4550.226461501553, 4556.931646025279, 4558.111168322179, 4567.885802854922, 4567.977160114178, 6795.490338224653, 6847.0, 6892.138482689664, 6931.0, 6943.444524438083, 4647.744374059459, 4653.348531205634, 4661.3707149534375, 4673.766311684471, 4674.69614475058, 4715.24556071027, 4717.9292310615365, 4735.621150307967, 4747.359106520645, 4752.7623618818925, 5494.0, 5495.53287970519, 5499.725013749377, 5500.0, 5502.669839809624, 6552.180977377828, 6625.569337993015, 6668.966655166693, 6690.13028306317, 6707.295733947963, 1624.910629915366, 1626.5770899566198, 1671.431713217512, 1673.4059408909905, 1678.0602862397097, 1107.451811353369, 1108.4790148630132, 1113.209621168979, 1114.7268919114706, 1117.1565468071717, 6187.84530386744, 6216.098665693539, 6225.408586184305, 6255.40573645503, 6282.811515654537, 6757.797266082025, 6777.830554236183, 6806.897896531556, 6810.693518791567, 6811.659417029129, 6077.24034495688, 6193.907091393633, 6200.3799620038535, 6217.626942383471, 6264.248290205113, 3682.521272234646, 3688.4098544232793, 3693.261347730465, 3700.8527356519567, 3704.7777133371546, 7037.472189585802, 7075.2217256101785, 7101.715931362791, 7125.2874712529365, 7149.53528020677, 6892.448604111659, 6957.79126626202, 6979.651017449209, 6982.79051628452, 7009.614471204132, 7263.89104163438, 7306.159791624032, 7307.525010874276, 7309.086364204474, 7335.0, 6910.308969103251, 6948.131483564554, 6957.4086202671315, 6999.720011199699, 7021.192562855337, 6796.932030679828, 6837.863242735217, 6899.965500172467, 6905.482088843256, 6913.0667359905765, 7235.602041887747, 7242.13094428672, 7267.527610705287, 7271.527350722397, 7291.927080729125, 4674.111918735565, 4690.179218636793, 4712.458067322164, 4719.764011799465, 4733.384659994179, 6879.552829066095, 6964.164300283998, 6968.965155174192, 6989.33601307875, 6996.265392133956, 6697.196336439659, 6702.798916032527, 6706.161729783777, 6707.865842683216, 6748.527603067934, 6665.900011499734, 6721.462283017249, 6735.326467353226, 6737.797866064026, 6740.764073257413, 6356.968215158895, 6551.377619126175, 6560.475161987125, 6606.8678626426245, 6614.239362473377, 6730.394264516217, 6764.0868482754195, 6768.052472653931, 6773.288804675438, 6786.491013174131, 6631.966840165768, 6640.701168447528, 6641.435477984425, 6649.936010238339, 6650.6342151180215], "unit": "score", "name": "prototype.html", "value": 5009.987273522222}, {"lowerIsBetter": false, "replicates": [716.9928300716995, 722.5520177489957, 768.5696010234269, 798.253632853282, 818.8812622169786, 13123.1469954453, 13271.20372777634, 13303.93348033261, 13336.666583335409, 13344.33278336083, 12690.111692181528, 12726.68183295418, 12752.426140823662, 12759.489620415172, 12797.744045119116, 675.2605896543278, 684.3635419060272, 819.4264015189361, 825.3314814999854, 831.5883637599367, 821.9219174178473, 822.0382152881143, 823.8311146215011, 826.8883700700419, 831.733845169546, 872.2847265242503, 875.711015364928, 877.4735158904638, 878.2403221213636, 882.4043770454949, 868.4181598329135, 869.7260362985703, 871.0418539606383, 871.5250188647202, 875.3959767760257, 640.6028262477294, 642.0337392224718, 643.0579201469823, 644.7485480662546, 647.5402464250341, 13179.538716144985, 13187.670308242275, 13206.933965330112, 13246.66883327915, 13298.069135160446, 12916.87083129166, 13153.342332883318, 13251.668708282274, 13269.0, 13601.523946661919, 10172.643957461527, 10221.0, 10262.589496420134, 10272.28094033418, 10850.29473084247, 3350.3466823969334, 3350.664933506654, 3365.1082463147286, 3629.383004889175, 3823.8279277432584, 45330.0, 47149.0, 47210.5278947213, 47229.76385118053, 47538.76230618825, 9252.121048500381, 9765.804683906425, 10009.599616015423, 10128.898711012796, 10268.948655256676, 17227.0, 17242.913785430992, 18221.271149154152, 18368.35710750144, 18436.631267374847, 7558.58427786477, 7586.165521792598, 7590.506617069873, 7601.201873803171, 7619.619019049025, 4185.727927684691, 4236.301010333322, 4258.254805409041, 4341.761203133795, 4369.300911854088, 3036.3927214557175, 3056.419280336729, 3057.6942305769244, 3083.9691603083684, 3097.0399176255432, 576.1703147467717, 608.4128815692877, 610.4322979628988, 616.5006344860677, 618.1932577985772, 529.6742503360406, 559.420999265758, 608.7869245763948, 727.5234721257585, 739.7706710919632, 8381.748547543584, 8405.621747021398, 9524.142827145452, 9586.808263834824, 9702.466364350028, 576.850018995056, 578.4851482180862, 598.5361344957605, 653.8263816449485, 674.5379415100672, 4099.344104943195, 4155.0, 4281.207976524353, 4403.9559604404185, 4439.178751930838, 54319.72840135774, 58294.0, 58318.7084064577, 58337.0, 58599.41400586025, 49600.255996160085, 49889.50110498921, 49912.500874991514, 50013.24980125301, 50274.245886311735, 44335.99999999935, 44543.0, 44880.0, 45142.097158056655, 45176.0, 9201.861972070557, 9245.58394872219, 9410.670626528312, 9446.38598491096, 9456.858147127936, 32484.350312993134, 32574.185645359055, 32664.183395415304, 32826.83586582052, 33115.17212069718, 38861.0, 38956.6104338953, 43012.13975720405, 43225.13549729051, 43978.56021439745, 10439.425831579336, 10512.0, 10527.210459215436, 10562.155027597928, 10581.62964296246, 12028.879711202775, 12150.331731754484, 12364.938175309426, 12644.620661380173, 12697.735981875825, 11726.94136529312, 11923.880761192277, 12004.879951200377, 12254.938725306316, 12296.508139674313, 10992.450377480935, 11129.0, 11810.940945295219, 11852.0, 12273.263604183778, 11283.0, 11283.887161128283, 11444.027257682857, 11545.422728863356, 11681.824772628248, 9436.9769717789, 9486.28852836054, 9540.85688714656, 9840.852387214341, 9875.506224688594, 9705.272104592043, 10164.085232329126, 10193.490325483845, 10232.283740138118, 10398.740031499274], "unit": "score", "name": "yui.html", "value": 6317.066588337204}], "name": "dromaeo_css", "value": 6837.205917436412}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 111.0, 112.0, 113.0, 124.0, 113.0, 113.0, 114.0, 111.0], "unit": "score", "name": "ai-astar", "value": 113.2}, {"lowerIsBetter": true, "replicates": [166.0, 126.0, 154.0, 183.0, 130.0, 157.0, 154.0, 135.0, 161.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 162.0, 161.0, 163.0, 161.0, 165.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 72.0, 73.0, 73.0, 73.0, 146.0, 74.0, 75.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 136.0, 96.0, 96.0, 99.0, 150.0, 97.0, 97.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 60.0, 61.0, 60.0, 59.0, 61.0, 61.0, 67.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 68.0, 67.0, 67.0, 68.0, 68.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 85.0, 81.0, 91.0, 83.0, 81.0, 82.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [124.0, 120.0, 121.0, 115.0, 118.0, 129.0, 115.0, 120.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [136.0, 138.0, 145.0, 142.0, 146.0, 151.0, 144.0, 144.0, 144.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 65.0, 68.0, 65.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1511.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.44809109176154], "unit": "score", "name": "Richards", "value": 210.82354399999997}, {"lowerIsBetter": false, "replicates": [191.0949742021785], "unit": "score", "name": "DeltaBlue", "value": 345.99549399999995}, {"lowerIsBetter": false, "replicates": [281.135788585887], "unit": "score", "name": "Encrypt", "value": 946.8058169999996}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1100.1100110011], "unit": "score", "name": "RayTrace", "value": 672.6500009999999}, {"lowerIsBetter": false, "replicates": [686.3417982155113], "unit": "score", "name": "Earley", "value": 971.0365909999999}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [42122.448979591834], "unit": "score", "name": "RegExp", "value": 21.62706637596898}, {"lowerIsBetter": false, "replicates": [631.3131313131313], "unit": "score", "name": "Splay", "value": 129.081744}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20209.81177578476}]} 07:13:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20209.81"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1511.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6837.21"}}} 07:13:36 INFO - Return code: 0 07:13:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:13:36 INFO - # TBPL SUCCESS # 07:13:36 INFO - Running post-action listener: _resource_record_post_action 07:13:36 INFO - Running post-run listener: _resource_record_post_run 07:13:38 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 548585472; Read time: 0; Write time: 490920 07:13:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236408832; Read time: 0; Write time: 244916 07:13:38 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 312176640; Read time: 0; Write time: 246004 07:13:38 INFO - Running post-run listener: _upload_blobber_files 07:13:38 INFO - Blob upload gear active. 07:13:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:13:38 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 07:13:38 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:13:38 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:13:38 INFO - (blobuploader) - INFO - Open directory for files ... 07:13:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:13:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:13:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:13:39 INFO - (blobuploader) - INFO - Done attempting. 07:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:13:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:13:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:13:40 INFO - (blobuploader) - INFO - Done attempting. 07:13:40 INFO - (blobuploader) - INFO - Iteration through files over. 07:13:40 INFO - Return code: 0 07:13:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:13:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:13:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2aa89cf4a4f5b469246b2cef392d203f84d4c51fd1672d6529c5ec959645790c437d6a06b23c532db04e472cea2b28c25b8e437ce54bd8b4222bb0583146e8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db387155f3bc331f654de8a407643590c29c6a070b5937e33d93f9d8029bb8796c257da4be578ac155a0a8acc020d9fdb4f83113eac4602cf3f17b58ae739e01"} 07:13:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:13:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:13:40 INFO - Contents: 07:13:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2aa89cf4a4f5b469246b2cef392d203f84d4c51fd1672d6529c5ec959645790c437d6a06b23c532db04e472cea2b28c25b8e437ce54bd8b4222bb0583146e8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db387155f3bc331f654de8a407643590c29c6a070b5937e33d93f9d8029bb8796c257da4be578ac155a0a8acc020d9fdb4f83113eac4602cf3f17b58ae739e01"} 07:13:40 INFO - Running post-run listener: copy_logs_to_upload_dir 07:13:40 INFO - Copying logs to upload dir... 07:13:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:13:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.977786 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-22 07:13:39.436751) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 07:13:39.440603) ========= 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=920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2aa89cf4a4f5b469246b2cef392d203f84d4c51fd1672d6529c5ec959645790c437d6a06b23c532db04e472cea2b28c25b8e437ce54bd8b4222bb0583146e8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db387155f3bc331f654de8a407643590c29c6a070b5937e33d93f9d8029bb8796c257da4be578ac155a0a8acc020d9fdb4f83113eac4602cf3f17b58ae739e01"} build_url:https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/XZBY1fdhRnSBU4fA1rxCQQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2aa89cf4a4f5b469246b2cef392d203f84d4c51fd1672d6529c5ec959645790c437d6a06b23c532db04e472cea2b28c25b8e437ce54bd8b4222bb0583146e8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db387155f3bc331f654de8a407643590c29c6a070b5937e33d93f9d8029bb8796c257da4be578ac155a0a8acc020d9fdb4f83113eac4602cf3f17b58ae739e01"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 07:13:39.464509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 07:13:39.464803) ========= 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=920470bf432669ad7e3a5387000001ca-1453474116.501707-626335537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 07:13:39.548950) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 07:13:39.549278) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 07:13:39.549558) ========= ========= Total master_lag: 0.25 =========