builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1453010772.6 results: success (0) buildid: 20160116193624 builduid: 99c88b450d2b4114adc016ddb85b3a06 revision: d2b4d101d00691f835c4f109524a3506d5f51626 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.598837) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.599252) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.599597) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006374 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.667213) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.667626) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.762496) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.762838) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004684 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.819750) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.820057) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.820472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.820798) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-16 22:06:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.6M=0s 2016-01-16 22:06:13 (84.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162174 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.994711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:12.995087) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019531 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.047185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.047525) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2b4d101d00691f835c4f109524a3506d5f51626 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2b4d101d00691f835c4f109524a3506d5f51626 --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=9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-16 22:06:13,836 truncating revision to first 12 chars 2016-01-16 22:06:13,837 Setting DEBUG logging. 2016-01-16 22:06:13,837 attempt 1/10 2016-01-16 22:06:13,837 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d2b4d101d006?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-16 22:06:14,111 unpacking tar archive at: mozilla-inbound-d2b4d101d006/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567654 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.629426) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.629768) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004483 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.685924) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.686225) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.718830) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.719110) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-16 22:06:13.719510) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-01-16 22:06:13.719847) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:06:14 INFO - MultiFileLogger online at 20160116 22:06:14 in /builds/slave/test-pgo 22:06:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:06:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:06:14 INFO - {'append_to_log': False, 22:06:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:06:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:06:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:06:14 INFO - 'branch': 'Mozilla-Inbound', 22:06:14 INFO - 'buildbot_json_path': 'buildprops.json', 22:06:14 INFO - 'config_files': ('talos/linux_config.py',), 22:06:14 INFO - 'default_actions': ('clobber', 22:06:14 INFO - 'read-buildbot-config', 22:06:14 INFO - 'download-and-extract', 22:06:14 INFO - 'populate-webroot', 22:06:14 INFO - 'create-virtualenv', 22:06:14 INFO - 'install', 22:06:14 INFO - 'run-tests'), 22:06:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:06:14 INFO - 'download_minidump_stackwalk': True, 22:06:14 INFO - 'download_symbols': 'ondemand', 22:06:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:06:14 INFO - 'tooltool.py': '/tools/tooltool.py', 22:06:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:06:14 INFO - '/tools/misc-python/virtualenv.py')}, 22:06:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:06:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:06:14 INFO - 'installer_path': 'installer.exe', 22:06:14 INFO - 'log_level': 'info', 22:06:14 INFO - 'log_name': 'talos', 22:06:14 INFO - 'log_to_console': True, 22:06:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:06:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:06:14 INFO - 'opt_config_files': (), 22:06:14 INFO - 'pip_index': False, 22:06:14 INFO - 'sps_profile': False, 22:06:14 INFO - 'sps_profile_interval': 0, 22:06:14 INFO - 'suite': 'dromaeojs', 22:06:14 INFO - 'system_bits': '32', 22:06:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:06:14 INFO - 'title': 'talos-linux64-ix-022', 22:06:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:06:14 INFO - 'use_talos_json': True, 22:06:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:06:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:06:14 INFO - 'work_dir': 'build'} 22:06:14 INFO - ##### 22:06:14 INFO - ##### Running clobber step. 22:06:14 INFO - ##### 22:06:14 INFO - Running pre-action listener: _resource_record_pre_action 22:06:14 INFO - Running main action method: clobber 22:06:14 INFO - rmtree: /builds/slave/test-pgo/build 22:06:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:06:15 INFO - Running post-action listener: _resource_record_post_action 22:06:15 INFO - ##### 22:06:15 INFO - ##### Running read-buildbot-config step. 22:06:15 INFO - ##### 22:06:15 INFO - Running pre-action listener: _resource_record_pre_action 22:06:15 INFO - Running main action method: read_buildbot_config 22:06:15 INFO - Using buildbot properties: 22:06:15 INFO - { 22:06:15 INFO - "project": "", 22:06:15 INFO - "product": "firefox", 22:06:15 INFO - "script_repo_revision": "production", 22:06:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:06:15 INFO - "repository": "", 22:06:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:06:15 INFO - "buildid": "20160116193624", 22:06:15 INFO - "pgo_build": "True", 22:06:15 INFO - "basedir": "/builds/slave/test-pgo", 22:06:15 INFO - "buildnumber": 632, 22:06:15 INFO - "slavename": "talos-linux64-ix-022", 22:06:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:06:15 INFO - "platform": "ubuntu64_hw", 22:06:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:06:15 INFO - "branch": "mozilla-inbound", 22:06:15 INFO - "repo_path": "integration/mozilla-inbound", 22:06:15 INFO - "revision": "d2b4d101d00691f835c4f109524a3506d5f51626", 22:06:15 INFO - "stage_platform": "linux64-pgo", 22:06:15 INFO - "builduid": "99c88b450d2b4114adc016ddb85b3a06", 22:06:15 INFO - "slavebuilddir": "test" 22:06:15 INFO - } 22:06:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:06:15 INFO - Running post-action listener: _resource_record_post_action 22:06:15 INFO - ##### 22:06:15 INFO - ##### Running download-and-extract step. 22:06:15 INFO - ##### 22:06:15 INFO - Running pre-action listener: _resource_record_pre_action 22:06:15 INFO - Running main action method: download_and_extract 22:06:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:15 INFO - https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:06:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/test_packages.json 22:06:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/test_packages.json 22:06:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:06:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:06:25 INFO - Downloaded 1448 bytes. 22:06:25 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:06:25 INFO - Using the following test package requirements: 22:06:25 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:25 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:06:25 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:06:25 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'jsshell-linux-x86_64.zip'], 22:06:25 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:06:25 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:25 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:06:25 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:06:25 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:06:25 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:25 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:06:25 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:25 INFO - https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:06:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:06:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:06:42 INFO - Downloaded 22483984 bytes. 22:06:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:06:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:06:43 INFO - Return code: 0 22:06:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:43 INFO - https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:06:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:06:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:06:46 INFO - Downloaded 22483984 bytes. 22:06:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:06:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:06:47 INFO - Return code: 0 22:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:47 INFO - https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:06:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:06:49 INFO - Downloaded 11132144 bytes. 22:06:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:06:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:06:50 INFO - Return code: 0 22:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:50 INFO - https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:06:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:06:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:06:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:06:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:06:52 INFO - Downloaded 55936272 bytes. 22:06:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:06:52 INFO - mkdir: /builds/slave/test-pgo/properties 22:06:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:06:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:06:52 INFO - Contents: 22:06:52 INFO - build_url:https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:06:52 INFO - Running post-action listener: _resource_record_post_action 22:06:52 INFO - Running post-action listener: set_extra_try_arguments 22:06:52 INFO - ##### 22:06:52 INFO - ##### Running populate-webroot step. 22:06:52 INFO - ##### 22:06:52 INFO - Running pre-action listener: _resource_record_pre_action 22:06:52 INFO - Running main action method: populate_webroot 22:06:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:06:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:06:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:06:52 INFO - '--tppagecycles', 22:06:52 INFO - '7'], 22:06:52 INFO - 'tests': ['tsvgm']}}, 22:06:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:06:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:06:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:06:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:06:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:06:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:06:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:06:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:52 INFO - 'talos_options': ['--e10s'], 22:06:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:06:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:52 INFO - 'tests': ['damp', 'tps']}, 22:06:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:52 INFO - 'talos_options': ['--e10s'], 22:06:52 INFO - 'tests': ['damp', 'tps']}, 22:06:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:06:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:06:52 INFO - 'other': {'tests': ['a11yr', 22:06:52 INFO - 'ts_paint', 22:06:52 INFO - 'tpaint', 22:06:52 INFO - 'sessionrestore', 22:06:52 INFO - 'sessionrestore_no_auto_restore']}, 22:06:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:06:52 INFO - 'tests': ['a11yr', 22:06:52 INFO - 'ts_paint', 22:06:52 INFO - 'tpaint', 22:06:52 INFO - 'sessionrestore', 22:06:52 INFO - 'sessionrestore_no_auto_restore']}, 22:06:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:06:52 INFO - 'tests': ['a11yr', 22:06:52 INFO - 'ts_paint', 22:06:52 INFO - 'tpaint', 22:06:52 INFO - 'sessionrestore', 22:06:52 INFO - 'sessionrestore_no_auto_restore']}, 22:06:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:06:52 INFO - 'tests': ['a11yr', 22:06:52 INFO - 'ts_paint', 22:06:52 INFO - 'tpaint', 22:06:52 INFO - 'sessionrestore', 22:06:52 INFO - 'sessionrestore_no_auto_restore']}, 22:06:52 INFO - 'other_l64': {'tests': ['a11yr', 22:06:52 INFO - 'ts_paint', 22:06:52 INFO - 'tpaint', 22:06:52 INFO - 'sessionrestore', 22:06:52 INFO - 'sessionrestore_no_auto_restore']}, 22:06:52 INFO - 'other_nol64': {'tests': ['a11yr', 22:06:52 INFO - 'ts_paint', 22:06:52 INFO - 'tpaint', 22:06:52 INFO - 'sessionrestore', 22:06:52 INFO - 'sessionrestore_no_auto_restore']}, 22:06:52 INFO - 'svgr': {'tests': ['tsvgx', 22:06:52 INFO - 'tsvgr_opacity', 22:06:52 INFO - 'tart', 22:06:52 INFO - 'tscrollx', 22:06:52 INFO - 'cart']}, 22:06:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:06:52 INFO - 'tests': ['tsvgx', 22:06:52 INFO - 'tsvgr_opacity', 22:06:52 INFO - 'tart', 22:06:52 INFO - 'tscrollx', 22:06:52 INFO - 'cart']}, 22:06:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:52 INFO - 'tests': ['tp5o']}, 22:06:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:52 INFO - 'talos_options': ['--e10s'], 22:06:52 INFO - 'tests': ['tp5o']}, 22:06:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:52 INFO - 'talos_options': ['--xperf_path', 22:06:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:06:52 INFO - 'tests': ['tp5n']}, 22:06:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:52 INFO - 'talos_options': ['--e10s', 22:06:52 INFO - '--xperf_path', 22:06:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:06:52 INFO - 'tests': ['tp5n']}}, 22:06:52 INFO - 'talos.zip': {'path': '', 22:06:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:06:52 INFO - Running post-action listener: _resource_record_post_action 22:06:52 INFO - ##### 22:06:52 INFO - ##### Running create-virtualenv step. 22:06:52 INFO - ##### 22:06:52 INFO - Running pre-action listener: _resource_record_pre_action 22:06:52 INFO - Running main action method: create_virtualenv 22:06:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:06:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:06:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:06:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:06:52 INFO - Using real prefix '/usr' 22:06:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:06:53 INFO - Installing distribute.............................................................................................................................................................................................done. 22:06:55 INFO - Installing pip.................done. 22:06:55 INFO - Return code: 0 22:06:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc19863ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c99540>, '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 0x1c9a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a8f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:06:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:06:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:06:55 INFO - Using env: {'DISPLAY': ':0', 22:06:55 INFO - 'HOME': '/home/cltbld', 22:06:55 INFO - 'LANG': 'en_US.UTF-8', 22:06:55 INFO - 'LANGUAGE': 'en_US:en', 22:06:55 INFO - 'LOGNAME': 'cltbld', 22:06:55 INFO - 'MAIL': '/var/mail/cltbld', 22:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:55 INFO - 'MOZ_NO_REMOTE': '1', 22:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:55 INFO - 'NO_EM_RESTART': '1', 22:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:06:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:06:55 INFO - 'SHELL': '/bin/bash', 22:06:55 INFO - 'SHLVL': '1', 22:06:55 INFO - 'TERM': 'linux', 22:06:55 INFO - 'TMOUT': '86400', 22:06:55 INFO - 'USER': 'cltbld', 22:06:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 22:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:55 INFO - '_': '/tools/buildbot/bin/python'} 22:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:06:55 INFO - Cleaning up... 22:06:55 INFO - Return code: 0 22:06:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc19863ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c99540>, '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 0x1c9a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a8f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:06:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:06:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:06:55 INFO - Using env: {'DISPLAY': ':0', 22:06:55 INFO - 'HOME': '/home/cltbld', 22:06:55 INFO - 'LANG': 'en_US.UTF-8', 22:06:55 INFO - 'LANGUAGE': 'en_US:en', 22:06:55 INFO - 'LOGNAME': 'cltbld', 22:06:55 INFO - 'MAIL': '/var/mail/cltbld', 22:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:55 INFO - 'MOZ_NO_REMOTE': '1', 22:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:55 INFO - 'NO_EM_RESTART': '1', 22:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:06:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:06:55 INFO - 'SHELL': '/bin/bash', 22:06:55 INFO - 'SHLVL': '1', 22:06:55 INFO - 'TERM': 'linux', 22:06:55 INFO - 'TMOUT': '86400', 22:06:55 INFO - 'USER': 'cltbld', 22:06:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 22:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:55 INFO - '_': '/tools/buildbot/bin/python'} 22:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:55 INFO - Downloading/unpacking psutil>=0.7.1 22:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:06:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:06:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:06:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:06:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:06:57 INFO - Installing collected packages: psutil 22:06:57 INFO - Running setup.py install for psutil 22:06:57 INFO - building 'psutil._psutil_linux' extension 22:06:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:06:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:06:57 INFO - building 'psutil._psutil_posix' extension 22:06:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:06:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:06:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:06:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:06:58 INFO - Successfully installed psutil 22:06:58 INFO - Cleaning up... 22:06:58 INFO - Return code: 0 22:06:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc19863ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c99540>, '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 0x1c9a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a8f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:06:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:06:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:06:58 INFO - Using env: {'DISPLAY': ':0', 22:06:58 INFO - 'HOME': '/home/cltbld', 22:06:58 INFO - 'LANG': 'en_US.UTF-8', 22:06:58 INFO - 'LANGUAGE': 'en_US:en', 22:06:58 INFO - 'LOGNAME': 'cltbld', 22:06:58 INFO - 'MAIL': '/var/mail/cltbld', 22:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:58 INFO - 'MOZ_NO_REMOTE': '1', 22:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:58 INFO - 'NO_EM_RESTART': '1', 22:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:06:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:06:58 INFO - 'SHELL': '/bin/bash', 22:06:58 INFO - 'SHLVL': '1', 22:06:58 INFO - 'TERM': 'linux', 22:06:58 INFO - 'TMOUT': '86400', 22:06:58 INFO - 'USER': 'cltbld', 22:06:58 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 22:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:58 INFO - '_': '/tools/buildbot/bin/python'} 22:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:07:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:07:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:07:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:07:00 INFO - Installing collected packages: mozsystemmonitor 22:07:00 INFO - Running setup.py install for mozsystemmonitor 22:07:00 INFO - Successfully installed mozsystemmonitor 22:07:00 INFO - Cleaning up... 22:07:00 INFO - Return code: 0 22:07:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc19863ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c99540>, '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 0x1c9a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a8f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:07:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:07:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:07:00 INFO - Using env: {'DISPLAY': ':0', 22:07:00 INFO - 'HOME': '/home/cltbld', 22:07:00 INFO - 'LANG': 'en_US.UTF-8', 22:07:00 INFO - 'LANGUAGE': 'en_US:en', 22:07:00 INFO - 'LOGNAME': 'cltbld', 22:07:00 INFO - 'MAIL': '/var/mail/cltbld', 22:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:00 INFO - 'MOZ_NO_REMOTE': '1', 22:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:00 INFO - 'NO_EM_RESTART': '1', 22:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:00 INFO - 'SHELL': '/bin/bash', 22:07:00 INFO - 'SHLVL': '1', 22:07:00 INFO - 'TERM': 'linux', 22:07:00 INFO - 'TMOUT': '86400', 22:07:00 INFO - 'USER': 'cltbld', 22:07:00 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 22:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:00 INFO - '_': '/tools/buildbot/bin/python'} 22:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:00 INFO - Downloading/unpacking blobuploader==1.2.4 22:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:02 INFO - Downloading blobuploader-1.2.4.tar.gz 22:07:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:07:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:07:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:07:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:07:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:03 INFO - Downloading docopt-0.6.1.tar.gz 22:07:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:07:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:07:03 INFO - Installing collected packages: blobuploader, requests, docopt 22:07:03 INFO - Running setup.py install for blobuploader 22:07:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:07:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:07:03 INFO - Running setup.py install for requests 22:07:03 INFO - Running setup.py install for docopt 22:07:03 INFO - Successfully installed blobuploader requests docopt 22:07:03 INFO - Cleaning up... 22:07:03 INFO - Return code: 0 22:07:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc19863ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c99540>, '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 0x1c9a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a8f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:07:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:07:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:07:03 INFO - Using env: {'DISPLAY': ':0', 22:07:03 INFO - 'HOME': '/home/cltbld', 22:07:03 INFO - 'LANG': 'en_US.UTF-8', 22:07:03 INFO - 'LANGUAGE': 'en_US:en', 22:07:03 INFO - 'LOGNAME': 'cltbld', 22:07:03 INFO - 'MAIL': '/var/mail/cltbld', 22:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:03 INFO - 'MOZ_NO_REMOTE': '1', 22:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:03 INFO - 'NO_EM_RESTART': '1', 22:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:03 INFO - 'SHELL': '/bin/bash', 22:07:03 INFO - 'SHLVL': '1', 22:07:03 INFO - 'TERM': 'linux', 22:07:03 INFO - 'TMOUT': '86400', 22:07:03 INFO - 'USER': 'cltbld', 22:07:03 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 22:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:03 INFO - '_': '/tools/buildbot/bin/python'} 22:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:03 INFO - Running setup.py (path:/tmp/pip-yeCrD6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:04 INFO - Running setup.py (path:/tmp/pip-ECooGg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:04 INFO - Running setup.py (path:/tmp/pip-FSE5x6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:04 INFO - Running setup.py (path:/tmp/pip-s3c_yO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:04 INFO - Running setup.py (path:/tmp/pip-l3uO41-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:04 INFO - Running setup.py (path:/tmp/pip-7O3J7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:04 INFO - Running setup.py (path:/tmp/pip-PvfjRI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:04 INFO - Running setup.py (path:/tmp/pip-DIM2ji-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:04 INFO - Running setup.py (path:/tmp/pip-nHgfM6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:04 INFO - Running setup.py (path:/tmp/pip-VIJi3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:04 INFO - Running setup.py (path:/tmp/pip-kijNZu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:04 INFO - Running setup.py (path:/tmp/pip-4k61XZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:04 INFO - Running setup.py (path:/tmp/pip-Q13hJW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:04 INFO - Running setup.py (path:/tmp/pip-uCc7pw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:04 INFO - Running setup.py (path:/tmp/pip-k7rcx3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:05 INFO - Running setup.py (path:/tmp/pip-NoEi9p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:05 INFO - Running setup.py (path:/tmp/pip-D21LAi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:07:05 INFO - Running setup.py install for manifestparser 22:07:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:07:05 INFO - Running setup.py install for mozcrash 22:07:05 INFO - Running setup.py install for mozdebug 22:07:05 INFO - Running setup.py install for mozdevice 22:07:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:07:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:07:05 INFO - Running setup.py install for mozfile 22:07:05 INFO - Running setup.py install for mozhttpd 22:07:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:07:05 INFO - Running setup.py install for mozinfo 22:07:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:07:05 INFO - Running setup.py install for mozInstall 22:07:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:07:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:07:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:07:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:07:05 INFO - Running setup.py install for mozleak 22:07:06 INFO - Running setup.py install for mozlog 22:07:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:07:06 INFO - Running setup.py install for moznetwork 22:07:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:07:06 INFO - Running setup.py install for mozprocess 22:07:06 INFO - Running setup.py install for mozprofile 22:07:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:07:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:07:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:07:06 INFO - Running setup.py install for mozrunner 22:07:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:07:06 INFO - Running setup.py install for mozscreenshot 22:07:06 INFO - Running setup.py install for moztest 22:07:06 INFO - Running setup.py install for mozversion 22:07:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:07:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:07:06 INFO - Cleaning up... 22:07:06 INFO - Return code: 0 22:07:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc19863ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c99540>, '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 0x1c9a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a8f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:07:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:07:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:07:06 INFO - Using env: {'DISPLAY': ':0', 22:07:06 INFO - 'HOME': '/home/cltbld', 22:07:06 INFO - 'LANG': 'en_US.UTF-8', 22:07:06 INFO - 'LANGUAGE': 'en_US:en', 22:07:06 INFO - 'LOGNAME': 'cltbld', 22:07:06 INFO - 'MAIL': '/var/mail/cltbld', 22:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:06 INFO - 'MOZ_NO_REMOTE': '1', 22:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:06 INFO - 'NO_EM_RESTART': '1', 22:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:06 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:06 INFO - 'SHELL': '/bin/bash', 22:07:06 INFO - 'SHLVL': '1', 22:07:06 INFO - 'TERM': 'linux', 22:07:06 INFO - 'TMOUT': '86400', 22:07:06 INFO - 'USER': 'cltbld', 22:07:06 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 22:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:06 INFO - '_': '/tools/buildbot/bin/python'} 22:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:07 INFO - Running setup.py (path:/tmp/pip-urTAso-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:07:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:07 INFO - Running setup.py (path:/tmp/pip-FvWgF7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:07:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:07 INFO - Running setup.py (path:/tmp/pip-CjzKJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:07:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:07 INFO - Running setup.py (path:/tmp/pip-1TPHEm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:07:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:07 INFO - Running setup.py (path:/tmp/pip-l1GyID-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:07:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:07 INFO - Running setup.py (path:/tmp/pip-Gq77Xg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:07:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:07 INFO - Running setup.py (path:/tmp/pip-beaCp1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:07:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:07 INFO - Running setup.py (path:/tmp/pip-7pAcjz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:07:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:07 INFO - Running setup.py (path:/tmp/pip-ka_bBZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:07:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:07 INFO - Running setup.py (path:/tmp/pip-EGwcWN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:07:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:07 INFO - Running setup.py (path:/tmp/pip-Lww1Kz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:07:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:07 INFO - Running setup.py (path:/tmp/pip-F2Rhzk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:07:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:08 INFO - Running setup.py (path:/tmp/pip-t3kYjj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:07:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:08 INFO - Running setup.py (path:/tmp/pip-LtLzbK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:07:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:08 INFO - Running setup.py (path:/tmp/pip-3GLKw2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:07:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:08 INFO - Running setup.py (path:/tmp/pip-f54WbR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:07:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:08 INFO - Running setup.py (path:/tmp/pip-pLcNLR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:07:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:10 INFO - Downloading blessings-1.5.1.tar.gz 22:07:10 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:07:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:07:10 INFO - Installing collected packages: blessings 22:07:10 INFO - Running setup.py install for blessings 22:07:10 INFO - Successfully installed blessings 22:07:10 INFO - Cleaning up... 22:07:10 INFO - Return code: 0 22:07:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:07:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:07:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:07:10 INFO - Reading from file tmpfile_stdout 22:07:10 INFO - Current package versions: 22:07:10 INFO - argparse == 1.2.1 22:07:10 INFO - blessings == 1.5.1 22:07:10 INFO - blobuploader == 1.2.4 22:07:10 INFO - docopt == 0.6.1 22:07:10 INFO - manifestparser == 1.1 22:07:10 INFO - mozInstall == 1.12 22:07:10 INFO - mozcrash == 0.16 22:07:10 INFO - mozdebug == 0.1 22:07:10 INFO - mozdevice == 0.48 22:07:10 INFO - mozfile == 1.2 22:07:10 INFO - mozhttpd == 0.7 22:07:10 INFO - mozinfo == 0.9 22:07:10 INFO - mozleak == 0.1 22:07:10 INFO - mozlog == 3.1 22:07:10 INFO - moznetwork == 0.27 22:07:10 INFO - mozprocess == 0.22 22:07:10 INFO - mozprofile == 0.28 22:07:10 INFO - mozrunner == 6.11 22:07:10 INFO - mozscreenshot == 0.1 22:07:10 INFO - mozsystemmonitor == 0.0 22:07:10 INFO - moztest == 0.7 22:07:10 INFO - mozversion == 1.4 22:07:10 INFO - psutil == 3.1.1 22:07:10 INFO - requests == 1.2.3 22:07:10 INFO - wsgiref == 0.1.2 22:07:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fc19863ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c99540>, '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 0x1c9a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a8f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:07:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:07:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:07:10 INFO - Using env: {'DISPLAY': ':0', 22:07:10 INFO - 'HOME': '/home/cltbld', 22:07:10 INFO - 'LANG': 'en_US.UTF-8', 22:07:10 INFO - 'LANGUAGE': 'en_US:en', 22:07:10 INFO - 'LOGNAME': 'cltbld', 22:07:10 INFO - 'MAIL': '/var/mail/cltbld', 22:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:10 INFO - 'MOZ_NO_REMOTE': '1', 22:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:10 INFO - 'NO_EM_RESTART': '1', 22:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:10 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:10 INFO - 'SHELL': '/bin/bash', 22:07:10 INFO - 'SHLVL': '1', 22:07:10 INFO - 'TERM': 'linux', 22:07:10 INFO - 'TMOUT': '86400', 22:07:10 INFO - 'USER': 'cltbld', 22:07:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 22:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:10 INFO - '_': '/tools/buildbot/bin/python'} 22:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:07:10 INFO - Cleaning up... 22:07:10 INFO - Return code: 0 22:07:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc19863ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c99540>, '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 0x1c9a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a8f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:07:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:07:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:07:10 INFO - Using env: {'DISPLAY': ':0', 22:07:10 INFO - 'HOME': '/home/cltbld', 22:07:10 INFO - 'LANG': 'en_US.UTF-8', 22:07:10 INFO - 'LANGUAGE': 'en_US:en', 22:07:10 INFO - 'LOGNAME': 'cltbld', 22:07:10 INFO - 'MAIL': '/var/mail/cltbld', 22:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:10 INFO - 'MOZ_NO_REMOTE': '1', 22:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:10 INFO - 'NO_EM_RESTART': '1', 22:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:10 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:10 INFO - 'SHELL': '/bin/bash', 22:07:10 INFO - 'SHLVL': '1', 22:07:10 INFO - 'TERM': 'linux', 22:07:10 INFO - 'TMOUT': '86400', 22:07:10 INFO - 'USER': 'cltbld', 22:07:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 22:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:10 INFO - '_': '/tools/buildbot/bin/python'} 22:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:11 INFO - Downloading/unpacking jsonschema 22:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:07:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 22:07:12 INFO - Downloading/unpacking functools32 (from jsonschema) 22:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:12 INFO - Downloading functools32-3.2.3-2.tar.gz 22:07:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:07:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:07:12 INFO - warning: no files found matching '*.txt' 22:07:12 INFO - no previously-included directories found matching 'build' 22:07:12 INFO - no previously-included directories found matching 'dist' 22:07:12 INFO - no previously-included directories found matching '.git*' 22:07:12 INFO - Installing collected packages: jsonschema, functools32 22:07:13 INFO - Running setup.py install for functools32 22:07:13 INFO - warning: no files found matching '*.txt' 22:07:13 INFO - no previously-included directories found matching 'build' 22:07:13 INFO - no previously-included directories found matching 'dist' 22:07:13 INFO - no previously-included directories found matching '.git*' 22:07:13 INFO - Successfully installed jsonschema functools32 22:07:13 INFO - Cleaning up... 22:07:13 INFO - Return code: 0 22:07:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc19863ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c99540>, '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 0x1c9a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a8f0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:07:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:07:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:07:13 INFO - Using env: {'DISPLAY': ':0', 22:07:13 INFO - 'HOME': '/home/cltbld', 22:07:13 INFO - 'LANG': 'en_US.UTF-8', 22:07:13 INFO - 'LANGUAGE': 'en_US:en', 22:07:13 INFO - 'LOGNAME': 'cltbld', 22:07:13 INFO - 'MAIL': '/var/mail/cltbld', 22:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:13 INFO - 'MOZ_NO_REMOTE': '1', 22:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:13 INFO - 'NO_EM_RESTART': '1', 22:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:13 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:13 INFO - 'SHELL': '/bin/bash', 22:07:13 INFO - 'SHLVL': '1', 22:07:13 INFO - 'TERM': 'linux', 22:07:13 INFO - 'TMOUT': '86400', 22:07:13 INFO - 'USER': 'cltbld', 22:07:13 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 22:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:13 INFO - '_': '/tools/buildbot/bin/python'} 22:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:13 INFO - Downloading/unpacking flake8 22:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:07:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 22:07:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:07:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 22:07:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 22:07:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:07:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:07:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:07:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:07:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:07:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:07:15 INFO - no previously-included directories found matching 'docs/_build' 22:07:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:07:15 INFO - Running setup.py install for pep8 22:07:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:07:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:07:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:07:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:07:15 INFO - no previously-included directories found matching 'docs/_build' 22:07:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:07:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:07:15 INFO - Cleaning up... 22:07:15 INFO - Return code: 0 22:07:15 INFO - Running post-action listener: _resource_record_post_action 22:07:15 INFO - Running post-action listener: _start_resource_monitoring 22:07:15 INFO - Starting resource monitoring. 22:07:15 INFO - ##### 22:07:15 INFO - ##### Running install step. 22:07:15 INFO - ##### 22:07:15 INFO - Running pre-action listener: _resource_record_pre_action 22:07:15 INFO - Running main action method: install 22:07:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:07:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:07:16 INFO - Reading from file tmpfile_stdout 22:07:16 INFO - Detecting whether we're running mozinstall >=1.0... 22:07:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:07:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:07:16 INFO - Reading from file tmpfile_stdout 22:07:16 INFO - Output received: 22:07:16 INFO - Usage: mozinstall [options] installer 22:07:16 INFO - Options: 22:07:16 INFO - -h, --help show this help message and exit 22:07:16 INFO - -d DEST, --destination=DEST 22:07:16 INFO - Directory to install application into. [default: 22:07:16 INFO - "/builds/slave/test-pgo"] 22:07:16 INFO - --app=APP Application being installed. [default: firefox] 22:07:16 INFO - mkdir: /builds/slave/test-pgo/build/application 22:07:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:07:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:07:32 INFO - Reading from file tmpfile_stdout 22:07:32 INFO - Output received: 22:07:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:07:32 INFO - Running post-action listener: _resource_record_post_action 22:07:32 INFO - ##### 22:07:32 INFO - ##### Running run-tests step. 22:07:32 INFO - ##### 22:07:32 INFO - Running pre-action listener: _resource_record_pre_action 22:07:32 INFO - Running main action method: run_tests 22:07:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:07:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:07:32 INFO - Python 2.7.3 22:07:32 INFO - Return code: 0 22:07:32 INFO - grabbing minidump binary from tooltool 22:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:32 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 0x1c99540>, '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 0x1c9a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:07:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:07:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:07:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:07:32 INFO - Return code: 0 22:07:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:07:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:07:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:07:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:07:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:07:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:07:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:07:33 INFO - Return code: 0 22:07:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:07:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:07:33 INFO - Using env: {'DISPLAY': ':0', 22:07:33 INFO - 'HOME': '/home/cltbld', 22:07:33 INFO - 'LANG': 'en_US.UTF-8', 22:07:33 INFO - 'LANGUAGE': 'en_US:en', 22:07:33 INFO - 'LOGNAME': 'cltbld', 22:07:33 INFO - 'MAIL': '/var/mail/cltbld', 22:07:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:07:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:33 INFO - 'MOZ_NO_REMOTE': '1', 22:07:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:33 INFO - 'NO_EM_RESTART': '1', 22:07:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:33 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:07:33 INFO - 'SHELL': '/bin/bash', 22:07:33 INFO - 'SHLVL': '1', 22:07:33 INFO - 'TERM': 'linux', 22:07:33 INFO - 'TMOUT': '86400', 22:07:33 INFO - 'USER': 'cltbld', 22:07:33 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122', 22:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:33 INFO - '_': '/tools/buildbot/bin/python'} 22:07:33 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:07:33 INFO - mozversion application_buildid: 20160116193624 22:07:33 INFO - mozversion application_changeset: d2b4d101d00691f835c4f109524a3506d5f51626 22:07:33 INFO - mozversion application_display_name: Nightly 22:07:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:07:33 INFO - mozversion application_name: Firefox 22:07:33 INFO - mozversion application_remotingname: firefox 22:07:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:07:33 INFO - mozversion application_vendor: Mozilla 22:07:33 INFO - mozversion application_version: 46.0a1 22:07:33 INFO - mozversion platform_buildid: 20160116193624 22:07:33 INFO - mozversion platform_changeset: d2b4d101d00691f835c4f109524a3506d5f51626 22:07:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:07:33 INFO - mozversion platform_version: 46.0a1 22:07:33 INFO - using testdate: 1453010853 22:07:33 INFO - actual date: 1453010853 22:07:33 INFO - starting webserver on 'localhost:49760' 22:07:33 INFO - SUITE-START | Running 3 tests 22:07:33 INFO - TEST-START | dromaeo_css 22:07:33 INFO - operating with platform_type : linux_ 22:07:33 INFO - Initialising browser for dromaeo_css test... 22:07:33 INFO - TEST-INFO | started process 18012 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5NK3ng/profile http://localhost:49760/getInfo.html) 22:07:37 INFO - PROCESS | 18012 | __metrics Screen width/height:1600/1200 22:07:37 INFO - PROCESS | 18012 | colorDepth:24 22:07:37 INFO - PROCESS | 18012 | Browser inner width/height: 1024/697 22:07:37 INFO - PROCESS | 18012 | __metrics 22:07:37 INFO - PROCESS | 18012 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:07:37 INFO - PROCESS | 18012 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:07:39 INFO - TEST-INFO | 18012: exit 0 22:07:39 INFO - Browser initialized. 22:07:39 INFO - Running cycle 1/1 for dromaeo_css test... 22:07:39 INFO - TEST-INFO | started process 18111 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5NK3ng/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:07:50 INFO - PROCESS | 18111 | RSS: Main: 149553152 22:07:50 INFO - PROCESS | 18111 | 22:08:42 INFO - PROCESS | 18111 | 1453010922298 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:10:50 INFO - PROCESS | 18111 | Cycle 1(1): loaded http://localhost:49760/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49760/tests/dromaeo/cssquery-ext.html) 22:10:51 INFO - PROCESS | 18111 | RSS: Main: 270106624 22:10:51 INFO - PROCESS | 18111 | 22:13:54 INFO - PROCESS | 18111 | Cycle 1(1): loaded http://localhost:49760/tests/dromaeo/cssquery-ext.html (next: http://localhost:49760/tests/dromaeo/cssquery-jquery.html) 22:13:54 INFO - PROCESS | 18111 | RSS: Main: 230920192 22:13:54 INFO - PROCESS | 18111 | 22:16:56 INFO - PROCESS | 18111 | Cycle 1(1): loaded http://localhost:49760/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49760/tests/dromaeo/cssquery-mootools.html) 22:16:57 INFO - PROCESS | 18111 | RSS: Main: 233672704 22:16:57 INFO - PROCESS | 18111 | 22:19:59 INFO - PROCESS | 18111 | Cycle 1(1): loaded http://localhost:49760/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49760/tests/dromaeo/cssquery-prototype.html) 22:19:59 INFO - PROCESS | 18111 | RSS: Main: 212738048 22:19:59 INFO - PROCESS | 18111 | 22:23:02 INFO - PROCESS | 18111 | Cycle 1(1): loaded http://localhost:49760/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49760/tests/dromaeo/cssquery-yui.html) 22:23:03 INFO - PROCESS | 18111 | RSS: Main: 213667840 22:23:03 INFO - PROCESS | 18111 | 22:26:05 INFO - PROCESS | 18111 | Cycle 1(1): loaded http://localhost:49760/tests/dromaeo/cssquery-yui.html (next: http://localhost:49760/tests/dromaeo/cssquery-dojo.html) 22:26:05 INFO - PROCESS | 18111 | RSS: Main: 289329152 22:26:05 INFO - PROCESS | 18111 | 22:26:05 INFO - PROCESS | 18111 | __start_tp_report 22:26:05 INFO - PROCESS | 18111 | _x_x_mozilla_page_load 22:26:05 INFO - PROCESS | 18111 | _x_x_mozilla_page_load_details 22:26:05 INFO - PROCESS | 18111 | |i|pagename|runs| 22:26:05 INFO - PROCESS | 18111 | |0;dojo.html;3112.517559778234;3122.609673790776;3165.256164801271;3171.191346206718;3190.7128358447744;5038.924416133752;5086.262491938672;5091.745412729368;5102.438731739506;5117.565006974407;5084.262781896623;5128.051310507559;5135.486451354872;5150.1244788385975;5175.223716442535;4628.30575413689;4654.767261636922;4704.106219818241;4784.688995215317;4799.160146974283;4710.3641008463765;4727.054589082198;4757.738324392157;4809.422869255677;4841.176999910006;4474.7762611869275;4631.397918270637;4645.349651048856;4659.7204167749705;4701.999999999983;4619.237825758746;4644.651651126179;4664.976675116603;4685.554872287127;4702.012577358759;4547.090581883636;4628.953710462886;4633.698809577367;4656.348111264426;4659.860204193879;4899.926501102486;4905.2151655734915;4960.2559616057515;4961.751912404366;4962.1812400953795;5497.340319161726;5513.50378465936;5515.889682206373;5516.310461192351;5526.668399896019;5413.485718856702;5493.725313734337;5540.196671482653;5556.16657501374;5567.081431563787;5068.645194836363;5083.542481176712;5106.310648062538;5122.257272695439;5147.819826306061;5518.586106042063;5533.3083364579425;5556.499915007668;5567.721613919369;5579.972100139474;5280.20796880471;5297.337832770903;5300.628955973122;5306.310179676694;5353.652012619245;5356.5179133877355;5368.087425137736;5385.407605163429;5386.461353864583;5436.483534064258;5410.08028635133;5435.891282174413;5436.809711660073;5437.972810135924;5445.891082178334;5295.814646487354;5370;5391.299131113009;5439.864003399867;5474.507294343528;4201.579842015835;4288.378185163134;4294.0767734937135;4325.2214601371425;4327.697061205686;3843.442700808367;3848.3457812171996;3851.6340947609933;3853.5761066282685;3892.6107389260847;4929.457759646436;4992.176290911959;4995.550400463976;5088.465711100355;5133.383993920754;5378.381486129145;5421.783128674809;5455.345358556999;5468.37113731918;5513.476219759116;5075.264086707481;5104.259882317043;5113.1052065888325;5114.590832733373;5160.380754309507;4660.720356778605;4672.859814205579;4708.976455117771;4716.1510928033285;4717.834875779331;5689.487946084955;5696.3733989261145;5720.599558030981;5729.455701708331;5751.798687045934;5519.475649813261;5522.751476183501;5524.281843360337;5525.060739674184;5528.44715528444;5612.663240205601;5621.971890140687;5632.971835140798;5657.745401457027;5692.51613612831;5401.378841433286;5402.324709411324;5405.621606487508;5415.756290966837;5456.154296084113;5403.378611459732;5441.673499590037;5455.536279416294;5487.067198576172;5562.276904002454;5176.741162941913;5177.068127737043;5222.503862133091;5347.652402593819;5359.678419294854;5286.15421532553;5296.04671159195;5298.15229563268;5301.231321458444;5364.222187782671;5164.9741751291;5204.427512973494;5211.354902689972;5212;5274.657147285414;5242.292290540729;5319.547838433622;5334.626576139633;5335.893282134258;5379.193121031876;5206.323177986837;5254.133068043883;5257.369115706139;5261.421243663118;5341 22:26:05 INFO - PROCESS | 18111 | |1;ext.html;531.5800517591103;532.3292651259413;537.9166229234468;554.0885243773993;559.9916001259979;28044.85977570112;28335.149945501667;28426.289342766442;28482.003129890483;28503.28741781454;29343.706562934363;36649.81675091621;37333;37342.43986340207;37354;8441.704540341088;8602.526861022641;8604.569771511431;8615.483071015758;8615.612297446598;8334.70828521002;8449.831003379928;8456.365772567051;8458.407911446202;8472.237498625123;8419.115992820758;8499.787505312355;8516;8518.829623407528;8623.223909848113;8549.187827156411;8612.267957223612;8615.526146061964;8626.784330391727;8627.568621568958;8597.269232115277;8695.217430431292;8714.477131372138;8715.912840871573;8718;39371.65340946023;39628.60371396278;39738.20523589541;39763.801180994196;39793.40309895325;3146.1505393543616;3180.4275230458506;3287.227501537137;3374.8481318340487;3556.928861422783;29543.409131817458;29777.70222297771;30096.369885774835;30685.693143068507;31044.689553104407;3984.3625019996953;4021.2560676274984;4036.9394459083137;4091.365838295069;4100.712950093494;261751;262504;262618;263251;263958.9999999981;52648;53850.46149538533;57945.42054579485;58425;61016.38983610196;59644;59787;60352;60420.39579604236;60493.395066049656;15378.38486460529;15555.688886222211;15570.688586228212;15582.376704931903;15620.76568851468;10257.846132308021;10787.892121078688;10831.187660925461;11712.180147389772;12441.440135193758;19503.317383891495;19507.414777556412;19587;19598.608027839364;19631.705524417146;7032.613206273704;7080.150381954096;7171.282871712891;7188.353048225685;7326.9267307326245;876.7851876290222;905.9592318345558;962.0860182826343;1073.5330131392868;1119.7200699825044;27272.181834544994;28010;28788.42423151525;28858.855705721337;29030.854845725637;851.9914800852036;1003.247564326755;1048.2609760119099;1084.6420681175193;1145.3414286785132;14681.192534410497;15355;15613.219339033003;15640.92179539095;15655;336336;345545;346616;346856;347263;51809;51860.22209666858;52041.21938170931;52245.477545224065;52257.216141757905;1311.1936159261986;1336.8128462015325;1339.7789364754706;1346.8720471555382;1350.5340657473157;28325;29107.126786196448;29458.705412946452;29840.10479685613;29934.401311974074;46190;46407.535924640324;46502.76748616235;46591.767041164574;46656.7667161662;305056;310097;311041;370420;375922;29628.111156665334;29643.849861019044;29655.703442965296;29963.85018074983;30039.549406759354;39355;40107.59892401039;40110.1977960445;40849.1830163401;40950.59049409587;34134.317313654086;34323.14192145217;34443.827780860935;34512.82743586266;34963;29469.410611788073;33766.831165844014;35491.82254088713;35515.82242088773;36296.45555316725;32184.517232242004;32243;32458.837705812264;32488.35023299568;32507.837460812545;29857.402851943272;30258.725507784427;35200.471992919614;35349;35363.46954795731;24089.156879509133;24232.515349692556;24320.635190472512;24503.387415314046;24728.505429891662 22:26:05 INFO - PROCESS | 18111 | |2;jquery.html;360.13926715150785;364.2441932989047;365.92315613721115;369.1951545630526;372.3799873211104;13501.864981350183;13943.442262309496;15797.842021579781;17221.22504487298;18348.908255458722;15555;15968.361265549363;16513.587160320996;16786;16799.916000420013;4890.193118135512;5066.74666266687;5073.619478539106;5073.7209453480045;5076.187809950408;3721.1999420124666;3820.5797362290127;4998.875028124307;5307.973460132694;5494.09347457671;5446.101393270105;5467;5467.097928841737;5492.258545096401;5569.331680198382;5944.7324870380935;5971.5222782177325;5991.7902873399225;6003.489703375219;6005.039193728982;5176.663516871429;5302.363716354023;5384.865378365572;5385.138377859563;5389.757460914268;19351.322703705304;19476.4157075288;20000.299989500298;20006.69989950152;20019;1918.3381733301987;2066.700328452381;2074.7199128117813;2429.3197904586746;2708.052181736396;9835.606575736962;10369.896301037044;12185.695357616041;12598.874011259953;12869.935650321688;1781.750554922312;1836.494963884929;1841.383136649224;1854.7310639957132;1859.9349022784272;56314.43685563174;57780.422195778345;58082.70958645222;58313.12530312049;59571.70214148902;9656.22750179998;9892.752681183028;10074.546645400975;10082.848757268646;10146.441945693057;13256;13307.467701292033;13322.933385333012;13349.132306400053;13375;7470.775876723707;7542.208068152875;7552.773416797505;7629.771106866803;7630.580318082559;7160.641967901584;7216.134063912364;7248.891266631004;7277.2358902315555;7316.670749816271;4032.919341613151;4362.9781851091175;4366.061296821199;4379.759113248802;4399.032212913154;1720.3720641965842;1759.727242277449;1784.5360206346184;1816.6366726654721;1837.7243413488084;895.2837729816121;896.2964073202505;926.5413620257881;1014.9238807089498;1035.1304903880775;13956.441742330397;14930.626734331729;15353.846461535464;15692.529224123295;15816.209189540477;852.3820230333083;871.0418539606383;894.3784070071238;900.0279697926223;921.5254144115786;7948.364130869517;8861.822763544822;9321.673741419017;9390.577424015935;9453.149216570542;391895;400787;411957;413554;571416;75155.62422187964;75543.62228188934;75717.62141189259;76110;79175;1078.44460103047;1123.2025262063862;1124.8650161980452;1128.6501184632791;1129.3054771315747;13991.930040349733;14525.636859078608;15044.924775376054;15260.389584416498;15318.617034574225;32375.67624323821;33279;34011.4898276531;34142.82928585341;34382.65617343794;37590;37600.2479950394;38819.417708733825;39644;40646.39030414487;6929.133858267716;7308.634568271672;7385.335319821242;7435.442341824277;7460.0674915635545;9546.713598592054;10619.628313009007;10803.783924321313;10862.293950893167;11538.94230528842;9452.527373631154;9535.189508891823;9630.903690963001;9741.951290243504;9831.557579908778;9343.579538920902;9479.194268487256;9565.856512152184;9746.561404736662;9841.409515429097;9632.27757918173;9716;9841.950790246003;9930.25523085786;10087.848682269625;7382.4094072475145;7392.4086073115095;7405.703771849066;7469.215732348242;7566;7533.962330188314;8019.719309824128;9209.17117459432;9600.183984361129;9839.065288797552 22:26:05 INFO - PROCESS | 18111 | |3;mootools.html;1332.1008319384414;1456.963575910602;1465.8460861609535;1609.7665838453424;1780.3679693708732;6896.172459304884;7551.433642476809;7696.114946781122;7705.422093343001;7713.190115037924;7459.291367320109;7642.770716878488;7644.732434364799;7647.541147531138;7653.19641437648;1957.50083728649;2000.8599398042143;2002.6495363311362;2283.908643654252;2311.768823117683;2013.436237853396;2299.5515874404496;2338.5556744218543;2343.261872510154;2346.9882650586724;2267.4784799496124;2291.2667946257206;2300.5858945389823;2302.067662596651;2326.1858349577597;2252.1329288223988;2284.132029828663;2287.748347681754;2292.266474728079;2295.276987748862;2286.7941885230407;2294.529621427603;2295.2425699519117;2296.552172326397;2307.4692820651344;7605.087389513238;7685.462017658766;7754.1470438251745;7761.068671759369;7765.495242809199;4699.201135806921;4781.545753153445;4830.420349558076;4860.198067318888;4862.051899879525;3079.9538006929915;3125.4374212641715;3210.7752457327997;3245.464498357768;3264.1186879542392;1065.536491626145;1099.912007039435;1124.9775004499863;1141.9429028548623;1163.9592614258545;10563.26057175998;10581.947090264577;10593.25847190697;10622.628208012682;10629.5216715248;4265.722728022669;4321.956780432219;4363.345498175299;4383.232934236496;4394.934075988863;9145.314101442418;9152.359334846496;9152.816943661222;9159.038300978435;9172.954135229415;4796.040791841646;4837.69382266786;4852.223644216909;4854.101991131652;4861.29511220871;4384.539623339567;4405.977970110193;4415;4430.889227769267;4439.489458712224;3411.4712219606;3474.1314671332166;3720.7581507201944;3777;3826.0626146594263;1207.3299318878107;1212.3695678247261;1224.871388504212;1230.2065167966612;1247.607003793802;1246.8628450870397;1257.1639859493516;1273.2233337664018;1315.2371624457792;1315.6579289384638;7115.359617634334;7124.893126603105;7310.634468276565;7450.925490745023;7454.589997550078;1097.5554900265406;1099.6426161497545;1102.4763237462141;1112.8942750438696;1115.5816568786704;5784.82645520635;5820.941790582125;5836.708164591753;5838.095095260242;5848.064309710511;9082.954585227031;9150.40522366044;9437.970836270097;9522.476263805418;9534.046595340411;9321.254299656011;9372.5313734313;9438.905610943802;9473.810523789623;9583.329166958247;7167.211606723256;7312.305330993547;7312.707491700379;7323.194448610755;7326.084239470067;7116.928830711627;7146.892796608159;7163.570185788869;7164.426845852424;7173.820654483471;8057.113717491188;8370.246677799027;8371.748847534584;8484.533350665773;8597.699080532151;8595.44129631572;8794.780130496789;8839.955800220958;8841;8854;6535.248446428532;6686.83282917931;6704.161979752531;6733.225679046972;6772;6473.320301368289;6620.271770105188;7007.913773365137;7281.9441181029515;7320.26797320285;6909.654517274015;6957.686904089227;6974.6512674367095;7087.22040575526;7089.326513981164;6863.279355667583;6893.965530172518;6947.826304342432;7040.0847889774;7083.787486375417;7070.939359096176;7094.893576596252;7122;7126.964365178141;7135.928640713526;6286.057091436322;6317.5893566918;6327.557071004985;6378.234611846423;6397.488200943821;6526.086347911201;6561.048647946117;6572.671366431755;6572.76995305162;6579.80260592183 22:26:05 INFO - PROCESS | 18111 | |4;prototype.html;325.201629998354;333.49975037443835;336.13780652626014;337.70450855501434;346.33330838136595;5655.830325090244;5798.39116892726;5833.037548804447;5836.270466191731;5867.823965281038;5630.605857589971;5747.023006088964;5748.971255143729;5750.3962083981105;5805.941940580593;4502.662300327472;4504.0766642838225;4537.523560026199;4548.272276435771;4551.5676010778925;4330.307150855863;4419.094085712437;4455.933161002587;4510.278355463127;4528.230200865861;4435.711678740888;4450.799714012877;4455.821767129327;4462.308342206963;4462.97768511157;4459.041306119184;4515.254982927846;4528.139653465847;4528.818847246106;4529.297958816389;3986.720929534934;3991.481107456012;3991.720579559432;3993.9600603993877;3994.141259629165;5401.675899446007;5554.583406244547;5559.33288005442;5572.832815015556;5594.9720251398885;5117.078925793356;5118.769655365518;5119.948800511985;5129.358830146231;5135.075686376451;5882.911756323659;6160.5687601867885;6220.502359811204;6220.564560480768;6224.439800417938;4166.437530933345;4202.789860506962;4233.280342341778;4235.9364609530885;4245.490541135053;6331.715072821688;6422.165118534561;6428.582142160744;6432.807015789534;6440.484761219138;4381.67137464685;4388.648908087345;4392.297232442794;4393.780310984438;4408.801603927831;4317.266064768997;4426.468823741172;4445.310976798602;4445.933311000337;4461.420015397977;5157.793688252428;5163.66436181647;5178.326817513775;5181.5077567631015;5182.067227899014;6195.690215489208;6202.100695399142;6208.1308616793685;6210.9068363974575;6211.875762484725;1535.7005383950022;1569.238919124224;1569.3173469540786;1571.5521076493144;1571.5756745678832;1049.354646892171;1050.3855244681795;1056.8361903904906;1059.057438879398;1081.7025318037602;5863.237779088691;5868.149118377897;5869.295684517885;5879.823605291848;5883.264591926009;6368.14030105939;6371.426571608577;6377.426031657174;6378.6810659467765;6384.968075159687;5862.677552734641;5863.413658634103;5866.765329386777;5866.823995280149;5872.119182122716;3287.161773747727;3435.038189306998;3435.587729472429;3436.055084851636;3439.1917899293644;6597.670116494156;6602.933970660232;6604.240512341046;6606.768763093269;6610.933890661128;6519.445847102955;6526.477881769447;6537.607743535308;6546.967265163644;6549.377809108127;6440.098386225932;6588.341165883373;6667.333266673294;6676.6995485202315;6683.5989840608745;6181.227346581677;6331.873362532631;6434.453071488976;6435.388638079375;6445.486260358371;6154.922888494406;6263.843403914939;6269.059641053696;6272.937270627235;6348.809535713936;6629.569078009914;6640.767573134917;6658.467322614082;6669.1330127083165;6672.132622759011;4408.118376324684;4462.866114016585;4488.057507923372;4489.214387482112;4489.775511224491;6384.329645387167;6387.041943708481;6388.552801303864;6388.64862432552;6388.840278992877;6214.130021797043;6215.96892015537;6217.533684973555;6219.875602488016;6219.968900155471;6037.547183961133;6181.289151747606;6189.876202476015;6195.535334849995;6195.659238741732;6118.418750218722;6127.8468038297615;6135.325114237341;6137.8465538360115;6140.539459540463;6272.843178920563;6283.057541368831;6285.277193122849;6286.654234017173;6287.2769631492965;5863.912041319299;6069.150318955261;6077.6353418795015;6078.57449978515;6081.179040829431 22:26:05 INFO - PROCESS | 18111 | |5;yui.html;733.29237286019;785.670018592191;787.1970589998202;808.8422757562271;822.7038266224158;12687.175333603322;12883.871161288384;12904.161229520098;12916.806247906265;12952.611421657342;12054.216475929059;12073.698157546065;12115.636530904065;12122.393880305972;12136.817947730791;650.6193876582205;663.230652443166;664.4551467796409;665.17518277336;665.8401983523968;792.7463211772235;804.0391731880405;808.9838203235931;810.8256724804166;810.8945837041206;839.4082172068677;849.6516428264413;850.5832142250284;851.7615067781;852.0371979662972;682.2256738601698;690.3441730356182;690.8272931767058;691.1567887177636;836.8117173635944;505.9392872855244;615.3047056825803;624.9937500624981;626.8746250749869;627.4447114303829;12480;12530.498780048787;12562.623121306375;12564.183328083736;12590.937045314806;12155.270683758914;12567.748645027139;12577;12655.177413468095;13001.414936327888;9444.669436569755;9457.952710236474;9525.428474291495;9639.325247232697;9992.600295988224;3556.466530020492;3565.5899571549344;3580.427131658922;3616.692581130607;3630.110622897407;46149.30776038362;46169.76915115403;46233.30650040252;46373.768131159464;46424.303635445496;9612.279079069098;9781.657641982496;9860.112589866947;9904.801903961881;10019.949900250453;16395.262213200436;16483.58791030234;16551.172441377883;16555.751663725056;16557.089360085312;7359.448041396917;7435.256474352522;7530.28462296081;7539.811504712426;7562.584057876869;4217.093324935154;4246.72396294246;4327.6110497675345;4332.978335108304;4349.934750978738;2997.3256017396347;3016.155476466593;3019;3025.2588115911744;3066.7546596272246;590.7873165660445;601.1283638723868;601.3895895665903;604.3322129047427;605.7940300297831;456.72596442134454;498.6534358620724;507.50771751401084;534.3187436019107;598.2133494454778;8260.463069900437;8968.955155224312;9200.263978881674;9208.769780755534;9325.160735533835;471.32365056144545;552.2434265056818;579.3800633322305;652.1424327009967;662.1557514169473;3661.688756455678;3844.7308688391545;3847.9230415392094;3875.6318149775725;4031.496062992126;49701.25448118281;53742.19386709203;53805.1929221062;53819;53904.46095538994;46004;47752.76123619429;47811.9999999993;48005.75997119992;48040;41845.79077104656;42536;42604.57395426068;42914.35628465513;42954.355684664755;7958.522488650699;8084.474509156886;8234.176582341717;8388.748337549883;8494.154458256306;31801.5229771549;31871.52192717065;32060.67939320577;32123.839380802947;32208;38457.4231386535;40580.30424979845;41216.79391603023;45149.32276015928;45718.314225287315;10895.618653347412;11000;11267.436628168723;11296.548138074713;11524.810286045624;10689.839652405375;11633.53465861356;12087.516499339928;12397.690057748629;12530.812037819622;9825.115739583473;10081.193504519475;10115.241356898408;11342.546298147981;11624.360660163773;10476.63331783384;10922.344659320466;11015.118790496901;11269.66191014271;11386.772264554496;9911.603535858485;10139.290249682452;10308.845367319345;10402.115820155372;10545.578176873147;9042.593083311136;9190;9251.722448326562;9385.343025988115;9629.807403852024;9112.726618201465;9128.726138215865;9317.86023209639;9574.856377154209;9735.80528389414 22:26:05 INFO - PROCESS | 18111 | __end_tp_report 22:26:05 INFO - PROCESS | 18111 | __start_cc_report 22:26:05 INFO - PROCESS | 18111 | _x_x_mozilla_cycle_collect,1025 22:26:05 INFO - PROCESS | 18111 | __end_cc_report 22:26:05 INFO - PROCESS | 18111 | __startTimestamp1453011965980__endTimestamp 22:26:05 INFO - PROCESS | 18111 | 22:26:05 INFO - PROCESS | 18111 | ------- Summary: start ------- 22:26:05 INFO - PROCESS | 18111 | Number of tests: 6 22:26:05 INFO - PROCESS | 18111 | 22:26:05 INFO - PROCESS | 18111 | [#0] dojo.html Cycles:165 Average:5075.16 Median:5222.50 stddev:534.57 (10.2%) stddev-sans-first:513.55 22:26:05 INFO - PROCESS | 18111 | Values: 3112.5 3122.6 3165.3 3171.2 3190.7 5038.9 5086.3 5091.7 5102.4 5117.6 5084.3 5128.1 5135.5 5150.1 5175.2 4628.3 4654.8 4704.1 4784.7 4799.2 4710.4 4727.1 4757.7 4809.4 4841.2 4474.8 4631.4 4645.3 4659.7 4702.0 4619.2 4644.7 4665.0 4685.6 4702.0 4547.1 4629.0 4633.7 4656.3 4659.9 4899.9 4905.2 4960.3 4961.8 4962.2 5497.3 5513.5 5515.9 5516.3 5526.7 5413.5 5493.7 5540.2 5556.2 5567.1 5068.6 5083.5 5106.3 5122.3 5147.8 5518.6 5533.3 5556.5 5567.7 5580.0 5280.2 5297.3 5300.6 5306.3 5353.7 5356.5 5368.1 5385.4 5386.5 5436.5 5410.1 5435.9 5436.8 5438.0 5445.9 5295.8 5370.0 5391.3 5439.9 5474.5 4201.6 4288.4 4294.1 4325.2 4327.7 3843.4 3848.3 3851.6 3853.6 3892.6 4929.5 4992.2 4995.6 5088.5 5133.4 5378.4 5421.8 5455.3 5468.4 5513.5 5075.3 5104.3 5113.1 5114.6 5160.4 4660.7 4672.9 4709.0 4716.2 4717.8 5689.5 5696.4 5720.6 5729.5 5751.8 5519.5 5522.8 5524.3 5525.1 5528.4 5612.7 5622.0 5633.0 5657.7 5692.5 5401.4 5402.3 5405.6 5415.8 5456.2 5403.4 5441.7 5455.5 5487.1 5562.3 5176.7 5177.1 5222.5 5347.7 5359.7 5286.2 5296.0 5298.2 5301.2 5364.2 5165.0 5204.4 5211.4 5212.0 5274.7 5242.3 5319.5 5334.6 5335.9 5379.2 5206.3 5254.1 5257.4 5261.4 5341.0 22:26:05 INFO - PROCESS | 18111 | 22:26:05 INFO - PROCESS | 18111 | [#1] ext.html Cycles:180 Average:47232.97 Median:347059.50 stddev:83126.98 (24.0%) stddev-sans-first:83286.22 22:26:05 INFO - PROCESS | 18111 | Values: 531.6 532.3 537.9 554.1 560.0 28044.9 28335.1 28426.3 28482.0 28503.3 29343.7 36649.8 37333.0 37342.4 37354.0 8441.7 8602.5 8604.6 8615.5 8615.6 8334.7 8449.8 8456.4 8458.4 8472.2 8419.1 8499.8 8516.0 8518.8 8623.2 8549.2 8612.3 8615.5 8626.8 8627.6 8597.3 8695.2 8714.5 8715.9 8718.0 39371.7 39628.6 39738.2 39763.8 39793.4 3146.2 3180.4 3287.2 3374.8 3556.9 29543.4 29777.7 30096.4 30685.7 31044.7 3984.4 4021.3 4036.9 4091.4 4100.7 261751.0 262504.0 262618.0 263251.0 263959.0 52648.0 53850.5 57945.4 58425.0 61016.4 59644.0 59787.0 60352.0 60420.4 60493.4 15378.4 15555.7 15570.7 15582.4 15620.8 10257.8 10787.9 10831.2 11712.2 12441.4 19503.3 19507.4 19587.0 19598.6 19631.7 7032.6 7080.2 7171.3 7188.4 7326.9 876.8 906.0 962.1 1073.5 1119.7 27272.2 28010.0 28788.4 28858.9 29030.9 852.0 1003.2 1048.3 1084.6 1145.3 14681.2 15355.0 15613.2 15640.9 15655.0 336336.0 345545.0 346616.0 346856.0 347263.0 51809.0 51860.2 52041.2 52245.5 52257.2 1311.2 1336.8 1339.8 1346.9 1350.5 28325.0 29107.1 29458.7 29840.1 29934.4 46190.0 46407.5 46502.8 46591.8 46656.8 305056.0 310097.0 311041.0 370420.0 375922.0 29628.1 29643.8 29655.7 29963.9 30039.5 39355.0 40107.6 40110.2 40849.2 40950.6 34134.3 34323.1 34443.8 34512.8 34963.0 29469.4 33766.8 35491.8 35515.8 36296.5 32184.5 32243.0 32458.8 32488.4 32507.8 29857.4 30258.7 35200.5 35349.0 35363.5 24089.2 24232.5 24320.6 24503.4 24728.5 22:26:05 INFO - PROCESS | 18111 | 22:26:05 INFO - PROCESS | 18111 | [#2] jquery.html Cycles:180 Average:24683.62 Median:4944.53 stddev:72643.82 (1469.2%) stddev-sans-first:72824.65 22:26:06 INFO - PROCESS | 18111 | Values: 360.1 364.2 365.9 369.2 372.4 13501.9 13943.4 15797.8 17221.2 18348.9 15555.0 15968.4 16513.6 16786.0 16799.9 4890.2 5066.7 5073.6 5073.7 5076.2 3721.2 3820.6 4998.9 5308.0 5494.1 5446.1 5467.0 5467.1 5492.3 5569.3 5944.7 5971.5 5991.8 6003.5 6005.0 5176.7 5302.4 5384.9 5385.1 5389.8 19351.3 19476.4 20000.3 20006.7 20019.0 1918.3 2066.7 2074.7 2429.3 2708.1 9835.6 10369.9 12185.7 12598.9 12869.9 1781.8 1836.5 1841.4 1854.7 1859.9 56314.4 57780.4 58082.7 58313.1 59571.7 9656.2 9892.8 10074.5 10082.8 10146.4 13256.0 13307.5 13322.9 13349.1 13375.0 7470.8 7542.2 7552.8 7629.8 7630.6 7160.6 7216.1 7248.9 7277.2 7316.7 4032.9 4363.0 4366.1 4379.8 4399.0 1720.4 1759.7 1784.5 1816.6 1837.7 895.3 896.3 926.5 1014.9 1035.1 13956.4 14930.6 15353.8 15692.5 15816.2 852.4 871.0 894.4 900.0 921.5 7948.4 8861.8 9321.7 9390.6 9453.1 391895.0 400787.0 411957.0 413554.0 571416.0 75155.6 75543.6 75717.6 76110.0 79175.0 1078.4 1123.2 1124.9 1128.7 1129.3 13991.9 14525.6 15044.9 15260.4 15318.6 32375.7 33279.0 34011.5 34142.8 34382.7 37590.0 37600.2 38819.4 39644.0 40646.4 6929.1 7308.6 7385.3 7435.4 7460.1 9546.7 10619.6 10803.8 10862.3 11538.9 9452.5 9535.2 9630.9 9742.0 9831.6 9343.6 9479.2 9565.9 9746.6 9841.4 9632.3 9716.0 9842.0 9930.3 10087.8 7382.4 7392.4 7405.7 7469.2 7566.0 7534.0 8019.7 9209.2 9600.2 9839.1 22:26:06 INFO - PROCESS | 18111 | 22:26:06 INFO - PROCESS | 18111 | [#3] mootools.html Cycles:180 Average:5457.09 Median:6301.82 stddev:2794.02 (44.3%) stddev-sans-first:2784.65 22:26:06 INFO - PROCESS | 18111 | Values: 1332.1 1457.0 1465.8 1609.8 1780.4 6896.2 7551.4 7696.1 7705.4 7713.2 7459.3 7642.8 7644.7 7647.5 7653.2 1957.5 2000.9 2002.6 2283.9 2311.8 2013.4 2299.6 2338.6 2343.3 2347.0 2267.5 2291.3 2300.6 2302.1 2326.2 2252.1 2284.1 2287.7 2292.3 2295.3 2286.8 2294.5 2295.2 2296.6 2307.5 7605.1 7685.5 7754.1 7761.1 7765.5 4699.2 4781.5 4830.4 4860.2 4862.1 3080.0 3125.4 3210.8 3245.5 3264.1 1065.5 1099.9 1125.0 1141.9 1164.0 10563.3 10581.9 10593.3 10622.6 10629.5 4265.7 4322.0 4363.3 4383.2 4394.9 9145.3 9152.4 9152.8 9159.0 9173.0 4796.0 4837.7 4852.2 4854.1 4861.3 4384.5 4406.0 4415.0 4430.9 4439.5 3411.5 3474.1 3720.8 3777.0 3826.1 1207.3 1212.4 1224.9 1230.2 1247.6 1246.9 1257.2 1273.2 1315.2 1315.7 7115.4 7124.9 7310.6 7450.9 7454.6 1097.6 1099.6 1102.5 1112.9 1115.6 5784.8 5820.9 5836.7 5838.1 5848.1 9083.0 9150.4 9438.0 9522.5 9534.0 9321.3 9372.5 9438.9 9473.8 9583.3 7167.2 7312.3 7312.7 7323.2 7326.1 7116.9 7146.9 7163.6 7164.4 7173.8 8057.1 8370.2 8371.7 8484.5 8597.7 8595.4 8794.8 8840.0 8841.0 8854.0 6535.2 6686.8 6704.2 6733.2 6772.0 6473.3 6620.3 7007.9 7281.9 7320.3 6909.7 6957.7 6974.7 7087.2 7089.3 6863.3 6894.0 6947.8 7040.1 7083.8 7070.9 7094.9 7122.0 7127.0 7135.9 6286.1 6317.6 6327.6 6378.2 6397.5 6526.1 6561.0 6572.7 6572.8 6579.8 22:26:06 INFO - PROCESS | 18111 | 22:26:06 INFO - PROCESS | 18111 | [#4] prototype.html Cycles:180 Average:5174.62 Median:5863.33 stddev:1553.86 (26.5%) stddev-sans-first:1514.99 22:26:06 INFO - PROCESS | 18111 | Values: 325.2 333.5 336.1 337.7 346.3 5655.8 5798.4 5833.0 5836.3 5867.8 5630.6 5747.0 5749.0 5750.4 5805.9 4502.7 4504.1 4537.5 4548.3 4551.6 4330.3 4419.1 4455.9 4510.3 4528.2 4435.7 4450.8 4455.8 4462.3 4463.0 4459.0 4515.3 4528.1 4528.8 4529.3 3986.7 3991.5 3991.7 3994.0 3994.1 5401.7 5554.6 5559.3 5572.8 5595.0 5117.1 5118.8 5119.9 5129.4 5135.1 5882.9 6160.6 6220.5 6220.6 6224.4 4166.4 4202.8 4233.3 4235.9 4245.5 6331.7 6422.2 6428.6 6432.8 6440.5 4381.7 4388.6 4392.3 4393.8 4408.8 4317.3 4426.5 4445.3 4445.9 4461.4 5157.8 5163.7 5178.3 5181.5 5182.1 6195.7 6202.1 6208.1 6210.9 6211.9 1535.7 1569.2 1569.3 1571.6 1571.6 1049.4 1050.4 1056.8 1059.1 1081.7 5863.2 5868.1 5869.3 5879.8 5883.3 6368.1 6371.4 6377.4 6378.7 6385.0 5862.7 5863.4 5866.8 5866.8 5872.1 3287.2 3435.0 3435.6 3436.1 3439.2 6597.7 6602.9 6604.2 6606.8 6610.9 6519.4 6526.5 6537.6 6547.0 6549.4 6440.1 6588.3 6667.3 6676.7 6683.6 6181.2 6331.9 6434.5 6435.4 6445.5 6154.9 6263.8 6269.1 6272.9 6348.8 6629.6 6640.8 6658.5 6669.1 6672.1 4408.1 4462.9 4488.1 4489.2 4489.8 6384.3 6387.0 6388.6 6388.6 6388.8 6214.1 6216.0 6217.5 6219.9 6220.0 6037.5 6181.3 6189.9 6195.5 6195.7 6118.4 6127.8 6135.3 6137.8 6140.5 6272.8 6283.1 6285.3 6286.7 6287.3 5863.9 6069.2 6077.6 6078.6 6081.2 22:26:06 INFO - PROCESS | 18111 | 22:26:06 INFO - PROCESS | 18111 | [#5] yui.html Cycles:180 Average:13024.11 Median:23447.81 stddev:14824.37 (63.2%) stddev-sans-first:14837.22 22:26:06 INFO - PROCESS | 18111 | Values: 733.3 785.7 787.2 808.8 822.7 12687.2 12883.9 12904.2 12916.8 12952.6 12054.2 12073.7 12115.6 12122.4 12136.8 650.6 663.2 664.5 665.2 665.8 792.7 804.0 809.0 810.8 810.9 839.4 849.7 850.6 851.8 852.0 682.2 690.3 690.8 691.2 836.8 505.9 615.3 625.0 626.9 627.4 12480.0 12530.5 12562.6 12564.2 12590.9 12155.3 12567.7 12577.0 12655.2 13001.4 9444.7 9458.0 9525.4 9639.3 9992.6 3556.5 3565.6 3580.4 3616.7 3630.1 46149.3 46169.8 46233.3 46373.8 46424.3 9612.3 9781.7 9860.1 9904.8 10019.9 16395.3 16483.6 16551.2 16555.8 16557.1 7359.4 7435.3 7530.3 7539.8 7562.6 4217.1 4246.7 4327.6 4333.0 4349.9 2997.3 3016.2 3019.0 3025.3 3066.8 590.8 601.1 601.4 604.3 605.8 456.7 498.7 507.5 534.3 598.2 8260.5 8969.0 9200.3 9208.8 9325.2 471.3 552.2 579.4 652.1 662.2 3661.7 3844.7 3847.9 3875.6 4031.5 49701.3 53742.2 53805.2 53819.0 53904.5 46004.0 47752.8 47812.0 48005.8 48040.0 41845.8 42536.0 42604.6 42914.4 42954.4 7958.5 8084.5 8234.2 8388.7 8494.2 31801.5 31871.5 32060.7 32123.8 32208.0 38457.4 40580.3 41216.8 45149.3 45718.3 10895.6 11000.0 11267.4 11296.5 11524.8 10689.8 11633.5 12087.5 12397.7 12530.8 9825.1 10081.2 10115.2 11342.5 11624.4 10476.6 10922.3 11015.1 11269.7 11386.8 9911.6 10139.3 10308.8 10402.1 10545.6 9042.6 9190.0 9251.7 9385.3 9629.8 9112.7 9128.7 9317.9 9574.9 9735.8 22:26:06 INFO - PROCESS | 18111 | -------- Summary: end -------- 22:26:06 INFO - PROCESS | 18111 | 22:26:06 INFO - TEST-INFO | 18111: exit 0 22:26:06 INFO - TEST-OK | dromaeo_css | took 1113052ms 22:26:06 INFO - TEST-START | kraken 22:26:06 INFO - operating with platform_type : linux_ 22:26:06 INFO - Initialising browser for kraken test... 22:26:06 INFO - TEST-INFO | started process 18314 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAvTtmR/profile http://localhost:49760/getInfo.html) 22:26:10 INFO - PROCESS | 18314 | __metrics Screen width/height:1600/1200 22:26:10 INFO - PROCESS | 18314 | colorDepth:24 22:26:10 INFO - PROCESS | 18314 | Browser inner width/height: 1024/697 22:26:10 INFO - PROCESS | 18314 | __metrics 22:26:11 INFO - PROCESS | 18314 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:26:11 INFO - PROCESS | 18314 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:26:11 INFO - TEST-INFO | 18314: exit 0 22:26:11 INFO - Browser initialized. 22:26:11 INFO - Running cycle 1/1 for kraken test... 22:26:11 INFO - TEST-INFO | started process 18398 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAvTtmR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:26:23 INFO - PROCESS | 18398 | RSS: Main: 149766144 22:26:23 INFO - PROCESS | 18398 | 22:26:26 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49760/tests/kraken/driver.html?testName=audio-beat-detection) 22:26:26 INFO - PROCESS | 18398 | RSS: Main: 185122816 22:26:26 INFO - PROCESS | 18398 | 22:26:29 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49760/tests/kraken/driver.html?testName=audio-dft) 22:26:29 INFO - PROCESS | 18398 | RSS: Main: 176156672 22:26:29 INFO - PROCESS | 18398 | 22:26:32 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49760/tests/kraken/driver.html?testName=audio-fft) 22:26:33 INFO - PROCESS | 18398 | RSS: Main: 160436224 22:26:33 INFO - PROCESS | 18398 | 22:26:35 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49760/tests/kraken/driver.html?testName=audio-oscillator) 22:26:35 INFO - PROCESS | 18398 | RSS: Main: 163553280 22:26:35 INFO - PROCESS | 18398 | 22:26:38 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49760/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:26:38 INFO - PROCESS | 18398 | RSS: Main: 165462016 22:26:38 INFO - PROCESS | 18398 | 22:26:41 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49760/tests/kraken/driver.html?testName=imaging-darkroom) 22:26:42 INFO - PROCESS | 18398 | RSS: Main: 165670912 22:26:42 INFO - PROCESS | 18398 | 22:26:45 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49760/tests/kraken/driver.html?testName=imaging-desaturate) 22:26:46 INFO - PROCESS | 18398 | RSS: Main: 166510592 22:26:46 INFO - PROCESS | 18398 | 22:26:48 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49760/tests/kraken/driver.html?testName=json-parse-financial) 22:26:49 INFO - PROCESS | 18398 | RSS: Main: 165060608 22:26:49 INFO - PROCESS | 18398 | 22:26:50 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49760/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:26:51 INFO - PROCESS | 18398 | RSS: Main: 179449856 22:26:51 INFO - PROCESS | 18398 | 22:26:53 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:26:53 INFO - PROCESS | 18398 | RSS: Main: 176562176 22:26:53 INFO - PROCESS | 18398 | 22:26:55 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:26:56 INFO - PROCESS | 18398 | RSS: Main: 190111744 22:26:56 INFO - PROCESS | 18398 | 22:26:58 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:26:59 INFO - PROCESS | 18398 | RSS: Main: 196075520 22:26:59 INFO - PROCESS | 18398 | 22:27:01 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:27:02 INFO - PROCESS | 18398 | RSS: Main: 193949696 22:27:02 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | Cycle 1(1): loaded http://localhost:49760/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49760/tests/kraken/driver.html?testName=ai-astar) 22:27:04 INFO - PROCESS | 18398 | RSS: Main: 251187200 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | __start_tp_report 22:27:04 INFO - PROCESS | 18398 | _x_x_mozilla_page_load 22:27:04 INFO - PROCESS | 18398 | _x_x_mozilla_page_load_details 22:27:04 INFO - PROCESS | 18398 | |i|pagename|runs| 22:27:04 INFO - PROCESS | 18398 | |0;ai-astar;112;111;105;111;110;111;111;111;103;112 22:27:04 INFO - PROCESS | 18398 | |1;audio-beat-detection;151;125;157;167;129;152;153;134;170;130 22:27:04 INFO - PROCESS | 18398 | |2;audio-dft;162;162;161;160;161;165;162;160;160;163 22:27:04 INFO - PROCESS | 18398 | |3;audio-fft;72;72;91;95;72;71;71;99;91;73 22:27:04 INFO - PROCESS | 18398 | |4;audio-oscillator;96;96;136;97;96;95;139;96;96;135 22:27:04 INFO - PROCESS | 18398 | |5;imaging-gaussian-blur;109;110;109;110;109;109;109;110;109;109 22:27:04 INFO - PROCESS | 18398 | |6;imaging-darkroom;145;145;145;146;146;146;146;146;146;146 22:27:04 INFO - PROCESS | 18398 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;96 22:27:04 INFO - PROCESS | 18398 | |8;json-parse-financial;60;56;57;57;56;57;56;55;63;56 22:27:04 INFO - PROCESS | 18398 | |9;json-stringify-tinderbox;68;69;68;69;69;68;70;69;69;69 22:27:04 INFO - PROCESS | 18398 | |10;stanford-crypto-aes;81;88;81;83;92;81;84;83;81;82 22:27:04 INFO - PROCESS | 18398 | |11;stanford-crypto-ccm;118;122;114;115;115;113;128;121;128;121 22:27:04 INFO - PROCESS | 18398 | |12;stanford-crypto-pbkdf2;141;158;132;139;141;129;143;141;140;135 22:27:04 INFO - PROCESS | 18398 | |13;stanford-crypto-sha256-iterative;68;69;71;67;66;68;67;65;67;65 22:27:04 INFO - PROCESS | 18398 | __end_tp_report 22:27:04 INFO - PROCESS | 18398 | __start_cc_report 22:27:04 INFO - PROCESS | 18398 | _x_x_mozilla_cycle_collect,933 22:27:04 INFO - PROCESS | 18398 | __end_cc_report 22:27:04 INFO - PROCESS | 18398 | __startTimestamp1453012024506__endTimestamp 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | ------- Summary: start ------- 22:27:04 INFO - PROCESS | 18398 | Number of tests: 14 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.09 (2.8%) stddev-sans-first:3.17 22:27:04 INFO - PROCESS | 18398 | Values: 112.0 111.0 105.0 111.0 110.0 111.0 111.0 111.0 103.0 112.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:152.50 stddev:16.23 (10.6%) stddev-sans-first:17.15 22:27:04 INFO - PROCESS | 18398 | Values: 151.0 125.0 157.0 167.0 129.0 152.0 153.0 134.0 170.0 130.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.58 (1.0%) stddev-sans-first:1.67 22:27:04 INFO - PROCESS | 18398 | Values: 162.0 162.0 161.0 160.0 161.0 165.0 162.0 160.0 160.0 163.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#3] audio-fft Cycles:10 Average:80.70 Median:82.00 stddev:11.67 (14.2%) stddev-sans-first:11.95 22:27:04 INFO - PROCESS | 18398 | Values: 72.0 72.0 91.0 95.0 72.0 71.0 71.0 99.0 91.0 73.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:96.00 stddev:19.67 (20.5%) stddev-sans-first:20.37 22:27:04 INFO - PROCESS | 18398 | Values: 96.0 96.0 136.0 97.0 96.0 95.0 139.0 96.0 96.0 135.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:27:04 INFO - PROCESS | 18398 | Values: 109.0 110.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 22:27:04 INFO - PROCESS | 18398 | Values: 145.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 22:27:04 INFO - PROCESS | 18398 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:2.41 (4.2%) stddev-sans-first:2.35 22:27:04 INFO - PROCESS | 18398 | Values: 60.0 56.0 57.0 57.0 56.0 57.0 56.0 55.0 63.0 56.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 22:27:04 INFO - PROCESS | 18398 | Values: 68.0 69.0 68.0 69.0 69.0 68.0 70.0 69.0 69.0 69.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:3.66 (4.4%) stddev-sans-first:3.76 22:27:04 INFO - PROCESS | 18398 | Values: 81.0 88.0 81.0 83.0 92.0 81.0 84.0 83.0 81.0 82.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:121.00 stddev:5.48 (4.5%) stddev-sans-first:5.79 22:27:04 INFO - PROCESS | 18398 | Values: 118.0 122.0 114.0 115.0 115.0 113.0 128.0 121.0 128.0 121.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.90 Median:141.00 stddev:7.80 (5.5%) stddev-sans-first:8.26 22:27:04 INFO - PROCESS | 18398 | Values: 141.0 158.0 132.0 139.0 141.0 129.0 143.0 141.0 140.0 135.0 22:27:04 INFO - PROCESS | 18398 | 22:27:04 INFO - PROCESS | 18398 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.83 (2.7%) stddev-sans-first:1.92 22:27:04 INFO - PROCESS | 18398 | Values: 68.0 69.0 71.0 67.0 66.0 68.0 67.0 65.0 67.0 65.0 22:27:04 INFO - PROCESS | 18398 | -------- Summary: end -------- 22:27:04 INFO - PROCESS | 18398 | 22:27:05 INFO - TEST-INFO | 18398: exit 0 22:27:05 INFO - TEST-OK | kraken | took 58774ms 22:27:05 INFO - TEST-START | v8_7 22:27:05 INFO - operating with platform_type : linux_ 22:27:05 INFO - Initialising browser for v8_7 test... 22:27:05 INFO - TEST-INFO | started process 18652 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp02MW_m/profile http://localhost:49760/getInfo.html) 22:27:09 INFO - PROCESS | 18652 | __metrics Screen width/height:1600/1200 22:27:09 INFO - PROCESS | 18652 | colorDepth:24 22:27:09 INFO - PROCESS | 18652 | Browser inner width/height: 1024/697 22:27:09 INFO - PROCESS | 18652 | __metrics 22:27:09 INFO - PROCESS | 18652 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:27:09 INFO - PROCESS | 18652 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:27:10 INFO - TEST-INFO | 18652: exit 0 22:27:10 INFO - Browser initialized. 22:27:10 INFO - Running cycle 1/1 for v8_7 test... 22:27:10 INFO - TEST-INFO | started process 18735 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp02MW_m/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:27:22 INFO - PROCESS | 18735 | RSS: Main: 149852160 22:27:22 INFO - PROCESS | 18735 | 22:27:44 INFO - PROCESS | 18735 | Cycle 1(1): loaded http://localhost:49760/tests/v8_7/run.html (next: http://localhost:49760/tests/v8_7/run.html) 22:27:45 INFO - PROCESS | 18735 | RSS: Main: 596033536 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - PROCESS | 18735 | __start_tp_report 22:27:45 INFO - PROCESS | 18735 | _x_x_mozilla_page_load 22:27:45 INFO - PROCESS | 18735 | _x_x_mozilla_page_load_details 22:27:45 INFO - PROCESS | 18735 | |i|pagename|runs| 22:27:45 INFO - PROCESS | 18735 | |0;Richards;171.73278378842522 22:27:45 INFO - PROCESS | 18735 | |1;DeltaBlue;188.43037497644622 22:27:45 INFO - PROCESS | 18735 | |2;Encrypt;279.2516056967328 22:27:45 INFO - PROCESS | 18735 | |3;Decrypt;5202.072538860104 22:27:45 INFO - PROCESS | 18735 | |4;RayTrace;1103.638368246968 22:27:45 INFO - PROCESS | 18735 | |5;Earley;787.5688434303698 22:27:45 INFO - PROCESS | 18735 | |6;Boyer;12353.658536585366 22:27:45 INFO - PROCESS | 18735 | |7;RegExp;42520.833333333336 22:27:45 INFO - PROCESS | 18735 | |8;Splay;583.4305717619603 22:27:45 INFO - PROCESS | 18735 | |9;NavierStokes;4887.804878048781 22:27:45 INFO - PROCESS | 18735 | __end_tp_report 22:27:45 INFO - PROCESS | 18735 | __startTimestamp1453012065079__endTimestamp 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - PROCESS | 18735 | ------- Summary: start ------- 22:27:45 INFO - PROCESS | 18735 | Number of tests: 10 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - PROCESS | 18735 | [#0] Richards Cycles:1 Average:171.73 Median:171.73 stddev:0.00 (0.0%) 22:27:45 INFO - PROCESS | 18735 | Values: 171.7 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - PROCESS | 18735 | [#1] DeltaBlue Cycles:1 Average:188.43 Median:188.43 stddev:0.00 (0.0%) 22:27:45 INFO - PROCESS | 18735 | Values: 188.4 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - PROCESS | 18735 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 22:27:45 INFO - PROCESS | 18735 | Values: 279.3 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - PROCESS | 18735 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 22:27:45 INFO - PROCESS | 18735 | Values: 5202.1 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - PROCESS | 18735 | [#4] RayTrace Cycles:1 Average:1103.64 Median:1103.64 stddev:0.00 (0.0%) 22:27:45 INFO - PROCESS | 18735 | Values: 1103.6 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - PROCESS | 18735 | [#5] Earley Cycles:1 Average:787.57 Median:787.57 stddev:0.00 (0.0%) 22:27:45 INFO - PROCESS | 18735 | Values: 787.6 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - PROCESS | 18735 | [#6] Boyer Cycles:1 Average:12353.66 Median:12353.66 stddev:0.00 (0.0%) 22:27:45 INFO - PROCESS | 18735 | Values: 12353.7 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - PROCESS | 18735 | [#7] RegExp Cycles:1 Average:42520.83 Median:42520.83 stddev:0.00 (0.0%) 22:27:45 INFO - PROCESS | 18735 | Values: 42520.8 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - PROCESS | 18735 | [#8] Splay Cycles:1 Average:583.43 Median:583.43 stddev:0.00 (0.0%) 22:27:45 INFO - PROCESS | 18735 | Values: 583.4 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - PROCESS | 18735 | [#9] NavierStokes Cycles:1 Average:4887.80 Median:4887.80 stddev:0.00 (0.0%) 22:27:45 INFO - PROCESS | 18735 | Values: 4887.8 22:27:45 INFO - PROCESS | 18735 | -------- Summary: end -------- 22:27:45 INFO - PROCESS | 18735 | 22:27:45 INFO - TEST-INFO | 18735: exit 0 22:27:45 INFO - TEST-OK | v8_7 | took 40477ms 22:27:45 INFO - SUITE-END | took 1212s 22:27:46 INFO - Completed test suite (00:20:12) 22:27:46 INFO - Working with test: dromaeo_css 22:27:46 INFO - Generating results file: dromaeo_css 22:27:46 INFO - Working with test: kraken 22:27:46 INFO - Generating results file: kraken 22:27:46 INFO - javascript benchmark 22:27:46 INFO - Working with test: v8_7 22:27:46 INFO - Generating results file: v8_7 22:27:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:27:46 INFO - process_Request line: dromaeo_css 6728.86 graph.html#tests=[[72,63,35]] 22:27:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:46 INFO - process_Request line: kraken 1494.30 graph.html#tests=[[232,63,35]] 22:27:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:46 INFO - process_Request line: v8_7 20019.60 graph.html#tests=[[230,63,35]] 22:27:46 INFO - RETURN: dromaeo_css: 6728.86 22:27:46 INFO - RETURN: kraken: 1494.30 22:27:46 INFO - RETURN: v8_7: 20019.60 22:27:46 INFO - javascript benchmark 22:27:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3112.517559778234, 3122.609673790776, 3165.256164801271, 3171.191346206718, 3190.7128358447744, 5038.924416133752, 5086.262491938672, 5091.745412729368, 5102.438731739506, 5117.565006974407, 5084.262781896623, 5128.051310507559, 5135.486451354872, 5150.1244788385975, 5175.223716442535, 4628.30575413689, 4654.767261636922, 4704.106219818241, 4784.688995215317, 4799.160146974283, 4710.3641008463765, 4727.054589082198, 4757.738324392157, 4809.422869255677, 4841.176999910006, 4474.7762611869275, 4631.397918270637, 4645.349651048856, 4659.7204167749705, 4701.999999999983, 4619.237825758746, 4644.651651126179, 4664.976675116603, 4685.554872287127, 4702.012577358759, 4547.090581883636, 4628.953710462886, 4633.698809577367, 4656.348111264426, 4659.860204193879, 4899.926501102486, 4905.2151655734915, 4960.2559616057515, 4961.751912404366, 4962.1812400953795, 5497.340319161726, 5513.50378465936, 5515.889682206373, 5516.310461192351, 5526.668399896019, 5413.485718856702, 5493.725313734337, 5540.196671482653, 5556.16657501374, 5567.081431563787, 5068.645194836363, 5083.542481176712, 5106.310648062538, 5122.257272695439, 5147.819826306061, 5518.586106042063, 5533.3083364579425, 5556.499915007668, 5567.721613919369, 5579.972100139474, 5280.20796880471, 5297.337832770903, 5300.628955973122, 5306.310179676694, 5353.652012619245, 5356.5179133877355, 5368.087425137736, 5385.407605163429, 5386.461353864583, 5436.483534064258, 5410.08028635133, 5435.891282174413, 5436.809711660073, 5437.972810135924, 5445.891082178334, 5295.814646487354, 5370.0, 5391.299131113009, 5439.864003399867, 5474.507294343528, 4201.579842015835, 4288.378185163134, 4294.0767734937135, 4325.2214601371425, 4327.697061205686, 3843.442700808367, 3848.3457812171996, 3851.6340947609933, 3853.5761066282685, 3892.6107389260847, 4929.457759646436, 4992.176290911959, 4995.550400463976, 5088.465711100355, 5133.383993920754, 5378.381486129145, 5421.783128674809, 5455.345358556999, 5468.37113731918, 5513.476219759116, 5075.264086707481, 5104.259882317043, 5113.1052065888325, 5114.590832733373, 5160.380754309507, 4660.720356778605, 4672.859814205579, 4708.976455117771, 4716.1510928033285, 4717.834875779331, 5689.487946084955, 5696.3733989261145, 5720.599558030981, 5729.455701708331, 5751.798687045934, 5519.475649813261, 5522.751476183501, 5524.281843360337, 5525.060739674184, 5528.44715528444, 5612.663240205601, 5621.971890140687, 5632.971835140798, 5657.745401457027, 5692.51613612831, 5401.378841433286, 5402.324709411324, 5405.621606487508, 5415.756290966837, 5456.154296084113, 5403.378611459732, 5441.673499590037, 5455.536279416294, 5487.067198576172, 5562.276904002454, 5176.741162941913, 5177.068127737043, 5222.503862133091, 5347.652402593819, 5359.678419294854, 5286.15421532553, 5296.04671159195, 5298.15229563268, 5301.231321458444, 5364.222187782671, 5164.9741751291, 5204.427512973494, 5211.354902689972, 5212.0, 5274.657147285414, 5242.292290540729, 5319.547838433622, 5334.626576139633, 5335.893282134258, 5379.193121031876, 5206.323177986837, 5254.133068043883, 5257.369115706139, 5261.421243663118, 5341.0], "unit": "score", "name": "dojo.html", "value": 5042.696029705741}, {"lowerIsBetter": false, "replicates": [531.5800517591103, 532.3292651259413, 537.9166229234468, 554.0885243773993, 559.9916001259979, 28044.85977570112, 28335.149945501667, 28426.289342766442, 28482.003129890483, 28503.28741781454, 29343.706562934363, 36649.81675091621, 37333.0, 37342.43986340207, 37354.0, 8441.704540341088, 8602.526861022641, 8604.569771511431, 8615.483071015758, 8615.612297446598, 8334.70828521002, 8449.831003379928, 8456.365772567051, 8458.407911446202, 8472.237498625123, 8419.115992820758, 8499.787505312355, 8516.0, 8518.829623407528, 8623.223909848113, 8549.187827156411, 8612.267957223612, 8615.526146061964, 8626.784330391727, 8627.568621568958, 8597.269232115277, 8695.217430431292, 8714.477131372138, 8715.912840871573, 8718.0, 39371.65340946023, 39628.60371396278, 39738.20523589541, 39763.801180994196, 39793.40309895325, 3146.1505393543616, 3180.4275230458506, 3287.227501537137, 3374.8481318340487, 3556.928861422783, 29543.409131817458, 29777.70222297771, 30096.369885774835, 30685.693143068507, 31044.689553104407, 3984.3625019996953, 4021.2560676274984, 4036.9394459083137, 4091.365838295069, 4100.712950093494, 261751.0, 262504.0, 262618.0, 263251.0, 263958.9999999981, 52648.0, 53850.46149538533, 57945.42054579485, 58425.0, 61016.38983610196, 59644.0, 59787.0, 60352.0, 60420.39579604236, 60493.395066049656, 15378.38486460529, 15555.688886222211, 15570.688586228212, 15582.376704931903, 15620.76568851468, 10257.846132308021, 10787.892121078688, 10831.187660925461, 11712.180147389772, 12441.440135193758, 19503.317383891495, 19507.414777556412, 19587.0, 19598.608027839364, 19631.705524417146, 7032.613206273704, 7080.150381954096, 7171.282871712891, 7188.353048225685, 7326.9267307326245, 876.7851876290222, 905.9592318345558, 962.0860182826343, 1073.5330131392868, 1119.7200699825044, 27272.181834544994, 28010.0, 28788.42423151525, 28858.855705721337, 29030.854845725637, 851.9914800852036, 1003.247564326755, 1048.2609760119099, 1084.6420681175193, 1145.3414286785132, 14681.192534410497, 15355.0, 15613.219339033003, 15640.92179539095, 15655.0, 336336.0, 345545.0, 346616.0, 346856.0, 347263.0, 51809.0, 51860.22209666858, 52041.21938170931, 52245.477545224065, 52257.216141757905, 1311.1936159261986, 1336.8128462015325, 1339.7789364754706, 1346.8720471555382, 1350.5340657473157, 28325.0, 29107.126786196448, 29458.705412946452, 29840.10479685613, 29934.401311974074, 46190.0, 46407.535924640324, 46502.76748616235, 46591.767041164574, 46656.7667161662, 305056.0, 310097.0, 311041.0, 370420.0, 375922.0, 29628.111156665334, 29643.849861019044, 29655.703442965296, 29963.85018074983, 30039.549406759354, 39355.0, 40107.59892401039, 40110.1977960445, 40849.1830163401, 40950.59049409587, 34134.317313654086, 34323.14192145217, 34443.827780860935, 34512.82743586266, 34963.0, 29469.410611788073, 33766.831165844014, 35491.82254088713, 35515.82242088773, 36296.45555316725, 32184.517232242004, 32243.0, 32458.837705812264, 32488.35023299568, 32507.837460812545, 29857.402851943272, 30258.725507784427, 35200.471992919614, 35349.0, 35363.46954795731, 24089.156879509133, 24232.515349692556, 24320.635190472512, 24503.387415314046, 24728.505429891662], "unit": "score", "name": "ext.html", "value": 18015.48389741955}, {"lowerIsBetter": false, "replicates": [360.13926715150785, 364.2441932989047, 365.92315613721115, 369.1951545630526, 372.3799873211104, 13501.864981350183, 13943.442262309496, 15797.842021579781, 17221.22504487298, 18348.908255458722, 15555.0, 15968.361265549363, 16513.587160320996, 16786.0, 16799.916000420013, 4890.193118135512, 5066.74666266687, 5073.619478539106, 5073.7209453480045, 5076.187809950408, 3721.1999420124666, 3820.5797362290127, 4998.875028124307, 5307.973460132694, 5494.09347457671, 5446.101393270105, 5467.0, 5467.097928841737, 5492.258545096401, 5569.331680198382, 5944.7324870380935, 5971.5222782177325, 5991.7902873399225, 6003.489703375219, 6005.039193728982, 5176.663516871429, 5302.363716354023, 5384.865378365572, 5385.138377859563, 5389.757460914268, 19351.322703705304, 19476.4157075288, 20000.299989500298, 20006.69989950152, 20019.0, 1918.3381733301987, 2066.700328452381, 2074.7199128117813, 2429.3197904586746, 2708.052181736396, 9835.606575736962, 10369.896301037044, 12185.695357616041, 12598.874011259953, 12869.935650321688, 1781.750554922312, 1836.494963884929, 1841.383136649224, 1854.7310639957132, 1859.9349022784272, 56314.43685563174, 57780.422195778345, 58082.70958645222, 58313.12530312049, 59571.70214148902, 9656.22750179998, 9892.752681183028, 10074.546645400975, 10082.848757268646, 10146.441945693057, 13256.0, 13307.467701292033, 13322.933385333012, 13349.132306400053, 13375.0, 7470.775876723707, 7542.208068152875, 7552.773416797505, 7629.771106866803, 7630.580318082559, 7160.641967901584, 7216.134063912364, 7248.891266631004, 7277.2358902315555, 7316.670749816271, 4032.919341613151, 4362.9781851091175, 4366.061296821199, 4379.759113248802, 4399.032212913154, 1720.3720641965842, 1759.727242277449, 1784.5360206346184, 1816.6366726654721, 1837.7243413488084, 895.2837729816121, 896.2964073202505, 926.5413620257881, 1014.9238807089498, 1035.1304903880775, 13956.441742330397, 14930.626734331729, 15353.846461535464, 15692.529224123295, 15816.209189540477, 852.3820230333083, 871.0418539606383, 894.3784070071238, 900.0279697926223, 921.5254144115786, 7948.364130869517, 8861.822763544822, 9321.673741419017, 9390.577424015935, 9453.149216570542, 391895.0, 400787.0, 411957.0, 413554.0, 571416.0, 75155.62422187964, 75543.62228188934, 75717.62141189259, 76110.0, 79175.0, 1078.44460103047, 1123.2025262063862, 1124.8650161980452, 1128.6501184632791, 1129.3054771315747, 13991.930040349733, 14525.636859078608, 15044.924775376054, 15260.389584416498, 15318.617034574225, 32375.67624323821, 33279.0, 34011.4898276531, 34142.82928585341, 34382.65617343794, 37590.0, 37600.2479950394, 38819.417708733825, 39644.0, 40646.39030414487, 6929.133858267716, 7308.634568271672, 7385.335319821242, 7435.442341824277, 7460.0674915635545, 9546.713598592054, 10619.628313009007, 10803.783924321313, 10862.293950893167, 11538.94230528842, 9452.527373631154, 9535.189508891823, 9630.903690963001, 9741.951290243504, 9831.557579908778, 9343.579538920902, 9479.194268487256, 9565.856512152184, 9746.561404736662, 9841.409515429097, 9632.27757918173, 9716.0, 9841.950790246003, 9930.25523085786, 10087.848682269625, 7382.4094072475145, 7392.4086073115095, 7405.703771849066, 7469.215732348242, 7566.0, 7533.962330188314, 8019.719309824128, 9209.17117459432, 9600.183984361129, 9839.065288797552], "unit": "score", "name": "jquery.html", "value": 8079.876129270325}, {"lowerIsBetter": false, "replicates": [1332.1008319384414, 1456.963575910602, 1465.8460861609535, 1609.7665838453424, 1780.3679693708732, 6896.172459304884, 7551.433642476809, 7696.114946781122, 7705.422093343001, 7713.190115037924, 7459.291367320109, 7642.770716878488, 7644.732434364799, 7647.541147531138, 7653.19641437648, 1957.50083728649, 2000.8599398042143, 2002.6495363311362, 2283.908643654252, 2311.768823117683, 2013.436237853396, 2299.5515874404496, 2338.5556744218543, 2343.261872510154, 2346.9882650586724, 2267.4784799496124, 2291.2667946257206, 2300.5858945389823, 2302.067662596651, 2326.1858349577597, 2252.1329288223988, 2284.132029828663, 2287.748347681754, 2292.266474728079, 2295.276987748862, 2286.7941885230407, 2294.529621427603, 2295.2425699519117, 2296.552172326397, 2307.4692820651344, 7605.087389513238, 7685.462017658766, 7754.1470438251745, 7761.068671759369, 7765.495242809199, 4699.201135806921, 4781.545753153445, 4830.420349558076, 4860.198067318888, 4862.051899879525, 3079.9538006929915, 3125.4374212641715, 3210.7752457327997, 3245.464498357768, 3264.1186879542392, 1065.536491626145, 1099.912007039435, 1124.9775004499863, 1141.9429028548623, 1163.9592614258545, 10563.26057175998, 10581.947090264577, 10593.25847190697, 10622.628208012682, 10629.5216715248, 4265.722728022669, 4321.956780432219, 4363.345498175299, 4383.232934236496, 4394.934075988863, 9145.314101442418, 9152.359334846496, 9152.816943661222, 9159.038300978435, 9172.954135229415, 4796.040791841646, 4837.69382266786, 4852.223644216909, 4854.101991131652, 4861.29511220871, 4384.539623339567, 4405.977970110193, 4415.0, 4430.889227769267, 4439.489458712224, 3411.4712219606, 3474.1314671332166, 3720.7581507201944, 3777.0, 3826.0626146594263, 1207.3299318878107, 1212.3695678247261, 1224.871388504212, 1230.2065167966612, 1247.607003793802, 1246.8628450870397, 1257.1639859493516, 1273.2233337664018, 1315.2371624457792, 1315.6579289384638, 7115.359617634334, 7124.893126603105, 7310.634468276565, 7450.925490745023, 7454.589997550078, 1097.5554900265406, 1099.6426161497545, 1102.4763237462141, 1112.8942750438696, 1115.5816568786704, 5784.82645520635, 5820.941790582125, 5836.708164591753, 5838.095095260242, 5848.064309710511, 9082.954585227031, 9150.40522366044, 9437.970836270097, 9522.476263805418, 9534.046595340411, 9321.254299656011, 9372.5313734313, 9438.905610943802, 9473.810523789623, 9583.329166958247, 7167.211606723256, 7312.305330993547, 7312.707491700379, 7323.194448610755, 7326.084239470067, 7116.928830711627, 7146.892796608159, 7163.570185788869, 7164.426845852424, 7173.820654483471, 8057.113717491188, 8370.246677799027, 8371.748847534584, 8484.533350665773, 8597.699080532151, 8595.44129631572, 8794.780130496789, 8839.955800220958, 8841.0, 8854.0, 6535.248446428532, 6686.83282917931, 6704.161979752531, 6733.225679046972, 6772.0, 6473.320301368289, 6620.271770105188, 7007.913773365137, 7281.9441181029515, 7320.26797320285, 6909.654517274015, 6957.686904089227, 6974.6512674367095, 7087.22040575526, 7089.326513981164, 6863.279355667583, 6893.965530172518, 6947.826304342432, 7040.0847889774, 7083.787486375417, 7070.939359096176, 7094.893576596252, 7122.0, 7126.964365178141, 7135.928640713526, 6286.057091436322, 6317.5893566918, 6327.557071004985, 6378.234611846423, 6397.488200943821, 6526.086347911201, 6561.048647946117, 6572.671366431755, 6572.76995305162, 6579.80260592183], "unit": "score", "name": "mootools.html", "value": 4513.871572626208}, {"lowerIsBetter": false, "replicates": [325.201629998354, 333.49975037443835, 336.13780652626014, 337.70450855501434, 346.33330838136595, 5655.830325090244, 5798.39116892726, 5833.037548804447, 5836.270466191731, 5867.823965281038, 5630.605857589971, 5747.023006088964, 5748.971255143729, 5750.3962083981105, 5805.941940580593, 4502.662300327472, 4504.0766642838225, 4537.523560026199, 4548.272276435771, 4551.5676010778925, 4330.307150855863, 4419.094085712437, 4455.933161002587, 4510.278355463127, 4528.230200865861, 4435.711678740888, 4450.799714012877, 4455.821767129327, 4462.308342206963, 4462.97768511157, 4459.041306119184, 4515.254982927846, 4528.139653465847, 4528.818847246106, 4529.297958816389, 3986.720929534934, 3991.481107456012, 3991.720579559432, 3993.9600603993877, 3994.141259629165, 5401.675899446007, 5554.583406244547, 5559.33288005442, 5572.832815015556, 5594.9720251398885, 5117.078925793356, 5118.769655365518, 5119.948800511985, 5129.358830146231, 5135.075686376451, 5882.911756323659, 6160.5687601867885, 6220.502359811204, 6220.564560480768, 6224.439800417938, 4166.437530933345, 4202.789860506962, 4233.280342341778, 4235.9364609530885, 4245.490541135053, 6331.715072821688, 6422.165118534561, 6428.582142160744, 6432.807015789534, 6440.484761219138, 4381.67137464685, 4388.648908087345, 4392.297232442794, 4393.780310984438, 4408.801603927831, 4317.266064768997, 4426.468823741172, 4445.310976798602, 4445.933311000337, 4461.420015397977, 5157.793688252428, 5163.66436181647, 5178.326817513775, 5181.5077567631015, 5182.067227899014, 6195.690215489208, 6202.100695399142, 6208.1308616793685, 6210.9068363974575, 6211.875762484725, 1535.7005383950022, 1569.238919124224, 1569.3173469540786, 1571.5521076493144, 1571.5756745678832, 1049.354646892171, 1050.3855244681795, 1056.8361903904906, 1059.057438879398, 1081.7025318037602, 5863.237779088691, 5868.149118377897, 5869.295684517885, 5879.823605291848, 5883.264591926009, 6368.14030105939, 6371.426571608577, 6377.426031657174, 6378.6810659467765, 6384.968075159687, 5862.677552734641, 5863.413658634103, 5866.765329386777, 5866.823995280149, 5872.119182122716, 3287.161773747727, 3435.038189306998, 3435.587729472429, 3436.055084851636, 3439.1917899293644, 6597.670116494156, 6602.933970660232, 6604.240512341046, 6606.768763093269, 6610.933890661128, 6519.445847102955, 6526.477881769447, 6537.607743535308, 6546.967265163644, 6549.377809108127, 6440.098386225932, 6588.341165883373, 6667.333266673294, 6676.6995485202315, 6683.5989840608745, 6181.227346581677, 6331.873362532631, 6434.453071488976, 6435.388638079375, 6445.486260358371, 6154.922888494406, 6263.843403914939, 6269.059641053696, 6272.937270627235, 6348.809535713936, 6629.569078009914, 6640.767573134917, 6658.467322614082, 6669.1330127083165, 6672.132622759011, 4408.118376324684, 4462.866114016585, 4488.057507923372, 4489.214387482112, 4489.775511224491, 6384.329645387167, 6387.041943708481, 6388.552801303864, 6388.64862432552, 6388.840278992877, 6214.130021797043, 6215.96892015537, 6217.533684973555, 6219.875602488016, 6219.968900155471, 6037.547183961133, 6181.289151747606, 6189.876202476015, 6195.535334849995, 6195.659238741732, 6118.418750218722, 6127.8468038297615, 6135.325114237341, 6137.8465538360115, 6140.539459540463, 6272.843178920563, 6283.057541368831, 6285.277193122849, 6286.654234017173, 6287.2769631492965, 5863.912041319299, 6069.150318955261, 6077.6353418795015, 6078.57449978515, 6081.179040829431], "unit": "score", "name": "prototype.html", "value": 4672.20057257208}, {"lowerIsBetter": false, "replicates": [733.29237286019, 785.670018592191, 787.1970589998202, 808.8422757562271, 822.7038266224158, 12687.175333603322, 12883.871161288384, 12904.161229520098, 12916.806247906265, 12952.611421657342, 12054.216475929059, 12073.698157546065, 12115.636530904065, 12122.393880305972, 12136.817947730791, 650.6193876582205, 663.230652443166, 664.4551467796409, 665.17518277336, 665.8401983523968, 792.7463211772235, 804.0391731880405, 808.9838203235931, 810.8256724804166, 810.8945837041206, 839.4082172068677, 849.6516428264413, 850.5832142250284, 851.7615067781, 852.0371979662972, 682.2256738601698, 690.3441730356182, 690.8272931767058, 691.1567887177636, 836.8117173635944, 505.9392872855244, 615.3047056825803, 624.9937500624981, 626.8746250749869, 627.4447114303829, 12480.0, 12530.498780048787, 12562.623121306375, 12564.183328083736, 12590.937045314806, 12155.270683758914, 12567.748645027139, 12577.0, 12655.177413468095, 13001.414936327888, 9444.669436569755, 9457.952710236474, 9525.428474291495, 9639.325247232697, 9992.600295988224, 3556.466530020492, 3565.5899571549344, 3580.427131658922, 3616.692581130607, 3630.110622897407, 46149.30776038362, 46169.76915115403, 46233.30650040252, 46373.768131159464, 46424.303635445496, 9612.279079069098, 9781.657641982496, 9860.112589866947, 9904.801903961881, 10019.949900250453, 16395.262213200436, 16483.58791030234, 16551.172441377883, 16555.751663725056, 16557.089360085312, 7359.448041396917, 7435.256474352522, 7530.28462296081, 7539.811504712426, 7562.584057876869, 4217.093324935154, 4246.72396294246, 4327.6110497675345, 4332.978335108304, 4349.934750978738, 2997.3256017396347, 3016.155476466593, 3019.0, 3025.2588115911744, 3066.7546596272246, 590.7873165660445, 601.1283638723868, 601.3895895665903, 604.3322129047427, 605.7940300297831, 456.72596442134454, 498.6534358620724, 507.50771751401084, 534.3187436019107, 598.2133494454778, 8260.463069900437, 8968.955155224312, 9200.263978881674, 9208.769780755534, 9325.160735533835, 471.32365056144545, 552.2434265056818, 579.3800633322305, 652.1424327009967, 662.1557514169473, 3661.688756455678, 3844.7308688391545, 3847.9230415392094, 3875.6318149775725, 4031.496062992126, 49701.25448118281, 53742.19386709203, 53805.1929221062, 53819.0, 53904.46095538994, 46004.0, 47752.76123619429, 47811.9999999993, 48005.75997119992, 48040.0, 41845.79077104656, 42536.0, 42604.57395426068, 42914.35628465513, 42954.355684664755, 7958.522488650699, 8084.474509156886, 8234.176582341717, 8388.748337549883, 8494.154458256306, 31801.5229771549, 31871.52192717065, 32060.67939320577, 32123.839380802947, 32208.0, 38457.4231386535, 40580.30424979845, 41216.79391603023, 45149.32276015928, 45718.314225287315, 10895.618653347412, 11000.0, 11267.436628168723, 11296.548138074713, 11524.810286045624, 10689.839652405375, 11633.53465861356, 12087.516499339928, 12397.690057748629, 12530.812037819622, 9825.115739583473, 10081.193504519475, 10115.241356898408, 11342.546298147981, 11624.360660163773, 10476.63331783384, 10922.344659320466, 11015.118790496901, 11269.66191014271, 11386.772264554496, 9911.603535858485, 10139.290249682452, 10308.845367319345, 10402.115820155372, 10545.578176873147, 9042.593083311136, 9190.0, 9251.722448326562, 9385.343025988115, 9629.807403852024, 9112.726618201465, 9128.726138215865, 9317.86023209639, 9574.856377154209, 9735.80528389414], "unit": "score", "name": "yui.html", "value": 5995.527722349598}], "name": "dromaeo_css", "value": 6728.862277600807}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 105.0, 111.0, 110.0, 111.0, 111.0, 111.0, 103.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [151.0, 125.0, 157.0, 167.0, 129.0, 152.0, 153.0, 134.0, 170.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 161.0, 165.0, 162.0, 160.0, 160.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 91.0, 95.0, 72.0, 71.0, 71.0, 99.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 136.0, 97.0, 96.0, 95.0, 139.0, 96.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [60.0, 56.0, 57.0, 57.0, 56.0, 57.0, 56.0, 55.0, 63.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 70.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [81.0, 88.0, 81.0, 83.0, 92.0, 81.0, 84.0, 83.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [118.0, 122.0, 114.0, 115.0, 115.0, 113.0, 128.0, 121.0, 128.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [141.0, 158.0, 132.0, 139.0, 141.0, 129.0, 143.0, 141.0, 140.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 71.0, 67.0, 66.0, 68.0, 67.0, 65.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1494.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.73278378842522], "unit": "score", "name": "Richards", "value": 205.5635459999999}, {"lowerIsBetter": false, "replicates": [188.43037497644622], "unit": "score", "name": "DeltaBlue", "value": 350.8882260000001}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1103.638368246968], "unit": "score", "name": "RayTrace", "value": 670.4995234765233}, {"lowerIsBetter": false, "replicates": [787.5688434303698], "unit": "score", "name": "Earley", "value": 846.228244755245}, {"lowerIsBetter": false, "replicates": [12353.658536585366], "unit": "score", "name": "Boyer", "value": 53.948633761105626}, {"lowerIsBetter": false, "replicates": [42520.833333333336], "unit": "score", "name": "RegExp", "value": 21.42443900048995}, {"lowerIsBetter": false, "replicates": [583.4305717619603], "unit": "score", "name": "Splay", "value": 139.67557399999995}, {"lowerIsBetter": false, "replicates": [4887.804878048781], "unit": "score", "name": "NavierStokes", "value": 303.61277445109783}], "name": "v8_7", "value": 20019.597815002657}]} 22:27:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20019.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1494.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6728.86"}}} 22:27:46 INFO - Return code: 0 22:27:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:27:46 INFO - # TBPL SUCCESS # 22:27:46 INFO - Running post-action listener: _resource_record_post_action 22:27:46 INFO - Running post-run listener: _resource_record_post_run 22:27:47 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 541863936; Read time: 0; Write time: 431952 22:27:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244158464; Read time: 0; Write time: 206472 22:27:47 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 297705472; Read time: 0; Write time: 225480 22:27:47 INFO - Running post-run listener: _upload_blobber_files 22:27:47 INFO - Blob upload gear active. 22:27:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:27:47 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 22:27:47 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:27:47 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:27:47 INFO - (blobuploader) - INFO - Open directory for files ... 22:27:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:27:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:27:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:48 INFO - (blobuploader) - INFO - Done attempting. 22:27:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:27:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:27:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:49 INFO - (blobuploader) - INFO - Done attempting. 22:27:49 INFO - (blobuploader) - INFO - Iteration through files over. 22:27:49 INFO - Return code: 0 22:27:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:27:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:27:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1fda04518ea6cdb41d8b4f82d73a5b63061464308bf1da9186d6f62576fb78663e441d4db74f11c5c583afbf154fd00f3c396d6a8c0798041fed5c4335ba4283", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2964c918bdfb412a1ee2bd903aa5f4c707f15686b7bc2960df2e36a5d2ff795da13a168fef454c140b8d9d6b7e52f8e3d3168e23322ca65698f5c23975207948"} 22:27:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:27:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:27:49 INFO - Contents: 22:27:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1fda04518ea6cdb41d8b4f82d73a5b63061464308bf1da9186d6f62576fb78663e441d4db74f11c5c583afbf154fd00f3c396d6a8c0798041fed5c4335ba4283", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2964c918bdfb412a1ee2bd903aa5f4c707f15686b7bc2960df2e36a5d2ff795da13a168fef454c140b8d9d6b7e52f8e3d3168e23322ca65698f5c23975207948"} 22:27:49 INFO - Running post-run listener: copy_logs_to_upload_dir 22:27:49 INFO - Copying logs to upload dir... 22:27:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:27:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1295.128756 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-01-16 22:27:48.873643) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-16 22:27:48.876958) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1fda04518ea6cdb41d8b4f82d73a5b63061464308bf1da9186d6f62576fb78663e441d4db74f11c5c583afbf154fd00f3c396d6a8c0798041fed5c4335ba4283", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2964c918bdfb412a1ee2bd903aa5f4c707f15686b7bc2960df2e36a5d2ff795da13a168fef454c140b8d9d6b7e52f8e3d3168e23322ca65698f5c23975207948"} build_url:https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/ZlkacnfsR0Cl8zg-zFi5Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1fda04518ea6cdb41d8b4f82d73a5b63061464308bf1da9186d6f62576fb78663e441d4db74f11c5c583afbf154fd00f3c396d6a8c0798041fed5c4335ba4283", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2964c918bdfb412a1ee2bd903aa5f4c707f15686b7bc2960df2e36a5d2ff795da13a168fef454c140b8d9d6b7e52f8e3d3168e23322ca65698f5c23975207948"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-16 22:27:48.906421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:27:48.907184) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453000422.96444-24887122 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 22:27:48.989204) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-16 22:27:48.989915) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-16 22:27:48.990257) ========= ========= Total master_lag: 0.34 =========