builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1453787953.84 results: success (0) buildid: 20160125193227 builduid: 1f0d16596bdd41aeba1e4b0ed05f1ec5 revision: 08f0995ef87370f56d8148dcdec0e74d3ab313f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:13.841664) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:13.842111) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:13.842454) ========= 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=8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006443 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:13.865868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:13.866187) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:13.879194) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:13.879554) ========= 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=8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:13.929281) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:13.929611) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:13.929999) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:13.930271) ========= 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=8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 21:59: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2016-01-25 21:59:14 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157854 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:14.100122) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:14.100413) ========= 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=8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021994 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:14.150331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 21:59:14.150694) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 08f0995ef87370f56d8148dcdec0e74d3ab313f6 --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 08f0995ef87370f56d8148dcdec0e74d3ab313f6 --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=8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 21:59:14,227 truncating revision to first 12 chars 2016-01-25 21:59:14,227 Setting DEBUG logging. 2016-01-25 21:59:14,227 attempt 1/10 2016-01-25 21:59:14,228 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/08f0995ef873?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 21:59:15,044 unpacking tar archive at: mozilla-inbound-08f0995ef873/testing/mozharness/ program finished with exit code 0 elapsedTime=1.164607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 21:59:15.329771) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:15.330083) ========= echo 08f0995ef87370f56d8148dcdec0e74d3ab313f6 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'08f0995ef87370f56d8148dcdec0e74d3ab313f6'] 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=8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08f0995ef87370f56d8148dcdec0e74d3ab313f6 program finished with exit code 0 elapsedTime=0.004074 script_repo_revision: '08f0995ef87370f56d8148dcdec0e74d3ab313f6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:15.380820) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:15.381112) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 21:59:15.391390) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-25 21:59:15.391666) ========= /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=8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:15 INFO - MultiFileLogger online at 20160125 21:59:15 in /builds/slave/test-pgo 21:59:15 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 21:59:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:59:15 INFO - {'append_to_log': False, 21:59:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:59:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:59:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:59:15 INFO - 'branch': 'Mozilla-Inbound', 21:59:15 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:15 INFO - 'config_files': ('talos/linux_config.py',), 21:59:15 INFO - 'default_actions': ('clobber', 21:59:15 INFO - 'read-buildbot-config', 21:59:15 INFO - 'download-and-extract', 21:59:15 INFO - 'populate-webroot', 21:59:15 INFO - 'create-virtualenv', 21:59:15 INFO - 'install', 21:59:15 INFO - 'run-tests'), 21:59:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:15 INFO - 'download_minidump_stackwalk': True, 21:59:15 INFO - 'download_symbols': 'ondemand', 21:59:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:15 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:15 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:15 INFO - 'installer_path': 'installer.exe', 21:59:15 INFO - 'log_level': 'info', 21:59:15 INFO - 'log_name': 'talos', 21:59:15 INFO - 'log_to_console': True, 21:59:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:15 INFO - 'opt_config_files': (), 21:59:15 INFO - 'pip_index': False, 21:59:15 INFO - 'sps_profile': False, 21:59:15 INFO - 'sps_profile_interval': 0, 21:59:15 INFO - 'suite': 'dromaeojs', 21:59:15 INFO - 'system_bits': '32', 21:59:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:15 INFO - 'title': 'talos-linux64-ix-038', 21:59:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:15 INFO - 'use_talos_json': True, 21:59:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:59:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:15 INFO - 'work_dir': 'build'} 21:59:15 INFO - ##### 21:59:15 INFO - ##### Running clobber step. 21:59:15 INFO - ##### 21:59:15 INFO - Running pre-action listener: _resource_record_pre_action 21:59:15 INFO - Running main action method: clobber 21:59:15 INFO - rmtree: /builds/slave/test-pgo/build 21:59:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:59:16 INFO - Running post-action listener: _resource_record_post_action 21:59:16 INFO - ##### 21:59:16 INFO - ##### Running read-buildbot-config step. 21:59:16 INFO - ##### 21:59:16 INFO - Running pre-action listener: _resource_record_pre_action 21:59:16 INFO - Running main action method: read_buildbot_config 21:59:16 INFO - Using buildbot properties: 21:59:16 INFO - { 21:59:16 INFO - "project": "", 21:59:16 INFO - "product": "firefox", 21:59:16 INFO - "script_repo_revision": "production", 21:59:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:59:16 INFO - "repository": "", 21:59:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:59:16 INFO - "buildid": "20160125193227", 21:59:16 INFO - "pgo_build": "True", 21:59:16 INFO - "basedir": "/builds/slave/test-pgo", 21:59:16 INFO - "buildnumber": 673, 21:59:16 INFO - "slavename": "talos-linux64-ix-038", 21:59:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:59:16 INFO - "platform": "ubuntu64_hw", 21:59:16 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:59:16 INFO - "branch": "mozilla-inbound", 21:59:16 INFO - "repo_path": "integration/mozilla-inbound", 21:59:16 INFO - "revision": "08f0995ef87370f56d8148dcdec0e74d3ab313f6", 21:59:16 INFO - "stage_platform": "linux64-pgo", 21:59:16 INFO - "builduid": "1f0d16596bdd41aeba1e4b0ed05f1ec5", 21:59:16 INFO - "slavebuilddir": "test" 21:59:16 INFO - } 21:59:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 21:59:16 INFO - Running post-action listener: _resource_record_post_action 21:59:16 INFO - ##### 21:59:16 INFO - ##### Running download-and-extract step. 21:59:16 INFO - ##### 21:59:16 INFO - Running pre-action listener: _resource_record_pre_action 21:59:16 INFO - Running main action method: download_and_extract 21:59:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:16 INFO - https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:59:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/test_packages.json 21:59:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/test_packages.json 21:59:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:59:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:59:17 INFO - Downloaded 1448 bytes. 21:59:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:59:17 INFO - Using the following test package requirements: 21:59:17 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:17 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:59:17 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:59:17 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:17 INFO - u'jsshell-linux-x86_64.zip'], 21:59:17 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:59:17 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:17 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:59:17 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:59:17 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:59:17 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:17 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:59:17 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:59:17 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')]} 21:59:17 INFO - https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:18 INFO - Downloaded 22501430 bytes. 21:59:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:19 INFO - Return code: 0 21:59:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:59:19 INFO - https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:29 INFO - Downloaded 22501430 bytes. 21:59:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:30 INFO - Return code: 0 21:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:59:30 INFO - https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:59:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:59:31 INFO - Downloaded 10706572 bytes. 21:59:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:31 INFO - Return code: 0 21:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:31 INFO - https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:59:32 INFO - Downloaded 55988105 bytes. 21:59:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:32 INFO - mkdir: /builds/slave/test-pgo/properties 21:59:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:59:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:59:32 INFO - Contents: 21:59:32 INFO - build_url:https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:32 INFO - Running post-action listener: _resource_record_post_action 21:59:32 INFO - Running post-action listener: set_extra_try_arguments 21:59:32 INFO - ##### 21:59:32 INFO - ##### Running populate-webroot step. 21:59:32 INFO - ##### 21:59:32 INFO - Running pre-action listener: _resource_record_pre_action 21:59:32 INFO - Running main action method: populate_webroot 21:59:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:32 INFO - '--tppagecycles', 21:59:32 INFO - '7'], 21:59:32 INFO - 'tests': ['tsvgm']}}, 21:59:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:59:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:59:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:59:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:59:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:59:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:32 INFO - 'talos_options': ['--e10s'], 21:59:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:32 INFO - 'tests': ['damp', 'tps']}, 21:59:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:32 INFO - 'talos_options': ['--e10s'], 21:59:32 INFO - 'tests': ['damp', 'tps']}, 21:59:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:59:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:32 INFO - 'other': {'tests': ['a11yr', 21:59:32 INFO - 'ts_paint', 21:59:32 INFO - 'tpaint', 21:59:32 INFO - 'sessionrestore', 21:59:32 INFO - 'sessionrestore_no_auto_restore']}, 21:59:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:59:32 INFO - 'tests': ['a11yr', 21:59:32 INFO - 'ts_paint', 21:59:32 INFO - 'tpaint', 21:59:32 INFO - 'sessionrestore', 21:59:32 INFO - 'sessionrestore_no_auto_restore']}, 21:59:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:59:32 INFO - 'tests': ['a11yr', 21:59:32 INFO - 'ts_paint', 21:59:32 INFO - 'tpaint', 21:59:32 INFO - 'sessionrestore', 21:59:32 INFO - 'sessionrestore_no_auto_restore']}, 21:59:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:59:32 INFO - 'tests': ['a11yr', 21:59:32 INFO - 'ts_paint', 21:59:32 INFO - 'tpaint', 21:59:32 INFO - 'sessionrestore', 21:59:32 INFO - 'sessionrestore_no_auto_restore']}, 21:59:32 INFO - 'other_l64': {'tests': ['a11yr', 21:59:32 INFO - 'ts_paint', 21:59:32 INFO - 'tpaint', 21:59:32 INFO - 'sessionrestore', 21:59:32 INFO - 'sessionrestore_no_auto_restore']}, 21:59:32 INFO - 'other_nol64': {'tests': ['a11yr', 21:59:32 INFO - 'ts_paint', 21:59:32 INFO - 'tpaint', 21:59:32 INFO - 'sessionrestore', 21:59:32 INFO - 'sessionrestore_no_auto_restore']}, 21:59:32 INFO - 'svgr': {'tests': ['tsvgx', 21:59:32 INFO - 'tsvgr_opacity', 21:59:32 INFO - 'tart', 21:59:32 INFO - 'tscrollx', 21:59:32 INFO - 'cart']}, 21:59:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:59:32 INFO - 'tests': ['tsvgx', 21:59:32 INFO - 'tsvgr_opacity', 21:59:32 INFO - 'tart', 21:59:32 INFO - 'tscrollx', 21:59:32 INFO - 'cart']}, 21:59:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:32 INFO - 'tests': ['tp5o']}, 21:59:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:32 INFO - 'talos_options': ['--e10s'], 21:59:32 INFO - 'tests': ['tp5o']}, 21:59:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:32 INFO - 'talos_options': ['--xperf_path', 21:59:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:32 INFO - 'tests': ['tp5n']}, 21:59:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:32 INFO - 'talos_options': ['--e10s', 21:59:32 INFO - '--xperf_path', 21:59:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:32 INFO - 'tests': ['tp5n']}}, 21:59:32 INFO - 'talos.zip': {'path': '', 21:59:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:32 INFO - Running post-action listener: _resource_record_post_action 21:59:32 INFO - ##### 21:59:32 INFO - ##### Running create-virtualenv step. 21:59:32 INFO - ##### 21:59:32 INFO - Running pre-action listener: _resource_record_pre_action 21:59:32 INFO - Running main action method: create_virtualenv 21:59:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:59:32 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 21:59:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:59:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:33 INFO - Using real prefix '/usr' 21:59:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:59:33 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:35 INFO - Installing pip.................done. 21:59:35 INFO - Return code: 0 21:59:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:59:35 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')]} 21:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:35 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')]} 21:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871762cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17f0>, '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 0x1e4d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d760>, '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': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', '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 21:59:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:59:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:59:35 INFO - Using env: {'DISPLAY': ':0', 21:59:35 INFO - 'HOME': '/home/cltbld', 21:59:35 INFO - 'LANG': 'en_US.UTF-8', 21:59:35 INFO - 'LANGUAGE': 'en_US:en', 21:59:35 INFO - 'LOGNAME': 'cltbld', 21:59:35 INFO - 'MAIL': '/var/mail/cltbld', 21:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:35 INFO - 'MOZ_NO_REMOTE': '1', 21:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:35 INFO - 'NO_EM_RESTART': '1', 21:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:35 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:35 INFO - 'SHELL': '/bin/bash', 21:59:35 INFO - 'SHLVL': '1', 21:59:35 INFO - 'TERM': 'linux', 21:59:35 INFO - 'TMOUT': '86400', 21:59:35 INFO - 'USER': 'cltbld', 21:59:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', 21:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:35 INFO - '_': '/tools/buildbot/bin/python'} 21:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:35 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 21:59:35 INFO - Cleaning up... 21:59:35 INFO - Return code: 0 21:59:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:59:35 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')]} 21:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:35 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')]} 21:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871762cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17f0>, '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 0x1e4d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d760>, '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': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', '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 21:59:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:59:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:59:35 INFO - Using env: {'DISPLAY': ':0', 21:59:35 INFO - 'HOME': '/home/cltbld', 21:59:35 INFO - 'LANG': 'en_US.UTF-8', 21:59:35 INFO - 'LANGUAGE': 'en_US:en', 21:59:35 INFO - 'LOGNAME': 'cltbld', 21:59:35 INFO - 'MAIL': '/var/mail/cltbld', 21:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:35 INFO - 'MOZ_NO_REMOTE': '1', 21:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:35 INFO - 'NO_EM_RESTART': '1', 21:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:35 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:35 INFO - 'SHELL': '/bin/bash', 21:59:35 INFO - 'SHLVL': '1', 21:59:35 INFO - 'TERM': 'linux', 21:59:35 INFO - 'TMOUT': '86400', 21:59:35 INFO - 'USER': 'cltbld', 21:59:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', 21:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:35 INFO - '_': '/tools/buildbot/bin/python'} 21:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:36 INFO - Downloading/unpacking psutil>=0.7.1 21:59:36 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 21:59:36 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 21:59:36 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 21:59:36 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 21:59:36 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 21:59:36 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 21:59:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:37 INFO - Installing collected packages: psutil 21:59:37 INFO - Running setup.py install for psutil 21:59:38 INFO - building 'psutil._psutil_linux' extension 21:59:38 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 21:59:38 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 21:59:38 INFO - building 'psutil._psutil_posix' extension 21:59:38 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 21:59:38 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 21:59:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:38 INFO - Successfully installed psutil 21:59:38 INFO - Cleaning up... 21:59:38 INFO - Return code: 0 21:59:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:59:38 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')]} 21:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:38 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')]} 21:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871762cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17f0>, '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 0x1e4d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d760>, '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': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', '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 21:59:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:59:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:59:38 INFO - Using env: {'DISPLAY': ':0', 21:59:38 INFO - 'HOME': '/home/cltbld', 21:59:38 INFO - 'LANG': 'en_US.UTF-8', 21:59:38 INFO - 'LANGUAGE': 'en_US:en', 21:59:38 INFO - 'LOGNAME': 'cltbld', 21:59:38 INFO - 'MAIL': '/var/mail/cltbld', 21:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:38 INFO - 'MOZ_NO_REMOTE': '1', 21:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:38 INFO - 'NO_EM_RESTART': '1', 21:59:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:38 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:38 INFO - 'SHELL': '/bin/bash', 21:59:38 INFO - 'SHLVL': '1', 21:59:38 INFO - 'TERM': 'linux', 21:59:38 INFO - 'TMOUT': '86400', 21:59:38 INFO - 'USER': 'cltbld', 21:59:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', 21:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:38 INFO - '_': '/tools/buildbot/bin/python'} 21:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:59:38 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 21:59:38 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 21:59:38 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 21:59:38 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 21:59:38 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 21:59:38 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 21:59:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:59:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:59:40 INFO - Installing collected packages: mozsystemmonitor 21:59:40 INFO - Running setup.py install for mozsystemmonitor 21:59:40 INFO - Successfully installed mozsystemmonitor 21:59:40 INFO - Cleaning up... 21:59:40 INFO - Return code: 0 21:59:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871762cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17f0>, '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 0x1e4d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d760>, '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': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', '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 21:59:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:59:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:59:40 INFO - Using env: {'DISPLAY': ':0', 21:59:40 INFO - 'HOME': '/home/cltbld', 21:59:40 INFO - 'LANG': 'en_US.UTF-8', 21:59:40 INFO - 'LANGUAGE': 'en_US:en', 21:59:40 INFO - 'LOGNAME': 'cltbld', 21:59:40 INFO - 'MAIL': '/var/mail/cltbld', 21:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:40 INFO - 'MOZ_NO_REMOTE': '1', 21:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:40 INFO - 'NO_EM_RESTART': '1', 21:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:40 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:40 INFO - 'SHELL': '/bin/bash', 21:59:40 INFO - 'SHLVL': '1', 21:59:40 INFO - 'TERM': 'linux', 21:59:40 INFO - 'TMOUT': '86400', 21:59:40 INFO - 'USER': 'cltbld', 21:59:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', 21:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:40 INFO - '_': '/tools/buildbot/bin/python'} 21:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:40 INFO - Downloading/unpacking blobuploader==1.2.4 21:59:40 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 21:59:40 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 21:59:40 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 21:59:40 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 21:59:40 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 21:59:40 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 21:59:42 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59:42 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 21:59:42 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 21:59:42 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 21:59:42 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 21:59:42 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 21:59:42 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 21:59:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:59:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59:43 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 21:59:43 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 21:59:43 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 21:59:43 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 21:59:43 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 21:59:43 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 21:59:43 INFO - Downloading docopt-0.6.1.tar.gz 21:59:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:43 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:43 INFO - Running setup.py install for blobuploader 21:59:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:59:43 INFO - Running setup.py install for requests 21:59:43 INFO - Running setup.py install for docopt 21:59:43 INFO - Successfully installed blobuploader requests docopt 21:59:43 INFO - Cleaning up... 21:59:43 INFO - Return code: 0 21:59:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871762cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17f0>, '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 0x1e4d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d760>, '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': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', '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 21:59:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:59:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:59:43 INFO - Using env: {'DISPLAY': ':0', 21:59:43 INFO - 'HOME': '/home/cltbld', 21:59:43 INFO - 'LANG': 'en_US.UTF-8', 21:59:43 INFO - 'LANGUAGE': 'en_US:en', 21:59:43 INFO - 'LOGNAME': 'cltbld', 21:59:43 INFO - 'MAIL': '/var/mail/cltbld', 21:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:43 INFO - 'MOZ_NO_REMOTE': '1', 21:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:43 INFO - 'NO_EM_RESTART': '1', 21:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:43 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:43 INFO - 'SHELL': '/bin/bash', 21:59:43 INFO - 'SHLVL': '1', 21:59:43 INFO - 'TERM': 'linux', 21:59:43 INFO - 'TMOUT': '86400', 21:59:43 INFO - 'USER': 'cltbld', 21:59:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', 21:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:43 INFO - '_': '/tools/buildbot/bin/python'} 21:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:44 INFO - Running setup.py (path:/tmp/pip-hy00fT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:44 INFO - Running setup.py (path:/tmp/pip-KmymcB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:44 INFO - Running setup.py (path:/tmp/pip-5fl1LD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:44 INFO - Running setup.py (path:/tmp/pip-rqvkgv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:44 INFO - Running setup.py (path:/tmp/pip-lHrkJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:44 INFO - Running setup.py (path:/tmp/pip-NJ7tBe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:44 INFO - Running setup.py (path:/tmp/pip-o4UpQV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:44 INFO - Running setup.py (path:/tmp/pip-dwqUBp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:44 INFO - Running setup.py (path:/tmp/pip-uAh7Wq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:44 INFO - Running setup.py (path:/tmp/pip-0psthy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:44 INFO - Running setup.py (path:/tmp/pip-Rq9d8g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:45 INFO - Running setup.py (path:/tmp/pip-DFu9Nu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:45 INFO - Running setup.py (path:/tmp/pip-dv2l_N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:45 INFO - Running setup.py (path:/tmp/pip-wb3aLZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:45 INFO - Running setup.py (path:/tmp/pip-iDkups-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:45 INFO - Running setup.py (path:/tmp/pip-SWoL4b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:45 INFO - Running setup.py (path:/tmp/pip-owNtmC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:45 INFO - Running setup.py install for manifestparser 21:59:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:59:45 INFO - Running setup.py install for mozcrash 21:59:45 INFO - Running setup.py install for mozdebug 21:59:45 INFO - Running setup.py install for mozdevice 21:59:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:59:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:59:45 INFO - Running setup.py install for mozfile 21:59:45 INFO - Running setup.py install for mozhttpd 21:59:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:59:46 INFO - Running setup.py install for mozinfo 21:59:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:59:46 INFO - Running setup.py install for mozInstall 21:59:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:59:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:59:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:59:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:59:46 INFO - Running setup.py install for mozleak 21:59:46 INFO - Running setup.py install for mozlog 21:59:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:59:46 INFO - Running setup.py install for moznetwork 21:59:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:59:46 INFO - Running setup.py install for mozprocess 21:59:46 INFO - Running setup.py install for mozprofile 21:59:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:59:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:59:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:59:46 INFO - Running setup.py install for mozrunner 21:59:46 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:59:46 INFO - Running setup.py install for mozscreenshot 21:59:47 INFO - Running setup.py install for moztest 21:59:47 INFO - Running setup.py install for mozversion 21:59:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:59:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:59:47 INFO - Cleaning up... 21:59:47 INFO - Return code: 0 21:59:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871762cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17f0>, '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 0x1e4d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d760>, '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': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', '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 21:59:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:59:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:59:47 INFO - Using env: {'DISPLAY': ':0', 21:59:47 INFO - 'HOME': '/home/cltbld', 21:59:47 INFO - 'LANG': 'en_US.UTF-8', 21:59:47 INFO - 'LANGUAGE': 'en_US:en', 21:59:47 INFO - 'LOGNAME': 'cltbld', 21:59:47 INFO - 'MAIL': '/var/mail/cltbld', 21:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:47 INFO - 'MOZ_NO_REMOTE': '1', 21:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:47 INFO - 'NO_EM_RESTART': '1', 21:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:47 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:47 INFO - 'SHELL': '/bin/bash', 21:59:47 INFO - 'SHLVL': '1', 21:59:47 INFO - 'TERM': 'linux', 21:59:47 INFO - 'TMOUT': '86400', 21:59:47 INFO - 'USER': 'cltbld', 21:59:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', 21:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:47 INFO - '_': '/tools/buildbot/bin/python'} 21:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:47 INFO - Running setup.py (path:/tmp/pip-EsJdLw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:47 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)) 21:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:47 INFO - Running setup.py (path:/tmp/pip-nZ1eWQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:47 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)) 21:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:47 INFO - Running setup.py (path:/tmp/pip-27xLlY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:47 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)) 21:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:47 INFO - Running setup.py (path:/tmp/pip-MwXxWX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:47 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)) 21:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:47 INFO - Running setup.py (path:/tmp/pip-cmNhmp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:47 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)) 21:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:47 INFO - Running setup.py (path:/tmp/pip-rAWlQg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:47 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)) 21:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:47 INFO - Running setup.py (path:/tmp/pip-t0kUf8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:47 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)) 21:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:47 INFO - Running setup.py (path:/tmp/pip-6gfdm_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:48 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)) 21:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:48 INFO - Running setup.py (path:/tmp/pip-7wQDiX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:48 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)) 21:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:48 INFO - Running setup.py (path:/tmp/pip-9yWkyg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:48 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)) 21:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:48 INFO - Running setup.py (path:/tmp/pip-bpdq6s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:48 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)) 21:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:48 INFO - Running setup.py (path:/tmp/pip-HYhgwq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:48 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)) 21:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:48 INFO - Running setup.py (path:/tmp/pip-cM044u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:48 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)) 21:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:48 INFO - Running setup.py (path:/tmp/pip-OsjJgE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:48 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)) 21:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:48 INFO - Running setup.py (path:/tmp/pip-a0CeOt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:48 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)) 21:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:48 INFO - Running setup.py (path:/tmp/pip-ZzSyGf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:48 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)) 21:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:48 INFO - Running setup.py (path:/tmp/pip-rRkauF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:48 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)) 21:59:48 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)) 21:59:48 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)) 21:59:48 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)) 21:59:48 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)) 21:59:48 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)) 21:59:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:59:48 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 21:59:48 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 21:59:48 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 21:59:48 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 21:59:48 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 21:59:48 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 21:59:50 INFO - Downloading blessings-1.6.tar.gz 21:59:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:59:50 INFO - Installing collected packages: blessings 21:59:50 INFO - Running setup.py install for blessings 21:59:50 INFO - Successfully installed blessings 21:59:50 INFO - Cleaning up... 21:59:50 INFO - Return code: 0 21:59:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:59:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:59:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:59:50 INFO - Reading from file tmpfile_stdout 21:59:50 INFO - Current package versions: 21:59:50 INFO - argparse == 1.2.1 21:59:50 INFO - blessings == 1.6 21:59:50 INFO - blobuploader == 1.2.4 21:59:50 INFO - docopt == 0.6.1 21:59:50 INFO - manifestparser == 1.1 21:59:50 INFO - mozInstall == 1.12 21:59:50 INFO - mozcrash == 0.16 21:59:50 INFO - mozdebug == 0.1 21:59:50 INFO - mozdevice == 0.48 21:59:50 INFO - mozfile == 1.2 21:59:50 INFO - mozhttpd == 0.7 21:59:50 INFO - mozinfo == 0.9 21:59:50 INFO - mozleak == 0.1 21:59:50 INFO - mozlog == 3.1 21:59:50 INFO - moznetwork == 0.27 21:59:50 INFO - mozprocess == 0.22 21:59:50 INFO - mozprofile == 0.28 21:59:50 INFO - mozrunner == 6.11 21:59:50 INFO - mozscreenshot == 0.1 21:59:50 INFO - mozsystemmonitor == 0.0 21:59:50 INFO - moztest == 0.7 21:59:50 INFO - mozversion == 1.4 21:59:50 INFO - psutil == 3.1.1 21:59:50 INFO - requests == 1.2.3 21:59:50 INFO - wsgiref == 0.1.2 21:59:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871762cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17f0>, '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 0x1e4d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d760>, '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': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', '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 21:59:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 21:59:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:59:50 INFO - Using env: {'DISPLAY': ':0', 21:59:50 INFO - 'HOME': '/home/cltbld', 21:59:50 INFO - 'LANG': 'en_US.UTF-8', 21:59:50 INFO - 'LANGUAGE': 'en_US:en', 21:59:50 INFO - 'LOGNAME': 'cltbld', 21:59:50 INFO - 'MAIL': '/var/mail/cltbld', 21:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:50 INFO - 'MOZ_NO_REMOTE': '1', 21:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:50 INFO - 'NO_EM_RESTART': '1', 21:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:50 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:50 INFO - 'SHELL': '/bin/bash', 21:59:50 INFO - 'SHLVL': '1', 21:59:50 INFO - 'TERM': 'linux', 21:59:50 INFO - 'TMOUT': '86400', 21:59:50 INFO - 'USER': 'cltbld', 21:59:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', 21:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:50 INFO - '_': '/tools/buildbot/bin/python'} 21:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:51 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)) 21:59:51 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)) 21:59:51 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)) 21:59:51 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)) 21:59:51 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)) 21:59:51 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)) 21:59:51 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)) 21:59:51 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)) 21:59:51 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)) 21:59:51 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)) 21:59:51 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)) 21:59:51 INFO - Cleaning up... 21:59:51 INFO - Return code: 0 21:59:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871762cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17f0>, '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 0x1e4d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d760>, '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': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', '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 21:59:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 21:59:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:59:51 INFO - Using env: {'DISPLAY': ':0', 21:59:51 INFO - 'HOME': '/home/cltbld', 21:59:51 INFO - 'LANG': 'en_US.UTF-8', 21:59:51 INFO - 'LANGUAGE': 'en_US:en', 21:59:51 INFO - 'LOGNAME': 'cltbld', 21:59:51 INFO - 'MAIL': '/var/mail/cltbld', 21:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:51 INFO - 'MOZ_NO_REMOTE': '1', 21:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:51 INFO - 'NO_EM_RESTART': '1', 21:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:51 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:51 INFO - 'SHELL': '/bin/bash', 21:59:51 INFO - 'SHLVL': '1', 21:59:51 INFO - 'TERM': 'linux', 21:59:51 INFO - 'TMOUT': '86400', 21:59:51 INFO - 'USER': 'cltbld', 21:59:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', 21:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:51 INFO - '_': '/tools/buildbot/bin/python'} 21:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:51 INFO - Downloading/unpacking jsonschema 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:59:53 INFO - Downloading/unpacking functools32 (from jsonschema) 21:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:53 INFO - Downloading functools32-3.2.3-2.tar.gz 21:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:59:53 INFO - warning: no files found matching '*.txt' 21:59:53 INFO - no previously-included directories found matching 'build' 21:59:53 INFO - no previously-included directories found matching 'dist' 21:59:53 INFO - no previously-included directories found matching '.git*' 21:59:53 INFO - Installing collected packages: jsonschema, functools32 21:59:53 INFO - Running setup.py install for functools32 21:59:53 INFO - warning: no files found matching '*.txt' 21:59:53 INFO - no previously-included directories found matching 'build' 21:59:53 INFO - no previously-included directories found matching 'dist' 21:59:53 INFO - no previously-included directories found matching '.git*' 21:59:53 INFO - Successfully installed jsonschema functools32 21:59:53 INFO - Cleaning up... 21:59:53 INFO - Return code: 0 21:59:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871762cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee17f0>, '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 0x1e4d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d760>, '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': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', '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 21:59:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 21:59:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:59:53 INFO - Using env: {'DISPLAY': ':0', 21:59:53 INFO - 'HOME': '/home/cltbld', 21:59:53 INFO - 'LANG': 'en_US.UTF-8', 21:59:53 INFO - 'LANGUAGE': 'en_US:en', 21:59:53 INFO - 'LOGNAME': 'cltbld', 21:59:53 INFO - 'MAIL': '/var/mail/cltbld', 21:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:53 INFO - 'MOZ_NO_REMOTE': '1', 21:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:53 INFO - 'NO_EM_RESTART': '1', 21:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:53 INFO - 'SHELL': '/bin/bash', 21:59:53 INFO - 'SHLVL': '1', 21:59:53 INFO - 'TERM': 'linux', 21:59:53 INFO - 'TMOUT': '86400', 21:59:53 INFO - 'USER': 'cltbld', 21:59:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', 21:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:53 INFO - '_': '/tools/buildbot/bin/python'} 21:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:53 INFO - Downloading/unpacking flake8 21:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:59:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:59:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:59:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:59:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:59:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:59:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:59:56 INFO - no previously-included directories found matching 'docs/_build' 21:59:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:59:56 INFO - Running setup.py install for pep8 21:59:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:59:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:59:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:59:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:59:56 INFO - no previously-included directories found matching 'docs/_build' 21:59:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:59:56 INFO - Cleaning up... 21:59:56 INFO - Return code: 0 21:59:56 INFO - Running post-action listener: _resource_record_post_action 21:59:56 INFO - Running post-action listener: _start_resource_monitoring 21:59:56 INFO - Starting resource monitoring. 21:59:56 INFO - ##### 21:59:56 INFO - ##### Running install step. 21:59:56 INFO - ##### 21:59:56 INFO - Running pre-action listener: _resource_record_pre_action 21:59:56 INFO - Running main action method: install 21:59:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:59:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:59:56 INFO - Reading from file tmpfile_stdout 21:59:56 INFO - Detecting whether we're running mozinstall >=1.0... 21:59:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:59:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:59:56 INFO - Reading from file tmpfile_stdout 21:59:56 INFO - Output received: 21:59:56 INFO - Usage: mozinstall [options] installer 21:59:56 INFO - Options: 21:59:56 INFO - -h, --help show this help message and exit 21:59:56 INFO - -d DEST, --destination=DEST 21:59:56 INFO - Directory to install application into. [default: 21:59:56 INFO - "/builds/slave/test-pgo"] 21:59:56 INFO - --app=APP Application being installed. [default: firefox] 21:59:56 INFO - mkdir: /builds/slave/test-pgo/build/application 21:59:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 21:59:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:00:12 INFO - Reading from file tmpfile_stdout 22:00:12 INFO - Output received: 22:00:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:00:12 INFO - Running post-action listener: _resource_record_post_action 22:00:12 INFO - ##### 22:00:12 INFO - ##### Running run-tests step. 22:00:12 INFO - ##### 22:00:12 INFO - Running pre-action listener: _resource_record_pre_action 22:00:12 INFO - Running main action method: run_tests 22:00:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:00:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:00:12 INFO - Python 2.7.3 22:00:12 INFO - Return code: 0 22:00:12 INFO - grabbing minidump binary from tooltool 22:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:12 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 0x1ee17f0>, '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 0x1e4d2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:00:12 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:00:12 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:00:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:12 INFO - Return code: 0 22:00:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:00:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:00:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:00:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:00:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:00:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:00:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:00:13 INFO - Return code: 0 22:00:13 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/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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:00:13 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/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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:00:13 INFO - Using env: {'DISPLAY': ':0', 22:00:13 INFO - 'HOME': '/home/cltbld', 22:00:13 INFO - 'LANG': 'en_US.UTF-8', 22:00:13 INFO - 'LANGUAGE': 'en_US:en', 22:00:13 INFO - 'LOGNAME': 'cltbld', 22:00:13 INFO - 'MAIL': '/var/mail/cltbld', 22:00:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:00:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:13 INFO - 'MOZ_NO_REMOTE': '1', 22:00:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:13 INFO - 'NO_EM_RESTART': '1', 22:00:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:13 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:00:13 INFO - 'SHELL': '/bin/bash', 22:00:13 INFO - 'SHLVL': '1', 22:00:13 INFO - 'TERM': 'linux', 22:00:13 INFO - 'TMOUT': '86400', 22:00:13 INFO - 'USER': 'cltbld', 22:00:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366', 22:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:13 INFO - '_': '/tools/buildbot/bin/python'} 22:00:13 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/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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:00:14 INFO - mozversion application_buildid: 20160125193227 22:00:14 INFO - mozversion application_changeset: 08f0995ef87370f56d8148dcdec0e74d3ab313f6 22:00:14 INFO - mozversion application_display_name: Nightly 22:00:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:14 INFO - mozversion application_name: Firefox 22:00:14 INFO - mozversion application_remotingname: firefox 22:00:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:00:14 INFO - mozversion application_vendor: Mozilla 22:00:14 INFO - mozversion application_version: 47.0a1 22:00:14 INFO - mozversion platform_buildid: 20160125193227 22:00:14 INFO - mozversion platform_changeset: 08f0995ef87370f56d8148dcdec0e74d3ab313f6 22:00:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:00:14 INFO - mozversion platform_version: 47.0a1 22:00:14 INFO - using testdate: 1453788014 22:00:14 INFO - actual date: 1453788014 22:00:14 INFO - starting webserver on 'localhost:49683' 22:00:14 INFO - SUITE-START | Running 3 tests 22:00:14 INFO - TEST-START | dromaeo_css 22:00:14 INFO - operating with platform_type : linux_ 22:00:14 INFO - Initialising browser for dromaeo_css test... 22:00:14 INFO - TEST-INFO | started process 32538 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpic6_uG/profile http://localhost:49683/getInfo.html) 22:00:18 INFO - PROCESS | 32538 | __metrics Screen width/height:1600/1200 22:00:18 INFO - PROCESS | 32538 | colorDepth:24 22:00:18 INFO - PROCESS | 32538 | Browser inner width/height: 1024/697 22:00:18 INFO - PROCESS | 32538 | __metrics 22:00:18 INFO - PROCESS | 32538 | 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:00:18 INFO - PROCESS | 32538 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:20 INFO - TEST-INFO | 32538: exit 0 22:00:20 INFO - Browser initialized. 22:00:20 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:20 INFO - TEST-INFO | started process 32630 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpic6_uG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:31 INFO - PROCESS | 32630 | RSS: Main: 148094976 22:00:31 INFO - PROCESS | 32630 | 22:01:23 INFO - PROCESS | 32630 | 1453788083447 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:03:31 INFO - PROCESS | 32630 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49683/tests/dromaeo/cssquery-ext.html) 22:03:32 INFO - PROCESS | 32630 | RSS: Main: 265760768 22:03:32 INFO - PROCESS | 32630 | 22:06:35 INFO - PROCESS | 32630 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-ext.html (next: http://localhost:49683/tests/dromaeo/cssquery-jquery.html) 22:06:35 INFO - PROCESS | 32630 | RSS: Main: 230199296 22:06:35 INFO - PROCESS | 32630 | 22:09:37 INFO - PROCESS | 32630 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49683/tests/dromaeo/cssquery-mootools.html) 22:09:38 INFO - PROCESS | 32630 | RSS: Main: 235986944 22:09:38 INFO - PROCESS | 32630 | 22:12:40 INFO - PROCESS | 32630 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49683/tests/dromaeo/cssquery-prototype.html) 22:12:41 INFO - PROCESS | 32630 | RSS: Main: 214073344 22:12:41 INFO - PROCESS | 32630 | 22:15:43 INFO - PROCESS | 32630 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49683/tests/dromaeo/cssquery-yui.html) 22:15:44 INFO - PROCESS | 32630 | RSS: Main: 219381760 22:15:44 INFO - PROCESS | 32630 | 22:18:46 INFO - PROCESS | 32630 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-yui.html (next: http://localhost:49683/tests/dromaeo/cssquery-dojo.html) 22:18:46 INFO - PROCESS | 32630 | RSS: Main: 304816128 22:18:46 INFO - PROCESS | 32630 | 22:18:46 INFO - PROCESS | 32630 | __start_tp_report 22:18:46 INFO - PROCESS | 32630 | _x_x_mozilla_page_load 22:18:46 INFO - PROCESS | 32630 | _x_x_mozilla_page_load_details 22:18:46 INFO - PROCESS | 32630 | |i|pagename|runs| 22:18:46 INFO - PROCESS | 32630 | |0;dojo.html;3090.2892334763005;3129.295908420604;3176.7140957313836;3178.6185657721076;3204.679532046795;4991.925121123177;5050.368703912011;5217.113090774568;5268.525832675054;5289.682619042856;5137.820176293831;5166.664166829153;5179.378474583046;5195.740212989354;5231.686098834072;4745.477997420289;4781.330613714083;4792.161371759928;4860.05228980349;4904.803807847682;4725;4757.83433058901;4804.327394164819;4819.493953134923;4904.5340692634145;4709.62323014158;4793.49668284832;4821.083994041156;4894.045661096087;4919.1637421638225;4648.74431906245;4688.46082700487;4699.483056863743;4705.411823522059;4707.246840505502;4689.88275293117;4692.859214223578;4698.765061746899;4700.694454860423;4741.431028276629;4891.608671306287;4969.055879382906;4972.502749725035;4981.476944920767;5027.924581131286;5523.28197334344;5593.105103183471;5660.490555849952;5675.31896172462;5693.914591281134;5499.285092937893;5503.449655034505;5507.779688812483;5513.3108361454815;5548.667079975215;5147.4080480744815;5147.768350424202;5148.845534633967;5157.71632560209;5197.818076367309;5584.692841893653;5586.022446071921;5634.408387119375;5676.233708449389;5702.315722113373;5482.122860342326;5490.396056433789;5492.066348720727;5495.917561236584;5498.615096943176;5576.721163941867;5578.107502799533;5581.190727344512;5584.553235741131;5587.692676902728;5382.327209098863;5505.201745746845;5571.916421253684;5594.608377413542;5657.57568182388;5407;5433.782648694008;5442;5446.019716451076;5457.699826509501;4083.3262511685834;4126.628603425706;4130.752154870717;4161.042960119129;4173.916521669549;3687.0597997510463;3697.9645699204266;3718.8140592970244;3725.9441108383394;3757.887263382103;5148.304978827885;5207;5212.113940630102;5213.661112027706;5216.530512253916;5312.92030619541;5380.650257733235;5623.606347555714;5625.128105143709;5638.097904335286;5194.272801807674;5227.18978558324;5258.763355648928;5261.394939581921;5300.390455097636;4723.267893476516;4736.147493451212;4743.169945259566;4743.762811859393;4784.521547845257;5732.742026608813;5741.339745929272;5747.971260143672;5824.271966004334;5841.123831425235;5533.612647114664;5659.6321239119325;5696.031674615242;5697.601167918206;5701.885962280814;5869.853253668693;5906.645601263938;5908;5909.8227053188475;5914.4381283777975;5384.380796208487;5410.107332290286;5524.502794748492;5578.497935185853;5609.859753506195;5607.663540187602;5610.607257491936;5619.325680918316;5651.519620832275;5664.85837854057;5516.558675305886;5541.002619528524;5543.417941116125;5544.695041772741;5549.805756798492;5275;5307.938412317629;5339.0389729849;5380.811671591476;5414.187871819258;5347.117725575236;5363.115086010765;5364.275822763877;5367.141257398797;5368.624196306221;5314.734263286898;5471.18826591144;5474.124140137559;5476.835694929158;5508.173773933942;5229.450907654642;5282.920756188737;5301.708406037705;5329.920051199313;5374.516293533601 22:18:46 INFO - PROCESS | 32630 | |1;ext.html;530.0644362699835;535.3762866260804;545.705319127671;552.792702736474;590.937951515091;28041.43917121659;28884.422311553757;28889.1333260002;28902.132936011953;28906.710932890666;29362.706372936264;29828.701712982864;36302;36941;37032.81483592578;8352.582370881462;8500.447470914401;8506.106858779833;8507.787305317386;8518;8273.089960104384;8357.164283571625;8372.079071302152;8404.495730256174;8412.453190542627;8376.371772117116;8449.619767110495;8454.450460720065;8457.19656632622;8473.067962524117;8529.658813647447;8603.483790972561;8615.966084069889;8616.65533378664;8616.827663446758;8418.831623367498;8539.188777066169;8541.231289184003;8548.914510854875;8550.52972086535;38898;39292.21415571673;39327.21345573072;39332.606673933464;39415.60584394148;3099.1477343730653;3134.639516455614;3430.9485357719655;3476.200473890994;3689.196846636366;29630.70369296301;30225.546616800766;30265.848670756506;30411.847940760155;30665;3902.492675952108;3929.528456585228;3949.6840252779707;3957.9010524736823;3984.980075099635;256002;256991;257724;257971;258179;41487.377689334084;51820;52817.20774188313;57236;57355.71322143362;39442.408363874565;39549.60450395459;39632;39662.40506392407;39680.404793928115;13377.130486518345;13528.526501572398;13528.932355338357;13539.86460135386;13546.187228766306;9717.708468745948;9878.259130565237;10478.109360704273;10508.842367364343;10724.678259652223;13632.522861699794;13677.384517696728;13715.177089374669;13779.586612401645;13810.37853296604;5470.671759694431;5572.192032155314;5590.301212348457;5600.887982240332;5636.464535869086;931.2549960031947;950.65482342486;1000.9599616015278;1045.6444808765057;1056.1181413519796;28878.711212887603;28997.56503652447;29844.40311193764;30957;31165.532517012263;1013.1287093099928;1030.7320096774893;1077.342820879263;1099.4612639806437;1164.318873459019;15785.842141578438;16395.262213200436;17023.744643830352;17275.481735547954;17356.4793056206;429738;434039;434726;434780;436655;51451.742741286806;51871.48128518742;51874;51899.48100519022;52014.47985520097;1381.6407733989236;1389.840168380629;1400.9019368644301;1401.3343661760582;1405.1217988757028;27879;29338.55992160162;29940.550891736206;30907.69092309138;31489.527657084705;47230.527694722616;47658.28512572245;47763.28355074607;47778.761106195634;47808;260860;266966;274544;278769;280724;30726.692733072385;30732;30734.846325769122;30768.846155769974;30813.691863081083;38618.6138138615;39698.206035878546;40196.598034020455;40235.59764402318;40259.19481610293;34206.31587368189;34542.65457345495;34613.82693086519;34885;38219.42670859884;32104.197395065312;32613;32991.340173195924;33066.338673226885;37867.431988520744;32660.673393265763;33417.49873751847;33708.49437258394;33786.83106584451;33843.830780845936;28187.295317617223;29307.41385172327;30315.848420757757;37253.81373093117;39076.41385379279;24927.127550535643;25418.745812542376;25442;25451.55015680168;25904.352391189615 22:18:46 INFO - PROCESS | 32630 | |2;jquery.html;363.75083068098354;364.52611604913625;365.57958347899927;367.40847235950116;372.28707026045123;13304;13532.797008044887;15408.845911540895;16039.4386196483;16915.915420422913;13745.312734363268;14305.141691498517;14767.483138090169;14783.852161478382;14785.334659940301;5100.591952643789;5282.128448805943;5287.312649355578;5287.947120528784;5288.8413347599635;3851.383778595425;3949.565547789741;5198.116320225571;5258.6318957672975;5582.692951887665;5756.798512052079;5776.942230577703;5803.73883175256;5806;5813.651180929137;4957.553820156185;5139.948600513984;5151.8196863109615;5168.250603662466;5168.715720635363;4824.228123500223;4933.432655244621;5011.874703132451;5050.873728156789;5051.873703157414;11924.403779810975;12301.56944506947;12436.81344779829;12503.49986000559;12504.187227830253;2020.6968954656772;2033.6441122803599;2042.7855075217185;2115.2490865742748;2217.977820221793;8956;8995.685151019683;9367.250619950388;9405.106514881143;9410.200132988704;1802.3781795280606;1829.2774354130177;1850.2044121027952;1883.7456943312752;1919.7888232294436;48004.51995480035;51096.489035109546;51546.74226628918;51577.742111289575;54868.06187443109;8972.506512141765;9189.81620367589;9353.485558294358;9358.672446464341;9435.575399107056;12068.09489288307;12081.45633446497;12091.758164836654;12100.81848772269;12102.576409825613;6993.440524758007;7202.567845929157;7205.171405288354;7246.492745507764;7263.0921134858145;6933.861322773516;7002.159740831133;7018.1929078155645;7048.718051277994;7054.400375967997;4080.8775736727944;4175.64507016907;4196.958030419718;4205.222033923734;4237.237297286456;1678.7901512310962;1750.422360620992;1759.0764848454664;1811.0944527736133;1840.10469216707;871.6817223876737;933.355984370782;941.5574679900436;974.9122578967927;988.980220395588;15966.76049859253;16291.348346066025;16515.83484165167;16561.751573726404;16586.917065414596;914.7530166854912;920.1994264989369;921.9124183202586;935.5930170375908;958.3755534369177;6776.457883369319;9105.499197544066;9121.726348209564;9445.14993650561;9541.713748587554;517411;534354;549724;558075;562042;69564.3043569568;72314.2768572318;72559;72586;74034.6298268516;1078.9568417263222;1107.0866535108569;1114.3202646385698;1117.921745477825;1123.2081382625393;14748;14966.625834353792;15158.521300129722;15241.748964718025;15305.387784488496;31698.207544811565;32458.513122302713;32501;32815.835920820246;33091;40679.38980915229;41264.793676031426;42426.575734243495;42557.57442425536;43831.34252986272;7191.748288809867;7389.889151662622;7647.655855486628;7715.112762032438;7733.574653393893;10413.791724165625;11053.11575073976;11408.543658253577;11651.941740291584;11838.171328006956;9892.752681183028;10089.495525223856;10119.190464762949;10296.96239609302;10525.368477891045;9911.405315681082;9915.058069483388;10005.449700266556;10172.440515771703;10181.440020798927;9549.379290346105;9553.04469553039;9784.315097943076;9969.40183588987;10387.584496620353;7291.34377905991;7663.923360766321;7674;7754.147043825287;7776.572288524186;7477.252274772479;8381.790455238668;9065.68270110543;9208.12522810332;9381.249500040118 22:18:46 INFO - PROCESS | 32630 | |3;mootools.html;1240.0513607090572;1438.870501654851;1439.1940513312545;1580.4231455518739;1740.0081953286624;6541.37856903594;7360.374368178711;7520.247975202477;7525.736599219028;7561.773146805591;7389.704411823521;7417.221191774867;7496.212897645751;7499.700011999527;7518.135414427329;1917.424772568231;1964.72493850861;2236.2732112063604;2247.404437823978;2280.7377151627525;2236.5974124657555;2298.138198175684;2301.3786277705008;2302.654601809725;2302.8618282902994;2217.2904670505445;2248.5840119577847;2248.7976082152604;2249.0329158461855;2260.1750361118156;1845.09590300753;1889.7448844406103;2198.5492973940304;2236.7315922089374;2260.660900864867;2187.9671804922937;2218.157100301891;2257.0633187227445;2257.0745994142485;2257.108442165352;7462.328390444886;7517.060367454068;7524.9247507525315;7527.510711803715;7535.472516923817;4430.734155950653;4555.4533455985165;4592.701474404186;4595.103954728829;4596.126735920165;2946.0867131189184;2973.4201830643033;3015.1858998070616;3036.483797754387;3074.769392295587;915.2403505090825;921.8893732752045;926.2543652359848;928.1878356438117;936.5832204668925;10655.041046305792;10668.679939601901;10670.146388288918;10677.359358438442;10688.305260158142;4240.279152544075;4284.8500302489265;4380.759058251763;4408.6913916026215;4440.777961101932;9037;9056.230220431205;9064.229540489001;9065.728028159167;9066.138716821892;4718.787654555554;4729;4729.6689231754135;4730.361401210793;4731.313959475857;4257.701960862772;4296.892577685583;4300.268954277781;4303.2469317869245;4318.265894797892;3574.3387473317;3626.854925802991;3627.183883626163;3648.434492653643;3649.489071529988;1172.0799172649429;1175.6766889105565;1180.4510902430238;1193.021722187815;1198.7722332756748;1238.7089034076985;1256.403208475985;1262.5139321361157;1282.0640932119418;1291.8449786025737;6379.075034120026;6504.577202481823;6888.758893438706;7078.575285482888;7088.468364872655;610.8656095658948;629.6757170057424;638.8243233110838;642.1876326447049;642.7493277621732;5545.112781954868;5550.611457198038;5599.552035837123;5618.129189975561;5635.8591035224445;8835.514046727363;9189.494577798152;9206.539673016323;9220.953895230481;9222.077792220858;9149.725508234764;9160.770980725536;9293.72118836436;9305.069493050776;9316.534173291308;6948.513604047668;7086.645667716593;7182.533135346186;7185;7190.245024272481;6951.0616066830335;7001.614911179934;7077.433805295461;7084.858302833812;7094.148702155774;8043.959780201061;8241.752747417588;8342.87485687703;8344.41589088758;8353.0811610724;8284.337253019865;8390.244877961013;8595.871061934202;8614.956925215334;8623;6843.828904277433;6962.7911162665205;6984.685689144102;7006.859862802818;7009.824754381181;7355.7057717690695;7411.110666719813;7427.925720742724;7435.62821858894;7441;6572.34276572339;6665.066890635412;6776.898346524905;6779.6271205084195;6853.280405557544;6267.122602835516;6345.238571371465;6393.073004414427;6417.294097649348;6636.070950066898;5919.052951527735;6274.466670333073;6737.3599508046655;6779.288174741581;6796.184457865088;6211.3478084800445;6215.65813880241;6257.2491301044165;6269.843253918689;6271.184745982993;6204.844878878064;6252.5935814171935;6255.030470277115;6258.280297765633;6261.843453913506 22:18:46 INFO - PROCESS | 32630 | |4;prototype.html;337.71294399760205;342.1463448695505;347.2135612836924;349.63113914819854;355.5040718198112;5748.942510574893;5928.49607783339;5947.167396564484;5952.910706339403;5966.79116230932;5727.971360143204;5898.970505147479;5916.88166236675;5937.821865344035;5954.523638108952;4570.565796249351;4571.38286331346;4573.588377046065;4574.1080489304595;4575.839845605405;4345.52199258083;4413.205622987861;4414.359917811916;4416.072624748806;4573;4381.759003254836;4473.709208901411;4538.523455037223;4541.750203738793;4563.429571303587;4512.075024619945;4516.796744146522;4529.139463501924;4531.207038768219;4594.678372513926;4047.5952404759582;4060.939085913714;4063.288924438241;4077.3883917412327;4084.591540845892;5484.095124304485;5634.690092044936;5645.491905728463;5672.432756724335;5689.345725241609;5262.105442074857;5268.947310526884;5271.42014378418;5273.472652734734;5276.736163191864;5901.675407852566;6301.306856245809;6305.621662700207;6317.14718513004;6326.87346253077;4141.979290103561;4218.177455396199;4266.2960611499375;4276.957230427718;4282.5503322151035;6443.645599492026;6611.966940165316;6631.568948018364;6644.634545100018;6645.833854153685;4399.406080179135;4402.679196241115;4405.669574781904;4406.537313582027;4417.4036505072045;4383.517813040563;4461.665375096881;4464.6428285737065;4518.977405112953;4571.108633816374;5253.474652534716;5254.448282930313;5257.738142845689;5260.237265596544;5260.395054568774;6288.339724328971;6303.558750887486;6310.1796766420075;6311;6315.684215789284;1582.7784110224577;1617.2641448141303;1618.708632446171;1619.2551426344014;1619.6760647870474;1030.7474668706216;1053.8366553184114;1071.517816982361;1080.9189310801721;1082.8917108289108;5992.820215393458;5994.190784244159;6006.639601623917;6014.789482368096;6016.819495415057;6479.773207937794;6497.967510162419;6505.772297969548;6518.380753828379;6526.869462610721;5945.316288626776;5961.701914904237;5961.850953726105;5972.074328479092;5980.282366116007;3421.4945424013854;3552.8223588820456;3556.6798988090677;3558.3061303045656;3560.0209942265565;6818.28408017161;6851.691673874688;6857.622830744257;6865.725370985205;6882.414994725505;6739.292374300628;6746.359095885883;6746.83132921671;6781.287964763629;6809.216940051859;6624.900626490607;6839.384455399038;6856.554323968926;6880.862382752217;6884.690188941409;6302.558820882494;6454.1609590752905;6551.70517326731;6596.90104648421;6607.438367738796;6224.502039836711;6437.7103030362805;6469.644169570719;6483.643399612878;6485.513586480938;6806.523543351917;6818.659067046528;6842.315768423118;6862;6864.828379290558;4541.636669066401;4601.953980460286;4631.629469642353;4634.443866736014;4644.907101857876;6431.292557818542;6488.870222595616;6489.545731798918;6493.285738568659;6501.349865013461;6325.96837015812;6327.936720632735;6329.810105696836;6331.556791024584;6332.081848131903;6169.56813023084;6264.373562643699;6274.403931626488;6294.4964402846745;6301.338359472189;6171.9074213887725;6172.197614310111;6181.1655426516845;6197.411245931629;6197.690115494117;6327.335629758809;6331.303556608677;6335.936640633535;6355.491560675043;6359.87280254383;6061.242344706911;6194.256689197326;6206;6211.65835879031;6216.627002379872 22:18:46 INFO - PROCESS | 32630 | |5;yui.html;735.7719107076804;736.5323019882374;835.1523203947994;835.9289460395865;841.760098371964;15291;15736.21318934053;15843.762343564857;15846.920765396171;15872.2063896805;14112.082714623542;14131.081479703838;14148.080374775658;14166.929165354184;14194.432222711079;659.8449364399386;667.4827009067986;793.7777422321744;803.493798906688;805.907320658123;795.0340336491162;796.9681212751483;803.8111043904678;809.8947136872198;809.951402915827;836.0844874862016;849.0151424347758;849.4308813095241;849.995750021249;850.2602735620019;680.9421199198074;694.1011390249614;828.3249151941209;836.2599099796694;846.9153084691482;615.123449085052;618.5453691536717;619.3249358199539;621.018790311307;621.7264403662374;13012.349382530836;13045.217286962812;13061.346932653425;13075.346232688327;13171.143875648053;12021.51913923442;12138.635840924786;12410.689732756662;12414.503419863195;12709.364531773374;10461.633842815465;10504.422256775873;10600.628977985734;10660.307080039773;10681.519331630096;3531.4173161428334;3585.8565657373674;3651.415773476231;3693.7229707771758;3694.538182727159;49671.503284967046;49732.25401619015;49816.50183498155;49908;49978;9745.269104817167;9939.950300248596;10035.949820250851;10061.849072263922;10137.64518241858;17569.121543922753;17572.824271757374;17575.824241757673;17584.648307034044;17593.472195834147;7038.577685338896;7190.820229494305;7300.9634951825965;7407.740729074457;7426.5915374654915;3907.8468733760274;3908.9210463544996;4023.295923213426;4050.4531888194715;4118.402831589463;2982.7315541600924;3027.6820933802073;3037.5747395364224;3038.255627371264;3042.0417568466305;551.8510002299357;554.431707499816;555.2032832884743;562.4768964862635;569.9882708192907;532.3558494221958;553.4133818152771;635.7012204263989;664.1498881431775;703.4794252253398;9523.142917137491;9639.518024098767;9784.755381115529;9823.11591956713;9941.900580994097;491.8647371972736;503.02210911404575;504.87630530520255;513.6661170239374;536.924830523727;3922.5292964844402;3944.7633142011573;4063.4108054331955;4145.440365550672;4161.535099916525;58509.70745146247;60249.09626355608;60265.69867150636;60388.698056509435;60392.69803650954;51073.233901491505;51583.48416515862;51584.22623660573;51862;52650.47349526532;44406.33390499145;44573.10853782906;44936.3259551107;46798.532014680095;47154.292685609056;6894.586324820527;8138.674453022049;8420.789480262798;8435.578221089043;8490.32077433816;33553.83223083869;34273.31453370969;34675.30649386947;34801.65198347984;34874.82562587171;41957.37063944104;42548.78725606352;43349.78325108354;43755;44278.55721442744;10218.080372766486;10366.585336586753;10946.890531094905;10963.232573719763;11461.312321260417;11516.82724759146;11905.166638335233;12139;12217.572384966483;12280.263184208976;10923.289986150874;10962.506687198937;10969.451527423438;10984;11694.181407301407;10885.727856803327;11031.944840275748;11067;11297.491612877277;11311.151663625096;11669.416529173677;11954.163208575315;12003.579874704343;12273.754524909631;12374.010079193822;8990.145936136056;9024.909750902669;9094.818103638023;9172.6789562365;9918.652847150315;8893.333000024895;8934.436473617221;9191.21874640663;9361.297902657192;9420.717378478657 22:18:46 INFO - PROCESS | 32630 | __end_tp_report 22:18:46 INFO - PROCESS | 32630 | __start_cc_report 22:18:46 INFO - PROCESS | 32630 | _x_x_mozilla_cycle_collect,949 22:18:46 INFO - PROCESS | 32630 | __end_cc_report 22:18:46 INFO - PROCESS | 32630 | __startTimestamp1453789126971__endTimestamp 22:18:46 INFO - PROCESS | 32630 | 22:18:46 INFO - PROCESS | 32630 | ------- Summary: start ------- 22:18:46 INFO - PROCESS | 32630 | Number of tests: 6 22:18:46 INFO - PROCESS | 32630 | 22:18:46 INFO - PROCESS | 32630 | [#0] dojo.html Cycles:165 Average:5161.64 Median:5329.92 stddev:586.88 (11.0%) stddev-sans-first:565.74 22:18:46 INFO - PROCESS | 32630 | Values: 3090.3 3129.3 3176.7 3178.6 3204.7 4991.9 5050.4 5217.1 5268.5 5289.7 5137.8 5166.7 5179.4 5195.7 5231.7 4745.5 4781.3 4792.2 4860.1 4904.8 4725.0 4757.8 4804.3 4819.5 4904.5 4709.6 4793.5 4821.1 4894.0 4919.2 4648.7 4688.5 4699.5 4705.4 4707.2 4689.9 4692.9 4698.8 4700.7 4741.4 4891.6 4969.1 4972.5 4981.5 5027.9 5523.3 5593.1 5660.5 5675.3 5693.9 5499.3 5503.4 5507.8 5513.3 5548.7 5147.4 5147.8 5148.8 5157.7 5197.8 5584.7 5586.0 5634.4 5676.2 5702.3 5482.1 5490.4 5492.1 5495.9 5498.6 5576.7 5578.1 5581.2 5584.6 5587.7 5382.3 5505.2 5571.9 5594.6 5657.6 5407.0 5433.8 5442.0 5446.0 5457.7 4083.3 4126.6 4130.8 4161.0 4173.9 3687.1 3698.0 3718.8 3725.9 3757.9 5148.3 5207.0 5212.1 5213.7 5216.5 5312.9 5380.7 5623.6 5625.1 5638.1 5194.3 5227.2 5258.8 5261.4 5300.4 4723.3 4736.1 4743.2 4743.8 4784.5 5732.7 5741.3 5748.0 5824.3 5841.1 5533.6 5659.6 5696.0 5697.6 5701.9 5869.9 5906.6 5908.0 5909.8 5914.4 5384.4 5410.1 5524.5 5578.5 5609.9 5607.7 5610.6 5619.3 5651.5 5664.9 5516.6 5541.0 5543.4 5544.7 5549.8 5275.0 5307.9 5339.0 5380.8 5414.2 5347.1 5363.1 5364.3 5367.1 5368.6 5314.7 5471.2 5474.1 5476.8 5508.2 5229.5 5282.9 5301.7 5329.9 5374.5 22:18:46 INFO - PROCESS | 32630 | 22:18:46 INFO - PROCESS | 32630 | [#1] ext.html Cycles:180 Average:46994.76 Median:19045.01 stddev:87454.17 (459.2%) stddev-sans-first:87629.91 22:18:46 INFO - PROCESS | 32630 | Values: 530.1 535.4 545.7 552.8 590.9 28041.4 28884.4 28889.1 28902.1 28906.7 29362.7 29828.7 36302.0 36941.0 37032.8 8352.6 8500.4 8506.1 8507.8 8518.0 8273.1 8357.2 8372.1 8404.5 8412.5 8376.4 8449.6 8454.5 8457.2 8473.1 8529.7 8603.5 8616.0 8616.7 8616.8 8418.8 8539.2 8541.2 8548.9 8550.5 38898.0 39292.2 39327.2 39332.6 39415.6 3099.1 3134.6 3430.9 3476.2 3689.2 29630.7 30225.5 30265.8 30411.8 30665.0 3902.5 3929.5 3949.7 3957.9 3985.0 256002.0 256991.0 257724.0 257971.0 258179.0 41487.4 51820.0 52817.2 57236.0 57355.7 39442.4 39549.6 39632.0 39662.4 39680.4 13377.1 13528.5 13528.9 13539.9 13546.2 9717.7 9878.3 10478.1 10508.8 10724.7 13632.5 13677.4 13715.2 13779.6 13810.4 5470.7 5572.2 5590.3 5600.9 5636.5 931.3 950.7 1001.0 1045.6 1056.1 28878.7 28997.6 29844.4 30957.0 31165.5 1013.1 1030.7 1077.3 1099.5 1164.3 15785.8 16395.3 17023.7 17275.5 17356.5 429738.0 434039.0 434726.0 434780.0 436655.0 51451.7 51871.5 51874.0 51899.5 52014.5 1381.6 1389.8 1400.9 1401.3 1405.1 27879.0 29338.6 29940.6 30907.7 31489.5 47230.5 47658.3 47763.3 47778.8 47808.0 260860.0 266966.0 274544.0 278769.0 280724.0 30726.7 30732.0 30734.8 30768.8 30813.7 38618.6 39698.2 40196.6 40235.6 40259.2 34206.3 34542.7 34613.8 34885.0 38219.4 32104.2 32613.0 32991.3 33066.3 37867.4 32660.7 33417.5 33708.5 33786.8 33843.8 28187.3 29307.4 30315.8 37253.8 39076.4 24927.1 25418.7 25442.0 25451.6 25904.4 22:18:46 INFO - PROCESS | 32630 | 22:18:46 INFO - PROCESS | 32630 | [#2] jquery.html Cycles:180 Average:27051.63 Median:5051.37 stddev:88954.60 (1761.0%) stddev-sans-first:89181.56 22:18:46 INFO - PROCESS | 32630 | Values: 363.8 364.5 365.6 367.4 372.3 13304.0 13532.8 15408.8 16039.4 16915.9 13745.3 14305.1 14767.5 14783.9 14785.3 5100.6 5282.1 5287.3 5287.9 5288.8 3851.4 3949.6 5198.1 5258.6 5582.7 5756.8 5776.9 5803.7 5806.0 5813.7 4957.6 5139.9 5151.8 5168.3 5168.7 4824.2 4933.4 5011.9 5050.9 5051.9 11924.4 12301.6 12436.8 12503.5 12504.2 2020.7 2033.6 2042.8 2115.2 2218.0 8956.0 8995.7 9367.3 9405.1 9410.2 1802.4 1829.3 1850.2 1883.7 1919.8 48004.5 51096.5 51546.7 51577.7 54868.1 8972.5 9189.8 9353.5 9358.7 9435.6 12068.1 12081.5 12091.8 12100.8 12102.6 6993.4 7202.6 7205.2 7246.5 7263.1 6933.9 7002.2 7018.2 7048.7 7054.4 4080.9 4175.6 4197.0 4205.2 4237.2 1678.8 1750.4 1759.1 1811.1 1840.1 871.7 933.4 941.6 974.9 989.0 15966.8 16291.3 16515.8 16561.8 16586.9 914.8 920.2 921.9 935.6 958.4 6776.5 9105.5 9121.7 9445.1 9541.7 517411.0 534354.0 549724.0 558075.0 562042.0 69564.3 72314.3 72559.0 72586.0 74034.6 1079.0 1107.1 1114.3 1117.9 1123.2 14748.0 14966.6 15158.5 15241.7 15305.4 31698.2 32458.5 32501.0 32815.8 33091.0 40679.4 41264.8 42426.6 42557.6 43831.3 7191.7 7389.9 7647.7 7715.1 7733.6 10413.8 11053.1 11408.5 11651.9 11838.2 9892.8 10089.5 10119.2 10297.0 10525.4 9911.4 9915.1 10005.4 10172.4 10181.4 9549.4 9553.0 9784.3 9969.4 10387.6 7291.3 7663.9 7674.0 7754.1 7776.6 7477.3 8381.8 9065.7 9208.1 9381.2 22:18:46 INFO - PROCESS | 32630 | 22:18:46 INFO - PROCESS | 32630 | [#3] mootools.html Cycles:180 Average:5312.43 Median:6268.48 stddev:2779.18 (44.3%) stddev-sans-first:2770.12 22:18:46 INFO - PROCESS | 32630 | Values: 1240.1 1438.9 1439.2 1580.4 1740.0 6541.4 7360.4 7520.2 7525.7 7561.8 7389.7 7417.2 7496.2 7499.7 7518.1 1917.4 1964.7 2236.3 2247.4 2280.7 2236.6 2298.1 2301.4 2302.7 2302.9 2217.3 2248.6 2248.8 2249.0 2260.2 1845.1 1889.7 2198.5 2236.7 2260.7 2188.0 2218.2 2257.1 2257.1 2257.1 7462.3 7517.1 7524.9 7527.5 7535.5 4430.7 4555.5 4592.7 4595.1 4596.1 2946.1 2973.4 3015.2 3036.5 3074.8 915.2 921.9 926.3 928.2 936.6 10655.0 10668.7 10670.1 10677.4 10688.3 4240.3 4284.9 4380.8 4408.7 4440.8 9037.0 9056.2 9064.2 9065.7 9066.1 4718.8 4729.0 4729.7 4730.4 4731.3 4257.7 4296.9 4300.3 4303.2 4318.3 3574.3 3626.9 3627.2 3648.4 3649.5 1172.1 1175.7 1180.5 1193.0 1198.8 1238.7 1256.4 1262.5 1282.1 1291.8 6379.1 6504.6 6888.8 7078.6 7088.5 610.9 629.7 638.8 642.2 642.7 5545.1 5550.6 5599.6 5618.1 5635.9 8835.5 9189.5 9206.5 9221.0 9222.1 9149.7 9160.8 9293.7 9305.1 9316.5 6948.5 7086.6 7182.5 7185.0 7190.2 6951.1 7001.6 7077.4 7084.9 7094.1 8044.0 8241.8 8342.9 8344.4 8353.1 8284.3 8390.2 8595.9 8615.0 8623.0 6843.8 6962.8 6984.7 7006.9 7009.8 7355.7 7411.1 7427.9 7435.6 7441.0 6572.3 6665.1 6776.9 6779.6 6853.3 6267.1 6345.2 6393.1 6417.3 6636.1 5919.1 6274.5 6737.4 6779.3 6796.2 6211.3 6215.7 6257.2 6269.8 6271.2 6204.8 6252.6 6255.0 6258.3 6261.8 22:18:46 INFO - PROCESS | 32630 | 22:18:46 INFO - PROCESS | 32630 | [#4] prototype.html Cycles:180 Average:5275.69 Median:5958.11 stddev:1595.53 (26.8%) stddev-sans-first:1556.36 22:18:46 INFO - PROCESS | 32630 | Values: 337.7 342.1 347.2 349.6 355.5 5748.9 5928.5 5947.2 5952.9 5966.8 5728.0 5899.0 5916.9 5937.8 5954.5 4570.6 4571.4 4573.6 4574.1 4575.8 4345.5 4413.2 4414.4 4416.1 4573.0 4381.8 4473.7 4538.5 4541.8 4563.4 4512.1 4516.8 4529.1 4531.2 4594.7 4047.6 4060.9 4063.3 4077.4 4084.6 5484.1 5634.7 5645.5 5672.4 5689.3 5262.1 5268.9 5271.4 5273.5 5276.7 5901.7 6301.3 6305.6 6317.1 6326.9 4142.0 4218.2 4266.3 4277.0 4282.6 6443.6 6612.0 6631.6 6644.6 6645.8 4399.4 4402.7 4405.7 4406.5 4417.4 4383.5 4461.7 4464.6 4519.0 4571.1 5253.5 5254.4 5257.7 5260.2 5260.4 6288.3 6303.6 6310.2 6311.0 6315.7 1582.8 1617.3 1618.7 1619.3 1619.7 1030.7 1053.8 1071.5 1080.9 1082.9 5992.8 5994.2 6006.6 6014.8 6016.8 6479.8 6498.0 6505.8 6518.4 6526.9 5945.3 5961.7 5961.9 5972.1 5980.3 3421.5 3552.8 3556.7 3558.3 3560.0 6818.3 6851.7 6857.6 6865.7 6882.4 6739.3 6746.4 6746.8 6781.3 6809.2 6624.9 6839.4 6856.6 6880.9 6884.7 6302.6 6454.2 6551.7 6596.9 6607.4 6224.5 6437.7 6469.6 6483.6 6485.5 6806.5 6818.7 6842.3 6862.0 6864.8 4541.6 4602.0 4631.6 4634.4 4644.9 6431.3 6488.9 6489.5 6493.3 6501.3 6326.0 6327.9 6329.8 6331.6 6332.1 6169.6 6264.4 6274.4 6294.5 6301.3 6171.9 6172.2 6181.2 6197.4 6197.7 6327.3 6331.3 6335.9 6355.5 6359.9 6061.2 6194.3 6206.0 6211.7 6216.6 22:18:46 INFO - PROCESS | 32630 | 22:18:46 INFO - PROCESS | 32630 | [#5] yui.html Cycles:180 Average:13880.67 Median:45867.43 stddev:16149.22 (35.2%) stddev-sans-first:16164.36 22:18:46 INFO - PROCESS | 32630 | Values: 735.8 736.5 835.2 835.9 841.8 15291.0 15736.2 15843.8 15846.9 15872.2 14112.1 14131.1 14148.1 14166.9 14194.4 659.8 667.5 793.8 803.5 805.9 795.0 797.0 803.8 809.9 810.0 836.1 849.0 849.4 850.0 850.3 680.9 694.1 828.3 836.3 846.9 615.1 618.5 619.3 621.0 621.7 13012.3 13045.2 13061.3 13075.3 13171.1 12021.5 12138.6 12410.7 12414.5 12709.4 10461.6 10504.4 10600.6 10660.3 10681.5 3531.4 3585.9 3651.4 3693.7 3694.5 49671.5 49732.3 49816.5 49908.0 49978.0 9745.3 9940.0 10035.9 10061.8 10137.6 17569.1 17572.8 17575.8 17584.6 17593.5 7038.6 7190.8 7301.0 7407.7 7426.6 3907.8 3908.9 4023.3 4050.5 4118.4 2982.7 3027.7 3037.6 3038.3 3042.0 551.9 554.4 555.2 562.5 570.0 532.4 553.4 635.7 664.1 703.5 9523.1 9639.5 9784.8 9823.1 9941.9 491.9 503.0 504.9 513.7 536.9 3922.5 3944.8 4063.4 4145.4 4161.5 58509.7 60249.1 60265.7 60388.7 60392.7 51073.2 51583.5 51584.2 51862.0 52650.5 44406.3 44573.1 44936.3 46798.5 47154.3 6894.6 8138.7 8420.8 8435.6 8490.3 33553.8 34273.3 34675.3 34801.7 34874.8 41957.4 42548.8 43349.8 43755.0 44278.6 10218.1 10366.6 10946.9 10963.2 11461.3 11516.8 11905.2 12139.0 12217.6 12280.3 10923.3 10962.5 10969.5 10984.0 11694.2 10885.7 11031.9 11067.0 11297.5 11311.2 11669.4 11954.2 12003.6 12273.8 12374.0 8990.1 9024.9 9094.8 9172.7 9918.7 8893.3 8934.4 9191.2 9361.3 9420.7 22:18:46 INFO - PROCESS | 32630 | -------- Summary: end -------- 22:18:46 INFO - PROCESS | 32630 | 22:18:47 INFO - TEST-INFO | 32630: exit 0 22:18:47 INFO - TEST-OK | dromaeo_css | took 1113402ms 22:18:47 INFO - TEST-START | kraken 22:18:47 INFO - operating with platform_type : linux_ 22:18:47 INFO - Initialising browser for kraken test... 22:18:47 INFO - TEST-INFO | started process 364 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmlnYk4/profile http://localhost:49683/getInfo.html) 22:18:52 INFO - PROCESS | 364 | __metrics Screen width/height:1600/1200 22:18:52 INFO - PROCESS | 364 | colorDepth:24 22:18:52 INFO - PROCESS | 364 | Browser inner width/height: 1024/697 22:18:52 INFO - PROCESS | 364 | __metrics 22:18:52 INFO - PROCESS | 364 | 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:18:52 INFO - PROCESS | 364 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:18:53 INFO - TEST-INFO | 364: exit 0 22:18:53 INFO - Browser initialized. 22:18:53 INFO - Running cycle 1/1 for kraken test... 22:18:53 INFO - TEST-INFO | started process 449 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmlnYk4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:05 INFO - PROCESS | 449 | RSS: Main: 148340736 22:19:05 INFO - PROCESS | 449 | 22:19:07 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49683/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:08 INFO - PROCESS | 449 | RSS: Main: 188272640 22:19:08 INFO - PROCESS | 449 | 22:19:10 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49683/tests/kraken/driver.html?testName=audio-dft) 22:19:11 INFO - PROCESS | 449 | RSS: Main: 179519488 22:19:11 INFO - PROCESS | 449 | 22:19:14 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49683/tests/kraken/driver.html?testName=audio-fft) 22:19:14 INFO - PROCESS | 449 | RSS: Main: 163557376 22:19:14 INFO - PROCESS | 449 | 22:19:16 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49683/tests/kraken/driver.html?testName=audio-oscillator) 22:19:17 INFO - PROCESS | 449 | RSS: Main: 167055360 22:19:17 INFO - PROCESS | 449 | 22:19:19 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49683/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:20 INFO - PROCESS | 449 | RSS: Main: 168476672 22:19:20 INFO - PROCESS | 449 | 22:19:23 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49683/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:23 INFO - PROCESS | 449 | RSS: Main: 168386560 22:19:23 INFO - PROCESS | 449 | 22:19:27 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49683/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:27 INFO - PROCESS | 449 | RSS: Main: 169164800 22:19:27 INFO - PROCESS | 449 | 22:19:30 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49683/tests/kraken/driver.html?testName=json-parse-financial) 22:19:31 INFO - PROCESS | 449 | RSS: Main: 168214528 22:19:31 INFO - PROCESS | 449 | 22:19:32 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49683/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:33 INFO - PROCESS | 449 | RSS: Main: 179523584 22:19:33 INFO - PROCESS | 449 | 22:19:35 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:35 INFO - PROCESS | 449 | RSS: Main: 179617792 22:19:35 INFO - PROCESS | 449 | 22:19:37 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:38 INFO - PROCESS | 449 | RSS: Main: 189673472 22:19:38 INFO - PROCESS | 449 | 22:19:40 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:19:41 INFO - PROCESS | 449 | RSS: Main: 198520832 22:19:41 INFO - PROCESS | 449 | 22:19:43 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:19:44 INFO - PROCESS | 449 | RSS: Main: 194129920 22:19:44 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49683/tests/kraken/driver.html?testName=ai-astar) 22:19:46 INFO - PROCESS | 449 | RSS: Main: 254672896 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | __start_tp_report 22:19:46 INFO - PROCESS | 449 | _x_x_mozilla_page_load 22:19:46 INFO - PROCESS | 449 | _x_x_mozilla_page_load_details 22:19:46 INFO - PROCESS | 449 | |i|pagename|runs| 22:19:46 INFO - PROCESS | 449 | |0;ai-astar;112;110;106;111;110;111;110;111;104;110 22:19:46 INFO - PROCESS | 449 | |1;audio-beat-detection;152;129;149;173;123;153;146;131;169;126 22:19:46 INFO - PROCESS | 449 | |2;audio-dft;161;159;160;159;160;163;161;160;160;162 22:19:46 INFO - PROCESS | 449 | |3;audio-fft;72;72;107;92;73;73;76;117;109;73 22:19:46 INFO - PROCESS | 449 | |4;audio-oscillator;95;97;149;95;96;96;141;94;95;152 22:19:46 INFO - PROCESS | 449 | |5;imaging-gaussian-blur;118;115;115;115;115;114;115;115;115;115 22:19:46 INFO - PROCESS | 449 | |6;imaging-darkroom;146;145;146;145;146;146;146;146;146;145 22:19:46 INFO - PROCESS | 449 | |7;imaging-desaturate;95;96;96;97;97;96;96;97;96;96 22:19:46 INFO - PROCESS | 449 | |8;json-parse-financial;57;56;55;56;56;56;55;55;57;54 22:19:46 INFO - PROCESS | 449 | |9;json-stringify-tinderbox;67;66;73;65;67;66;66;66;68;66 22:19:46 INFO - PROCESS | 449 | |10;stanford-crypto-aes;81;83;84;83;83;84;82;86;83;83 22:19:46 INFO - PROCESS | 449 | |11;stanford-crypto-ccm;115;114;123;117;114;127;124;122;116;115 22:19:46 INFO - PROCESS | 449 | |12;stanford-crypto-pbkdf2;144;139;148;149;148;139;151;143;144;138 22:19:46 INFO - PROCESS | 449 | |13;stanford-crypto-sha256-iterative;67;69;68;67;68;69;68;70;68;68 22:19:46 INFO - PROCESS | 449 | __end_tp_report 22:19:46 INFO - PROCESS | 449 | __start_cc_report 22:19:46 INFO - PROCESS | 449 | _x_x_mozilla_cycle_collect,934 22:19:46 INFO - PROCESS | 449 | __end_cc_report 22:19:46 INFO - PROCESS | 449 | __startTimestamp1453789186342__endTimestamp 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | ------- Summary: start ------- 22:19:46 INFO - PROCESS | 449 | Number of tests: 14 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.51 (2.3%) stddev-sans-first:2.49 22:19:46 INFO - PROCESS | 449 | Values: 112.0 110.0 106.0 111.0 110.0 111.0 110.0 111.0 104.0 110.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:150.50 stddev:17.60 (11.7%) stddev-sans-first:18.49 22:19:46 INFO - PROCESS | 449 | Values: 152.0 129.0 149.0 173.0 123.0 153.0 146.0 131.0 169.0 126.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 22:19:46 INFO - PROCESS | 449 | Values: 161.0 159.0 160.0 159.0 160.0 163.0 161.0 160.0 160.0 162.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#3] audio-fft Cycles:10 Average:86.40 Median:73.00 stddev:18.15 (24.9%) stddev-sans-first:18.49 22:19:46 INFO - PROCESS | 449 | Values: 72.0 72.0 107.0 92.0 73.0 73.0 76.0 117.0 109.0 73.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:95.00 stddev:25.23 (26.6%) stddev-sans-first:26.09 22:19:46 INFO - PROCESS | 449 | Values: 95.0 97.0 149.0 95.0 96.0 96.0 141.0 94.0 95.0 152.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.03 (0.9%) stddev-sans-first:0.33 22:19:46 INFO - PROCESS | 449 | Values: 118.0 115.0 115.0 115.0 115.0 114.0 115.0 115.0 115.0 115.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:19:46 INFO - PROCESS | 449 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 22:19:46 INFO - PROCESS | 449 | Values: 95.0 96.0 96.0 97.0 97.0 96.0 96.0 97.0 96.0 96.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:0.95 (1.7%) stddev-sans-first:0.88 22:19:46 INFO - PROCESS | 449 | Values: 57.0 56.0 55.0 56.0 56.0 56.0 55.0 55.0 57.0 54.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:66.50 stddev:2.26 (3.4%) stddev-sans-first:2.40 22:19:46 INFO - PROCESS | 449 | Values: 67.0 66.0 73.0 65.0 67.0 66.0 66.0 66.0 68.0 66.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:1.32 (1.6%) stddev-sans-first:1.13 22:19:46 INFO - PROCESS | 449 | Values: 81.0 83.0 84.0 83.0 83.0 84.0 82.0 86.0 83.0 83.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:119.50 stddev:4.81 (4.0%) stddev-sans-first:4.91 22:19:46 INFO - PROCESS | 449 | Values: 115.0 114.0 123.0 117.0 114.0 127.0 124.0 122.0 116.0 115.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:146.00 stddev:4.62 (3.2%) stddev-sans-first:4.90 22:19:46 INFO - PROCESS | 449 | Values: 144.0 139.0 148.0 149.0 148.0 139.0 151.0 143.0 144.0 138.0 22:19:46 INFO - PROCESS | 449 | 22:19:46 INFO - PROCESS | 449 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 22:19:46 INFO - PROCESS | 449 | Values: 67.0 69.0 68.0 67.0 68.0 69.0 68.0 70.0 68.0 68.0 22:19:46 INFO - PROCESS | 449 | -------- Summary: end -------- 22:19:46 INFO - PROCESS | 449 | 22:19:47 INFO - TEST-INFO | 449: exit 0 22:19:47 INFO - TEST-OK | kraken | took 59590ms 22:19:47 INFO - TEST-START | v8_7 22:19:47 INFO - operating with platform_type : linux_ 22:19:47 INFO - Initialising browser for v8_7 test... 22:19:47 INFO - TEST-INFO | started process 701 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp52B6KO/profile http://localhost:49683/getInfo.html) 22:19:52 INFO - PROCESS | 701 | __metrics Screen width/height:1600/1200 22:19:52 INFO - PROCESS | 701 | colorDepth:24 22:19:52 INFO - PROCESS | 701 | Browser inner width/height: 1024/697 22:19:52 INFO - PROCESS | 701 | __metrics 22:19:52 INFO - PROCESS | 701 | 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:19:52 INFO - PROCESS | 701 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:19:53 INFO - TEST-INFO | 701: exit 0 22:19:53 INFO - Browser initialized. 22:19:53 INFO - Running cycle 1/1 for v8_7 test... 22:19:53 INFO - TEST-INFO | started process 782 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp52B6KO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:05 INFO - PROCESS | 782 | RSS: Main: 148172800 22:20:05 INFO - PROCESS | 782 | 22:20:27 INFO - PROCESS | 782 | Cycle 1(1): loaded http://localhost:49683/tests/v8_7/run.html (next: http://localhost:49683/tests/v8_7/run.html) 22:20:28 INFO - PROCESS | 782 | RSS: Main: 477663232 22:20:28 INFO - PROCESS | 782 | 22:20:28 INFO - PROCESS | 782 | __start_tp_report 22:20:28 INFO - PROCESS | 782 | _x_x_mozilla_page_load 22:20:28 INFO - PROCESS | 782 | _x_x_mozilla_page_load_details 22:20:28 INFO - PROCESS | 782 | |i|pagename|runs| 22:20:28 INFO - PROCESS | 782 | |0;Richards;167.33601070950468 22:20:28 INFO - PROCESS | 782 | |1;DeltaBlue;189.6813353566009 22:20:28 INFO - PROCESS | 782 | |2;Encrypt;272.92576419213975 22:20:28 INFO - PROCESS | 782 | |3;Decrypt;5291.005291005291 22:20:28 INFO - PROCESS | 782 | |4;RayTrace;1934.2359767891683 22:20:28 INFO - PROCESS | 782 | |5;Earley;801.924619085806 22:20:28 INFO - PROCESS | 782 | |6;Boyer;12456.79012345679 22:20:28 INFO - PROCESS | 782 | |7;RegExp;41612.244897959186 22:20:28 INFO - PROCESS | 782 | |8;Splay;631.3131313131313 22:20:28 INFO - PROCESS | 782 | |9;NavierStokes;4817.307692307692 22:20:28 INFO - PROCESS | 782 | __end_tp_report 22:20:28 INFO - PROCESS | 782 | __startTimestamp1453789228187__endTimestamp 22:20:28 INFO - PROCESS | 782 | 22:20:28 INFO - PROCESS | 782 | ------- Summary: start ------- 22:20:28 INFO - PROCESS | 782 | Number of tests: 10 22:20:28 INFO - PROCESS | 782 | 22:20:28 INFO - PROCESS | 782 | [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 22:20:28 INFO - PROCESS | 782 | Values: 167.3 22:20:28 INFO - PROCESS | 782 | 22:20:28 INFO - PROCESS | 782 | [#1] DeltaBlue Cycles:1 Average:189.68 Median:189.68 stddev:0.00 (0.0%) 22:20:28 INFO - PROCESS | 782 | Values: 189.7 22:20:28 INFO - PROCESS | 782 | 22:20:28 INFO - PROCESS | 782 | [#2] Encrypt Cycles:1 Average:272.93 Median:272.93 stddev:0.00 (0.0%) 22:20:28 INFO - PROCESS | 782 | Values: 272.9 22:20:28 INFO - PROCESS | 782 | 22:20:28 INFO - PROCESS | 782 | [#3] Decrypt Cycles:1 Average:5291.01 Median:5291.01 stddev:0.00 (0.0%) 22:20:28 INFO - PROCESS | 782 | Values: 5291.0 22:20:28 INFO - PROCESS | 782 | 22:20:28 INFO - PROCESS | 782 | [#4] RayTrace Cycles:1 Average:1934.24 Median:1934.24 stddev:0.00 (0.0%) 22:20:28 INFO - PROCESS | 782 | Values: 1934.2 22:20:28 INFO - PROCESS | 782 | 22:20:28 INFO - PROCESS | 782 | [#5] Earley Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 22:20:28 INFO - PROCESS | 782 | Values: 801.9 22:20:28 INFO - PROCESS | 782 | 22:20:28 INFO - PROCESS | 782 | [#6] Boyer Cycles:1 Average:12456.79 Median:12456.79 stddev:0.00 (0.0%) 22:20:28 INFO - PROCESS | 782 | Values: 12456.8 22:20:28 INFO - PROCESS | 782 | 22:20:28 INFO - PROCESS | 782 | [#7] RegExp Cycles:1 Average:41612.24 Median:41612.24 stddev:0.00 (0.0%) 22:20:28 INFO - PROCESS | 782 | Values: 41612.2 22:20:28 INFO - PROCESS | 782 | 22:20:28 INFO - PROCESS | 782 | [#8] Splay Cycles:1 Average:631.31 Median:631.31 stddev:0.00 (0.0%) 22:20:28 INFO - PROCESS | 782 | Values: 631.3 22:20:28 INFO - PROCESS | 782 | 22:20:28 INFO - PROCESS | 782 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 22:20:28 INFO - PROCESS | 782 | Values: 4817.3 22:20:28 INFO - PROCESS | 782 | -------- Summary: end -------- 22:20:28 INFO - PROCESS | 782 | 22:20:29 INFO - TEST-INFO | 782: exit 0 22:20:29 INFO - TEST-OK | v8_7 | took 41782ms 22:20:29 INFO - SUITE-END | took 1214s 22:20:29 INFO - Completed test suite (00:20:14) 22:20:29 INFO - Working with test: dromaeo_css 22:20:29 INFO - Generating results file: dromaeo_css 22:20:29 INFO - Working with test: kraken 22:20:29 INFO - Generating results file: kraken 22:20:29 INFO - javascript benchmark 22:20:29 INFO - Working with test: v8_7 22:20:29 INFO - Generating results file: v8_7 22:20:29 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:20:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:20:29 INFO - process_Request line: dromaeo_css 6699.45 graph.html#tests=[[72,63,35]] 22:20:29 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:20:29 INFO - process_Request line: kraken 1506.70 graph.html#tests=[[232,63,35]] 22:20:29 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:20:29 INFO - process_Request line: v8_7 18840.59 graph.html#tests=[[230,63,35]] 22:20:29 INFO - RETURN: dromaeo_css: 6699.45 22:20:29 INFO - RETURN: kraken: 1506.70 22:20:29 INFO - RETURN: v8_7: 18840.59 22:20:29 INFO - javascript benchmark 22:20:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3090.2892334763005, 3129.295908420604, 3176.7140957313836, 3178.6185657721076, 3204.679532046795, 4991.925121123177, 5050.368703912011, 5217.113090774568, 5268.525832675054, 5289.682619042856, 5137.820176293831, 5166.664166829153, 5179.378474583046, 5195.740212989354, 5231.686098834072, 4745.477997420289, 4781.330613714083, 4792.161371759928, 4860.05228980349, 4904.803807847682, 4725.0, 4757.83433058901, 4804.327394164819, 4819.493953134923, 4904.5340692634145, 4709.62323014158, 4793.49668284832, 4821.083994041156, 4894.045661096087, 4919.1637421638225, 4648.74431906245, 4688.46082700487, 4699.483056863743, 4705.411823522059, 4707.246840505502, 4689.88275293117, 4692.859214223578, 4698.765061746899, 4700.694454860423, 4741.431028276629, 4891.608671306287, 4969.055879382906, 4972.502749725035, 4981.476944920767, 5027.924581131286, 5523.28197334344, 5593.105103183471, 5660.490555849952, 5675.31896172462, 5693.914591281134, 5499.285092937893, 5503.449655034505, 5507.779688812483, 5513.3108361454815, 5548.667079975215, 5147.4080480744815, 5147.768350424202, 5148.845534633967, 5157.71632560209, 5197.818076367309, 5584.692841893653, 5586.022446071921, 5634.408387119375, 5676.233708449389, 5702.315722113373, 5482.122860342326, 5490.396056433789, 5492.066348720727, 5495.917561236584, 5498.615096943176, 5576.721163941867, 5578.107502799533, 5581.190727344512, 5584.553235741131, 5587.692676902728, 5382.327209098863, 5505.201745746845, 5571.916421253684, 5594.608377413542, 5657.57568182388, 5407.0, 5433.782648694008, 5442.0, 5446.019716451076, 5457.699826509501, 4083.3262511685834, 4126.628603425706, 4130.752154870717, 4161.042960119129, 4173.916521669549, 3687.0597997510463, 3697.9645699204266, 3718.8140592970244, 3725.9441108383394, 3757.887263382103, 5148.304978827885, 5207.0, 5212.113940630102, 5213.661112027706, 5216.530512253916, 5312.92030619541, 5380.650257733235, 5623.606347555714, 5625.128105143709, 5638.097904335286, 5194.272801807674, 5227.18978558324, 5258.763355648928, 5261.394939581921, 5300.390455097636, 4723.267893476516, 4736.147493451212, 4743.169945259566, 4743.762811859393, 4784.521547845257, 5732.742026608813, 5741.339745929272, 5747.971260143672, 5824.271966004334, 5841.123831425235, 5533.612647114664, 5659.6321239119325, 5696.031674615242, 5697.601167918206, 5701.885962280814, 5869.853253668693, 5906.645601263938, 5908.0, 5909.8227053188475, 5914.4381283777975, 5384.380796208487, 5410.107332290286, 5524.502794748492, 5578.497935185853, 5609.859753506195, 5607.663540187602, 5610.607257491936, 5619.325680918316, 5651.519620832275, 5664.85837854057, 5516.558675305886, 5541.002619528524, 5543.417941116125, 5544.695041772741, 5549.805756798492, 5275.0, 5307.938412317629, 5339.0389729849, 5380.811671591476, 5414.187871819258, 5347.117725575236, 5363.115086010765, 5364.275822763877, 5367.141257398797, 5368.624196306221, 5314.734263286898, 5471.18826591144, 5474.124140137559, 5476.835694929158, 5508.173773933942, 5229.450907654642, 5282.920756188737, 5301.708406037705, 5329.920051199313, 5374.516293533601], "unit": "score", "name": "dojo.html", "value": 5122.978311621281}, {"lowerIsBetter": false, "replicates": [530.0644362699835, 535.3762866260804, 545.705319127671, 552.792702736474, 590.937951515091, 28041.43917121659, 28884.422311553757, 28889.1333260002, 28902.132936011953, 28906.710932890666, 29362.706372936264, 29828.701712982864, 36302.0, 36941.0, 37032.81483592578, 8352.582370881462, 8500.447470914401, 8506.106858779833, 8507.787305317386, 8518.0, 8273.089960104384, 8357.164283571625, 8372.079071302152, 8404.495730256174, 8412.453190542627, 8376.371772117116, 8449.619767110495, 8454.450460720065, 8457.19656632622, 8473.067962524117, 8529.658813647447, 8603.483790972561, 8615.966084069889, 8616.65533378664, 8616.827663446758, 8418.831623367498, 8539.188777066169, 8541.231289184003, 8548.914510854875, 8550.52972086535, 38898.0, 39292.21415571673, 39327.21345573072, 39332.606673933464, 39415.60584394148, 3099.1477343730653, 3134.639516455614, 3430.9485357719655, 3476.200473890994, 3689.196846636366, 29630.70369296301, 30225.546616800766, 30265.848670756506, 30411.847940760155, 30665.0, 3902.492675952108, 3929.528456585228, 3949.6840252779707, 3957.9010524736823, 3984.980075099635, 256002.0, 256991.0, 257724.0, 257971.0, 258179.0, 41487.377689334084, 51820.0, 52817.20774188313, 57236.0, 57355.71322143362, 39442.408363874565, 39549.60450395459, 39632.0, 39662.40506392407, 39680.404793928115, 13377.130486518345, 13528.526501572398, 13528.932355338357, 13539.86460135386, 13546.187228766306, 9717.708468745948, 9878.259130565237, 10478.109360704273, 10508.842367364343, 10724.678259652223, 13632.522861699794, 13677.384517696728, 13715.177089374669, 13779.586612401645, 13810.37853296604, 5470.671759694431, 5572.192032155314, 5590.301212348457, 5600.887982240332, 5636.464535869086, 931.2549960031947, 950.65482342486, 1000.9599616015278, 1045.6444808765057, 1056.1181413519796, 28878.711212887603, 28997.56503652447, 29844.40311193764, 30957.0, 31165.532517012263, 1013.1287093099928, 1030.7320096774893, 1077.342820879263, 1099.4612639806437, 1164.318873459019, 15785.842141578438, 16395.262213200436, 17023.744643830352, 17275.481735547954, 17356.4793056206, 429738.0, 434039.0, 434726.0, 434780.0, 436655.0, 51451.742741286806, 51871.48128518742, 51874.0, 51899.48100519022, 52014.47985520097, 1381.6407733989236, 1389.840168380629, 1400.9019368644301, 1401.3343661760582, 1405.1217988757028, 27879.0, 29338.55992160162, 29940.550891736206, 30907.69092309138, 31489.527657084705, 47230.527694722616, 47658.28512572245, 47763.28355074607, 47778.761106195634, 47808.0, 260860.0, 266966.0, 274544.0, 278769.0, 280724.0, 30726.692733072385, 30732.0, 30734.846325769122, 30768.846155769974, 30813.691863081083, 38618.6138138615, 39698.206035878546, 40196.598034020455, 40235.59764402318, 40259.19481610293, 34206.31587368189, 34542.65457345495, 34613.82693086519, 34885.0, 38219.42670859884, 32104.197395065312, 32613.0, 32991.340173195924, 33066.338673226885, 37867.431988520744, 32660.673393265763, 33417.49873751847, 33708.49437258394, 33786.83106584451, 33843.830780845936, 28187.295317617223, 29307.41385172327, 30315.848420757757, 37253.81373093117, 39076.41385379279, 24927.127550535643, 25418.745812542376, 25442.0, 25451.55015680168, 25904.352391189615], "unit": "score", "name": "ext.html", "value": 17500.01275529485}, {"lowerIsBetter": false, "replicates": [363.75083068098354, 364.52611604913625, 365.57958347899927, 367.40847235950116, 372.28707026045123, 13304.0, 13532.797008044887, 15408.845911540895, 16039.4386196483, 16915.915420422913, 13745.312734363268, 14305.141691498517, 14767.483138090169, 14783.852161478382, 14785.334659940301, 5100.591952643789, 5282.128448805943, 5287.312649355578, 5287.947120528784, 5288.8413347599635, 3851.383778595425, 3949.565547789741, 5198.116320225571, 5258.6318957672975, 5582.692951887665, 5756.798512052079, 5776.942230577703, 5803.73883175256, 5806.0, 5813.651180929137, 4957.553820156185, 5139.948600513984, 5151.8196863109615, 5168.250603662466, 5168.715720635363, 4824.228123500223, 4933.432655244621, 5011.874703132451, 5050.873728156789, 5051.873703157414, 11924.403779810975, 12301.56944506947, 12436.81344779829, 12503.49986000559, 12504.187227830253, 2020.6968954656772, 2033.6441122803599, 2042.7855075217185, 2115.2490865742748, 2217.977820221793, 8956.0, 8995.685151019683, 9367.250619950388, 9405.106514881143, 9410.200132988704, 1802.3781795280606, 1829.2774354130177, 1850.2044121027952, 1883.7456943312752, 1919.7888232294436, 48004.51995480035, 51096.489035109546, 51546.74226628918, 51577.742111289575, 54868.06187443109, 8972.506512141765, 9189.81620367589, 9353.485558294358, 9358.672446464341, 9435.575399107056, 12068.09489288307, 12081.45633446497, 12091.758164836654, 12100.81848772269, 12102.576409825613, 6993.440524758007, 7202.567845929157, 7205.171405288354, 7246.492745507764, 7263.0921134858145, 6933.861322773516, 7002.159740831133, 7018.1929078155645, 7048.718051277994, 7054.400375967997, 4080.8775736727944, 4175.64507016907, 4196.958030419718, 4205.222033923734, 4237.237297286456, 1678.7901512310962, 1750.422360620992, 1759.0764848454664, 1811.0944527736133, 1840.10469216707, 871.6817223876737, 933.355984370782, 941.5574679900436, 974.9122578967927, 988.980220395588, 15966.76049859253, 16291.348346066025, 16515.83484165167, 16561.751573726404, 16586.917065414596, 914.7530166854912, 920.1994264989369, 921.9124183202586, 935.5930170375908, 958.3755534369177, 6776.457883369319, 9105.499197544066, 9121.726348209564, 9445.14993650561, 9541.713748587554, 517411.0, 534354.0, 549724.0, 558075.0, 562042.0, 69564.3043569568, 72314.2768572318, 72559.0, 72586.0, 74034.6298268516, 1078.9568417263222, 1107.0866535108569, 1114.3202646385698, 1117.921745477825, 1123.2081382625393, 14748.0, 14966.625834353792, 15158.521300129722, 15241.748964718025, 15305.387784488496, 31698.207544811565, 32458.513122302713, 32501.0, 32815.835920820246, 33091.0, 40679.38980915229, 41264.793676031426, 42426.575734243495, 42557.57442425536, 43831.34252986272, 7191.748288809867, 7389.889151662622, 7647.655855486628, 7715.112762032438, 7733.574653393893, 10413.791724165625, 11053.11575073976, 11408.543658253577, 11651.941740291584, 11838.171328006956, 9892.752681183028, 10089.495525223856, 10119.190464762949, 10296.96239609302, 10525.368477891045, 9911.405315681082, 9915.058069483388, 10005.449700266556, 10172.440515771703, 10181.440020798927, 9549.379290346105, 9553.04469553039, 9784.315097943076, 9969.40183588987, 10387.584496620353, 7291.34377905991, 7663.923360766321, 7674.0, 7754.147043825287, 7776.572288524186, 7477.252274772479, 8381.790455238668, 9065.68270110543, 9208.12522810332, 9381.249500040118], "unit": "score", "name": "jquery.html", "value": 7871.1512943887665}, {"lowerIsBetter": false, "replicates": [1240.0513607090572, 1438.870501654851, 1439.1940513312545, 1580.4231455518739, 1740.0081953286624, 6541.37856903594, 7360.374368178711, 7520.247975202477, 7525.736599219028, 7561.773146805591, 7389.704411823521, 7417.221191774867, 7496.212897645751, 7499.700011999527, 7518.135414427329, 1917.424772568231, 1964.72493850861, 2236.2732112063604, 2247.404437823978, 2280.7377151627525, 2236.5974124657555, 2298.138198175684, 2301.3786277705008, 2302.654601809725, 2302.8618282902994, 2217.2904670505445, 2248.5840119577847, 2248.7976082152604, 2249.0329158461855, 2260.1750361118156, 1845.09590300753, 1889.7448844406103, 2198.5492973940304, 2236.7315922089374, 2260.660900864867, 2187.9671804922937, 2218.157100301891, 2257.0633187227445, 2257.0745994142485, 2257.108442165352, 7462.328390444886, 7517.060367454068, 7524.9247507525315, 7527.510711803715, 7535.472516923817, 4430.734155950653, 4555.4533455985165, 4592.701474404186, 4595.103954728829, 4596.126735920165, 2946.0867131189184, 2973.4201830643033, 3015.1858998070616, 3036.483797754387, 3074.769392295587, 915.2403505090825, 921.8893732752045, 926.2543652359848, 928.1878356438117, 936.5832204668925, 10655.041046305792, 10668.679939601901, 10670.146388288918, 10677.359358438442, 10688.305260158142, 4240.279152544075, 4284.8500302489265, 4380.759058251763, 4408.6913916026215, 4440.777961101932, 9037.0, 9056.230220431205, 9064.229540489001, 9065.728028159167, 9066.138716821892, 4718.787654555554, 4729.0, 4729.6689231754135, 4730.361401210793, 4731.313959475857, 4257.701960862772, 4296.892577685583, 4300.268954277781, 4303.2469317869245, 4318.265894797892, 3574.3387473317, 3626.854925802991, 3627.183883626163, 3648.434492653643, 3649.489071529988, 1172.0799172649429, 1175.6766889105565, 1180.4510902430238, 1193.021722187815, 1198.7722332756748, 1238.7089034076985, 1256.403208475985, 1262.5139321361157, 1282.0640932119418, 1291.8449786025737, 6379.075034120026, 6504.577202481823, 6888.758893438706, 7078.575285482888, 7088.468364872655, 610.8656095658948, 629.6757170057424, 638.8243233110838, 642.1876326447049, 642.7493277621732, 5545.112781954868, 5550.611457198038, 5599.552035837123, 5618.129189975561, 5635.8591035224445, 8835.514046727363, 9189.494577798152, 9206.539673016323, 9220.953895230481, 9222.077792220858, 9149.725508234764, 9160.770980725536, 9293.72118836436, 9305.069493050776, 9316.534173291308, 6948.513604047668, 7086.645667716593, 7182.533135346186, 7185.0, 7190.245024272481, 6951.0616066830335, 7001.614911179934, 7077.433805295461, 7084.858302833812, 7094.148702155774, 8043.959780201061, 8241.752747417588, 8342.87485687703, 8344.41589088758, 8353.0811610724, 8284.337253019865, 8390.244877961013, 8595.871061934202, 8614.956925215334, 8623.0, 6843.828904277433, 6962.7911162665205, 6984.685689144102, 7006.859862802818, 7009.824754381181, 7355.7057717690695, 7411.110666719813, 7427.925720742724, 7435.62821858894, 7441.0, 6572.34276572339, 6665.066890635412, 6776.898346524905, 6779.6271205084195, 6853.280405557544, 6267.122602835516, 6345.238571371465, 6393.073004414427, 6417.294097649348, 6636.070950066898, 5919.052951527735, 6274.466670333073, 6737.3599508046655, 6779.288174741581, 6796.184457865088, 6211.3478084800445, 6215.65813880241, 6257.2491301044165, 6269.843253918689, 6271.184745982993, 6204.844878878064, 6252.5935814171935, 6255.030470277115, 6258.280297765633, 6261.843453913506], "unit": "score", "name": "mootools.html", "value": 4317.847595634209}, {"lowerIsBetter": false, "replicates": [337.71294399760205, 342.1463448695505, 347.2135612836924, 349.63113914819854, 355.5040718198112, 5748.942510574893, 5928.49607783339, 5947.167396564484, 5952.910706339403, 5966.79116230932, 5727.971360143204, 5898.970505147479, 5916.88166236675, 5937.821865344035, 5954.523638108952, 4570.565796249351, 4571.38286331346, 4573.588377046065, 4574.1080489304595, 4575.839845605405, 4345.52199258083, 4413.205622987861, 4414.359917811916, 4416.072624748806, 4573.0, 4381.759003254836, 4473.709208901411, 4538.523455037223, 4541.750203738793, 4563.429571303587, 4512.075024619945, 4516.796744146522, 4529.139463501924, 4531.207038768219, 4594.678372513926, 4047.5952404759582, 4060.939085913714, 4063.288924438241, 4077.3883917412327, 4084.591540845892, 5484.095124304485, 5634.690092044936, 5645.491905728463, 5672.432756724335, 5689.345725241609, 5262.105442074857, 5268.947310526884, 5271.42014378418, 5273.472652734734, 5276.736163191864, 5901.675407852566, 6301.306856245809, 6305.621662700207, 6317.14718513004, 6326.87346253077, 4141.979290103561, 4218.177455396199, 4266.2960611499375, 4276.957230427718, 4282.5503322151035, 6443.645599492026, 6611.966940165316, 6631.568948018364, 6644.634545100018, 6645.833854153685, 4399.406080179135, 4402.679196241115, 4405.669574781904, 4406.537313582027, 4417.4036505072045, 4383.517813040563, 4461.665375096881, 4464.6428285737065, 4518.977405112953, 4571.108633816374, 5253.474652534716, 5254.448282930313, 5257.738142845689, 5260.237265596544, 5260.395054568774, 6288.339724328971, 6303.558750887486, 6310.1796766420075, 6311.0, 6315.684215789284, 1582.7784110224577, 1617.2641448141303, 1618.708632446171, 1619.2551426344014, 1619.6760647870474, 1030.7474668706216, 1053.8366553184114, 1071.517816982361, 1080.9189310801721, 1082.8917108289108, 5992.820215393458, 5994.190784244159, 6006.639601623917, 6014.789482368096, 6016.819495415057, 6479.773207937794, 6497.967510162419, 6505.772297969548, 6518.380753828379, 6526.869462610721, 5945.316288626776, 5961.701914904237, 5961.850953726105, 5972.074328479092, 5980.282366116007, 3421.4945424013854, 3552.8223588820456, 3556.6798988090677, 3558.3061303045656, 3560.0209942265565, 6818.28408017161, 6851.691673874688, 6857.622830744257, 6865.725370985205, 6882.414994725505, 6739.292374300628, 6746.359095885883, 6746.83132921671, 6781.287964763629, 6809.216940051859, 6624.900626490607, 6839.384455399038, 6856.554323968926, 6880.862382752217, 6884.690188941409, 6302.558820882494, 6454.1609590752905, 6551.70517326731, 6596.90104648421, 6607.438367738796, 6224.502039836711, 6437.7103030362805, 6469.644169570719, 6483.643399612878, 6485.513586480938, 6806.523543351917, 6818.659067046528, 6842.315768423118, 6862.0, 6864.828379290558, 4541.636669066401, 4601.953980460286, 4631.629469642353, 4634.443866736014, 4644.907101857876, 6431.292557818542, 6488.870222595616, 6489.545731798918, 6493.285738568659, 6501.349865013461, 6325.96837015812, 6327.936720632735, 6329.810105696836, 6331.556791024584, 6332.081848131903, 6169.56813023084, 6264.373562643699, 6274.403931626488, 6294.4964402846745, 6301.338359472189, 6171.9074213887725, 6172.197614310111, 6181.1655426516845, 6197.411245931629, 6197.690115494117, 6327.335629758809, 6331.303556608677, 6335.936640633535, 6355.491560675043, 6359.87280254383, 6061.242344706911, 6194.256689197326, 6206.0, 6211.65835879031, 6216.627002379872], "unit": "score", "name": "prototype.html", "value": 4761.751796895569}, {"lowerIsBetter": false, "replicates": [735.7719107076804, 736.5323019882374, 835.1523203947994, 835.9289460395865, 841.760098371964, 15291.0, 15736.21318934053, 15843.762343564857, 15846.920765396171, 15872.2063896805, 14112.082714623542, 14131.081479703838, 14148.080374775658, 14166.929165354184, 14194.432222711079, 659.8449364399386, 667.4827009067986, 793.7777422321744, 803.493798906688, 805.907320658123, 795.0340336491162, 796.9681212751483, 803.8111043904678, 809.8947136872198, 809.951402915827, 836.0844874862016, 849.0151424347758, 849.4308813095241, 849.995750021249, 850.2602735620019, 680.9421199198074, 694.1011390249614, 828.3249151941209, 836.2599099796694, 846.9153084691482, 615.123449085052, 618.5453691536717, 619.3249358199539, 621.018790311307, 621.7264403662374, 13012.349382530836, 13045.217286962812, 13061.346932653425, 13075.346232688327, 13171.143875648053, 12021.51913923442, 12138.635840924786, 12410.689732756662, 12414.503419863195, 12709.364531773374, 10461.633842815465, 10504.422256775873, 10600.628977985734, 10660.307080039773, 10681.519331630096, 3531.4173161428334, 3585.8565657373674, 3651.415773476231, 3693.7229707771758, 3694.538182727159, 49671.503284967046, 49732.25401619015, 49816.50183498155, 49908.0, 49978.0, 9745.269104817167, 9939.950300248596, 10035.949820250851, 10061.849072263922, 10137.64518241858, 17569.121543922753, 17572.824271757374, 17575.824241757673, 17584.648307034044, 17593.472195834147, 7038.577685338896, 7190.820229494305, 7300.9634951825965, 7407.740729074457, 7426.5915374654915, 3907.8468733760274, 3908.9210463544996, 4023.295923213426, 4050.4531888194715, 4118.402831589463, 2982.7315541600924, 3027.6820933802073, 3037.5747395364224, 3038.255627371264, 3042.0417568466305, 551.8510002299357, 554.431707499816, 555.2032832884743, 562.4768964862635, 569.9882708192907, 532.3558494221958, 553.4133818152771, 635.7012204263989, 664.1498881431775, 703.4794252253398, 9523.142917137491, 9639.518024098767, 9784.755381115529, 9823.11591956713, 9941.900580994097, 491.8647371972736, 503.02210911404575, 504.87630530520255, 513.6661170239374, 536.924830523727, 3922.5292964844402, 3944.7633142011573, 4063.4108054331955, 4145.440365550672, 4161.535099916525, 58509.70745146247, 60249.09626355608, 60265.69867150636, 60388.698056509435, 60392.69803650954, 51073.233901491505, 51583.48416515862, 51584.22623660573, 51862.0, 52650.47349526532, 44406.33390499145, 44573.10853782906, 44936.3259551107, 46798.532014680095, 47154.292685609056, 6894.586324820527, 8138.674453022049, 8420.789480262798, 8435.578221089043, 8490.32077433816, 33553.83223083869, 34273.31453370969, 34675.30649386947, 34801.65198347984, 34874.82562587171, 41957.37063944104, 42548.78725606352, 43349.78325108354, 43755.0, 44278.55721442744, 10218.080372766486, 10366.585336586753, 10946.890531094905, 10963.232573719763, 11461.312321260417, 11516.82724759146, 11905.166638335233, 12139.0, 12217.572384966483, 12280.263184208976, 10923.289986150874, 10962.506687198937, 10969.451527423438, 10984.0, 11694.181407301407, 10885.727856803327, 11031.944840275748, 11067.0, 11297.491612877277, 11311.151663625096, 11669.416529173677, 11954.163208575315, 12003.579874704343, 12273.754524909631, 12374.010079193822, 8990.145936136056, 9024.909750902669, 9094.818103638023, 9172.6789562365, 9918.652847150315, 8893.333000024895, 8934.436473617221, 9191.21874640663, 9361.297902657192, 9420.717378478657], "unit": "score", "name": "yui.html", "value": 6231.12083685313}], "name": "dromaeo_css", "value": 6699.454540192096}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 106.0, 111.0, 110.0, 111.0, 110.0, 111.0, 104.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [152.0, 129.0, 149.0, 173.0, 123.0, 153.0, 146.0, 131.0, 169.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 160.0, 159.0, 160.0, 163.0, 161.0, 160.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 107.0, 92.0, 73.0, 73.0, 76.0, 117.0, 109.0, 73.0], "unit": "score", "name": "audio-fft", "value": 86.4}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 149.0, 95.0, 96.0, 96.0, 141.0, 94.0, 95.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 111.0}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 56.0, 56.0, 56.0, 55.0, 55.0, 57.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 73.0, 65.0, 67.0, 66.0, 66.0, 66.0, 68.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 84.0, 83.0, 83.0, 84.0, 82.0, 86.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [115.0, 114.0, 123.0, 117.0, 114.0, 127.0, 124.0, 122.0, 116.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [144.0, 139.0, 148.0, 149.0, 148.0, 139.0, 151.0, 143.0, 144.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 67.0, 68.0, 69.0, 68.0, 70.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1506.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [189.6813353566009], "unit": "score", "name": "DeltaBlue", "value": 348.57409599999994}, {"lowerIsBetter": false, "replicates": [272.92576419213975], "unit": "score", "name": "Encrypt", "value": 975.2871839999998}, {"lowerIsBetter": false, "replicates": [5291.005291005291], "unit": "score", "name": "Decrypt", "value": 50.30820900000001}, {"lowerIsBetter": false, "replicates": [1934.2359767891683], "unit": "score", "name": "RayTrace", "value": 382.574313}, {"lowerIsBetter": false, "replicates": [801.924619085806], "unit": "score", "name": "Earley", "value": 831.079361}, {"lowerIsBetter": false, "replicates": [12456.79012345679], "unit": "score", "name": "Boyer", "value": 53.501985133795806}, {"lowerIsBetter": false, "replicates": [41612.244897959186], "unit": "score", "name": "RegExp", "value": 21.892233938205006}, {"lowerIsBetter": false, "replicates": [631.3131313131313], "unit": "score", "name": "Splay", "value": 129.081744}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 18840.591907904607}]} 22:20:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "18840.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1506.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6699.45"}}} 22:20:29 INFO - Return code: 0 22:20:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:20:29 INFO - # TBPL SUCCESS # 22:20:29 INFO - Running post-action listener: _resource_record_post_action 22:20:29 INFO - Running post-run listener: _resource_record_post_run 22:20:30 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 549482496; Read time: 92; Write time: 990880 22:20:30 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 4096; Write bytes: 235659264; Read time: 84; Write time: 625564 22:20:30 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 313225216; Read time: 8; Write time: 365316 22:20:30 INFO - Running post-run listener: _upload_blobber_files 22:20:30 INFO - Blob upload gear active. 22:20:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:20:30 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:20:30 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:20:30 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:20:31 INFO - (blobuploader) - INFO - Open directory for files ... 22:20:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:20:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:20:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:31 INFO - (blobuploader) - INFO - Done attempting. 22:20:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:20:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:20:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:32 INFO - (blobuploader) - INFO - Done attempting. 22:20:32 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:32 INFO - Return code: 0 22:20:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:20:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4953b071af0cd3169f3b9336c17cec3688ad15603e6ba068b684329597921730589ab0af18d03cd8f266481f326ec8c3195e130eb295d5d357ecaf23958f3319", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3aa27a2b598df5677289c7e5beaebfa8a5b26d119280cc8ea078d1092c8431df3776355730c3e542e5d5281b5855dd14583b853b4aca1e383f7cc7935a8099d"} 22:20:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:20:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:20:32 INFO - Contents: 22:20:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4953b071af0cd3169f3b9336c17cec3688ad15603e6ba068b684329597921730589ab0af18d03cd8f266481f326ec8c3195e130eb295d5d357ecaf23958f3319", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3aa27a2b598df5677289c7e5beaebfa8a5b26d119280cc8ea078d1092c8431df3776355730c3e542e5d5281b5855dd14583b853b4aca1e383f7cc7935a8099d"} 22:20:32 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:32 INFO - Copying logs to upload dir... 22:20:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:20:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.299184 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-25 22:20:32.708240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 22:20:32.711908) ========= 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=8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366 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/4953b071af0cd3169f3b9336c17cec3688ad15603e6ba068b684329597921730589ab0af18d03cd8f266481f326ec8c3195e130eb295d5d357ecaf23958f3319", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3aa27a2b598df5677289c7e5beaebfa8a5b26d119280cc8ea078d1092c8431df3776355730c3e542e5d5281b5855dd14583b853b4aca1e383f7cc7935a8099d"} build_url:https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011517 build_url: 'https://queue.taskcluster.net/v1/task/VF0yHQ8YQh-Qjn4qct1Hxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4953b071af0cd3169f3b9336c17cec3688ad15603e6ba068b684329597921730589ab0af18d03cd8f266481f326ec8c3195e130eb295d5d357ecaf23958f3319", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3aa27a2b598df5677289c7e5beaebfa8a5b26d119280cc8ea078d1092c8431df3776355730c3e542e5d5281b5855dd14583b853b4aca1e383f7cc7935a8099d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 22:20:32.739848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 22:20:32.740176) ========= 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=8783db0840cc980e80bb0bd400000236-1453787010.638308-102096366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 22:20:32.826056) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 22:20:32.826484) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 22:20:32.826982) ========= ========= Total master_lag: 0.28 =========