builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1452432804.66 results: success (0) buildid: 20160110030214 builduid: afe8b182359548a7a562d1d6774cf1fb revision: c33f30666b37dbceffb9fbe5089a668db8893a85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.662063) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.662544) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.662897) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006315 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.712113) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.712439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.805408) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.805709) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.865083) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.865423) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.865842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.866157) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-10 05:33:27-- 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% 85.1M=0s 2016-01-10 05:33:27 (85.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.079014) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.079330) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015638 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.137373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.137755) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c33f30666b37dbceffb9fbe5089a668db8893a85 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c33f30666b37dbceffb9fbe5089a668db8893a85 --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=74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-10 05:33:27,477 truncating revision to first 12 chars 2016-01-10 05:33:27,477 Setting DEBUG logging. 2016-01-10 05:33:27,477 attempt 1/10 2016-01-10 05:33:27,477 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c33f30666b37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-10 05:33:27,824 unpacking tar archive at: mozilla-central-c33f30666b37/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618355 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.773535) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.773891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.804598) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.804908) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.805351) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-10 05:33:25.805796) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:33:28 INFO - MultiFileLogger online at 20160110 05:33:28 in /builds/slave/test-pgo 05:33:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:33:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:33:28 INFO - {'append_to_log': False, 05:33:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:33:28 INFO - 'blob_upload_branch': 'Firefox', 05:33:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:33:28 INFO - 'branch': 'Firefox', 05:33:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:33:28 INFO - 'config_files': ('talos/linux_config.py',), 05:33:28 INFO - 'default_actions': ('clobber', 05:33:28 INFO - 'read-buildbot-config', 05:33:28 INFO - 'download-and-extract', 05:33:28 INFO - 'populate-webroot', 05:33:28 INFO - 'create-virtualenv', 05:33:28 INFO - 'install', 05:33:28 INFO - 'run-tests'), 05:33:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:33:28 INFO - 'download_minidump_stackwalk': True, 05:33:28 INFO - 'download_symbols': 'ondemand', 05:33:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:33:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:33:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:33:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:33:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:33:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:33:28 INFO - 'installer_path': 'installer.exe', 05:33:28 INFO - 'log_level': 'info', 05:33:28 INFO - 'log_name': 'talos', 05:33:28 INFO - 'log_to_console': True, 05:33:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:33:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:33:28 INFO - 'opt_config_files': (), 05:33:28 INFO - 'pip_index': False, 05:33:28 INFO - 'sps_profile': False, 05:33:28 INFO - 'sps_profile_interval': 0, 05:33:28 INFO - 'suite': 'dromaeojs', 05:33:28 INFO - 'system_bits': '32', 05:33:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:33:28 INFO - 'title': 'talos-linux64-ix-042', 05:33:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:33:28 INFO - 'use_talos_json': True, 05:33:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:33:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:33:28 INFO - 'work_dir': 'build'} 05:33:28 INFO - ##### 05:33:28 INFO - ##### Running clobber step. 05:33:28 INFO - ##### 05:33:28 INFO - Running pre-action listener: _resource_record_pre_action 05:33:28 INFO - Running main action method: clobber 05:33:28 INFO - rmtree: /builds/slave/test-pgo/build 05:33:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:33:28 INFO - Running post-action listener: _resource_record_post_action 05:33:28 INFO - ##### 05:33:28 INFO - ##### Running read-buildbot-config step. 05:33:28 INFO - ##### 05:33:28 INFO - Running pre-action listener: _resource_record_pre_action 05:33:28 INFO - Running main action method: read_buildbot_config 05:33:28 INFO - Using buildbot properties: 05:33:28 INFO - { 05:33:28 INFO - "project": "", 05:33:28 INFO - "product": "firefox", 05:33:28 INFO - "script_repo_revision": "production", 05:33:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:33:28 INFO - "repository": "", 05:33:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:33:28 INFO - "buildid": "20160110030214", 05:33:28 INFO - "stage_platform": "linux64-pgo", 05:33:28 INFO - "basedir": "/builds/slave/test-pgo", 05:33:28 INFO - "nightly_build": "True", 05:33:28 INFO - "buildnumber": 639, 05:33:28 INFO - "slavename": "talos-linux64-ix-042", 05:33:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:33:28 INFO - "platform": "ubuntu64_hw", 05:33:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:33:28 INFO - "branch": "mozilla-central", 05:33:28 INFO - "repo_path": "mozilla-central", 05:33:28 INFO - "revision": "c33f30666b37dbceffb9fbe5089a668db8893a85", 05:33:28 INFO - "pgo_build": "True", 05:33:28 INFO - "builduid": "afe8b182359548a7a562d1d6774cf1fb", 05:33:28 INFO - "slavebuilddir": "test" 05:33:28 INFO - } 05:33:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:33:28 INFO - Running post-action listener: _resource_record_post_action 05:33:28 INFO - ##### 05:33:28 INFO - ##### Running download-and-extract step. 05:33:28 INFO - ##### 05:33:28 INFO - Running pre-action listener: _resource_record_pre_action 05:33:28 INFO - Running main action method: download_and_extract 05:33:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:33:28 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')]} 05:33:28 INFO - https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:33:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/test_packages.json 05:33:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/test_packages.json 05:33:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:33:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:33:35 INFO - Downloaded 1302 bytes. 05:33:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:33:35 INFO - Using the following test package requirements: 05:33:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:33:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:33:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:35 INFO - u'jsshell-linux-x86_64.zip'], 05:33:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:33:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:33:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:33:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:33:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:33:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:33:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:33:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:33: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')]} 05:33:35 INFO - https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:33:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:33:44 INFO - Downloaded 24028434 bytes. 05:33:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:33:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:33:45 INFO - Return code: 0 05:33:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:45 INFO - https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:33:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:33:48 INFO - Downloaded 24028434 bytes. 05:33:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:33:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:33:50 INFO - Return code: 0 05:33: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')]} 05:33:50 INFO - https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:33:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:33:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:33:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:33:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:33:53 INFO - Downloaded 11132285 bytes. 05:33:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:33:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:33:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:33:53 INFO - Return code: 0 05:33: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')]} 05:33:53 INFO - https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:33:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:33:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:33:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:33:55 INFO - Downloaded 55925742 bytes. 05:33:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:33:55 INFO - mkdir: /builds/slave/test-pgo/properties 05:33:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:33:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:33:55 INFO - Contents: 05:33:55 INFO - build_url:https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:33:55 INFO - Running post-action listener: _resource_record_post_action 05:33:55 INFO - Running post-action listener: set_extra_try_arguments 05:33:55 INFO - ##### 05:33:55 INFO - ##### Running populate-webroot step. 05:33:55 INFO - ##### 05:33:55 INFO - Running pre-action listener: _resource_record_pre_action 05:33:55 INFO - Running main action method: populate_webroot 05:33:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:33:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:33:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:33:55 INFO - '--tppagecycles', 05:33:55 INFO - '7'], 05:33:55 INFO - 'tests': ['tsvgm']}}, 05:33:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:33:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:33:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:33:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:33:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:33:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:33:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:55 INFO - 'talos_options': ['--e10s'], 05:33:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:55 INFO - 'tests': ['damp', 'tps']}, 05:33:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:55 INFO - 'talos_options': ['--e10s'], 05:33:55 INFO - 'tests': ['damp', 'tps']}, 05:33:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:33:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:33:55 INFO - 'other': {'tests': ['a11yr', 05:33:55 INFO - 'ts_paint', 05:33:55 INFO - 'tpaint', 05:33:55 INFO - 'sessionrestore', 05:33:55 INFO - 'sessionrestore_no_auto_restore']}, 05:33:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:33:55 INFO - 'tests': ['a11yr', 05:33:55 INFO - 'ts_paint', 05:33:55 INFO - 'tpaint', 05:33:55 INFO - 'sessionrestore', 05:33:55 INFO - 'sessionrestore_no_auto_restore']}, 05:33:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:33:55 INFO - 'tests': ['a11yr', 05:33:55 INFO - 'ts_paint', 05:33:55 INFO - 'tpaint', 05:33:55 INFO - 'sessionrestore', 05:33:55 INFO - 'sessionrestore_no_auto_restore']}, 05:33:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:33:55 INFO - 'tests': ['a11yr', 05:33:55 INFO - 'ts_paint', 05:33:55 INFO - 'tpaint', 05:33:55 INFO - 'sessionrestore', 05:33:55 INFO - 'sessionrestore_no_auto_restore']}, 05:33:55 INFO - 'other_l64': {'tests': ['a11yr', 05:33:55 INFO - 'ts_paint', 05:33:55 INFO - 'tpaint', 05:33:55 INFO - 'sessionrestore', 05:33:55 INFO - 'sessionrestore_no_auto_restore']}, 05:33:55 INFO - 'other_nol64': {'tests': ['a11yr', 05:33:55 INFO - 'ts_paint', 05:33:55 INFO - 'tpaint', 05:33:55 INFO - 'sessionrestore', 05:33:55 INFO - 'sessionrestore_no_auto_restore']}, 05:33:55 INFO - 'svgr': {'tests': ['tsvgx', 05:33:55 INFO - 'tsvgr_opacity', 05:33:55 INFO - 'tart', 05:33:55 INFO - 'tscrollx', 05:33:55 INFO - 'cart']}, 05:33:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:33:55 INFO - 'tests': ['tsvgx', 05:33:55 INFO - 'tsvgr_opacity', 05:33:55 INFO - 'tart', 05:33:55 INFO - 'tscrollx', 05:33:55 INFO - 'cart']}, 05:33:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:55 INFO - 'tests': ['tp5o']}, 05:33:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:55 INFO - 'talos_options': ['--e10s'], 05:33:55 INFO - 'tests': ['tp5o']}, 05:33:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:55 INFO - 'talos_options': ['--xperf_path', 05:33:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:55 INFO - 'tests': ['tp5n']}, 05:33:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:55 INFO - 'talos_options': ['--e10s', 05:33:55 INFO - '--xperf_path', 05:33:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:55 INFO - 'tests': ['tp5n']}}, 05:33:55 INFO - 'talos.zip': {'path': '', 05:33:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:33:55 INFO - Running post-action listener: _resource_record_post_action 05:33:55 INFO - ##### 05:33:55 INFO - ##### Running create-virtualenv step. 05:33:55 INFO - ##### 05:33:55 INFO - Running pre-action listener: _resource_record_pre_action 05:33:55 INFO - Running main action method: create_virtualenv 05:33:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:33:55 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 05:33:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:33:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:33:55 INFO - Using real prefix '/usr' 05:33:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:33:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:57 INFO - Installing pip.................done. 05:33:57 INFO - Return code: 0 05:33:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f213ef65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2015630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a6840>, '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 0x20136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2013b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', '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 05:33:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:33:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:33:57 INFO - Using env: {'DISPLAY': ':0', 05:33:57 INFO - 'HOME': '/home/cltbld', 05:33:57 INFO - 'LANG': 'en_US.UTF-8', 05:33:57 INFO - 'LANGUAGE': 'en_US:en', 05:33:57 INFO - 'LOGNAME': 'cltbld', 05:33:57 INFO - 'MAIL': '/var/mail/cltbld', 05:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:57 INFO - 'MOZ_NO_REMOTE': '1', 05:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:57 INFO - 'NO_EM_RESTART': '1', 05:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:57 INFO - 'SHELL': '/bin/bash', 05:33:57 INFO - 'SHLVL': '1', 05:33:57 INFO - 'TERM': 'linux', 05:33:57 INFO - 'TMOUT': '86400', 05:33:57 INFO - 'USER': 'cltbld', 05:33:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', 05:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:57 INFO - '_': '/tools/buildbot/bin/python'} 05:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:57 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 05:33:57 INFO - Cleaning up... 05:33:57 INFO - Return code: 0 05:33:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f213ef65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2015630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a6840>, '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 0x20136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2013b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', '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 05:33:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:33:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:33:57 INFO - Using env: {'DISPLAY': ':0', 05:33:57 INFO - 'HOME': '/home/cltbld', 05:33:57 INFO - 'LANG': 'en_US.UTF-8', 05:33:57 INFO - 'LANGUAGE': 'en_US:en', 05:33:57 INFO - 'LOGNAME': 'cltbld', 05:33:57 INFO - 'MAIL': '/var/mail/cltbld', 05:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:57 INFO - 'MOZ_NO_REMOTE': '1', 05:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:57 INFO - 'NO_EM_RESTART': '1', 05:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:57 INFO - 'SHELL': '/bin/bash', 05:33:57 INFO - 'SHLVL': '1', 05:33:57 INFO - 'TERM': 'linux', 05:33:57 INFO - 'TMOUT': '86400', 05:33:57 INFO - 'USER': 'cltbld', 05:33:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', 05:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:57 INFO - '_': '/tools/buildbot/bin/python'} 05:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:58 INFO - Downloading/unpacking psutil>=0.7.1 05:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:33:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:33:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:59 INFO - Installing collected packages: psutil 05:33:59 INFO - Running setup.py install for psutil 05:34:00 INFO - building 'psutil._psutil_linux' extension 05:34:00 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 05:34:00 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 05:34:00 INFO - building 'psutil._psutil_posix' extension 05:34:00 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 05:34:00 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 05:34:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:00 INFO - Successfully installed psutil 05:34:00 INFO - Cleaning up... 05:34:00 INFO - Return code: 0 05:34:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f213ef65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2015630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a6840>, '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 0x20136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2013b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', '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 05:34:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:34:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:34:00 INFO - Using env: {'DISPLAY': ':0', 05:34:00 INFO - 'HOME': '/home/cltbld', 05:34:00 INFO - 'LANG': 'en_US.UTF-8', 05:34:00 INFO - 'LANGUAGE': 'en_US:en', 05:34:00 INFO - 'LOGNAME': 'cltbld', 05:34:00 INFO - 'MAIL': '/var/mail/cltbld', 05:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:00 INFO - 'MOZ_NO_REMOTE': '1', 05:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:00 INFO - 'NO_EM_RESTART': '1', 05:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:00 INFO - 'SHELL': '/bin/bash', 05:34:00 INFO - 'SHLVL': '1', 05:34:00 INFO - 'TERM': 'linux', 05:34:00 INFO - 'TMOUT': '86400', 05:34:00 INFO - 'USER': 'cltbld', 05:34:00 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', 05:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:00 INFO - '_': '/tools/buildbot/bin/python'} 05:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:34:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:34:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:34:02 INFO - Installing collected packages: mozsystemmonitor 05:34:02 INFO - Running setup.py install for mozsystemmonitor 05:34:02 INFO - Successfully installed mozsystemmonitor 05:34:02 INFO - Cleaning up... 05:34:02 INFO - Return code: 0 05:34:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f213ef65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2015630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a6840>, '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 0x20136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2013b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', '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 05:34:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:34:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:34:02 INFO - Using env: {'DISPLAY': ':0', 05:34:02 INFO - 'HOME': '/home/cltbld', 05:34:02 INFO - 'LANG': 'en_US.UTF-8', 05:34:02 INFO - 'LANGUAGE': 'en_US:en', 05:34:02 INFO - 'LOGNAME': 'cltbld', 05:34:02 INFO - 'MAIL': '/var/mail/cltbld', 05:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:02 INFO - 'MOZ_NO_REMOTE': '1', 05:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:02 INFO - 'NO_EM_RESTART': '1', 05:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:02 INFO - 'SHELL': '/bin/bash', 05:34:02 INFO - 'SHLVL': '1', 05:34:02 INFO - 'TERM': 'linux', 05:34:02 INFO - 'TMOUT': '86400', 05:34:02 INFO - 'USER': 'cltbld', 05:34:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', 05:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:02 INFO - '_': '/tools/buildbot/bin/python'} 05:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:02 INFO - Downloading/unpacking blobuploader==1.2.4 05:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:34:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:34:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:34:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:34:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:34:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:05 INFO - Downloading docopt-0.6.1.tar.gz 05:34:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:34:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:34:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:34:05 INFO - Running setup.py install for blobuploader 05:34:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:34:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:34:05 INFO - Running setup.py install for requests 05:34:05 INFO - Running setup.py install for docopt 05:34:05 INFO - Successfully installed blobuploader requests docopt 05:34:05 INFO - Cleaning up... 05:34:05 INFO - Return code: 0 05:34:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:34:05 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')]} 05:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:05 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')]} 05:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f213ef65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2015630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a6840>, '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 0x20136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2013b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', '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 05:34:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:34:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:34:05 INFO - Using env: {'DISPLAY': ':0', 05:34:05 INFO - 'HOME': '/home/cltbld', 05:34:05 INFO - 'LANG': 'en_US.UTF-8', 05:34:05 INFO - 'LANGUAGE': 'en_US:en', 05:34:05 INFO - 'LOGNAME': 'cltbld', 05:34:05 INFO - 'MAIL': '/var/mail/cltbld', 05:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:05 INFO - 'MOZ_NO_REMOTE': '1', 05:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:05 INFO - 'NO_EM_RESTART': '1', 05:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:05 INFO - 'SHELL': '/bin/bash', 05:34:05 INFO - 'SHLVL': '1', 05:34:05 INFO - 'TERM': 'linux', 05:34:05 INFO - 'TMOUT': '86400', 05:34:05 INFO - 'USER': 'cltbld', 05:34:05 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', 05:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:05 INFO - '_': '/tools/buildbot/bin/python'} 05:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:34:06 INFO - Running setup.py (path:/tmp/pip-R_56aO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:34:06 INFO - Running setup.py (path:/tmp/pip-dJI1B7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:34:06 INFO - Running setup.py (path:/tmp/pip-Ib9zmA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:34:06 INFO - Running setup.py (path:/tmp/pip-MeeRRr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:34:06 INFO - Running setup.py (path:/tmp/pip-C3JLjC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:34:06 INFO - Running setup.py (path:/tmp/pip-FJqajp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:34:06 INFO - Running setup.py (path:/tmp/pip-Cj8cKw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:34:06 INFO - Running setup.py (path:/tmp/pip-bkPFEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:34:06 INFO - Running setup.py (path:/tmp/pip-pIKOtn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:34:06 INFO - Running setup.py (path:/tmp/pip-Udm64a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:34:06 INFO - Running setup.py (path:/tmp/pip-GJ2AsI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:34:06 INFO - Running setup.py (path:/tmp/pip-DWvwIC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:34:06 INFO - Running setup.py (path:/tmp/pip-RU5xTF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:34:07 INFO - Running setup.py (path:/tmp/pip-qgLGMo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:34:07 INFO - Running setup.py (path:/tmp/pip-kruTuV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:34:07 INFO - Running setup.py (path:/tmp/pip-Mxfqu1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:34:07 INFO - Running setup.py (path:/tmp/pip-MDb7_G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:34:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:34:07 INFO - Running setup.py install for manifestparser 05:34:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:34:07 INFO - Running setup.py install for mozcrash 05:34:07 INFO - Running setup.py install for mozdebug 05:34:07 INFO - Running setup.py install for mozdevice 05:34:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:34:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:34:07 INFO - Running setup.py install for mozfile 05:34:07 INFO - Running setup.py install for mozhttpd 05:34:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:34:07 INFO - Running setup.py install for mozinfo 05:34:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:34:08 INFO - Running setup.py install for mozInstall 05:34:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:34:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:34:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:34:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:34:08 INFO - Running setup.py install for mozleak 05:34:08 INFO - Running setup.py install for mozlog 05:34:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:34:08 INFO - Running setup.py install for moznetwork 05:34:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:34:08 INFO - Running setup.py install for mozprocess 05:34:08 INFO - Running setup.py install for mozprofile 05:34:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:34:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:34:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:34:08 INFO - Running setup.py install for mozrunner 05:34:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:34:08 INFO - Running setup.py install for mozscreenshot 05:34:08 INFO - Running setup.py install for moztest 05:34:09 INFO - Running setup.py install for mozversion 05:34:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:34:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:34:09 INFO - Cleaning up... 05:34:09 INFO - Return code: 0 05:34:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:34:09 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')]} 05:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:09 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')]} 05:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f213ef65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2015630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a6840>, '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 0x20136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2013b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', '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 05:34:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:34:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:34:09 INFO - Using env: {'DISPLAY': ':0', 05:34:09 INFO - 'HOME': '/home/cltbld', 05:34:09 INFO - 'LANG': 'en_US.UTF-8', 05:34:09 INFO - 'LANGUAGE': 'en_US:en', 05:34:09 INFO - 'LOGNAME': 'cltbld', 05:34:09 INFO - 'MAIL': '/var/mail/cltbld', 05:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:09 INFO - 'MOZ_NO_REMOTE': '1', 05:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:09 INFO - 'NO_EM_RESTART': '1', 05:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:09 INFO - 'SHELL': '/bin/bash', 05:34:09 INFO - 'SHLVL': '1', 05:34:09 INFO - 'TERM': 'linux', 05:34:09 INFO - 'TMOUT': '86400', 05:34:09 INFO - 'USER': 'cltbld', 05:34:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', 05:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:09 INFO - '_': '/tools/buildbot/bin/python'} 05:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:34:09 INFO - Running setup.py (path:/tmp/pip-jMGn4q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:34:09 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)) 05:34:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:34:09 INFO - Running setup.py (path:/tmp/pip-JO1dmA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:34:09 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)) 05:34:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:34:09 INFO - Running setup.py (path:/tmp/pip-SVt8MV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:34:09 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)) 05:34:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:34:09 INFO - Running setup.py (path:/tmp/pip-on4HLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 05:34:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:34:09 INFO - Running setup.py (path:/tmp/pip-sqC8sK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:34:09 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)) 05:34:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:34:09 INFO - Running setup.py (path:/tmp/pip-b94Cxw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:34:09 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)) 05:34:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:34:09 INFO - Running setup.py (path:/tmp/pip-qfxmkR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:34:09 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)) 05:34:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:34:09 INFO - Running setup.py (path:/tmp/pip-1BVScB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:34:09 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)) 05:34:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:34:09 INFO - Running setup.py (path:/tmp/pip-v1nD_L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:34:09 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)) 05:34:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:34:10 INFO - Running setup.py (path:/tmp/pip-JVwpCd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:34:10 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)) 05:34:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:34:10 INFO - Running setup.py (path:/tmp/pip-aD80Lr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:34:10 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)) 05:34:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:34:10 INFO - Running setup.py (path:/tmp/pip-AAOnSL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:34:10 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)) 05:34:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:34:10 INFO - Running setup.py (path:/tmp/pip-3P3gkf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:34:10 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)) 05:34:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:34:10 INFO - Running setup.py (path:/tmp/pip-03w1Ro-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:34:10 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)) 05:34:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:34:10 INFO - Running setup.py (path:/tmp/pip-TEln1B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:34:10 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)) 05:34:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:34:10 INFO - Running setup.py (path:/tmp/pip-HI37uj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:34:10 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)) 05:34:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:34:10 INFO - Running setup.py (path:/tmp/pip-5nRRHC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:34:10 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)) 05:34:10 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)) 05:34:10 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)) 05:34:10 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)) 05:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:34:10 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:34:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:12 INFO - Downloading blessings-1.5.1.tar.gz 05:34:12 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:34:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:34:12 INFO - Installing collected packages: blessings 05:34:12 INFO - Running setup.py install for blessings 05:34:12 INFO - Successfully installed blessings 05:34:12 INFO - Cleaning up... 05:34:12 INFO - Return code: 0 05:34:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:34:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:34:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:34:12 INFO - Reading from file tmpfile_stdout 05:34:12 INFO - Current package versions: 05:34:12 INFO - argparse == 1.2.1 05:34:12 INFO - blessings == 1.5.1 05:34:12 INFO - blobuploader == 1.2.4 05:34:12 INFO - docopt == 0.6.1 05:34:12 INFO - manifestparser == 1.1 05:34:12 INFO - mozInstall == 1.12 05:34:12 INFO - mozcrash == 0.16 05:34:12 INFO - mozdebug == 0.1 05:34:12 INFO - mozdevice == 0.47 05:34:12 INFO - mozfile == 1.2 05:34:12 INFO - mozhttpd == 0.7 05:34:12 INFO - mozinfo == 0.9 05:34:12 INFO - mozleak == 0.1 05:34:12 INFO - mozlog == 3.1 05:34:12 INFO - moznetwork == 0.27 05:34:12 INFO - mozprocess == 0.22 05:34:12 INFO - mozprofile == 0.28 05:34:12 INFO - mozrunner == 6.11 05:34:12 INFO - mozscreenshot == 0.1 05:34:12 INFO - mozsystemmonitor == 0.0 05:34:12 INFO - moztest == 0.7 05:34:12 INFO - mozversion == 1.4 05:34:12 INFO - psutil == 3.1.1 05:34:12 INFO - requests == 1.2.3 05:34:12 INFO - wsgiref == 0.1.2 05:34:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f213ef65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2015630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a6840>, '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 0x20136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2013b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', '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 05:34:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:34:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:34:12 INFO - Using env: {'DISPLAY': ':0', 05:34:12 INFO - 'HOME': '/home/cltbld', 05:34:12 INFO - 'LANG': 'en_US.UTF-8', 05:34:12 INFO - 'LANGUAGE': 'en_US:en', 05:34:12 INFO - 'LOGNAME': 'cltbld', 05:34:12 INFO - 'MAIL': '/var/mail/cltbld', 05:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:12 INFO - 'MOZ_NO_REMOTE': '1', 05:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:12 INFO - 'NO_EM_RESTART': '1', 05:34:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:12 INFO - 'SHELL': '/bin/bash', 05:34:12 INFO - 'SHLVL': '1', 05:34:12 INFO - 'TERM': 'linux', 05:34:12 INFO - 'TMOUT': '86400', 05:34:12 INFO - 'USER': 'cltbld', 05:34:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', 05:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:12 INFO - '_': '/tools/buildbot/bin/python'} 05:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:12 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)) 05:34:12 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)) 05:34:12 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)) 05:34:12 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)) 05:34:12 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)) 05:34:12 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)) 05:34:12 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)) 05:34:12 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)) 05:34:12 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)) 05:34:12 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)) 05:34:12 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)) 05:34:12 INFO - Cleaning up... 05:34:12 INFO - Return code: 0 05:34:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f213ef65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2015630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a6840>, '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 0x20136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2013b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', '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 05:34:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:34:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:34:12 INFO - Using env: {'DISPLAY': ':0', 05:34:12 INFO - 'HOME': '/home/cltbld', 05:34:12 INFO - 'LANG': 'en_US.UTF-8', 05:34:12 INFO - 'LANGUAGE': 'en_US:en', 05:34:12 INFO - 'LOGNAME': 'cltbld', 05:34:12 INFO - 'MAIL': '/var/mail/cltbld', 05:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:12 INFO - 'MOZ_NO_REMOTE': '1', 05:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:12 INFO - 'NO_EM_RESTART': '1', 05:34:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:12 INFO - 'SHELL': '/bin/bash', 05:34:12 INFO - 'SHLVL': '1', 05:34:12 INFO - 'TERM': 'linux', 05:34:12 INFO - 'TMOUT': '86400', 05:34:12 INFO - 'USER': 'cltbld', 05:34:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', 05:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:12 INFO - '_': '/tools/buildbot/bin/python'} 05:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:13 INFO - Downloading/unpacking jsonschema 05:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:34:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:34:14 INFO - Downloading/unpacking functools32 (from jsonschema) 05:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:34:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:34:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:34:15 INFO - warning: no files found matching '*.txt' 05:34:15 INFO - no previously-included directories found matching 'build' 05:34:15 INFO - no previously-included directories found matching 'dist' 05:34:15 INFO - no previously-included directories found matching '.git*' 05:34:15 INFO - Installing collected packages: jsonschema, functools32 05:34:15 INFO - Running setup.py install for functools32 05:34:15 INFO - warning: no files found matching '*.txt' 05:34:15 INFO - no previously-included directories found matching 'build' 05:34:15 INFO - no previously-included directories found matching 'dist' 05:34:15 INFO - no previously-included directories found matching '.git*' 05:34:15 INFO - Successfully installed jsonschema functools32 05:34:15 INFO - Cleaning up... 05:34:15 INFO - Return code: 0 05:34:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f213ef65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2015630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a6840>, '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 0x20136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2013b60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', '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 05:34:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:34:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:34:15 INFO - Using env: {'DISPLAY': ':0', 05:34:15 INFO - 'HOME': '/home/cltbld', 05:34:15 INFO - 'LANG': 'en_US.UTF-8', 05:34:15 INFO - 'LANGUAGE': 'en_US:en', 05:34:15 INFO - 'LOGNAME': 'cltbld', 05:34:15 INFO - 'MAIL': '/var/mail/cltbld', 05:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:15 INFO - 'MOZ_NO_REMOTE': '1', 05:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:15 INFO - 'NO_EM_RESTART': '1', 05:34:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:15 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:15 INFO - 'SHELL': '/bin/bash', 05:34:15 INFO - 'SHLVL': '1', 05:34:15 INFO - 'TERM': 'linux', 05:34:15 INFO - 'TMOUT': '86400', 05:34:15 INFO - 'USER': 'cltbld', 05:34:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', 05:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:15 INFO - '_': '/tools/buildbot/bin/python'} 05:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:15 INFO - Downloading/unpacking flake8 05:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:34:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:34:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:34:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:34:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:34:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 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 05:34:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:34:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:34:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:34:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:34:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:34:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:34:17 INFO - no previously-included directories found matching 'docs/_build' 05:34:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:34:18 INFO - Running setup.py install for pep8 05:34:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:34:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:34:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:34:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:34:18 INFO - no previously-included directories found matching 'docs/_build' 05:34:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:34:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:34:18 INFO - Cleaning up... 05:34:18 INFO - Return code: 0 05:34:18 INFO - Running post-action listener: _resource_record_post_action 05:34:18 INFO - Running post-action listener: _start_resource_monitoring 05:34:18 INFO - Starting resource monitoring. 05:34:18 INFO - ##### 05:34:18 INFO - ##### Running install step. 05:34:18 INFO - ##### 05:34:18 INFO - Running pre-action listener: _resource_record_pre_action 05:34:18 INFO - Running main action method: install 05:34:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:34:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:34:18 INFO - Reading from file tmpfile_stdout 05:34:18 INFO - Detecting whether we're running mozinstall >=1.0... 05:34:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:34:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:34:18 INFO - Reading from file tmpfile_stdout 05:34:18 INFO - Output received: 05:34:18 INFO - Usage: mozinstall [options] installer 05:34:18 INFO - Options: 05:34:18 INFO - -h, --help show this help message and exit 05:34:18 INFO - -d DEST, --destination=DEST 05:34:18 INFO - Directory to install application into. [default: 05:34:18 INFO - "/builds/slave/test-pgo"] 05:34:18 INFO - --app=APP Application being installed. [default: firefox] 05:34:18 INFO - mkdir: /builds/slave/test-pgo/build/application 05:34:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:34:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:34:34 INFO - Reading from file tmpfile_stdout 05:34:34 INFO - Output received: 05:34:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:34:34 INFO - Running post-action listener: _resource_record_post_action 05:34:34 INFO - ##### 05:34:34 INFO - ##### Running run-tests step. 05:34:34 INFO - ##### 05:34:34 INFO - Running pre-action listener: _resource_record_pre_action 05:34:34 INFO - Running main action method: run_tests 05:34:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:34:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:34:34 INFO - Python 2.7.3 05:34:34 INFO - Return code: 0 05:34:34 INFO - grabbing minidump binary from tooltool 05:34:34 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')]} 05:34:34 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 0x20a6840>, '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 0x20136b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2013b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:34:34 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 05:34:34 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 05:34:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:34:34 INFO - Return code: 0 05:34:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:34:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:34:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:34:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:34:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:34:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:34:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:34:35 INFO - Return code: 0 05:34:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 05:34:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 05:34:35 INFO - Using env: {'DISPLAY': ':0', 05:34:35 INFO - 'HOME': '/home/cltbld', 05:34:35 INFO - 'LANG': 'en_US.UTF-8', 05:34:35 INFO - 'LANGUAGE': 'en_US:en', 05:34:35 INFO - 'LOGNAME': 'cltbld', 05:34:35 INFO - 'MAIL': '/var/mail/cltbld', 05:34:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:34:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:35 INFO - 'MOZ_NO_REMOTE': '1', 05:34:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:35 INFO - 'NO_EM_RESTART': '1', 05:34:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:35 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:34:35 INFO - 'SHELL': '/bin/bash', 05:34:35 INFO - 'SHLVL': '1', 05:34:35 INFO - 'TERM': 'linux', 05:34:35 INFO - 'TMOUT': '86400', 05:34:35 INFO - 'USER': 'cltbld', 05:34:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826', 05:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:35 INFO - '_': '/tools/buildbot/bin/python'} 05:34:35 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 05:34:35 INFO - mozversion application_buildid: 20160110030214 05:34:35 INFO - mozversion application_changeset: c33f30666b37dbceffb9fbe5089a668db8893a85 05:34:35 INFO - mozversion application_display_name: Nightly 05:34:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:34:35 INFO - mozversion application_name: Firefox 05:34:35 INFO - mozversion application_remotingname: firefox 05:34:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:34:35 INFO - mozversion application_vendor: Mozilla 05:34:35 INFO - mozversion application_version: 46.0a1 05:34:35 INFO - mozversion platform_buildid: 20160110030214 05:34:35 INFO - mozversion platform_changeset: c33f30666b37dbceffb9fbe5089a668db8893a85 05:34:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:34:35 INFO - mozversion platform_version: 46.0a1 05:34:35 INFO - using testdate: 1452432875 05:34:35 INFO - actual date: 1452432875 05:34:35 INFO - starting webserver on 'localhost:52519' 05:34:35 INFO - SUITE-START | Running 3 tests 05:34:35 INFO - TEST-START | dromaeo_css 05:34:35 INFO - operating with platform_type : linux_ 05:34:35 INFO - Initialising browser for dromaeo_css test... 05:34:35 INFO - TEST-INFO | started process 6997 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSLJVF2/profile http://localhost:52519/getInfo.html) 05:34:39 INFO - PROCESS | 6997 | __metrics Screen width/height:1600/1200 05:34:39 INFO - PROCESS | 6997 | colorDepth:24 05:34:39 INFO - PROCESS | 6997 | Browser inner width/height: 1024/697 05:34:39 INFO - PROCESS | 6997 | __metrics 05:34:39 INFO - PROCESS | 6997 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:34:39 INFO - PROCESS | 6997 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:34:40 INFO - TEST-INFO | 6997: exit 0 05:34:40 INFO - Browser initialized. 05:34:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:34:40 INFO - TEST-INFO | started process 7090 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSLJVF2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:52 INFO - PROCESS | 7090 | RSS: Main: 149045248 05:34:52 INFO - PROCESS | 7090 | 05:35:44 INFO - PROCESS | 7090 | 1452432944113 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] 05:37:52 INFO - PROCESS | 7090 | Cycle 1(1): loaded http://localhost:52519/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52519/tests/dromaeo/cssquery-ext.html) 05:37:53 INFO - PROCESS | 7090 | RSS: Main: 279396352 05:37:53 INFO - PROCESS | 7090 | 05:40:56 INFO - PROCESS | 7090 | Cycle 1(1): loaded http://localhost:52519/tests/dromaeo/cssquery-ext.html (next: http://localhost:52519/tests/dromaeo/cssquery-jquery.html) 05:40:56 INFO - PROCESS | 7090 | RSS: Main: 232902656 05:40:56 INFO - PROCESS | 7090 | 05:43:58 INFO - PROCESS | 7090 | Cycle 1(1): loaded http://localhost:52519/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52519/tests/dromaeo/cssquery-mootools.html) 05:43:59 INFO - PROCESS | 7090 | RSS: Main: 226603008 05:43:59 INFO - PROCESS | 7090 | 05:47:01 INFO - PROCESS | 7090 | Cycle 1(1): loaded http://localhost:52519/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52519/tests/dromaeo/cssquery-prototype.html) 05:47:01 INFO - PROCESS | 7090 | RSS: Main: 212111360 05:47:01 INFO - PROCESS | 7090 | 05:50:04 INFO - PROCESS | 7090 | Cycle 1(1): loaded http://localhost:52519/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52519/tests/dromaeo/cssquery-yui.html) 05:50:05 INFO - PROCESS | 7090 | RSS: Main: 216907776 05:50:05 INFO - PROCESS | 7090 | 05:53:07 INFO - PROCESS | 7090 | Cycle 1(1): loaded http://localhost:52519/tests/dromaeo/cssquery-yui.html (next: http://localhost:52519/tests/dromaeo/cssquery-dojo.html) 05:53:07 INFO - PROCESS | 7090 | RSS: Main: 259911680 05:53:07 INFO - PROCESS | 7090 | 05:53:07 INFO - PROCESS | 7090 | __start_tp_report 05:53:07 INFO - PROCESS | 7090 | _x_x_mozilla_page_load 05:53:07 INFO - PROCESS | 7090 | _x_x_mozilla_page_load_details 05:53:07 INFO - PROCESS | 7090 | |i|pagename|runs| 05:53:07 INFO - PROCESS | 7090 | |0;dojo.html;3037.2255074955883;3097.8141311521326;3099.194209505529;3140.387624413239;3164.288035192081;4966.826161084363;5089.46560611136;5148.48515148485;5164.380274367072;5201.089809283374;4969.826056088038;5013.97213571218;5113.463086375933;5126.41046279678;5132.692038477694;4670.392848929634;4700.882477938045;4719.693219940693;4756.7145971241835;4830.058138662962;4796.952030479685;4806.182948898678;4810.446798618169;4862.927056094161;4867.342908707315;4591.357209990604;4643.605293550052;4702.224133018048;4736.029114031615;4747.2879068140055;4718.386609740746;4719.032598317337;4725.3384526166365;4728.196206644879;4750.406199225097;4672.229082201433;4674.906501869944;4677.251639737659;4681.508441613616;4719.646026548023;4859.198232291667;4920.8031678732805;4952.702837829742;4958.553730164303;4963.70217786934;5421.051316019721;5421.241026256327;5424.864378390572;5426.9185962210595;5433.8369848904595;5473.2063850741815;5474;5478.753456094485;5511.834644960658;5611.523020543259;5202.115640341151;5205.583553315726;5210.817621383271;5212.661177023481;5217.947820521784;5564.582656300713;5633.63381380209;5655.066913959151;5680.460356266148;5705.400932902068;5358.732063396815;5418.972905135449;5447.101228297366;5449.591280653967;5461.781528738886;5549.833504994856;5557.277553917965;5561.694106824163;5563.916541251884;5564.4713752193475;5463.562914966793;5520.199571062254;5521.944780552223;5528.143137813645;5536.695481748542;5402.837914862561;5446.863828404243;5458.153986132156;5500.944990550123;5522.530584900329;4300.440942677432;4313.094250207491;4342.261815491311;4349.369341445473;4378.737275763465;3886.106195575034;3888;3896.0649444133205;3897.2205558888336;3909.4526766252748;4988.351514303117;5119.948800512022;5169.586562663603;5178.119719647669;5216.530512253839;5387.46125387466;5425.511703946664;5493.890122197534;5495.0383682855345;5553.77784888608;5118.283440318359;5141.126008578476;5159.432462429129;5162.92255616166;5199.792008319625;4626.606738427204;4716.080364328923;4739.715617062987;4749.168895443284;4751.524847515221;5651;5664.461876121762;5684.261046064068;5703.572232082527;5731.684757338387;5473.781048758005;5480.177973304037;5494.945050549443;5495.807646732345;5496.120620700669;5524.613277070566;5576.693281869536;5596.145965557514;5610.803621873215;5672.205891175321;5425.376081750492;5443.047466693392;5466.562674985912;5483.177523371526;5554.111342185231;5379.031774280667;5382.03123437785;5389.083855744454;5395.919061214164;5399.379071406682;5235.031519168966;5280;5286.3392075990505;5349.037173308841;5353.330833645794;5283.762230699551;5323.547498462674;5365.248865158803;5387.542058924879;5403.324584426947;5255.080360936897;5274.525292723673;5274.578033757213;5296.443873393392;5314.62797604164;5175.767090481013;5383.865403364947;5402.864928376822;5407.215953686772;5436.374816895949;5195.064888319987;5204.401493828258;5232.947670523246;5259.42146363892;5272.894542109213 05:53:07 INFO - PROCESS | 7090 | |1;ext.html;536.5010540197615;573.6730063863598;587.6532845621083;589.9469447037039;592.6592209479549;28171.577426338597;29133.708662913392;29192.708072919264;32314.67685323146;32416.513752293733;39135;39590.406143907865;39654.405183922194;39659.60340396595;39702.20595588086;8490.702825401127;8667.609957551926;8746.606402711894;8751.912480875206;8751.956240218822;7372.926270737277;7525.172231054579;9981.550830212658;10079.647212347569;10087.293889427743;9904.950475247613;9944.502774861265;9953.552090155925;9978.900210997906;9990.550425230882;7388.556686598821;7537.359324457428;9756.170725488342;9855.162311203556;9858.211343092535;9933;10101.848472272923;10105.242106842017;10106;10110.696679099565;35726.464103038474;36147.277054459024;36176.09559761027;36225.81887090574;36227.09432264188;2493.289412517424;2696.7438093381097;2751.917442476709;2839.5882597023524;2933.149386677861;28033;28767.28081797951;28871.133865984055;29667.258318542208;30419;3723.757955732896;3796.335641262768;3797.4303854421782;3839.033324043475;3903.512060992376;269082;270557;271268;272654;272878;57851.710741446026;58272.70863645655;58298.12552811711;58317.70841145767;58350;55090.72454637701;56091.71954140203;62892;63430.682846586395;63464.36535634584;14574.562763117123;14649.194294313702;14731.410743570352;14763.483278085216;14780.852191478163;11292.717682058013;11343.716407089723;11354.829677554842;11364.374959377314;11364.431778411046;18706.906465467586;18708;18846.81153188478;18930.716039259423;18932.81067189338;7102;7156.785296441115;7187.748428804966;7239.167495737952;7244.160594884719;886.8625363068735;931.2456909903;959.1415682963848;963.7301555564453;993.2103977338033;28262.85868570644;28686;28879.278018049295;28937.421251575273;28999.85500072486;927.6243121535789;947.1381043250747;947.2564037230741;999.5302207962392;1044.9529771160317;13010.154339967872;13143.408546615425;13301.26843023643;13341.933290333487;13384.732305353838;252444;253361;253667;255502;256031;45371;45729.54270457319;45736.542634573896;45774;45781.31328030016;1266.1453518874907;1269.4795133995203;1279.5969269680022;1298.9350532473527;1313.7832257677376;21508.247211347527;25564.48871022532;26466.735332646425;26631.866840665672;26665.600016000164;41850;42136.36795448009;42213;42222.366664499445;42278.154436910474;204782;205840;206045;206416;206705;26823.329416763958;27052.32369190786;28562.85718571477;30317.66505684417;31380.529292061095;36006.81996590105;36882.44676329804;36978.63021369752;37542;39335.803320983214;32791.836040819646;33625.663743363235;33676.326473469904;33914;34229.828850855585;33181.50227746634;34147.829260853534;34306.14234644054;34408.13979650529;34565.48151777675;33007;33434.49848252229;33638.495422568194;33822;34169;29708.55437168401;30162;31121.53317700191;31126.844365778026;31192.22019449532;23460.882695587097;23861.761382385954;23905.402364941016;24213;24273 05:53:07 INFO - PROCESS | 7090 | |2;jquery.html;349.7883780312911;355.7616397014001;360.9133807886107;361.6492002757324;365.23118834852653;13532.93233533831;14061.086029408081;15932;16033.278502467389;16690.33238670452;15492.922535387335;15559.92220038901;16376.099314537696;16472.588185295375;16482.093484858327;4961.751912404384;5462.071447853875;5469.56243500521;5473.370562385317;5475.972620136914;3919.3729003359467;4052;5372.677639341632;5806.796762113327;5916.674582897939;5722.856928576777;5908.852278693024;5913.053911374181;5955.612885162473;6026.819195424145;5900.498457631106;5908.02517584598;5909.143174239733;5913.940860591382;5967.313758917737;5039.924401133986;5161.974190129063;5248.9737551312;5251.159814429673;5255.789768409259;19905.60188796216;20092.899535502376;20586.58826823455;20601.175952961865;20682.276120335868;1990.9402717918485;2024.665930121543;2031.1266155553105;2055.1162999910034;2093.884836334001;12866.549670761478;13536.526221582197;13971.301434928213;13977.3710183042;14041.64895877601;1734.470986349163;1772.53027947594;1813.6644720726708;1907.7329173915664;1953.5897461532952;56122.438775612536;60655;62276;64447.67776161089;64506.3549364505;14406.855931440761;14860.84517744921;14920.59215351669;14982.700345993018;15185.164815935008;22128.33614991553;22154.667679984814;22382.88808555947;22446.32661020172;22491;8780.912190878138;8971.102889711106;9007.189352958265;9020;9068.682596109105;7685.154632990367;7709.2290770922455;7750.186230445835;7770.261825126604;7819.530828150329;7003.439724822104;7509.399248060142;7641.1212710539;7644.197359277307;7681.61591920413;2677.357434215813;2935.4275916196566;2983.6419629644583;2998.7151220634005;3032.529957856536;973.3673112476947;992.7865508915618;1027.6043723166486;1031.3141760729181;1051.2010871737382;13704.588862334145;15353.692926141415;15931.601709957344;16482.83517164837;16698.58253543671;863.2575984653193;882.4969767232744;923.2429407885469;990.3513198854617;997.9671040473075;9308.627654893728;9343.672971445967;9395.06049395055;9594.42433453995;9790.06994335537;272492;279795;337527;340702;483254;64133.679331603045;64379.67810160919;64694.35305646883;69284.6535767318;70373;1094.370736826328;1133.9433028348549;1138.2032577195996;1143.8684551276542;1161.285809227319;14461.751230019916;15253.237338132827;15340.769888451905;15411;15422.305996229972;30968.690313097482;33128.66871331256;33335.33329333448;33471.83264083664;33700.831495842365;42325.78837105795;42391.7880410596;42996.78501607472;43646.78176609224;43853.78073109742;7065.611391373318;7094.219635840157;7275.308845659654;7314.743983960536;7315.926840731525;9259.444433334022;10870.076043536388;11057.61298354586;11281.32312061279;11715.355655439032;9713.70858874235;9882.308238423242;9941.602335906482;10146.695599132037;10259.7435064124;9679.854802178113;10324.328918620266;10375.869151015642;10405.58377664885;10414.166866650497;9751.073648003428;9981.850272246067;10195.388276703421;10273.304904690642;10472.581096756348;7287.417006639562;7474.7757567273065;7478.6260686966525;7527.1720110788865;7538.509996850187;8968.417052891542;9790.412575245224;10084.596616135272;10314.27800053989;10615.363078215332 05:53:07 INFO - PROCESS | 7090 | |3;mootools.html;1263.2041813657395;1429.3710767262403;1438.784182372644;1580.754982977639;1772.3796671165094;6711.932880671192;7275.345218930295;7371.447141464399;7383.48315617907;7403.592802395866;7262.600556969364;7398.926010739891;7408.814779630512;7423.331900128987;7427.702891884332;2275.601769690302;2306.6885970394032;2307.180950762472;2307.2962746362355;2308.6306191009444;2205.52581195043;2226.6882636430832;2227.766084561122;2230.319752475494;2250.2011785816044;2248.1119957616734;2268.5462907418582;2268.886555672218;2290.0725206291477;2304.6427803690453;2252.9636367271073;2274.6133157363206;2275.6586512023164;2281.0533628544135;2283.5318759654315;2212.9557408851892;2213.1589995801655;2213.6347502662043;2216.1467834883524;2217.1796435318875;7475.7383491578075;7529.284717951786;7531.5481071135355;7556.773296801105;7588.58262795546;4549.658775591811;4697.436307643071;4713.410823647044;4720.197566413718;4728.219843725781;2900.506913824655;2941.735243828066;3041.635003799558;3058;3060.32672811981;961.0917682789767;981.8723565936453;1008.0322890025584;1008.3748076192734;1017.2167431078102;10171.89828101717;10218.591256349737;10259.897401026043;10290.434026128485;10295.794084118275;4263.296556068276;4283.250431174532;4332.350147477903;4340.76125813077;4380.802863871133;8608.48349099056;8615.655373785105;8624.870626940601;8632.741017769476;8636.17956294151;4754.144254034307;4759.452662943737;4802.183628783116;4803.759812009385;4809.230523116355;3863.710221733325;3998.7200895937585;4260.744355338689;4309.310510318334;4346.6522678185665;3657.3782456981844;3661.2677464507206;3672.2839046385698;3710.3692372296773;3716.7212459065136;1207.7403358278013;1212.2241765270235;1213.4963989944251;1215.440897187286;1220.0666490135054;1284.1203775413871;1287.3949243855373;1290.0647030902521;1299.7205600795874;1312.3766211049865;7013.088298521262;7014.719411223494;7021.087258656444;7053.329933656294;7171.964140179266;478.909007288614;489.21236808737905;492.28864291099734;492.33043061436416;497.47267896030326;5461.726913654381;5514.09017512114;5517.779288828482;5521.668699878021;5524.558035357162;8874.556272186364;8875.644974201088;9124.403229434954;9124.635014599342;9224.631014759334;9022.413543119676;9111.544422778834;9124.270058395312;9129.132732390412;9134.132257435533;7014;7084.36240738336;7198.956151358128;7206.639668016683;7210.954411610392;6649.439965613177;6724.899126513008;6738.2924792898;6766.7969960901255;6781;8093.392995525477;8377.287930525974;8385.28725058377;8388.119247478928;8392.328613710766;8173.18268173178;8347.791305217175;8365.372597055124;8401.243888050105;8553.572321383781;5956.463918247378;6139.662318572521;6261.123442717932;6683.498737594797;6771.86456270862;7070.292970702889;7074.929250707427;7103.857922841411;7129.82175445618;7132.714691412285;6524.967375163284;6642.269350371359;6675.532712710064;6801.319868013357;6825.249222585611;6678.499112566674;6702.564333318319;6717.529772915849;6765.729370825112;6804.76183333581;6659.433948114271;6722.529422940543;6818;6842.349976752201;6852.691628876612;6307.3377295383325;6363.077353783768;6376.808695739135;6391.041343798467;6392.616443013248;6334.841628959313;6362.236531616236;6366.395192456709;6377.426031656987;6382.074599183 05:53:07 INFO - PROCESS | 7090 | |4;prototype.html;338.3351713882221;342.708697607034;345.4386621739673;349.5386090360724;352.79361573479514;5790.478856902878;5880.441358070982;5908.645481271126;5927.992241318981;5989.341172471025;5682.914756278659;5825.854353641151;5859.0625499920025;5865.472107510323;5878.794242201524;4580.541945805426;4589.151007063687;4590.196715574761;4592.311153327011;4594.494605593382;4412.8455504057365;4454.576815202567;4481.7983190756495;4517.819287228507;4590.3344015117955;4510.097980403916;4515.729056256635;4522.751248681321;4524.61540769035;4542.523035081318;4530.614897733697;4531.886702832423;4533.252013417782;4533.478649955248;4537.387452693877;3984.183242435294;3991.44119823225;3993.301172294866;3993.9201215975518;3996.4205190247544;5476.972615136939;5633.887322253573;5639.2668953036255;5656.943430565724;5698.772049118031;5256.369235691704;5256.632035757499;5259.684418934876;5261.237120617528;5267.920981185285;5961.642301461926;6280.183576135073;6281.497480201619;6287.276963149251;6289.182406287154;4171.436856024458;4393.802278897458;4418.5802348776815;4445.422095127613;4452.799624016927;6410.358964103552;6475.7085931133215;6491.642959637218;6505.381988711065;6551.705173267167;4565.474970378383;4581.793819278074;4605.447346318463;4607.470140933769;4611.446626404853;4519.0961807638605;4615.838445654386;4647.651426143053;4655.604273636779;4692.014676917817;5304.363476382781;5314.7608357624;5331.067063263913;5338.065838478251;5338.492843179892;6265.4361107500545;6321.1150438938585;6321.715522801485;6324.494040476751;6330.208723909512;1630.7390817469147;1655.4040545403886;1655.6192075822387;1658.0631942952193;1658.7097257979806;1112.076976109827;1127.560251501915;1132.796096702585;1132.937688427128;1160.1530882455686;5989.760409583568;5994.7602095916545;5995.250593675791;5998.1002849572915;5998.310194327621;6506.739730410825;6508.967455162694;6509.121268628674;6510.7721229756735;6516.152900123048;5854.502367298827;5979.133025711248;5992.861356342281;5996.610220335664;6000.729967151488;3477.704395126392;3503.2818272254126;3504.141485336058;3504.5093686883856;3512.3150985557572;6747.190337159573;6751.831204219934;6752.088468056848;6753.831154221184;6755.932440675629;6525.0538671893255;6623.3376662333385;6634.137562116894;6634.436072933758;6639.867202656016;6725.562838415487;6744.12326397575;6747.696353664097;6750.83122921921;6751.56114852533;6284.560080794484;6402.807915762534;6450.580712253689;6453.354664533509;6461.57999730016;6296.590721603081;6335.493160547053;6336.986082226822;6339.112524246517;6428.228612566522;6802.693878775368;6810.727570897108;6814.318568143344;6817.625030623363;6821.727130914708;4526.547345265447;4616.49218585962;4616.769161541843;4617.307403889444;4618.30725391194;6490.837729056811;6492.35076492347;6539.378759017885;6550.082988381535;6566.9014964774615;6368.23581170244;6379.266384365672;6380.617162970237;6386.105945167773;6386.648734319657;6145.324014358506;6259.3427690091885;6349.936500635119;6352.555321127662;6370.55406121567;6206.193194884636;6227.470664993526;6248;6250.406211409909;6253.624782513064;6375.234971803413;6383.87232255343;6384.936150638434;6385.45723613498;6387.55287129915;6081.726322315595;6217.844553886189;6236.563440559299;6237.75048998035;6238.719257633326 05:53:07 INFO - PROCESS | 7090 | |5;yui.html;689.2521614048757;757.7347928225118;819.802294652428;842.3934766967785;849.4011721736179;12932.418041188146;13056.216627002363;13060.281684507348;13070.15044022139;13114.47542098316;12419.813702794465;12423.068269879772;12481.188722733015;12484.375781210949;12493.68765780856;656.9507286953474;663.6515829189666;785.8035491127232;787.6416230615085;799.4443861516248;797.0316065979833;797.0913158998746;797.1868693932186;797.6729540888236;797.8045378882153;850.7915560687641;853.8036251662121;854.444611002847;854.6410507586828;855.2046596665099;697.9581225126509;705.28413660135;820.8030072782549;848.7793173774801;854.5300084953282;616.808789275326;617.7065893700501;617.7065893700501;618.0975775367968;620.2835724737935;12465.626031219077;12540.498380064786;12579.308138052404;12581.748365032649;12599.93700031503;11729;11942.343171125585;12105.273683578926;12456.626301210888;12957.805632915513;9122.998094012175;9269.907300926972;9408.717738467856;9425.104615061558;9494.05059494052;3544.167120726627;3583.8387272572795;3583.964160358415;3648.452732090181;3668.248009158116;46406.53593464056;46448;46592.76703616494;46661.53338466606;46748.02641775453;8683.088275731083;8707.956460217785;8921.55392230386;8931.19619234259;9638.807223855483;18584.163712632962;18680.7197892029;18739.25042998292;18743.90628046851;18747.81252187488;7324.963375183196;7371;7503.399728021745;7636.045494313211;7764.34003109742;4097.508299004079;4114.917701645951;4115.938260926088;4133.441985332001;4171.186618609403;3056.908292751221;3068.248279171617;3072.6312842459047;3073.523603841408;3076.86154123065;546.6856557479465;564.0946281218667;568.5196009372074;569.8205065404385;570.9229254050733;589.8820235952827;593.4243783529969;603.2338929559522;611.1688104178314;649.8108461515416;7764.728234511765;8065.233802788725;8134.959325203336;8198.877016844752;8496.660133594587;511.8797082685566;563.7998510528703;592.6681058607194;598.2193237824594;600.834770438133;3888.8055597220027;4099.672026237894;4238.385434112098;4302.333138363559;4350.73895566267;52325.47674523206;53029.7348513255;53648;53650;57347.42652573504;50819.23771143436;51569.2264616031;51839.481605183464;51864.74067629638;51919.221211681855;46008;46121;46319.5368046322;46790.29814552784;46894.29658555056;8538.871916921127;8743.781405464913;8855.60149793248;8864.645414183618;8895.73312800617;31716.36567268688;32396;32655.18362040873;33442.49836252409;33551.496727549595;41753.74738757842;43992;44455.33317000183;44463.77768111139;44504;9934.354266972623;9967.700968970943;10349.844752328872;10441.791164176522;10705.839412408975;10097.343672661253;10099.79800403973;10238.846417303896;10451.84322235152;10456.68629941103;10806.783864322511;10835.837462437912;11008.559657613927;11086.168537359568;11170.441477926233;10205.285630005828;10579.523921423708;10774.838377424501;10792.406417647106;11040.558377665126;10513.57945682164;10637.840432393676;10705.143588513056;10729.46352682347;10751.19366047534;8705.260052895575;9033.367664263438;9194.31042671789;9455.479948602893;9489.580157059905;8631.395802293779;9370.437773733598;9430.669926552811;9513.12989349565;9518.428894266366 05:53:07 INFO - PROCESS | 7090 | __end_tp_report 05:53:07 INFO - PROCESS | 7090 | __start_cc_report 05:53:07 INFO - PROCESS | 7090 | _x_x_mozilla_cycle_collect,998 05:53:07 INFO - PROCESS | 7090 | __end_cc_report 05:53:07 INFO - PROCESS | 7090 | __startTimestamp1452433987913__endTimestamp 05:53:07 INFO - PROCESS | 7090 | 05:53:07 INFO - PROCESS | 7090 | ------- Summary: start ------- 05:53:07 INFO - PROCESS | 7090 | Number of tests: 6 05:53:07 INFO - PROCESS | 7090 | 05:53:07 INFO - PROCESS | 7090 | [#0] dojo.html Cycles:165 Average:5106.73 Median:5272.89 stddev:537.39 (10.2%) stddev-sans-first:513.93 05:53:07 INFO - PROCESS | 7090 | Values: 3037.2 3097.8 3099.2 3140.4 3164.3 4966.8 5089.5 5148.5 5164.4 5201.1 4969.8 5014.0 5113.5 5126.4 5132.7 4670.4 4700.9 4719.7 4756.7 4830.1 4797.0 4806.2 4810.4 4862.9 4867.3 4591.4 4643.6 4702.2 4736.0 4747.3 4718.4 4719.0 4725.3 4728.2 4750.4 4672.2 4674.9 4677.3 4681.5 4719.6 4859.2 4920.8 4952.7 4958.6 4963.7 5421.1 5421.2 5424.9 5426.9 5433.8 5473.2 5474.0 5478.8 5511.8 5611.5 5202.1 5205.6 5210.8 5212.7 5217.9 5564.6 5633.6 5655.1 5680.5 5705.4 5358.7 5419.0 5447.1 5449.6 5461.8 5549.8 5557.3 5561.7 5563.9 5564.5 5463.6 5520.2 5521.9 5528.1 5536.7 5402.8 5446.9 5458.2 5500.9 5522.5 4300.4 4313.1 4342.3 4349.4 4378.7 3886.1 3888.0 3896.1 3897.2 3909.5 4988.4 5119.9 5169.6 5178.1 5216.5 5387.5 5425.5 5493.9 5495.0 5553.8 5118.3 5141.1 5159.4 5162.9 5199.8 4626.6 4716.1 4739.7 4749.2 4751.5 5651.0 5664.5 5684.3 5703.6 5731.7 5473.8 5480.2 5494.9 5495.8 5496.1 5524.6 5576.7 5596.1 5610.8 5672.2 5425.4 5443.0 5466.6 5483.2 5554.1 5379.0 5382.0 5389.1 5395.9 5399.4 5235.0 5280.0 5286.3 5349.0 5353.3 5283.8 5323.5 5365.2 5387.5 5403.3 5255.1 5274.5 5274.6 5296.4 5314.6 5175.8 5383.9 5402.9 5407.2 5436.4 5195.1 5204.4 5232.9 5259.4 5272.9 05:53:07 INFO - PROCESS | 7090 | 05:53:07 INFO - PROCESS | 7090 | [#1] ext.html Cycles:180 Average:40867.57 Median:33530.08 stddev:63877.00 (190.5%) stddev-sans-first:63984.41 05:53:07 INFO - PROCESS | 7090 | Values: 536.5 573.7 587.7 589.9 592.7 28171.6 29133.7 29192.7 32314.7 32416.5 39135.0 39590.4 39654.4 39659.6 39702.2 8490.7 8667.6 8746.6 8751.9 8752.0 7372.9 7525.2 9981.6 10079.6 10087.3 9905.0 9944.5 9953.6 9978.9 9990.6 7388.6 7537.4 9756.2 9855.2 9858.2 9933.0 10101.8 10105.2 10106.0 10110.7 35726.5 36147.3 36176.1 36225.8 36227.1 2493.3 2696.7 2751.9 2839.6 2933.1 28033.0 28767.3 28871.1 29667.3 30419.0 3723.8 3796.3 3797.4 3839.0 3903.5 269082.0 270557.0 271268.0 272654.0 272878.0 57851.7 58272.7 58298.1 58317.7 58350.0 55090.7 56091.7 62892.0 63430.7 63464.4 14574.6 14649.2 14731.4 14763.5 14780.9 11292.7 11343.7 11354.8 11364.4 11364.4 18706.9 18708.0 18846.8 18930.7 18932.8 7102.0 7156.8 7187.7 7239.2 7244.2 886.9 931.2 959.1 963.7 993.2 28262.9 28686.0 28879.3 28937.4 28999.9 927.6 947.1 947.3 999.5 1045.0 13010.2 13143.4 13301.3 13341.9 13384.7 252444.0 253361.0 253667.0 255502.0 256031.0 45371.0 45729.5 45736.5 45774.0 45781.3 1266.1 1269.5 1279.6 1298.9 1313.8 21508.2 25564.5 26466.7 26631.9 26665.6 41850.0 42136.4 42213.0 42222.4 42278.2 204782.0 205840.0 206045.0 206416.0 206705.0 26823.3 27052.3 28562.9 30317.7 31380.5 36006.8 36882.4 36978.6 37542.0 39335.8 32791.8 33625.7 33676.3 33914.0 34229.8 33181.5 34147.8 34306.1 34408.1 34565.5 33007.0 33434.5 33638.5 33822.0 34169.0 29708.6 30162.0 31121.5 31126.8 31192.2 23460.9 23861.8 23905.4 24213.0 24273.0 05:53:07 INFO - PROCESS | 7090 | 05:53:07 INFO - PROCESS | 7090 | [#2] jquery.html Cycles:180 Average:22706.76 Median:361.28 stddev:57706.64 (15972.8%) stddev-sans-first:57844.11 05:53:07 INFO - PROCESS | 7090 | Values: 349.8 355.8 360.9 361.6 365.2 13532.9 14061.1 15932.0 16033.3 16690.3 15492.9 15559.9 16376.1 16472.6 16482.1 4961.8 5462.1 5469.6 5473.4 5476.0 3919.4 4052.0 5372.7 5806.8 5916.7 5722.9 5908.9 5913.1 5955.6 6026.8 5900.5 5908.0 5909.1 5913.9 5967.3 5039.9 5162.0 5249.0 5251.2 5255.8 19905.6 20092.9 20586.6 20601.2 20682.3 1990.9 2024.7 2031.1 2055.1 2093.9 12866.5 13536.5 13971.3 13977.4 14041.6 1734.5 1772.5 1813.7 1907.7 1953.6 56122.4 60655.0 62276.0 64447.7 64506.4 14406.9 14860.8 14920.6 14982.7 15185.2 22128.3 22154.7 22382.9 22446.3 22491.0 8780.9 8971.1 9007.2 9020.0 9068.7 7685.2 7709.2 7750.2 7770.3 7819.5 7003.4 7509.4 7641.1 7644.2 7681.6 2677.4 2935.4 2983.6 2998.7 3032.5 973.4 992.8 1027.6 1031.3 1051.2 13704.6 15353.7 15931.6 16482.8 16698.6 863.3 882.5 923.2 990.4 998.0 9308.6 9343.7 9395.1 9594.4 9790.1 272492.0 279795.0 337527.0 340702.0 483254.0 64133.7 64379.7 64694.4 69284.7 70373.0 1094.4 1133.9 1138.2 1143.9 1161.3 14461.8 15253.2 15340.8 15411.0 15422.3 30968.7 33128.7 33335.3 33471.8 33700.8 42325.8 42391.8 42996.8 43646.8 43853.8 7065.6 7094.2 7275.3 7314.7 7315.9 9259.4 10870.1 11057.6 11281.3 11715.4 9713.7 9882.3 9941.6 10146.7 10259.7 9679.9 10324.3 10375.9 10405.6 10414.2 9751.1 9981.9 10195.4 10273.3 10472.6 7287.4 7474.8 7478.6 7527.2 7538.5 8968.4 9790.4 10084.6 10314.3 10615.4 05:53:07 INFO - PROCESS | 7090 | 05:53:07 INFO - PROCESS | 7090 | [#3] mootools.html Cycles:180 Average:5281.03 Median:6284.23 stddev:2712.13 (43.2%) stddev-sans-first:2702.92 05:53:07 INFO - PROCESS | 7090 | Values: 1263.2 1429.4 1438.8 1580.8 1772.4 6711.9 7275.3 7371.4 7383.5 7403.6 7262.6 7398.9 7408.8 7423.3 7427.7 2275.6 2306.7 2307.2 2307.3 2308.6 2205.5 2226.7 2227.8 2230.3 2250.2 2248.1 2268.5 2268.9 2290.1 2304.6 2253.0 2274.6 2275.7 2281.1 2283.5 2213.0 2213.2 2213.6 2216.1 2217.2 7475.7 7529.3 7531.5 7556.8 7588.6 4549.7 4697.4 4713.4 4720.2 4728.2 2900.5 2941.7 3041.6 3058.0 3060.3 961.1 981.9 1008.0 1008.4 1017.2 10171.9 10218.6 10259.9 10290.4 10295.8 4263.3 4283.3 4332.4 4340.8 4380.8 8608.5 8615.7 8624.9 8632.7 8636.2 4754.1 4759.5 4802.2 4803.8 4809.2 3863.7 3998.7 4260.7 4309.3 4346.7 3657.4 3661.3 3672.3 3710.4 3716.7 1207.7 1212.2 1213.5 1215.4 1220.1 1284.1 1287.4 1290.1 1299.7 1312.4 7013.1 7014.7 7021.1 7053.3 7172.0 478.9 489.2 492.3 492.3 497.5 5461.7 5514.1 5517.8 5521.7 5524.6 8874.6 8875.6 9124.4 9124.6 9224.6 9022.4 9111.5 9124.3 9129.1 9134.1 7014.0 7084.4 7199.0 7206.6 7211.0 6649.4 6724.9 6738.3 6766.8 6781.0 8093.4 8377.3 8385.3 8388.1 8392.3 8173.2 8347.8 8365.4 8401.2 8553.6 5956.5 6139.7 6261.1 6683.5 6771.9 7070.3 7074.9 7103.9 7129.8 7132.7 6525.0 6642.3 6675.5 6801.3 6825.2 6678.5 6702.6 6717.5 6765.7 6804.8 6659.4 6722.5 6818.0 6842.3 6852.7 6307.3 6363.1 6376.8 6391.0 6392.6 6334.8 6362.2 6366.4 6377.4 6382.1 05:53:07 INFO - PROCESS | 7090 | 05:53:07 INFO - PROCESS | 7090 | [#4] prototype.html Cycles:180 Average:5280.00 Median:5970.39 stddev:1570.97 (26.3%) stddev-sans-first:1530.97 05:53:07 INFO - PROCESS | 7090 | Values: 338.3 342.7 345.4 349.5 352.8 5790.5 5880.4 5908.6 5928.0 5989.3 5682.9 5825.9 5859.1 5865.5 5878.8 4580.5 4589.2 4590.2 4592.3 4594.5 4412.8 4454.6 4481.8 4517.8 4590.3 4510.1 4515.7 4522.8 4524.6 4542.5 4530.6 4531.9 4533.3 4533.5 4537.4 3984.2 3991.4 3993.3 3993.9 3996.4 5477.0 5633.9 5639.3 5656.9 5698.8 5256.4 5256.6 5259.7 5261.2 5267.9 5961.6 6280.2 6281.5 6287.3 6289.2 4171.4 4393.8 4418.6 4445.4 4452.8 6410.4 6475.7 6491.6 6505.4 6551.7 4565.5 4581.8 4605.4 4607.5 4611.4 4519.1 4615.8 4647.7 4655.6 4692.0 5304.4 5314.8 5331.1 5338.1 5338.5 6265.4 6321.1 6321.7 6324.5 6330.2 1630.7 1655.4 1655.6 1658.1 1658.7 1112.1 1127.6 1132.8 1132.9 1160.2 5989.8 5994.8 5995.3 5998.1 5998.3 6506.7 6509.0 6509.1 6510.8 6516.2 5854.5 5979.1 5992.9 5996.6 6000.7 3477.7 3503.3 3504.1 3504.5 3512.3 6747.2 6751.8 6752.1 6753.8 6755.9 6525.1 6623.3 6634.1 6634.4 6639.9 6725.6 6744.1 6747.7 6750.8 6751.6 6284.6 6402.8 6450.6 6453.4 6461.6 6296.6 6335.5 6337.0 6339.1 6428.2 6802.7 6810.7 6814.3 6817.6 6821.7 4526.5 4616.5 4616.8 4617.3 4618.3 6490.8 6492.4 6539.4 6550.1 6566.9 6368.2 6379.3 6380.6 6386.1 6386.6 6145.3 6259.3 6349.9 6352.6 6370.6 6206.2 6227.5 6248.0 6250.4 6253.6 6375.2 6383.9 6384.9 6385.5 6387.6 6081.7 6217.8 6236.6 6237.8 6238.7 05:53:07 INFO - PROCESS | 7090 | 05:53:07 INFO - PROCESS | 7090 | [#5] yui.html Cycles:180 Average:13321.99 Median:51704.35 stddev:15549.22 (30.1%) stddev-sans-first:15563.90 05:53:07 INFO - PROCESS | 7090 | Values: 689.3 757.7 819.8 842.4 849.4 12932.4 13056.2 13060.3 13070.2 13114.5 12419.8 12423.1 12481.2 12484.4 12493.7 657.0 663.7 785.8 787.6 799.4 797.0 797.1 797.2 797.7 797.8 850.8 853.8 854.4 854.6 855.2 698.0 705.3 820.8 848.8 854.5 616.8 617.7 617.7 618.1 620.3 12465.6 12540.5 12579.3 12581.7 12599.9 11729.0 11942.3 12105.3 12456.6 12957.8 9123.0 9269.9 9408.7 9425.1 9494.1 3544.2 3583.8 3584.0 3648.5 3668.2 46406.5 46448.0 46592.8 46661.5 46748.0 8683.1 8708.0 8921.6 8931.2 9638.8 18584.2 18680.7 18739.3 18743.9 18747.8 7325.0 7371.0 7503.4 7636.0 7764.3 4097.5 4114.9 4115.9 4133.4 4171.2 3056.9 3068.2 3072.6 3073.5 3076.9 546.7 564.1 568.5 569.8 570.9 589.9 593.4 603.2 611.2 649.8 7764.7 8065.2 8135.0 8198.9 8496.7 511.9 563.8 592.7 598.2 600.8 3888.8 4099.7 4238.4 4302.3 4350.7 52325.5 53029.7 53648.0 53650.0 57347.4 50819.2 51569.2 51839.5 51864.7 51919.2 46008.0 46121.0 46319.5 46790.3 46894.3 8538.9 8743.8 8855.6 8864.6 8895.7 31716.4 32396.0 32655.2 33442.5 33551.5 41753.7 43992.0 44455.3 44463.8 44504.0 9934.4 9967.7 10349.8 10441.8 10705.8 10097.3 10099.8 10238.8 10451.8 10456.7 10806.8 10835.8 11008.6 11086.2 11170.4 10205.3 10579.5 10774.8 10792.4 11040.6 10513.6 10637.8 10705.1 10729.5 10751.2 8705.3 9033.4 9194.3 9455.5 9489.6 8631.4 9370.4 9430.7 9513.1 9518.4 05:53:07 INFO - PROCESS | 7090 | -------- Summary: end -------- 05:53:07 INFO - PROCESS | 7090 | 05:53:08 INFO - TEST-INFO | 7090: exit 0 05:53:08 INFO - TEST-OK | dromaeo_css | took 1112795ms 05:53:08 INFO - TEST-START | kraken 05:53:08 INFO - operating with platform_type : linux_ 05:53:08 INFO - Initialising browser for kraken test... 05:53:08 INFO - TEST-INFO | started process 7283 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzFZ4L3/profile http://localhost:52519/getInfo.html) 05:53:12 INFO - PROCESS | 7283 | __metrics Screen width/height:1600/1200 05:53:12 INFO - PROCESS | 7283 | colorDepth:24 05:53:12 INFO - PROCESS | 7283 | Browser inner width/height: 1024/697 05:53:12 INFO - PROCESS | 7283 | __metrics 05:53:12 INFO - PROCESS | 7283 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:53:12 INFO - PROCESS | 7283 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:53:13 INFO - TEST-INFO | 7283: exit 0 05:53:13 INFO - Browser initialized. 05:53:13 INFO - Running cycle 1/1 for kraken test... 05:53:13 INFO - TEST-INFO | started process 7362 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzFZ4L3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:25 INFO - PROCESS | 7362 | RSS: Main: 149204992 05:53:25 INFO - PROCESS | 7362 | 05:53:28 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52519/tests/kraken/driver.html?testName=audio-beat-detection) 05:53:28 INFO - PROCESS | 7362 | RSS: Main: 185393152 05:53:28 INFO - PROCESS | 7362 | 05:53:31 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52519/tests/kraken/driver.html?testName=audio-dft) 05:53:31 INFO - PROCESS | 7362 | RSS: Main: 175599616 05:53:31 INFO - PROCESS | 7362 | 05:53:34 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52519/tests/kraken/driver.html?testName=audio-fft) 05:53:35 INFO - PROCESS | 7362 | RSS: Main: 160894976 05:53:35 INFO - PROCESS | 7362 | 05:53:37 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52519/tests/kraken/driver.html?testName=audio-oscillator) 05:53:37 INFO - PROCESS | 7362 | RSS: Main: 162463744 05:53:37 INFO - PROCESS | 7362 | 05:53:40 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52519/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:53:40 INFO - PROCESS | 7362 | RSS: Main: 164065280 05:53:40 INFO - PROCESS | 7362 | 05:53:43 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52519/tests/kraken/driver.html?testName=imaging-darkroom) 05:53:44 INFO - PROCESS | 7362 | RSS: Main: 163831808 05:53:44 INFO - PROCESS | 7362 | 05:53:47 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52519/tests/kraken/driver.html?testName=imaging-desaturate) 05:53:48 INFO - PROCESS | 7362 | RSS: Main: 166371328 05:53:48 INFO - PROCESS | 7362 | 05:53:50 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52519/tests/kraken/driver.html?testName=json-parse-financial) 05:53:51 INFO - PROCESS | 7362 | RSS: Main: 164352000 05:53:51 INFO - PROCESS | 7362 | 05:53:53 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52519/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:53 INFO - PROCESS | 7362 | RSS: Main: 177389568 05:53:53 INFO - PROCESS | 7362 | 05:53:55 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52519/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:55 INFO - PROCESS | 7362 | RSS: Main: 175542272 05:53:55 INFO - PROCESS | 7362 | 05:53:58 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52519/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:58 INFO - PROCESS | 7362 | RSS: Main: 191016960 05:53:58 INFO - PROCESS | 7362 | 05:54:01 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:54:01 INFO - PROCESS | 7362 | RSS: Main: 195784704 05:54:01 INFO - PROCESS | 7362 | 05:54:04 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:54:04 INFO - PROCESS | 7362 | RSS: Main: 194699264 05:54:04 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | Cycle 1(1): loaded http://localhost:52519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52519/tests/kraken/driver.html?testName=ai-astar) 05:54:06 INFO - PROCESS | 7362 | RSS: Main: 251285504 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | __start_tp_report 05:54:06 INFO - PROCESS | 7362 | _x_x_mozilla_page_load 05:54:06 INFO - PROCESS | 7362 | _x_x_mozilla_page_load_details 05:54:06 INFO - PROCESS | 7362 | |i|pagename|runs| 05:54:06 INFO - PROCESS | 7362 | |0;ai-astar;110;111;103;110;111;112;101;112;111;109 05:54:06 INFO - PROCESS | 7362 | |1;audio-beat-detection;156;125;150;173;131;155;151;140;165;132 05:54:06 INFO - PROCESS | 7362 | |2;audio-dft;162;161;162;160;161;160;161;164;162;161 05:54:06 INFO - PROCESS | 7362 | |3;audio-fft;72;75;85;98;72;71;73;98;95;71 05:54:06 INFO - PROCESS | 7362 | |4;audio-oscillator;96;96;146;95;96;97;136;96;96;149 05:54:06 INFO - PROCESS | 7362 | |5;imaging-gaussian-blur;109;108;109;110;109;109;109;109;109;109 05:54:06 INFO - PROCESS | 7362 | |6;imaging-darkroom;146;145;145;145;145;145;145;146;145;145 05:54:06 INFO - PROCESS | 7362 | |7;imaging-desaturate;95;95;96;95;95;95;96;96;95;96 05:54:06 INFO - PROCESS | 7362 | |8;json-parse-financial;55;56;55;59;56;55;55;64;54;53 05:54:06 INFO - PROCESS | 7362 | |9;json-stringify-tinderbox;68;67;68;68;68;70;68;68;68;69 05:54:06 INFO - PROCESS | 7362 | |10;stanford-crypto-aes;82;85;84;85;84;84;85;85;85;85 05:54:06 INFO - PROCESS | 7362 | |11;stanford-crypto-ccm;118;119;120;119;129;116;117;117;122;116 05:54:06 INFO - PROCESS | 7362 | |12;stanford-crypto-pbkdf2;138;149;147;146;148;139;149;148;147;139 05:54:06 INFO - PROCESS | 7362 | |13;stanford-crypto-sha256-iterative;68;68;66;67;67;66;68;69;66;67 05:54:06 INFO - PROCESS | 7362 | __end_tp_report 05:54:06 INFO - PROCESS | 7362 | __start_cc_report 05:54:06 INFO - PROCESS | 7362 | _x_x_mozilla_cycle_collect,983 05:54:06 INFO - PROCESS | 7362 | __end_cc_report 05:54:06 INFO - PROCESS | 7362 | __startTimestamp1452434046667__endTimestamp 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | ------- Summary: start ------- 05:54:06 INFO - PROCESS | 7362 | Number of tests: 14 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:3.83 (3.5%) stddev-sans-first:4.04 05:54:06 INFO - PROCESS | 7362 | Values: 110.0 111.0 103.0 110.0 111.0 112.0 101.0 112.0 111.0 109.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:153.00 stddev:15.55 (10.2%) stddev-sans-first:16.21 05:54:06 INFO - PROCESS | 7362 | Values: 156.0 125.0 150.0 173.0 131.0 155.0 151.0 140.0 165.0 132.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 05:54:06 INFO - PROCESS | 7362 | Values: 162.0 161.0 162.0 160.0 161.0 160.0 161.0 164.0 162.0 161.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#3] audio-fft Cycles:10 Average:81.00 Median:80.00 stddev:11.79 (14.7%) stddev-sans-first:12.05 05:54:06 INFO - PROCESS | 7362 | Values: 72.0 75.0 85.0 98.0 72.0 71.0 73.0 98.0 95.0 71.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:96.00 stddev:23.25 (24.2%) stddev-sans-first:24.08 05:54:06 INFO - PROCESS | 7362 | Values: 96.0 96.0 146.0 95.0 96.0 97.0 136.0 96.0 96.0 149.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:54:06 INFO - PROCESS | 7362 | Values: 109.0 108.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 05:54:06 INFO - PROCESS | 7362 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:54:06 INFO - PROCESS | 7362 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.50 stddev:3.16 (5.7%) stddev-sans-first:3.32 05:54:06 INFO - PROCESS | 7362 | Values: 55.0 56.0 55.0 59.0 56.0 55.0 55.0 64.0 54.0 53.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 05:54:06 INFO - PROCESS | 7362 | Values: 68.0 67.0 68.0 68.0 68.0 70.0 68.0 68.0 68.0 69.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:0.97 (1.1%) stddev-sans-first:0.50 05:54:06 INFO - PROCESS | 7362 | Values: 82.0 85.0 84.0 85.0 84.0 84.0 85.0 85.0 85.0 85.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:119.00 stddev:3.89 (3.3%) stddev-sans-first:4.10 05:54:06 INFO - PROCESS | 7362 | Values: 118.0 119.0 120.0 119.0 129.0 116.0 117.0 117.0 122.0 116.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:147.50 stddev:4.47 (3.0%) stddev-sans-first:3.96 05:54:06 INFO - PROCESS | 7362 | Values: 138.0 149.0 147.0 146.0 148.0 139.0 149.0 148.0 147.0 139.0 05:54:06 INFO - PROCESS | 7362 | 05:54:06 INFO - PROCESS | 7362 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.03 (1.5%) stddev-sans-first:1.05 05:54:06 INFO - PROCESS | 7362 | Values: 68.0 68.0 66.0 67.0 67.0 66.0 68.0 69.0 66.0 67.0 05:54:06 INFO - PROCESS | 7362 | -------- Summary: end -------- 05:54:06 INFO - PROCESS | 7362 | 05:54:07 INFO - TEST-INFO | 7362: exit 0 05:54:07 INFO - TEST-OK | kraken | took 58941ms 05:54:07 INFO - TEST-START | v8_7 05:54:07 INFO - operating with platform_type : linux_ 05:54:07 INFO - Initialising browser for v8_7 test... 05:54:07 INFO - TEST-INFO | started process 7614 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOzCW5w/profile http://localhost:52519/getInfo.html) 05:54:11 INFO - PROCESS | 7614 | __metrics Screen width/height:1600/1200 05:54:11 INFO - PROCESS | 7614 | colorDepth:24 05:54:11 INFO - PROCESS | 7614 | Browser inner width/height: 1024/697 05:54:11 INFO - PROCESS | 7614 | __metrics 05:54:11 INFO - PROCESS | 7614 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:54:11 INFO - PROCESS | 7614 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:54:12 INFO - TEST-INFO | 7614: exit 0 05:54:12 INFO - Browser initialized. 05:54:12 INFO - Running cycle 1/1 for v8_7 test... 05:54:12 INFO - TEST-INFO | started process 7697 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOzCW5w/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:24 INFO - PROCESS | 7697 | RSS: Main: 148938752 05:54:24 INFO - PROCESS | 7697 | 05:54:46 INFO - PROCESS | 7697 | Cycle 1(1): loaded http://localhost:52519/tests/v8_7/run.html (next: http://localhost:52519/tests/v8_7/run.html) 05:54:47 INFO - PROCESS | 7697 | RSS: Main: 538832896 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - PROCESS | 7697 | __start_tp_report 05:54:47 INFO - PROCESS | 7697 | _x_x_mozilla_page_load 05:54:47 INFO - PROCESS | 7697 | _x_x_mozilla_page_load_details 05:54:47 INFO - PROCESS | 7697 | |i|pagename|runs| 05:54:47 INFO - PROCESS | 7697 | |0;Richards;171.46776406035664 05:54:47 INFO - PROCESS | 7697 | |1;DeltaBlue;190.91256204658268 05:54:47 INFO - PROCESS | 7697 | |2;Encrypt;280.58361391694723 05:54:47 INFO - PROCESS | 7697 | |3;Decrypt;5263.1578947368425 05:54:47 INFO - PROCESS | 7697 | |4;RayTrace;1939.922480620155 05:54:47 INFO - PROCESS | 7697 | |5;Earley;797.609561752988 05:54:47 INFO - PROCESS | 7697 | |6;Boyer;12207.317073170732 05:54:47 INFO - PROCESS | 7697 | |7;RegExp;41979.5918367347 05:54:47 INFO - PROCESS | 7697 | |8;Splay;571.7552887364208 05:54:47 INFO - PROCESS | 7697 | |9;NavierStokes;4826.923076923077 05:54:47 INFO - PROCESS | 7697 | __end_tp_report 05:54:47 INFO - PROCESS | 7697 | __startTimestamp1452434087008__endTimestamp 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - PROCESS | 7697 | ------- Summary: start ------- 05:54:47 INFO - PROCESS | 7697 | Number of tests: 10 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - PROCESS | 7697 | [#0] Richards Cycles:1 Average:171.47 Median:171.47 stddev:0.00 (0.0%) 05:54:47 INFO - PROCESS | 7697 | Values: 171.5 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - PROCESS | 7697 | [#1] DeltaBlue Cycles:1 Average:190.91 Median:190.91 stddev:0.00 (0.0%) 05:54:47 INFO - PROCESS | 7697 | Values: 190.9 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - PROCESS | 7697 | [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 05:54:47 INFO - PROCESS | 7697 | Values: 280.6 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - PROCESS | 7697 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 05:54:47 INFO - PROCESS | 7697 | Values: 5263.2 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - PROCESS | 7697 | [#4] RayTrace Cycles:1 Average:1939.92 Median:1939.92 stddev:0.00 (0.0%) 05:54:47 INFO - PROCESS | 7697 | Values: 1939.9 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - PROCESS | 7697 | [#5] Earley Cycles:1 Average:797.61 Median:797.61 stddev:0.00 (0.0%) 05:54:47 INFO - PROCESS | 7697 | Values: 797.6 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - PROCESS | 7697 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 05:54:47 INFO - PROCESS | 7697 | Values: 12207.3 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - PROCESS | 7697 | [#7] RegExp Cycles:1 Average:41979.59 Median:41979.59 stddev:0.00 (0.0%) 05:54:47 INFO - PROCESS | 7697 | Values: 41979.6 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - PROCESS | 7697 | [#8] Splay Cycles:1 Average:571.76 Median:571.76 stddev:0.00 (0.0%) 05:54:47 INFO - PROCESS | 7697 | Values: 571.8 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - PROCESS | 7697 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 05:54:47 INFO - PROCESS | 7697 | Values: 4826.9 05:54:47 INFO - PROCESS | 7697 | -------- Summary: end -------- 05:54:47 INFO - PROCESS | 7697 | 05:54:47 INFO - TEST-INFO | 7697: exit 0 05:54:47 INFO - TEST-OK | v8_7 | took 40247ms 05:54:47 INFO - SUITE-END | took 1211s 05:54:48 INFO - Completed test suite (00:20:12) 05:54:48 INFO - Working with test: dromaeo_css 05:54:48 INFO - Generating results file: dromaeo_css 05:54:48 INFO - Working with test: kraken 05:54:48 INFO - Generating results file: kraken 05:54:48 INFO - javascript benchmark 05:54:48 INFO - Working with test: v8_7 05:54:48 INFO - Generating results file: v8_7 05:54:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:54:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 05:54:48 INFO - process_Request line: dromaeo_css 6758.86 graph.html#tests=[[72,1,35]] 05:54:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:54:48 INFO - process_Request line: kraken 1499.40 graph.html#tests=[[232,1,35]] 05:54:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:54:48 INFO - process_Request line: v8_7 18949.06 graph.html#tests=[[230,1,35]] 05:54:48 INFO - RETURN: dromaeo_css: 6758.86 05:54:48 INFO - RETURN: kraken: 1499.40 05:54:48 INFO - RETURN: v8_7: 18949.06 05:54:48 INFO - javascript benchmark 05:54:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3037.2255074955883, 3097.8141311521326, 3099.194209505529, 3140.387624413239, 3164.288035192081, 4966.826161084363, 5089.46560611136, 5148.48515148485, 5164.380274367072, 5201.089809283374, 4969.826056088038, 5013.97213571218, 5113.463086375933, 5126.41046279678, 5132.692038477694, 4670.392848929634, 4700.882477938045, 4719.693219940693, 4756.7145971241835, 4830.058138662962, 4796.952030479685, 4806.182948898678, 4810.446798618169, 4862.927056094161, 4867.342908707315, 4591.357209990604, 4643.605293550052, 4702.224133018048, 4736.029114031615, 4747.2879068140055, 4718.386609740746, 4719.032598317337, 4725.3384526166365, 4728.196206644879, 4750.406199225097, 4672.229082201433, 4674.906501869944, 4677.251639737659, 4681.508441613616, 4719.646026548023, 4859.198232291667, 4920.8031678732805, 4952.702837829742, 4958.553730164303, 4963.70217786934, 5421.051316019721, 5421.241026256327, 5424.864378390572, 5426.9185962210595, 5433.8369848904595, 5473.2063850741815, 5474.0, 5478.753456094485, 5511.834644960658, 5611.523020543259, 5202.115640341151, 5205.583553315726, 5210.817621383271, 5212.661177023481, 5217.947820521784, 5564.582656300713, 5633.63381380209, 5655.066913959151, 5680.460356266148, 5705.400932902068, 5358.732063396815, 5418.972905135449, 5447.101228297366, 5449.591280653967, 5461.781528738886, 5549.833504994856, 5557.277553917965, 5561.694106824163, 5563.916541251884, 5564.4713752193475, 5463.562914966793, 5520.199571062254, 5521.944780552223, 5528.143137813645, 5536.695481748542, 5402.837914862561, 5446.863828404243, 5458.153986132156, 5500.944990550123, 5522.530584900329, 4300.440942677432, 4313.094250207491, 4342.261815491311, 4349.369341445473, 4378.737275763465, 3886.106195575034, 3888.0, 3896.0649444133205, 3897.2205558888336, 3909.4526766252748, 4988.351514303117, 5119.948800512022, 5169.586562663603, 5178.119719647669, 5216.530512253839, 5387.46125387466, 5425.511703946664, 5493.890122197534, 5495.0383682855345, 5553.77784888608, 5118.283440318359, 5141.126008578476, 5159.432462429129, 5162.92255616166, 5199.792008319625, 4626.606738427204, 4716.080364328923, 4739.715617062987, 4749.168895443284, 4751.524847515221, 5651.0, 5664.461876121762, 5684.261046064068, 5703.572232082527, 5731.684757338387, 5473.781048758005, 5480.177973304037, 5494.945050549443, 5495.807646732345, 5496.120620700669, 5524.613277070566, 5576.693281869536, 5596.145965557514, 5610.803621873215, 5672.205891175321, 5425.376081750492, 5443.047466693392, 5466.562674985912, 5483.177523371526, 5554.111342185231, 5379.031774280667, 5382.03123437785, 5389.083855744454, 5395.919061214164, 5399.379071406682, 5235.031519168966, 5280.0, 5286.3392075990505, 5349.037173308841, 5353.330833645794, 5283.762230699551, 5323.547498462674, 5365.248865158803, 5387.542058924879, 5403.324584426947, 5255.080360936897, 5274.525292723673, 5274.578033757213, 5296.443873393392, 5314.62797604164, 5175.767090481013, 5383.865403364947, 5402.864928376822, 5407.215953686772, 5436.374816895949, 5195.064888319987, 5204.401493828258, 5232.947670523246, 5259.42146363892, 5272.894542109213], "unit": "score", "name": "dojo.html", "value": 5073.703831150439}, {"lowerIsBetter": false, "replicates": [536.5010540197615, 573.6730063863598, 587.6532845621083, 589.9469447037039, 592.6592209479549, 28171.577426338597, 29133.708662913392, 29192.708072919264, 32314.67685323146, 32416.513752293733, 39135.0, 39590.406143907865, 39654.405183922194, 39659.60340396595, 39702.20595588086, 8490.702825401127, 8667.609957551926, 8746.606402711894, 8751.912480875206, 8751.956240218822, 7372.926270737277, 7525.172231054579, 9981.550830212658, 10079.647212347569, 10087.293889427743, 9904.950475247613, 9944.502774861265, 9953.552090155925, 9978.900210997906, 9990.550425230882, 7388.556686598821, 7537.359324457428, 9756.170725488342, 9855.162311203556, 9858.211343092535, 9933.0, 10101.848472272923, 10105.242106842017, 10106.0, 10110.696679099565, 35726.464103038474, 36147.277054459024, 36176.09559761027, 36225.81887090574, 36227.09432264188, 2493.289412517424, 2696.7438093381097, 2751.917442476709, 2839.5882597023524, 2933.149386677861, 28033.0, 28767.28081797951, 28871.133865984055, 29667.258318542208, 30419.0, 3723.757955732896, 3796.335641262768, 3797.4303854421782, 3839.033324043475, 3903.512060992376, 269082.0, 270557.0, 271268.0, 272654.0, 272878.0, 57851.710741446026, 58272.70863645655, 58298.12552811711, 58317.70841145767, 58350.0, 55090.72454637701, 56091.71954140203, 62892.0, 63430.682846586395, 63464.36535634584, 14574.562763117123, 14649.194294313702, 14731.410743570352, 14763.483278085216, 14780.852191478163, 11292.717682058013, 11343.716407089723, 11354.829677554842, 11364.374959377314, 11364.431778411046, 18706.906465467586, 18708.0, 18846.81153188478, 18930.716039259423, 18932.81067189338, 7102.0, 7156.785296441115, 7187.748428804966, 7239.167495737952, 7244.160594884719, 886.8625363068735, 931.2456909903, 959.1415682963848, 963.7301555564453, 993.2103977338033, 28262.85868570644, 28686.0, 28879.278018049295, 28937.421251575273, 28999.85500072486, 927.6243121535789, 947.1381043250747, 947.2564037230741, 999.5302207962392, 1044.9529771160317, 13010.154339967872, 13143.408546615425, 13301.26843023643, 13341.933290333487, 13384.732305353838, 252444.0, 253361.0, 253667.0, 255502.0, 256031.0, 45371.0, 45729.54270457319, 45736.542634573896, 45774.0, 45781.31328030016, 1266.1453518874907, 1269.4795133995203, 1279.5969269680022, 1298.9350532473527, 1313.7832257677376, 21508.247211347527, 25564.48871022532, 26466.735332646425, 26631.866840665672, 26665.600016000164, 41850.0, 42136.36795448009, 42213.0, 42222.366664499445, 42278.154436910474, 204782.0, 205840.0, 206045.0, 206416.0, 206705.0, 26823.329416763958, 27052.32369190786, 28562.85718571477, 30317.66505684417, 31380.529292061095, 36006.81996590105, 36882.44676329804, 36978.63021369752, 37542.0, 39335.803320983214, 32791.836040819646, 33625.663743363235, 33676.326473469904, 33914.0, 34229.828850855585, 33181.50227746634, 34147.829260853534, 34306.14234644054, 34408.13979650529, 34565.48151777675, 33007.0, 33434.49848252229, 33638.495422568194, 33822.0, 34169.0, 29708.55437168401, 30162.0, 31121.53317700191, 31126.844365778026, 31192.22019449532, 23460.882695587097, 23861.761382385954, 23905.402364941016, 24213.0, 24273.0], "unit": "score", "name": "ext.html", "value": 17335.86173299304}, {"lowerIsBetter": false, "replicates": [349.7883780312911, 355.7616397014001, 360.9133807886107, 361.6492002757324, 365.23118834852653, 13532.93233533831, 14061.086029408081, 15932.0, 16033.278502467389, 16690.33238670452, 15492.922535387335, 15559.92220038901, 16376.099314537696, 16472.588185295375, 16482.093484858327, 4961.751912404384, 5462.071447853875, 5469.56243500521, 5473.370562385317, 5475.972620136914, 3919.3729003359467, 4052.0, 5372.677639341632, 5806.796762113327, 5916.674582897939, 5722.856928576777, 5908.852278693024, 5913.053911374181, 5955.612885162473, 6026.819195424145, 5900.498457631106, 5908.02517584598, 5909.143174239733, 5913.940860591382, 5967.313758917737, 5039.924401133986, 5161.974190129063, 5248.9737551312, 5251.159814429673, 5255.789768409259, 19905.60188796216, 20092.899535502376, 20586.58826823455, 20601.175952961865, 20682.276120335868, 1990.9402717918485, 2024.665930121543, 2031.1266155553105, 2055.1162999910034, 2093.884836334001, 12866.549670761478, 13536.526221582197, 13971.301434928213, 13977.3710183042, 14041.64895877601, 1734.470986349163, 1772.53027947594, 1813.6644720726708, 1907.7329173915664, 1953.5897461532952, 56122.438775612536, 60655.0, 62276.0, 64447.67776161089, 64506.3549364505, 14406.855931440761, 14860.84517744921, 14920.59215351669, 14982.700345993018, 15185.164815935008, 22128.33614991553, 22154.667679984814, 22382.88808555947, 22446.32661020172, 22491.0, 8780.912190878138, 8971.102889711106, 9007.189352958265, 9020.0, 9068.682596109105, 7685.154632990367, 7709.2290770922455, 7750.186230445835, 7770.261825126604, 7819.530828150329, 7003.439724822104, 7509.399248060142, 7641.1212710539, 7644.197359277307, 7681.61591920413, 2677.357434215813, 2935.4275916196566, 2983.6419629644583, 2998.7151220634005, 3032.529957856536, 973.3673112476947, 992.7865508915618, 1027.6043723166486, 1031.3141760729181, 1051.2010871737382, 13704.588862334145, 15353.692926141415, 15931.601709957344, 16482.83517164837, 16698.58253543671, 863.2575984653193, 882.4969767232744, 923.2429407885469, 990.3513198854617, 997.9671040473075, 9308.627654893728, 9343.672971445967, 9395.06049395055, 9594.42433453995, 9790.06994335537, 272492.0, 279795.0, 337527.0, 340702.0, 483254.0, 64133.679331603045, 64379.67810160919, 64694.35305646883, 69284.6535767318, 70373.0, 1094.370736826328, 1133.9433028348549, 1138.2032577195996, 1143.8684551276542, 1161.285809227319, 14461.751230019916, 15253.237338132827, 15340.769888451905, 15411.0, 15422.305996229972, 30968.690313097482, 33128.66871331256, 33335.33329333448, 33471.83264083664, 33700.831495842365, 42325.78837105795, 42391.7880410596, 42996.78501607472, 43646.78176609224, 43853.78073109742, 7065.611391373318, 7094.219635840157, 7275.308845659654, 7314.743983960536, 7315.926840731525, 9259.444433334022, 10870.076043536388, 11057.61298354586, 11281.32312061279, 11715.355655439032, 9713.70858874235, 9882.308238423242, 9941.602335906482, 10146.695599132037, 10259.7435064124, 9679.854802178113, 10324.328918620266, 10375.869151015642, 10405.58377664885, 10414.166866650497, 9751.073648003428, 9981.850272246067, 10195.388276703421, 10273.304904690642, 10472.581096756348, 7287.417006639562, 7474.7757567273065, 7478.6260686966525, 7527.1720110788865, 7538.509996850187, 8968.417052891542, 9790.412575245224, 10084.596616135272, 10314.27800053989, 10615.363078215332], "unit": "score", "name": "jquery.html", "value": 8698.285609118377}, {"lowerIsBetter": false, "replicates": [1263.2041813657395, 1429.3710767262403, 1438.784182372644, 1580.754982977639, 1772.3796671165094, 6711.932880671192, 7275.345218930295, 7371.447141464399, 7383.48315617907, 7403.592802395866, 7262.600556969364, 7398.926010739891, 7408.814779630512, 7423.331900128987, 7427.702891884332, 2275.601769690302, 2306.6885970394032, 2307.180950762472, 2307.2962746362355, 2308.6306191009444, 2205.52581195043, 2226.6882636430832, 2227.766084561122, 2230.319752475494, 2250.2011785816044, 2248.1119957616734, 2268.5462907418582, 2268.886555672218, 2290.0725206291477, 2304.6427803690453, 2252.9636367271073, 2274.6133157363206, 2275.6586512023164, 2281.0533628544135, 2283.5318759654315, 2212.9557408851892, 2213.1589995801655, 2213.6347502662043, 2216.1467834883524, 2217.1796435318875, 7475.7383491578075, 7529.284717951786, 7531.5481071135355, 7556.773296801105, 7588.58262795546, 4549.658775591811, 4697.436307643071, 4713.410823647044, 4720.197566413718, 4728.219843725781, 2900.506913824655, 2941.735243828066, 3041.635003799558, 3058.0, 3060.32672811981, 961.0917682789767, 981.8723565936453, 1008.0322890025584, 1008.3748076192734, 1017.2167431078102, 10171.89828101717, 10218.591256349737, 10259.897401026043, 10290.434026128485, 10295.794084118275, 4263.296556068276, 4283.250431174532, 4332.350147477903, 4340.76125813077, 4380.802863871133, 8608.48349099056, 8615.655373785105, 8624.870626940601, 8632.741017769476, 8636.17956294151, 4754.144254034307, 4759.452662943737, 4802.183628783116, 4803.759812009385, 4809.230523116355, 3863.710221733325, 3998.7200895937585, 4260.744355338689, 4309.310510318334, 4346.6522678185665, 3657.3782456981844, 3661.2677464507206, 3672.2839046385698, 3710.3692372296773, 3716.7212459065136, 1207.7403358278013, 1212.2241765270235, 1213.4963989944251, 1215.440897187286, 1220.0666490135054, 1284.1203775413871, 1287.3949243855373, 1290.0647030902521, 1299.7205600795874, 1312.3766211049865, 7013.088298521262, 7014.719411223494, 7021.087258656444, 7053.329933656294, 7171.964140179266, 478.909007288614, 489.21236808737905, 492.28864291099734, 492.33043061436416, 497.47267896030326, 5461.726913654381, 5514.09017512114, 5517.779288828482, 5521.668699878021, 5524.558035357162, 8874.556272186364, 8875.644974201088, 9124.403229434954, 9124.635014599342, 9224.631014759334, 9022.413543119676, 9111.544422778834, 9124.270058395312, 9129.132732390412, 9134.132257435533, 7014.0, 7084.36240738336, 7198.956151358128, 7206.639668016683, 7210.954411610392, 6649.439965613177, 6724.899126513008, 6738.2924792898, 6766.7969960901255, 6781.0, 8093.392995525477, 8377.287930525974, 8385.28725058377, 8388.119247478928, 8392.328613710766, 8173.18268173178, 8347.791305217175, 8365.372597055124, 8401.243888050105, 8553.572321383781, 5956.463918247378, 6139.662318572521, 6261.123442717932, 6683.498737594797, 6771.86456270862, 7070.292970702889, 7074.929250707427, 7103.857922841411, 7129.82175445618, 7132.714691412285, 6524.967375163284, 6642.269350371359, 6675.532712710064, 6801.319868013357, 6825.249222585611, 6678.499112566674, 6702.564333318319, 6717.529772915849, 6765.729370825112, 6804.76183333581, 6659.433948114271, 6722.529422940543, 6818.0, 6842.349976752201, 6852.691628876612, 6307.3377295383325, 6363.077353783768, 6376.808695739135, 6391.041343798467, 6392.616443013248, 6334.841628959313, 6362.236531616236, 6366.395192456709, 6377.426031656987, 6382.074599183], "unit": "score", "name": "mootools.html", "value": 4300.626825808819}, {"lowerIsBetter": false, "replicates": [338.3351713882221, 342.708697607034, 345.4386621739673, 349.5386090360724, 352.79361573479514, 5790.478856902878, 5880.441358070982, 5908.645481271126, 5927.992241318981, 5989.341172471025, 5682.914756278659, 5825.854353641151, 5859.0625499920025, 5865.472107510323, 5878.794242201524, 4580.541945805426, 4589.151007063687, 4590.196715574761, 4592.311153327011, 4594.494605593382, 4412.8455504057365, 4454.576815202567, 4481.7983190756495, 4517.819287228507, 4590.3344015117955, 4510.097980403916, 4515.729056256635, 4522.751248681321, 4524.61540769035, 4542.523035081318, 4530.614897733697, 4531.886702832423, 4533.252013417782, 4533.478649955248, 4537.387452693877, 3984.183242435294, 3991.44119823225, 3993.301172294866, 3993.9201215975518, 3996.4205190247544, 5476.972615136939, 5633.887322253573, 5639.2668953036255, 5656.943430565724, 5698.772049118031, 5256.369235691704, 5256.632035757499, 5259.684418934876, 5261.237120617528, 5267.920981185285, 5961.642301461926, 6280.183576135073, 6281.497480201619, 6287.276963149251, 6289.182406287154, 4171.436856024458, 4393.802278897458, 4418.5802348776815, 4445.422095127613, 4452.799624016927, 6410.358964103552, 6475.7085931133215, 6491.642959637218, 6505.381988711065, 6551.705173267167, 4565.474970378383, 4581.793819278074, 4605.447346318463, 4607.470140933769, 4611.446626404853, 4519.0961807638605, 4615.838445654386, 4647.651426143053, 4655.604273636779, 4692.014676917817, 5304.363476382781, 5314.7608357624, 5331.067063263913, 5338.065838478251, 5338.492843179892, 6265.4361107500545, 6321.1150438938585, 6321.715522801485, 6324.494040476751, 6330.208723909512, 1630.7390817469147, 1655.4040545403886, 1655.6192075822387, 1658.0631942952193, 1658.7097257979806, 1112.076976109827, 1127.560251501915, 1132.796096702585, 1132.937688427128, 1160.1530882455686, 5989.760409583568, 5994.7602095916545, 5995.250593675791, 5998.1002849572915, 5998.310194327621, 6506.739730410825, 6508.967455162694, 6509.121268628674, 6510.7721229756735, 6516.152900123048, 5854.502367298827, 5979.133025711248, 5992.861356342281, 5996.610220335664, 6000.729967151488, 3477.704395126392, 3503.2818272254126, 3504.141485336058, 3504.5093686883856, 3512.3150985557572, 6747.190337159573, 6751.831204219934, 6752.088468056848, 6753.831154221184, 6755.932440675629, 6525.0538671893255, 6623.3376662333385, 6634.137562116894, 6634.436072933758, 6639.867202656016, 6725.562838415487, 6744.12326397575, 6747.696353664097, 6750.83122921921, 6751.56114852533, 6284.560080794484, 6402.807915762534, 6450.580712253689, 6453.354664533509, 6461.57999730016, 6296.590721603081, 6335.493160547053, 6336.986082226822, 6339.112524246517, 6428.228612566522, 6802.693878775368, 6810.727570897108, 6814.318568143344, 6817.625030623363, 6821.727130914708, 4526.547345265447, 4616.49218585962, 4616.769161541843, 4617.307403889444, 4618.30725391194, 6490.837729056811, 6492.35076492347, 6539.378759017885, 6550.082988381535, 6566.9014964774615, 6368.23581170244, 6379.266384365672, 6380.617162970237, 6386.105945167773, 6386.648734319657, 6145.324014358506, 6259.3427690091885, 6349.936500635119, 6352.555321127662, 6370.55406121567, 6206.193194884636, 6227.470664993526, 6248.0, 6250.406211409909, 6253.624782513064, 6375.234971803413, 6383.87232255343, 6384.936150638434, 6385.45723613498, 6387.55287129915, 6081.726322315595, 6217.844553886189, 6236.563440559299, 6237.75048998035, 6238.719257633326], "unit": "score", "name": "prototype.html", "value": 4778.230583568558}, {"lowerIsBetter": false, "replicates": [689.2521614048757, 757.7347928225118, 819.802294652428, 842.3934766967785, 849.4011721736179, 12932.418041188146, 13056.216627002363, 13060.281684507348, 13070.15044022139, 13114.47542098316, 12419.813702794465, 12423.068269879772, 12481.188722733015, 12484.375781210949, 12493.68765780856, 656.9507286953474, 663.6515829189666, 785.8035491127232, 787.6416230615085, 799.4443861516248, 797.0316065979833, 797.0913158998746, 797.1868693932186, 797.6729540888236, 797.8045378882153, 850.7915560687641, 853.8036251662121, 854.444611002847, 854.6410507586828, 855.2046596665099, 697.9581225126509, 705.28413660135, 820.8030072782549, 848.7793173774801, 854.5300084953282, 616.808789275326, 617.7065893700501, 617.7065893700501, 618.0975775367968, 620.2835724737935, 12465.626031219077, 12540.498380064786, 12579.308138052404, 12581.748365032649, 12599.93700031503, 11729.0, 11942.343171125585, 12105.273683578926, 12456.626301210888, 12957.805632915513, 9122.998094012175, 9269.907300926972, 9408.717738467856, 9425.104615061558, 9494.05059494052, 3544.167120726627, 3583.8387272572795, 3583.964160358415, 3648.452732090181, 3668.248009158116, 46406.53593464056, 46448.0, 46592.76703616494, 46661.53338466606, 46748.02641775453, 8683.088275731083, 8707.956460217785, 8921.55392230386, 8931.19619234259, 9638.807223855483, 18584.163712632962, 18680.7197892029, 18739.25042998292, 18743.90628046851, 18747.81252187488, 7324.963375183196, 7371.0, 7503.399728021745, 7636.045494313211, 7764.34003109742, 4097.508299004079, 4114.917701645951, 4115.938260926088, 4133.441985332001, 4171.186618609403, 3056.908292751221, 3068.248279171617, 3072.6312842459047, 3073.523603841408, 3076.86154123065, 546.6856557479465, 564.0946281218667, 568.5196009372074, 569.8205065404385, 570.9229254050733, 589.8820235952827, 593.4243783529969, 603.2338929559522, 611.1688104178314, 649.8108461515416, 7764.728234511765, 8065.233802788725, 8134.959325203336, 8198.877016844752, 8496.660133594587, 511.8797082685566, 563.7998510528703, 592.6681058607194, 598.2193237824594, 600.834770438133, 3888.8055597220027, 4099.672026237894, 4238.385434112098, 4302.333138363559, 4350.73895566267, 52325.47674523206, 53029.7348513255, 53648.0, 53650.0, 57347.42652573504, 50819.23771143436, 51569.2264616031, 51839.481605183464, 51864.74067629638, 51919.221211681855, 46008.0, 46121.0, 46319.5368046322, 46790.29814552784, 46894.29658555056, 8538.871916921127, 8743.781405464913, 8855.60149793248, 8864.645414183618, 8895.73312800617, 31716.36567268688, 32396.0, 32655.18362040873, 33442.49836252409, 33551.496727549595, 41753.74738757842, 43992.0, 44455.33317000183, 44463.77768111139, 44504.0, 9934.354266972623, 9967.700968970943, 10349.844752328872, 10441.791164176522, 10705.839412408975, 10097.343672661253, 10099.79800403973, 10238.846417303896, 10451.84322235152, 10456.68629941103, 10806.783864322511, 10835.837462437912, 11008.559657613927, 11086.168537359568, 11170.441477926233, 10205.285630005828, 10579.523921423708, 10774.838377424501, 10792.406417647106, 11040.558377665126, 10513.57945682164, 10637.840432393676, 10705.143588513056, 10729.46352682347, 10751.19366047534, 8705.260052895575, 9033.367664263438, 9194.31042671789, 9455.479948602893, 9489.580157059905, 8631.395802293779, 9370.437773733598, 9430.669926552811, 9513.12989349565, 9518.428894266366], "unit": "score", "name": "yui.html", "value": 6063.1787153459645}], "name": "dromaeo_css", "value": 6758.8633069109455}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 103.0, 110.0, 111.0, 112.0, 101.0, 112.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [156.0, 125.0, 150.0, 173.0, 131.0, 155.0, 151.0, 140.0, 165.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 160.0, 161.0, 160.0, 161.0, 164.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 85.0, 98.0, 72.0, 71.0, 73.0, 98.0, 95.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 146.0, 95.0, 96.0, 97.0, 136.0, 96.0, 96.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [109.0, 108.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 55.0, 59.0, 56.0, 55.0, 55.0, 64.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 68.0, 70.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 120.0, 119.0, 129.0, 116.0, 117.0, 117.0, 122.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [138.0, 149.0, 147.0, 146.0, 148.0, 139.0, 149.0, 148.0, 147.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 66.0, 67.0, 67.0, 66.0, 68.0, 69.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1499.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.46776406035664], "unit": "score", "name": "Richards", "value": 205.881264}, {"lowerIsBetter": false, "replicates": [190.91256204658268], "unit": "score", "name": "DeltaBlue", "value": 346.3260840000001}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1939.922480620155], "unit": "score", "name": "RayTrace", "value": 381.452871128871}, {"lowerIsBetter": false, "replicates": [797.609561752988], "unit": "score", "name": "Earley", "value": 835.5754895104897}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [41979.5918367347], "unit": "score", "name": "RegExp", "value": 21.700663587749155}, {"lowerIsBetter": false, "replicates": [571.7552887364208], "unit": "score", "name": "Splay", "value": 142.52775899999997}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 18949.05757749151}]} 05:54:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18949.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1499.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6758.86"}}} 05:54:48 INFO - Return code: 0 05:54:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:54:48 INFO - # TBPL SUCCESS # 05:54:48 INFO - Running post-action listener: _resource_record_post_action 05:54:48 INFO - Running post-run listener: _resource_record_post_run 05:54:49 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 550526976; Read time: 0; Write time: 429600 05:54:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 239607808; Read time: 0; Write time: 225448 05:54:49 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 310919168; Read time: 0; Write time: 204152 05:54:49 INFO - Running post-run listener: _upload_blobber_files 05:54:49 INFO - Blob upload gear active. 05:54:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:54:49 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 05:54:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:54:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:54:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:54:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:54:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:54:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:50 INFO - (blobuploader) - INFO - Done attempting. 05:54:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:54:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:54:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:51 INFO - (blobuploader) - INFO - Done attempting. 05:54:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:54:51 INFO - Return code: 0 05:54:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:54:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:54:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0945103113e046560437f102d321e6b4f7812a72678c9f03b02f75c4365f4ad19de86e0bc4db06d02f98ef3289ac732e1fad65cd3995a9f38593edbe97cd5140", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fe78ae7b0e85cdfe3cc959b644d033dfc7cbaafe0e9d7144c298bf1fe5d81a159d4e10a840df5f9ceb3e0b37d81ebc75f9234b6a16a25648cfd0ee932e052a1"} 05:54:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:54:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:54:51 INFO - Contents: 05:54:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0945103113e046560437f102d321e6b4f7812a72678c9f03b02f75c4365f4ad19de86e0bc4db06d02f98ef3289ac732e1fad65cd3995a9f38593edbe97cd5140", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fe78ae7b0e85cdfe3cc959b644d033dfc7cbaafe0e9d7144c298bf1fe5d81a159d4e10a840df5f9ceb3e0b37d81ebc75f9234b6a16a25648cfd0ee932e052a1"} 05:54:51 INFO - Copying logs to upload dir... 05:54:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1283.443323 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-10 05:54:49.260557) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 05:54:49.266260) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0945103113e046560437f102d321e6b4f7812a72678c9f03b02f75c4365f4ad19de86e0bc4db06d02f98ef3289ac732e1fad65cd3995a9f38593edbe97cd5140", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fe78ae7b0e85cdfe3cc959b644d033dfc7cbaafe0e9d7144c298bf1fe5d81a159d4e10a840df5f9ceb3e0b37d81ebc75f9234b6a16a25648cfd0ee932e052a1"} build_url:https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0945103113e046560437f102d321e6b4f7812a72678c9f03b02f75c4365f4ad19de86e0bc4db06d02f98ef3289ac732e1fad65cd3995a9f38593edbe97cd5140", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fe78ae7b0e85cdfe3cc959b644d033dfc7cbaafe0e9d7144c298bf1fe5d81a159d4e10a840df5f9ceb3e0b37d81ebc75f9234b6a16a25648cfd0ee932e052a1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 05:54:49.291354) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:54:49.291715) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452424418.801328-398452826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:54:49.376593) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 05:54:49.376919) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 05:54:49.377244) ========= ========= Total master_lag: 0.28 =========