builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1452869491.19 results: success (0) buildid: 20160115043011 builduid: f0b9728ffb82426bb433d3014e27b376 revision: e1486d83107fc4933982d371828d038ad57682e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.186623) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.187223) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.187970) ========= 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=337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006406 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.214462) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.214803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.234684) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.234989) ========= 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=337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004723 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.287336) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.288070) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.288570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.288907) ========= 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=337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 06:51:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-01-15 06:51:31 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136792 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.441195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.441568) ========= 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=337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019910 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.494295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.495042) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e1486d83107fc4933982d371828d038ad57682e4 --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 e1486d83107fc4933982d371828d038ad57682e4 --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=337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 06:51:31,748 truncating revision to first 12 chars 2016-01-15 06:51:31,748 Setting DEBUG logging. 2016-01-15 06:51:31,748 attempt 1/10 2016-01-15 06:51:31,748 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e1486d83107f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 06:51:31,991 unpacking tar archive at: mozilla-central-e1486d83107f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556522 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.072518) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.072859) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.335235) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.335572) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.336028) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-15 06:51:32.336369) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:51:32 INFO - MultiFileLogger online at 20160115 06:51:32 in /builds/slave/test-pgo 06:51:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:51:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:51:32 INFO - {'append_to_log': False, 06:51:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:51:32 INFO - 'blob_upload_branch': 'Firefox', 06:51:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:51:32 INFO - 'branch': 'Firefox', 06:51:32 INFO - 'buildbot_json_path': 'buildprops.json', 06:51:32 INFO - 'config_files': ('talos/linux_config.py',), 06:51:32 INFO - 'default_actions': ('clobber', 06:51:32 INFO - 'read-buildbot-config', 06:51:32 INFO - 'download-and-extract', 06:51:32 INFO - 'populate-webroot', 06:51:32 INFO - 'create-virtualenv', 06:51:32 INFO - 'install', 06:51:32 INFO - 'run-tests'), 06:51:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:51:32 INFO - 'download_minidump_stackwalk': True, 06:51:32 INFO - 'download_symbols': 'ondemand', 06:51:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:51:32 INFO - 'tooltool.py': '/tools/tooltool.py', 06:51:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:51:32 INFO - '/tools/misc-python/virtualenv.py')}, 06:51:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:51:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:51:32 INFO - 'installer_path': 'installer.exe', 06:51:32 INFO - 'log_level': 'info', 06:51:32 INFO - 'log_name': 'talos', 06:51:32 INFO - 'log_to_console': True, 06:51:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:51:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:51:32 INFO - 'opt_config_files': (), 06:51:32 INFO - 'pip_index': False, 06:51:32 INFO - 'sps_profile': False, 06:51:32 INFO - 'sps_profile_interval': 0, 06:51:32 INFO - 'suite': 'dromaeojs-e10s', 06:51:32 INFO - 'system_bits': '32', 06:51:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:51:32 INFO - 'title': 'talos-linux64-ix-060', 06:51:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:51:32 INFO - 'use_talos_json': True, 06:51:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:51:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:51:32 INFO - 'work_dir': 'build'} 06:51:32 INFO - ##### 06:51:32 INFO - ##### Running clobber step. 06:51:32 INFO - ##### 06:51:32 INFO - Running pre-action listener: _resource_record_pre_action 06:51:32 INFO - Running main action method: clobber 06:51:32 INFO - rmtree: /builds/slave/test-pgo/build 06:51:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:51:33 INFO - Running post-action listener: _resource_record_post_action 06:51:33 INFO - ##### 06:51:33 INFO - ##### Running read-buildbot-config step. 06:51:33 INFO - ##### 06:51:33 INFO - Running pre-action listener: _resource_record_pre_action 06:51:33 INFO - Running main action method: read_buildbot_config 06:51:33 INFO - Using buildbot properties: 06:51:33 INFO - { 06:51:33 INFO - "project": "", 06:51:33 INFO - "product": "firefox", 06:51:33 INFO - "script_repo_revision": "production", 06:51:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:51:33 INFO - "repository": "", 06:51:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:51:33 INFO - "buildid": "20160115043011", 06:51:33 INFO - "pgo_build": "True", 06:51:33 INFO - "basedir": "/builds/slave/test-pgo", 06:51:33 INFO - "buildnumber": 300, 06:51:33 INFO - "slavename": "talos-linux64-ix-060", 06:51:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:51:33 INFO - "platform": "ubuntu64_hw", 06:51:33 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:51:33 INFO - "branch": "mozilla-central", 06:51:33 INFO - "repo_path": "mozilla-central", 06:51:33 INFO - "revision": "e1486d83107fc4933982d371828d038ad57682e4", 06:51:33 INFO - "stage_platform": "linux64-pgo", 06:51:33 INFO - "builduid": "f0b9728ffb82426bb433d3014e27b376", 06:51:33 INFO - "slavebuilddir": "test" 06:51:33 INFO - } 06:51:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:51:33 INFO - Running post-action listener: _resource_record_post_action 06:51:33 INFO - ##### 06:51:33 INFO - ##### Running download-and-extract step. 06:51:33 INFO - ##### 06:51:33 INFO - Running pre-action listener: _resource_record_pre_action 06:51:33 INFO - Running main action method: download_and_extract 06:51:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:33 INFO - https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:51:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/test_packages.json 06:51:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/test_packages.json 06:51:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:51:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:51:39 INFO - Downloaded 1448 bytes. 06:51:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:51:39 INFO - Using the following test package requirements: 06:51:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:51:39 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:51:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:39 INFO - u'jsshell-linux-x86_64.zip'], 06:51:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:51:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:51:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:51:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:51:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:51:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:39 INFO - https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:51:42 INFO - Downloaded 22440531 bytes. 06:51:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:51:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:51:44 INFO - Return code: 0 06:51:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:44 INFO - https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:51:51 INFO - Downloaded 22440531 bytes. 06:51:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:51:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:51:52 INFO - Return code: 0 06:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:52 INFO - https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:51:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:51:55 INFO - Downloaded 11132144 bytes. 06:51:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:51:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 06:51:55 INFO - Return code: 0 06:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:55 INFO - https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:51:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:51:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:51:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:51:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:51:58 INFO - Downloaded 55940114 bytes. 06:51:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:51:58 INFO - mkdir: /builds/slave/test-pgo/properties 06:51:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:51:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:51:58 INFO - Contents: 06:51:58 INFO - build_url:https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:51:58 INFO - Running post-action listener: _resource_record_post_action 06:51:58 INFO - Running post-action listener: set_extra_try_arguments 06:51:58 INFO - ##### 06:51:58 INFO - ##### Running populate-webroot step. 06:51:58 INFO - ##### 06:51:58 INFO - Running pre-action listener: _resource_record_pre_action 06:51:58 INFO - Running main action method: populate_webroot 06:51:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:58 INFO - '--tppagecycles', 06:51:58 INFO - '7'], 06:51:58 INFO - 'tests': ['tsvgm']}}, 06:51:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:51:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:51:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:51:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:51:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:51:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:58 INFO - 'talos_options': ['--e10s'], 06:51:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:58 INFO - 'tests': ['damp', 'tps']}, 06:51:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:58 INFO - 'talos_options': ['--e10s'], 06:51:58 INFO - 'tests': ['damp', 'tps']}, 06:51:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:51:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:58 INFO - 'other': {'tests': ['a11yr', 06:51:58 INFO - 'ts_paint', 06:51:58 INFO - 'tpaint', 06:51:58 INFO - 'sessionrestore', 06:51:58 INFO - 'sessionrestore_no_auto_restore']}, 06:51:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:51:58 INFO - 'tests': ['a11yr', 06:51:58 INFO - 'ts_paint', 06:51:58 INFO - 'tpaint', 06:51:58 INFO - 'sessionrestore', 06:51:58 INFO - 'sessionrestore_no_auto_restore']}, 06:51:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:51:58 INFO - 'tests': ['a11yr', 06:51:58 INFO - 'ts_paint', 06:51:58 INFO - 'tpaint', 06:51:58 INFO - 'sessionrestore', 06:51:58 INFO - 'sessionrestore_no_auto_restore']}, 06:51:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:51:58 INFO - 'tests': ['a11yr', 06:51:58 INFO - 'ts_paint', 06:51:58 INFO - 'tpaint', 06:51:58 INFO - 'sessionrestore', 06:51:58 INFO - 'sessionrestore_no_auto_restore']}, 06:51:58 INFO - 'other_l64': {'tests': ['a11yr', 06:51:58 INFO - 'ts_paint', 06:51:58 INFO - 'tpaint', 06:51:58 INFO - 'sessionrestore', 06:51:58 INFO - 'sessionrestore_no_auto_restore']}, 06:51:58 INFO - 'other_nol64': {'tests': ['a11yr', 06:51:58 INFO - 'ts_paint', 06:51:58 INFO - 'tpaint', 06:51:58 INFO - 'sessionrestore', 06:51:58 INFO - 'sessionrestore_no_auto_restore']}, 06:51:58 INFO - 'svgr': {'tests': ['tsvgx', 06:51:58 INFO - 'tsvgr_opacity', 06:51:58 INFO - 'tart', 06:51:58 INFO - 'tscrollx', 06:51:58 INFO - 'cart']}, 06:51:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:51:58 INFO - 'tests': ['tsvgx', 06:51:58 INFO - 'tsvgr_opacity', 06:51:58 INFO - 'tart', 06:51:58 INFO - 'tscrollx', 06:51:58 INFO - 'cart']}, 06:51:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:58 INFO - 'tests': ['tp5o']}, 06:51:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:58 INFO - 'talos_options': ['--e10s'], 06:51:58 INFO - 'tests': ['tp5o']}, 06:51:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:58 INFO - 'talos_options': ['--xperf_path', 06:51:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:58 INFO - 'tests': ['tp5n']}, 06:51:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:58 INFO - 'talos_options': ['--e10s', 06:51:58 INFO - '--xperf_path', 06:51:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:58 INFO - 'tests': ['tp5n']}}, 06:51:58 INFO - 'talos.zip': {'path': '', 06:51:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:58 INFO - Running post-action listener: _resource_record_post_action 06:51:58 INFO - ##### 06:51:58 INFO - ##### Running create-virtualenv step. 06:51:58 INFO - ##### 06:51:58 INFO - Running pre-action listener: _resource_record_pre_action 06:51:58 INFO - Running main action method: create_virtualenv 06:51:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:51:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 06:51:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:51:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:58 INFO - Using real prefix '/usr' 06:51:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:51:59 INFO - Installing distribute.............................................................................................................................................................................................done. 06:52:01 INFO - Installing pip.................done. 06:52:01 INFO - Return code: 0 06:52:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:01 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 0x7fcf7e581f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb840>, '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 0x1c286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c28b60>, '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': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:52:01 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 06:52:01 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 06:52:01 INFO - Using env: {'DISPLAY': ':0', 06:52:01 INFO - 'HOME': '/home/cltbld', 06:52:01 INFO - 'LANG': 'en_US.UTF-8', 06:52:01 INFO - 'LANGUAGE': 'en_US:en', 06:52:01 INFO - 'LOGNAME': 'cltbld', 06:52:01 INFO - 'MAIL': '/var/mail/cltbld', 06:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:01 INFO - 'MOZ_NO_REMOTE': '1', 06:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:01 INFO - 'NO_EM_RESTART': '1', 06:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:01 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:01 INFO - 'SHELL': '/bin/bash', 06:52:01 INFO - 'SHLVL': '1', 06:52:01 INFO - 'TERM': 'linux', 06:52:01 INFO - 'TMOUT': '86400', 06:52:01 INFO - 'USER': 'cltbld', 06:52:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 06:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:01 INFO - '_': '/tools/buildbot/bin/python'} 06:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:52:01 INFO - Cleaning up... 06:52:01 INFO - Return code: 0 06:52:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:01 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 0x7fcf7e581f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb840>, '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 0x1c286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c28b60>, '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': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:52:01 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 06:52:01 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 06:52:01 INFO - Using env: {'DISPLAY': ':0', 06:52:01 INFO - 'HOME': '/home/cltbld', 06:52:01 INFO - 'LANG': 'en_US.UTF-8', 06:52:01 INFO - 'LANGUAGE': 'en_US:en', 06:52:01 INFO - 'LOGNAME': 'cltbld', 06:52:01 INFO - 'MAIL': '/var/mail/cltbld', 06:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:01 INFO - 'MOZ_NO_REMOTE': '1', 06:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:01 INFO - 'NO_EM_RESTART': '1', 06:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:01 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:01 INFO - 'SHELL': '/bin/bash', 06:52:01 INFO - 'SHLVL': '1', 06:52:01 INFO - 'TERM': 'linux', 06:52:01 INFO - 'TMOUT': '86400', 06:52:01 INFO - 'USER': 'cltbld', 06:52:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 06:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:01 INFO - '_': '/tools/buildbot/bin/python'} 06:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:01 INFO - Downloading/unpacking psutil>=0.7.1 06:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:52:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:52:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:52:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:03 INFO - Installing collected packages: psutil 06:52:03 INFO - Running setup.py install for psutil 06:52:03 INFO - building 'psutil._psutil_linux' extension 06:52:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:52:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:52:03 INFO - building 'psutil._psutil_posix' extension 06:52:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:52:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:52:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:03 INFO - Successfully installed psutil 06:52:03 INFO - Cleaning up... 06:52:03 INFO - Return code: 0 06:52:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:03 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 0x7fcf7e581f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb840>, '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 0x1c286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c28b60>, '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': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:52:03 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 06:52:03 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 06:52:03 INFO - Using env: {'DISPLAY': ':0', 06:52:03 INFO - 'HOME': '/home/cltbld', 06:52:03 INFO - 'LANG': 'en_US.UTF-8', 06:52:03 INFO - 'LANGUAGE': 'en_US:en', 06:52:03 INFO - 'LOGNAME': 'cltbld', 06:52:03 INFO - 'MAIL': '/var/mail/cltbld', 06:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:03 INFO - 'MOZ_NO_REMOTE': '1', 06:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:03 INFO - 'NO_EM_RESTART': '1', 06:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:03 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:03 INFO - 'SHELL': '/bin/bash', 06:52:03 INFO - 'SHLVL': '1', 06:52:03 INFO - 'TERM': 'linux', 06:52:03 INFO - 'TMOUT': '86400', 06:52:03 INFO - 'USER': 'cltbld', 06:52:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 06:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:03 INFO - '_': '/tools/buildbot/bin/python'} 06:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:52:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:52:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:52:05 INFO - Installing collected packages: mozsystemmonitor 06:52:05 INFO - Running setup.py install for mozsystemmonitor 06:52:06 INFO - Successfully installed mozsystemmonitor 06:52:06 INFO - Cleaning up... 06:52:06 INFO - Return code: 0 06:52:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fcf7e581f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb840>, '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 0x1c286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c28b60>, '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': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:52:06 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 06:52:06 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 06:52:06 INFO - Using env: {'DISPLAY': ':0', 06:52:06 INFO - 'HOME': '/home/cltbld', 06:52:06 INFO - 'LANG': 'en_US.UTF-8', 06:52:06 INFO - 'LANGUAGE': 'en_US:en', 06:52:06 INFO - 'LOGNAME': 'cltbld', 06:52:06 INFO - 'MAIL': '/var/mail/cltbld', 06:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:06 INFO - 'MOZ_NO_REMOTE': '1', 06:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:06 INFO - 'NO_EM_RESTART': '1', 06:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:06 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:06 INFO - 'SHELL': '/bin/bash', 06:52:06 INFO - 'SHLVL': '1', 06:52:06 INFO - 'TERM': 'linux', 06:52:06 INFO - 'TMOUT': '86400', 06:52:06 INFO - 'USER': 'cltbld', 06:52:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 06:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:06 INFO - '_': '/tools/buildbot/bin/python'} 06:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:06 INFO - Downloading/unpacking blobuploader==1.2.4 06:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:07 INFO - Downloading blobuploader-1.2.4.tar.gz 06:52:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:52:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:52:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:52:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:52:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:08 INFO - Downloading docopt-0.6.1.tar.gz 06:52:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:52:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:52:08 INFO - Installing collected packages: blobuploader, requests, docopt 06:52:08 INFO - Running setup.py install for blobuploader 06:52:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:52:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:52:08 INFO - Running setup.py install for requests 06:52:09 INFO - Running setup.py install for docopt 06:52:09 INFO - Successfully installed blobuploader requests docopt 06:52:09 INFO - Cleaning up... 06:52:09 INFO - Return code: 0 06:52:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:09 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 0x7fcf7e581f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb840>, '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 0x1c286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c28b60>, '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': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:52:09 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 06:52:09 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 06:52:09 INFO - Using env: {'DISPLAY': ':0', 06:52:09 INFO - 'HOME': '/home/cltbld', 06:52:09 INFO - 'LANG': 'en_US.UTF-8', 06:52:09 INFO - 'LANGUAGE': 'en_US:en', 06:52:09 INFO - 'LOGNAME': 'cltbld', 06:52:09 INFO - 'MAIL': '/var/mail/cltbld', 06:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:09 INFO - 'MOZ_NO_REMOTE': '1', 06:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:09 INFO - 'NO_EM_RESTART': '1', 06:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:09 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:09 INFO - 'SHELL': '/bin/bash', 06:52:09 INFO - 'SHLVL': '1', 06:52:09 INFO - 'TERM': 'linux', 06:52:09 INFO - 'TMOUT': '86400', 06:52:09 INFO - 'USER': 'cltbld', 06:52:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 06:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:09 INFO - '_': '/tools/buildbot/bin/python'} 06:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:09 INFO - Running setup.py (path:/tmp/pip-NxIq7w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:09 INFO - Running setup.py (path:/tmp/pip-o7exZC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:09 INFO - Running setup.py (path:/tmp/pip-yacGXh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:09 INFO - Running setup.py (path:/tmp/pip-KHmZTF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:09 INFO - Running setup.py (path:/tmp/pip-O6cfdx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:09 INFO - Running setup.py (path:/tmp/pip-Cg1uTn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:09 INFO - Running setup.py (path:/tmp/pip-kqpPLY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:10 INFO - Running setup.py (path:/tmp/pip-CpoEZ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:10 INFO - Running setup.py (path:/tmp/pip-M1N7PN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:10 INFO - Running setup.py (path:/tmp/pip-YO7GZe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:10 INFO - Running setup.py (path:/tmp/pip-tfT4J2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:10 INFO - Running setup.py (path:/tmp/pip-oVWDgq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:10 INFO - Running setup.py (path:/tmp/pip-ktJRzS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:10 INFO - Running setup.py (path:/tmp/pip-WbmSWd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:10 INFO - Running setup.py (path:/tmp/pip-jylXOz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:10 INFO - Running setup.py (path:/tmp/pip-hGvqV9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:10 INFO - Running setup.py (path:/tmp/pip-LPuzi4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:52:10 INFO - Running setup.py install for manifestparser 06:52:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:52:10 INFO - Running setup.py install for mozcrash 06:52:10 INFO - Running setup.py install for mozdebug 06:52:11 INFO - Running setup.py install for mozdevice 06:52:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:52:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:52:11 INFO - Running setup.py install for mozfile 06:52:11 INFO - Running setup.py install for mozhttpd 06:52:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:52:11 INFO - Running setup.py install for mozinfo 06:52:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:52:11 INFO - Running setup.py install for mozInstall 06:52:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:52:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:52:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:52:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:52:11 INFO - Running setup.py install for mozleak 06:52:11 INFO - Running setup.py install for mozlog 06:52:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:52:11 INFO - Running setup.py install for moznetwork 06:52:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:52:11 INFO - Running setup.py install for mozprocess 06:52:11 INFO - Running setup.py install for mozprofile 06:52:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:52:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:52:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:52:12 INFO - Running setup.py install for mozrunner 06:52:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:52:12 INFO - Running setup.py install for mozscreenshot 06:52:12 INFO - Running setup.py install for moztest 06:52:12 INFO - Running setup.py install for mozversion 06:52:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:52:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:52:12 INFO - Cleaning up... 06:52:12 INFO - Return code: 0 06:52:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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/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 0x7fcf7e581f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb840>, '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 0x1c286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c28b60>, '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': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:52: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/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:52: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/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:52:12 INFO - Using env: {'DISPLAY': ':0', 06:52:12 INFO - 'HOME': '/home/cltbld', 06:52:12 INFO - 'LANG': 'en_US.UTF-8', 06:52:12 INFO - 'LANGUAGE': 'en_US:en', 06:52:12 INFO - 'LOGNAME': 'cltbld', 06:52:12 INFO - 'MAIL': '/var/mail/cltbld', 06:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:12 INFO - 'MOZ_NO_REMOTE': '1', 06:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:12 INFO - 'NO_EM_RESTART': '1', 06:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:12 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:12 INFO - 'SHELL': '/bin/bash', 06:52:12 INFO - 'SHLVL': '1', 06:52:12 INFO - 'TERM': 'linux', 06:52:12 INFO - 'TMOUT': '86400', 06:52:12 INFO - 'USER': 'cltbld', 06:52:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 06:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:12 INFO - '_': '/tools/buildbot/bin/python'} 06:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:12 INFO - Running setup.py (path:/tmp/pip-GEDtKO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 06:52:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:12 INFO - Running setup.py (path:/tmp/pip-0fWWh2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:52:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:12 INFO - Running setup.py (path:/tmp/pip-rK0AKE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:52:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:12 INFO - Running setup.py (path:/tmp/pip-PEpWZj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:13 INFO - Running setup.py (path:/tmp/pip-n2wYrL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:13 INFO - Running setup.py (path:/tmp/pip-SchQbW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:13 INFO - Running setup.py (path:/tmp/pip-pLkUdt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:13 INFO - Running setup.py (path:/tmp/pip-ydZ98_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:13 INFO - Running setup.py (path:/tmp/pip-PoEF1v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:13 INFO - Running setup.py (path:/tmp/pip-2qIV4V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:13 INFO - Running setup.py (path:/tmp/pip-ew1SwM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:13 INFO - Running setup.py (path:/tmp/pip-hdiXQn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:13 INFO - Running setup.py (path:/tmp/pip-0OCDtW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:13 INFO - Running setup.py (path:/tmp/pip-YW2RZq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:13 INFO - Running setup.py (path:/tmp/pip-xl85pL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:13 INFO - Running setup.py (path:/tmp/pip-uf_Znz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 06:52:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:13 INFO - Running setup.py (path:/tmp/pip-ada866-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 06:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:15 INFO - Downloading blessings-1.5.1.tar.gz 06:52:15 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 06:52:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:52:15 INFO - Installing collected packages: blessings 06:52:15 INFO - Running setup.py install for blessings 06:52:15 INFO - Successfully installed blessings 06:52:15 INFO - Cleaning up... 06:52:15 INFO - Return code: 0 06:52:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:52:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:52:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:52:16 INFO - Reading from file tmpfile_stdout 06:52:16 INFO - Current package versions: 06:52:16 INFO - argparse == 1.2.1 06:52:16 INFO - blessings == 1.5.1 06:52:16 INFO - blobuploader == 1.2.4 06:52:16 INFO - docopt == 0.6.1 06:52:16 INFO - manifestparser == 1.1 06:52:16 INFO - mozInstall == 1.12 06:52:16 INFO - mozcrash == 0.16 06:52:16 INFO - mozdebug == 0.1 06:52:16 INFO - mozdevice == 0.48 06:52:16 INFO - mozfile == 1.2 06:52:16 INFO - mozhttpd == 0.7 06:52:16 INFO - mozinfo == 0.9 06:52:16 INFO - mozleak == 0.1 06:52:16 INFO - mozlog == 3.1 06:52:16 INFO - moznetwork == 0.27 06:52:16 INFO - mozprocess == 0.22 06:52:16 INFO - mozprofile == 0.28 06:52:16 INFO - mozrunner == 6.11 06:52:16 INFO - mozscreenshot == 0.1 06:52:16 INFO - mozsystemmonitor == 0.0 06:52:16 INFO - moztest == 0.7 06:52:16 INFO - mozversion == 1.4 06:52:16 INFO - psutil == 3.1.1 06:52:16 INFO - requests == 1.2.3 06:52:16 INFO - wsgiref == 0.1.2 06:52:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:16 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 0x7fcf7e581f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb840>, '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 0x1c286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c28b60>, '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': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:52:16 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 06:52:16 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 06:52:16 INFO - Using env: {'DISPLAY': ':0', 06:52:16 INFO - 'HOME': '/home/cltbld', 06:52:16 INFO - 'LANG': 'en_US.UTF-8', 06:52:16 INFO - 'LANGUAGE': 'en_US:en', 06:52:16 INFO - 'LOGNAME': 'cltbld', 06:52:16 INFO - 'MAIL': '/var/mail/cltbld', 06:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:16 INFO - 'MOZ_NO_REMOTE': '1', 06:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:16 INFO - 'NO_EM_RESTART': '1', 06:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:16 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:16 INFO - 'SHELL': '/bin/bash', 06:52:16 INFO - 'SHLVL': '1', 06:52:16 INFO - 'TERM': 'linux', 06:52:16 INFO - 'TMOUT': '86400', 06:52:16 INFO - 'USER': 'cltbld', 06:52:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 06:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:16 INFO - '_': '/tools/buildbot/bin/python'} 06:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 06:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 06:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 06:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 06:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 06:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 06:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:52:16 INFO - Cleaning up... 06:52:16 INFO - Return code: 0 06:52:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:16 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 0x7fcf7e581f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb840>, '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 0x1c286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c28b60>, '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': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:52:16 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 06:52:16 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 06:52:16 INFO - Using env: {'DISPLAY': ':0', 06:52:16 INFO - 'HOME': '/home/cltbld', 06:52:16 INFO - 'LANG': 'en_US.UTF-8', 06:52:16 INFO - 'LANGUAGE': 'en_US:en', 06:52:16 INFO - 'LOGNAME': 'cltbld', 06:52:16 INFO - 'MAIL': '/var/mail/cltbld', 06:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:16 INFO - 'MOZ_NO_REMOTE': '1', 06:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:16 INFO - 'NO_EM_RESTART': '1', 06:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:16 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:16 INFO - 'SHELL': '/bin/bash', 06:52:16 INFO - 'SHLVL': '1', 06:52:16 INFO - 'TERM': 'linux', 06:52:16 INFO - 'TMOUT': '86400', 06:52:16 INFO - 'USER': 'cltbld', 06:52:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 06:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:16 INFO - '_': '/tools/buildbot/bin/python'} 06:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:16 INFO - Downloading/unpacking jsonschema 06:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:52:18 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 06:52:18 INFO - Downloading/unpacking functools32 (from jsonschema) 06:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:18 INFO - Downloading functools32-3.2.3-2.tar.gz 06:52:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:52:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:52:18 INFO - warning: no files found matching '*.txt' 06:52:18 INFO - no previously-included directories found matching 'build' 06:52:18 INFO - no previously-included directories found matching 'dist' 06:52:18 INFO - no previously-included directories found matching '.git*' 06:52:18 INFO - Installing collected packages: jsonschema, functools32 06:52:18 INFO - Running setup.py install for functools32 06:52:18 INFO - warning: no files found matching '*.txt' 06:52:18 INFO - no previously-included directories found matching 'build' 06:52:18 INFO - no previously-included directories found matching 'dist' 06:52:18 INFO - no previously-included directories found matching '.git*' 06:52:18 INFO - Successfully installed jsonschema functools32 06:52:18 INFO - Cleaning up... 06:52:18 INFO - Return code: 0 06:52:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fcf7e581f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb840>, '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 0x1c286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c28b60>, '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': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:52:18 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 06:52:18 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 06:52:18 INFO - Using env: {'DISPLAY': ':0', 06:52:18 INFO - 'HOME': '/home/cltbld', 06:52:18 INFO - 'LANG': 'en_US.UTF-8', 06:52:18 INFO - 'LANGUAGE': 'en_US:en', 06:52:18 INFO - 'LOGNAME': 'cltbld', 06:52:18 INFO - 'MAIL': '/var/mail/cltbld', 06:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:18 INFO - 'MOZ_NO_REMOTE': '1', 06:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:18 INFO - 'NO_EM_RESTART': '1', 06:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:18 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:18 INFO - 'SHELL': '/bin/bash', 06:52:18 INFO - 'SHLVL': '1', 06:52:18 INFO - 'TERM': 'linux', 06:52:18 INFO - 'TMOUT': '86400', 06:52:18 INFO - 'USER': 'cltbld', 06:52:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 06:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:18 INFO - '_': '/tools/buildbot/bin/python'} 06:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:19 INFO - Downloading/unpacking flake8 06:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:52:20 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 06:52:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:52:20 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 06:52:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:21 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 06:52:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:52:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:52:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:52:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:52:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:52:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:52:21 INFO - no previously-included directories found matching 'docs/_build' 06:52:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:52:21 INFO - Running setup.py install for pep8 06:52:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:52:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:52:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:52:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:52:21 INFO - no previously-included directories found matching 'docs/_build' 06:52:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:52:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:52:21 INFO - Cleaning up... 06:52:21 INFO - Return code: 0 06:52:21 INFO - Running post-action listener: _resource_record_post_action 06:52:21 INFO - Running post-action listener: _start_resource_monitoring 06:52:21 INFO - Starting resource monitoring. 06:52:21 INFO - ##### 06:52:21 INFO - ##### Running install step. 06:52:21 INFO - ##### 06:52:21 INFO - Running pre-action listener: _resource_record_pre_action 06:52:21 INFO - Running main action method: install 06:52:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:52:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:52:21 INFO - Reading from file tmpfile_stdout 06:52:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:52:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:52:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:52:22 INFO - Reading from file tmpfile_stdout 06:52:22 INFO - Output received: 06:52:22 INFO - Usage: mozinstall [options] installer 06:52:22 INFO - Options: 06:52:22 INFO - -h, --help show this help message and exit 06:52:22 INFO - -d DEST, --destination=DEST 06:52:22 INFO - Directory to install application into. [default: 06:52:22 INFO - "/builds/slave/test-pgo"] 06:52:22 INFO - --app=APP Application being installed. [default: firefox] 06:52:22 INFO - mkdir: /builds/slave/test-pgo/build/application 06:52:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:52:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:52:38 INFO - Reading from file tmpfile_stdout 06:52:38 INFO - Output received: 06:52:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:52:38 INFO - Running post-action listener: _resource_record_post_action 06:52:38 INFO - ##### 06:52:38 INFO - ##### Running run-tests step. 06:52:38 INFO - ##### 06:52:38 INFO - Running pre-action listener: _resource_record_pre_action 06:52:38 INFO - Running main action method: run_tests 06:52:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:52:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:52:38 INFO - Python 2.7.3 06:52:38 INFO - Return code: 0 06:52:38 INFO - grabbing minidump binary from tooltool 06:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:38 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 0x1cbb840>, '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 0x1c286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c28b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:52:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 06:52:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:52:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:52:38 INFO - Return code: 0 06:52:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:52:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:52:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:52:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:52:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:52:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:52:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:52:39 INFO - Return code: 0 06:52:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 06:52:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:52:39 INFO - Using env: {'DISPLAY': ':0', 06:52:39 INFO - 'HOME': '/home/cltbld', 06:52:39 INFO - 'LANG': 'en_US.UTF-8', 06:52:39 INFO - 'LANGUAGE': 'en_US:en', 06:52:39 INFO - 'LOGNAME': 'cltbld', 06:52:39 INFO - 'MAIL': '/var/mail/cltbld', 06:52:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:52:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:39 INFO - 'MOZ_NO_REMOTE': '1', 06:52:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:39 INFO - 'NO_EM_RESTART': '1', 06:52:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:39 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:52:39 INFO - 'SHELL': '/bin/bash', 06:52:39 INFO - 'SHLVL': '1', 06:52:39 INFO - 'TERM': 'linux', 06:52:39 INFO - 'TMOUT': '86400', 06:52:39 INFO - 'USER': 'cltbld', 06:52:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444', 06:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:39 INFO - '_': '/tools/buildbot/bin/python'} 06:52:39 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:52:39 INFO - mozversion application_buildid: 20160115043011 06:52:39 INFO - mozversion application_changeset: e1486d83107fc4933982d371828d038ad57682e4 06:52:39 INFO - mozversion application_display_name: Nightly 06:52:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:52:39 INFO - mozversion application_name: Firefox 06:52:39 INFO - mozversion application_remotingname: firefox 06:52:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:52:39 INFO - mozversion application_vendor: Mozilla 06:52:39 INFO - mozversion application_version: 46.0a1 06:52:39 INFO - mozversion platform_buildid: 20160115043011 06:52:39 INFO - mozversion platform_changeset: e1486d83107fc4933982d371828d038ad57682e4 06:52:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:52:39 INFO - mozversion platform_version: 46.0a1 06:52:39 INFO - using testdate: 1452869559 06:52:39 INFO - actual date: 1452869559 06:52:39 INFO - starting webserver on 'localhost:57115' 06:52:39 INFO - SUITE-START | Running 3 tests 06:52:39 INFO - TEST-START | dromaeo_css 06:52:39 INFO - operating with platform_type : linux_ 06:52:39 INFO - Initialising browser for dromaeo_css test... 06:52:39 INFO - TEST-INFO | started process 21154 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzohBxM/profile http://localhost:57115/getInfo.html) 06:52:42 INFO - PROCESS | 21154 | 06:52:42 INFO - PROCESS | 21154 | (process:21240): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:52:43 INFO - PROCESS | 21154 | __metrics Screen width/height:1600/1200 06:52:43 INFO - PROCESS | 21154 | colorDepth:24 06:52:43 INFO - PROCESS | 21154 | Browser inner width/height: 1024/697 06:52:43 INFO - PROCESS | 21154 | __metrics 06:52:43 INFO - PROCESS | 21154 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:52:44 INFO - TEST-INFO | 21154: exit 0 06:52:44 INFO - Browser initialized. 06:52:44 INFO - Running cycle 1/1 for dromaeo_css test... 06:52:44 INFO - TEST-INFO | started process 21289 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzohBxM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:46 INFO - PROCESS | 21289 | 06:52:46 INFO - PROCESS | 21289 | (process:21352): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:52:56 INFO - PROCESS | 21289 | RSS: Main: 150466560 06:52:56 INFO - PROCESS | 21289 | 06:53:46 INFO - PROCESS | 21289 | 1452869626257 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:55:55 INFO - PROCESS | 21289 | Cycle 1(1): loaded http://localhost:57115/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57115/tests/dromaeo/cssquery-ext.html) 06:55:56 INFO - PROCESS | 21289 | RSS: Main: 156250112 06:55:56 INFO - PROCESS | 21289 | 06:58:58 INFO - PROCESS | 21289 | Cycle 1(1): loaded http://localhost:57115/tests/dromaeo/cssquery-ext.html (next: http://localhost:57115/tests/dromaeo/cssquery-jquery.html) 06:58:58 INFO - PROCESS | 21289 | RSS: Main: 151552000 06:58:58 INFO - PROCESS | 21289 | 07:02:00 INFO - PROCESS | 21289 | Cycle 1(1): loaded http://localhost:57115/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57115/tests/dromaeo/cssquery-mootools.html) 07:02:01 INFO - PROCESS | 21289 | RSS: Main: 151732224 07:02:01 INFO - PROCESS | 21289 | 07:05:03 INFO - PROCESS | 21289 | Cycle 1(1): loaded http://localhost:57115/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57115/tests/dromaeo/cssquery-prototype.html) 07:05:03 INFO - PROCESS | 21289 | RSS: Main: 150892544 07:05:03 INFO - PROCESS | 21289 | 07:08:05 INFO - PROCESS | 21289 | Cycle 1(1): loaded http://localhost:57115/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57115/tests/dromaeo/cssquery-yui.html) 07:08:06 INFO - PROCESS | 21289 | RSS: Main: 151576576 07:08:06 INFO - PROCESS | 21289 | 07:11:08 INFO - PROCESS | 21289 | Cycle 1(1): loaded http://localhost:57115/tests/dromaeo/cssquery-yui.html (next: http://localhost:57115/tests/dromaeo/cssquery-dojo.html) 07:11:09 INFO - PROCESS | 21289 | RSS: Main: 153948160 07:11:09 INFO - PROCESS | 21289 | 07:11:09 INFO - PROCESS | 21289 | __start_tp_report 07:11:09 INFO - PROCESS | 21289 | _x_x_mozilla_page_load 07:11:09 INFO - PROCESS | 21289 | _x_x_mozilla_page_load_details 07:11:09 INFO - PROCESS | 21289 | |i|pagename|runs| 07:11:09 INFO - PROCESS | 21289 | |0;dojo.html;3213.807171569706;3237.9352412951744;3278.2132288250828;3282.277898862251;3283.3433313337323;5210.348706411699;5354.116570765824;5357.142857142862;5375.354957405112;5380.515753582186;5222.268882356464;5232.16285394337;5272.1300985337375;5329.680219186852;5342.759575819087;4862.076205520949;4899.8775030624165;4942.53045960635;4978.103941290567;4984.4018717753925;4832.299316599091;4874.390701162355;4884.609231261508;4888.388951381077;4940.061388336223;4776.5701086902345;4779.474257831635;4831.082094402088;4840.346553215341;4858.878528036809;4868.853934381974;4869.756512174377;4881.292212629149;4903;4903.411590609114;4895.559399654048;4897.559219670211;4898;4915.041566894457;4939.827106051307;4957.355543779286;4988.226824842155;5084.694918304914;5099.796008159669;5238.135707608279;5642.4357564243655;5695.515881150066;5741.971290143564;5761.625494342854;5793.304803423574;5785.045467497858;5787.276590426197;5787.681677507735;5788.392218817005;5791.73937172824;5251.2123181523075;5334.093204155303;5394.083005889008;5398.082326004589;5404.405515393303;5741.684207368635;5868.031774757117;5961.046232602763;5968.85077873048;5989;5659.377468478464;5659.547236221092;5659.801906933238;5661.094224923992;5680.289963754531;5540.390557038722;5693.914591281134;5731.111677689964;5765.971170144123;5798.188253644493;5584.46947539983;5611.663300202001;5626.493615574536;5629.859253518613;5731.197632331477;5731.713414329267;5750.741216645261;5753.683547404933;5760.567957403212;5766.740496677659;4416.183006143874;4426.778661066934;4447.688661793708;4475.216837053567;4477.1493416250805;3908.511436070491;3923.6272554107313;3965.504311961005;3977.840886364571;4002.1195337025806;5279.1289437243195;5290.206469029599;5331.253624492574;5333.879885224069;5373.596980226499;5665.943340566624;5694.5159661428415;5700.201971723962;5706.828795136153;5707.315122185364;5317.973410133002;5394.811181608625;5411.972940135274;5452.972735136299;5487.862803429946;4879.756012199376;4927.1131196384995;4940.209566469348;4942.92585611209;4984.950150498521;5751.769929202868;5904.822855314347;5960.374160713062;5980.401959804072;5998.670073146019;5627.606067575394;5697.515711164598;5772.740226689725;5799.449052340021;5853.736581853912;6004.969975150097;6024.759009639565;6040.909386359121;6045.123457098608;6051.243594550681;5541.778328866801;5726.455986681259;5733.971330143323;5749.396313387034;5751.8562035949435;5648.802291919763;5696.11710184922;5710.37185909558;5739.856503587277;5780.046292361713;5535.612507124462;5550.084236100998;5576.972115139399;5581;5586.720663966867;5456.809011684572;5492.0663487206475;5565.30433695788;5571.415001424792;5578.916316255179;5446.264754258283;5469.917951230815;5480.013597552319;5492.286002819608;5518.530924871431;5534.501894829324;5544.7227638618715;5621.381648018796;5635.0702134147405;5664.603477756517;5358.598105142208;5488.341399031982;5492.917606235989;5508.55931525469;5520.254765606592 07:11:09 INFO - PROCESS | 21289 | |1;ext.html;519.2859817750593;530.3211888782358;549.1049589169653;555.2337773872057;593.9435753603406;35457.46813797792;36233.637663623354;36250.81874590623;36282.455763163576;36376;38620.42069368955;38779;38879.61120388795;38945.22109557807;38975.025624359405;8385.538795366268;8465.576721163949;8545.829083418328;8564.229219370256;8578.785530361729;8351.16488351163;8403.41176117672;8473.618687159062;8474.576271186446;8500.362472814533;8639.611217495229;8687.522186279784;8744.387892847502;8747.95626021869;8754.956225218864;8577.39958202926;8594;8631.741047768577;8637.0499245083;8736.956315218447;8570.657173713043;8613.397062205648;8662.956685216534;8691.565421728952;8701.7824554386;39942.400863987066;40218.59781402178;40393.798031009654;40490.19019619591;40571.7971410144;2619.3975385661215;2759.2412086676322;3024.3195281061803;3084.599002129709;3172.904812855618;26434.47131057368;26453;26589.601155982484;26601.600975985377;26807.597886031726;3667.7615954963107;3704.2961837250837;3733.3466643337306;3781.6596506314563;3850.8074596270076;173418;174782;175102;175256;175444.47333160051;53438;54930.45069549333;57423.42576574264;61952.38047619466;63368.68315658484;55887;56003.79971502154;56106.158407623916;56132.43867561272;56266.71866640722;13417.262050587116;13523.59429217125;13545.45818167282;13568.457261709618;13731.107478013897;10396.896031039592;10420.531076101593;10468.319559228627;10473.423961682029;10504.947475262576;19903.402897913085;20576.485587860425;20599.4850128745;20803.791962080184;20879.478013049797;7300.780976570712;7513.2111128331835;7534.3595794357;7560.697572097055;7650.42621803367;991.4150651115876;1018.3940555369543;1023.7901230247782;1025.5795123999123;1025.9945253651463;29103;29371.853140734158;29469.26326841846;29735.85132074369;29935.70064299329;1020.4387586827215;1081.259337353915;1086.3807629651023;1128.311729844794;1145.7364806094645;15209.695806083817;15303.38786448552;15422.537323880302;15467.458638947583;15488.690226195638;328001;328457;329088;330463;330925;53624.463755362725;53734.19398709023;53913.1913021305;53937.1909421359;54043;1297.331874084847;1304.0545604436898;1314.3822403470353;1328.5814968285154;1330.481112366178;27733.583996240475;28921.276968075967;29034.41931161407;29162.708372916;29585.112446626637;47930.760346199444;48186.759066204446;48249.75875120602;48534;48642.5135748638;301545;303593;304124;304223;304418;32408.83795581007;32654.34691306113;32960.505592415655;33170;33192.66807331896;38590.80704596459;41210;41604.58395416007;42256.788716056224;42604;35043.47434788531;35846;35846.820765896;35947.28105437929;36406.27187456289;35716.28567428689;35789.82105089458;35827.641723582434;35946;36509.45235821412;35665.82167089148;35935.82032089823;36172;36454;36720.449193261586;30604;32027.199320017186;33241.83379083186;33244;33312;24889.751102488743;25382.873085635194;25497;25607.48785024252;25729.485410292065 07:11:09 INFO - PROCESS | 21289 | |2;jquery.html;359.26350980489997;362.2121884900343;362.53595397890695;363.58551251573203;370.1265014565623;15535.844641553595;15912.76130858038;16713.331466741332;16805.83194168058;17757.200925958332;10609.78780424393;10745.731356716085;10745.946270268638;10883.401412922287;10894.564217431312;4676.532346765322;4844.563989240967;4846.466888642247;4901.240307752286;5397.514223719864;5294.629375943686;5344.251804747339;5396.568274538027;5399.136138217886;5406.189071639266;4921.901561968759;5167.819126330579;5347.973260133694;5380.542653874425;5389.838304850841;5287.312649355578;5301.045811753902;5315.388730296027;5334.853006603599;5593.2449119368775;5323.201519772027;5347.358317001946;5351.438098999627;5360.303160589137;5387.595930305243;18966.24135034597;19137.712934305997;19832.60334793296;19856.900715496475;19975.400737977885;2076.1280262289874;2135.4661334666334;2222.200007997136;2279.4985103277254;2292.873891935943;9360.11078947499;9398.765030874214;9573.090556397132;9713.514324283828;12358.073144514197;1781.2785821742216;1786.9910650446664;1787.6960916644202;1806.151108978778;1839.6596629623562;56404.43595564033;56811.71594142044;56948.715256423864;57854.710726446516;58563;10066.69799906004;10218.284720069523;10238.33450825694;10259.281850270409;10337;13313.40089695966;13491.123076999964;13532.661683457796;13598.252096134807;13620;7301.817454563678;7359.059885567665;7376.0411146550605;7432.591207483641;7499.362554182846;7078.398336141486;7081.610511421818;7081.610511421921;7142.321479459443;7175.569465831963;3962.663173630216;4161.146964872194;4379.0366119453665;4458.799354029076;4510.1656193604285;1674.9748753768704;1712.383541924906;1770.4157627982993;1799.631075629493;1838.9977462283089;872.0886673426285;913.1370854542527;914.2731528434911;921.4517362169498;990.346371394876;14966.551003469913;15234.009789363656;15555.533333999998;15693.372265109268;15817.604559886095;896.2919293757989;922.7785331520387;929.8884133903839;929.9209567186865;937.1097457415347;8952.418092823946;9380.812383752287;9497.715068547956;9995.450250236161;10023.398596084258;491804;495273;498873;543138;560811;70452;72919.63540182372;73185;74725;74998.6250068757;1128.610629332879;1136.2046567402851;1145.8796826333114;1147.17976646698;1148.035650053942;15140.697186056437;15291.694166116838;15432.537023889301;15467.381304747683;15671.529854104396;33602.66397335995;34177.14557136092;35175.12062198466;35353.46969795404;35519.82240088783;45041.77479112714;45558.86102847455;45834.77082614566;48590;49014.26478602895;7211.67547460376;7332.96333518329;7355.117385913724;7443;7444.441666875115;7154.676384868816;10840.349579025284;11348.205625606459;11390.088792896715;11420.543178272776;8965.865512017455;8986.640534378552;9879.160271376726;10074.54664540112;10094.394336339843;9621.18219951312;9667.951660241653;10024.949875250577;10207.693769186937;10274.640387586398;9432.481213533321;9690.273229507957;9780.559874805509;10097.495125243855;10152.796944061225;7065.540739851893;7385;7408.703651853865;7478.2521747824785;7498.250174982458;9480;9757.707268781947;10057.647982320585;10092.34399764013;10129.392236465836 07:11:09 INFO - PROCESS | 21289 | |3;mootools.html;1484.8960572759904;1497.0792962328171;1644.3997940751622;1761.964760704785;1803.0533969665917;7488.32605065544;7506.286902744244;7595.696172153107;7650.196729343423;7717;7611.69553217872;7633.961830190841;7692.115406728228;7741.845163096735;7749.92250077499;2330.615448451008;2331.6619090231907;2337.3922780077132;2352.329586067971;2360.586897292967;2314.2941402872116;2339.590571649963;2383.4041489627593;2388.176079252655;2398.2325655790155;2271.9886400568057;2312.3525412884337;2325.6046472099697;2327.7555856635063;2343.285297984114;2318.084356679111;2333.9183128590503;2335.521218150275;2342.1802369170823;2344.8944797484155;2336.918207862717;2349.6945397098266;2357.9528409431887;2359.2214569192124;2363.869987150706;7654.578998155099;7703.3067023968115;7704.191059938737;7708.38332933364;7730.536167829948;4757.381540399726;4887.804487820483;4890.119778439879;4902.19113846215;4917.336159618441;2966.4512065267995;3027.409655117253;3059.7552195824283;3070.570120183176;3088.1970687621156;933.5052422216236;960.2462067277223;999.0089592079688;1009.8232809258424;1022.0597050713361;10340.689779306633;10357.119644830198;10378.169746420268;10461.84307235392;10498.317609355367;4172.70791044624;4195.895102622398;4277.807498662568;4295.098029413795;4311.073119279307;8514.70198543048;8530.232279094911;8592.65629374818;8600.13998600135;8625.266852317498;4731.526847315241;4760.785764640599;4783.378160839138;4789.521047895182;4794.568488836021;4334.804933777925;4362.062156636275;4375.27807911691;4377.190219809346;4385.495667998157;3466.838609065991;3489.982550087284;3502.7372947029075;3504.8773292934625;3508.8421021054114;1053.8998795114605;1071.7320669832543;1080.5353697909818;1082.6697857153645;1103.0458653264868;1042.3797840285017;1057.4659796802719;1069.5828626835541;1115.2137742891243;1146.8050431426677;7086.185088714864;7115.501914866013;7127.7148914042855;7160.391366733886;7164.104486939133;1184.8696643369221;1218.7623413434474;1244.440001999104;1248.1699669719717;1261.6971926737517;5550.5282051026115;5698.287714035746;5730.11183266586;5771.018926782457;5810.622309549865;9082.727518174333;9324.627014919328;9363.25093992479;9381.812363752686;9427.575759090858;9102.590383432762;9127.543622818832;9153.313501487415;9221.262299016063;9265.814683706289;7292.8906066409045;7344.596047217347;7348.96325518369;7355.301246381585;7370.8894366584545;6931.861362772817;7050.823729406806;7062.081929349357;7092.751753688596;7115.181754098345;8355.12271211514;8407.579621018802;8457.112003239818;8462.19609137131;8603.870941935751;8086.15095414973;8412.957935210285;8480.194381533991;8484.703035393732;8645.26515246211;6915.550489218184;6980.162380514371;6988.685509152202;7003.124609423822;7041.823954401181;7270.163931147774;7308.59802710856;7338.96330518344;7345.889811652936;7423.628818558943;6844.589324640538;6882.69027893756;6898.724051037902;7001.789946301619;7271.60006199643;6705.430038446787;6736.528443008942;6924.896126558207;6943.930560694531;7153.892691609734;6949.722011119498;6994.545354551938;7039.824004399931;7060.905559638264;7069.752558660422;6506.479481641362;6509.641969691713;6516.5112616553;6524.119243902012;6552.967235163794;6474.773382931575;6536.300561854047;6589.374009469093;6697.397234248941;6702.296258892941 07:11:09 INFO - PROCESS | 21289 | |4;prototype.html;332.1132576022021;332.57430488974114;343.60313837517674;348.4494498692066;349.7831344566369;6135.233095863017;6260.12358269842;6282;6282.465990390817;6295.874082518352;6127.7855275065385;6258.499320054396;6267.968660156705;6272.592281501699;6281.9057714134215;4809.975950120253;4821.252705830584;4822.638302127337;4825.324454576345;4831.734254615994;4824.4210694716685;4825.25208592667;4829.830955916544;4830.420349558058;4843.927341089887;4705.623550116;4766.809327626908;4772.260299653542;4779.64152688548;4780.90438191236;4765.761711914425;4769.213079841822;4779.235322348408;4784.114938736345;4784.210605250129;4134.111166099303;4143.834246630131;4157.251694694954;4159.958400416018;4180.331147016494;5833.7083145842535;5850.795222167247;5863.208466856962;5885.61743486672;5944.762209511614;5432.91850622241;5552.3892371839065;5556.111022236423;5575;5580.581456390746;6634.46924246064;6646.401823835878;6646.60120392778;6647.169103862017;6651.102101216322;4610;4619.076184763061;4623.214053610895;4630.606398456135;4642.466116396624;6762.391384775345;6911.861762764716;6970.372666460043;6987.6855541500245;6996.580205187654;4689.320048592935;4720.221163508051;4734;4741.786619602126;4755.120302743934;4779.641526885497;4787.0904528139545;4790.473047964721;4801.087793319258;4801.855944321676;5489.615726899158;5516.862078448071;5522.420145884625;5522.641028333145;5531.502164805187;6525.771597994048;6672.199336079701;6681.298463661343;6713.1272934519175;6718.294579069225;1633.681432120749;1680.655465629543;1684.6630673865277;1685.2837544043732;1705.1815128738026;1067.4502631144967;1072.91953103516;1099.1261946752352;1125.139268459629;1136.9147313951487;6214.751409943642;6222.315545290015;6278.30938596754;6281.277653069956;6288.968555157195;6797.490188235902;6811.795646130624;6836.726530938806;6842.7605033823575;6842.931570684329;6083.209182806207;6160.630362178284;6194.81415557534;6200.782972595937;6217.875642487125;3689.206820533598;3698.7595806272507;3705.7776533408082;3712.2575484903127;3719.1260053887313;7034.929650703428;7105.2894710528535;7118.216996130422;7139.750108746169;7151.177614574391;6890.44876409886;6910.689018994158;6948.861022779617;6959.130108736408;6977.860442791116;7236.529625574321;7290.4167666586545;7296.343329100407;7299.160596531467;7302.96348518254;6881.518293719391;6923.238443771282;6961.269066747918;6962.294237911744;6976.720931162697;6780.32196780318;6796.776580215609;6861.759838405632;6886.690098945459;6903.6203008835;7235.131784185932;7247.347738703331;7269.418446524372;7271.054762880792;7271.309225623558;4616.561426664462;4657.045305712389;4663.044075964352;4673.205555055717;4681.859544213679;6817.454603631797;6842.384185423336;6902.827429314308;6922.7923162305215;7013.894791578233;6754.425873800782;6774.42417394527;6780.93219067803;6795.218549866829;6798.796036118924;6723.1259936209935;6774.525783195326;6785.423239024541;6804.523683342119;6807.149106361705;6520.902186467301;6600.471962243105;6629.635370054693;6653;6653.201615806134;6767.796966091025;6792.932070679428;6824.351686589766;6830.180378354629;6832.282610325844;6576.76981305652;6594.241662208908;6612.768553100618;6626.072349871119;6633.1045308882685 07:11:09 INFO - PROCESS | 21289 | |5;yui.html;760.1903972269532;829.8878316089339;837.882696422501;856.1566856646205;868.1015149320455;12657.936710316448;12728.236305821645;12882.80675789864;13321.600351989431;13323.800142997863;12944.546940857072;12973;12979.286139262336;12988.61034168974;13012.089153759242;798.9480683755537;810.5784991804259;820.3724151024471;822.8148666550038;823.3043078598574;815.0708192660372;815.8939337886067;819.573821612761;821.2772759971247;834.8872902158191;857.648364170687;857.9528125953101;860.849351363512;863.753830158405;874.514644372373;844.5608283692476;846.5259454705354;849.8512760266929;856.9887532711398;861.9439736417113;634.1629049654458;639.2776162935853;639.4341008207723;639.6098379988204;639.9040143978394;13654.726905461934;13682.452701891913;13811.585652430344;13812.93093534536;13828.861711382959;11062.834057489064;11109.777804443947;11162.162837787198;11401.600943967005;11507.539698412054;10048.296619236657;10101.797964040677;10358.844617330746;10557.366558006544;10667.253292269545;3384.560007199073;3384.644612315696;3491;3492.266624008961;3550.343186510478;46151.07697846058;46425.535744642795;46756.29865551985;46874;47403.05193896103;9675.516224188763;9685.370450920667;9799.755006124762;9859.211263098934;9890.20878329732;17062.402815901383;17206.1396930153;17313.268673132585;17324.133793310284;17339.826601734072;7060.258672839278;7306.561606303532;7373.115226172787;7480.551166930001;7577.848443031219;4073.898152546151;4095.672346212296;4111.403846442249;4140;4165.562615925284;2984.985075074611;3005.3838963012968;3005.729484346419;3008.669046404894;3012.8041677290908;576.1789450033768;586.4311617730795;596.6062398816761;597.4175179200245;600.0099835271836;510.90548248574135;640.2981450186101;645.6416688737702;658.256170527301;668.7793028300649;8603.569821509025;8606.44058136219;8675.696350627697;8745.125487451203;8777.363902555644;546.6392181160415;696.7317582730685;703.6833424958687;735.5917465806422;742.1279996004673;4056.6146216109423;4171.541130475645;4261.765602891809;4299.484061912591;4375.824967001285;51914;52197.7390113047;52200.95598088093;52348.738256308476;52888.735556321975;43330.56669433265;43711.562884371386;44895.775521122836;44996;45181.54818451839;47787.76106119447;48632.756836215594;49062.50937490579;49573.75213123983;50203.24695129649;8253.669853205805;8299.875501867356;8319.916800832156;8376.371772116994;8458.069612342515;32923.34153316968;33171.83414082914;33403.99788006364;33643;34067.14832129217;39243;41233;42636;43320.78339608282;43893;11028.70266347178;11029;11095.778084438427;11109.777804444027;11514.733379328434;11705.063594912557;11878.821817672915;12132.841474782179;12327.445264962918;12719.682007949876;10739.140868730326;10969.50637221343;11165.944170279097;11230.94384528072;11472.598459053894;11466.31202127875;11518.193726439404;11970;12249.203801752858;12284.262944223376;9554.474503902075;10681.57273709043;10854.728631783953;11004.119670426508;11221.079500027521;9015.233705135137;9102.59038343263;9123.5438228087;9163.083194551518;9319.16127548524;8984.775380615536;9228.861567076634;9253.213476854542;9425.764355891157;10016.949915250378 07:11:09 INFO - PROCESS | 21289 | __end_tp_report 07:11:09 INFO - PROCESS | 21289 | __start_cc_report 07:11:09 INFO - PROCESS | 21289 | _x_x_mozilla_cycle_collect,305 07:11:09 INFO - PROCESS | 21289 | __end_cc_report 07:11:09 INFO - PROCESS | 21289 | __startTimestamp1452870669223__endTimestamp 07:11:09 INFO - PROCESS | 21289 | 07:11:09 INFO - PROCESS | 21289 | ------- Summary: start ------- 07:11:09 INFO - PROCESS | 21289 | Number of tests: 6 07:11:09 INFO - PROCESS | 21289 | 07:11:09 INFO - PROCESS | 21289 | [#0] dojo.html Cycles:165 Average:5316.82 Median:5492.29 stddev:582.72 (10.6%) stddev-sans-first:560.66 07:11:09 INFO - PROCESS | 21289 | Values: 3213.8 3237.9 3278.2 3282.3 3283.3 5210.3 5354.1 5357.1 5375.4 5380.5 5222.3 5232.2 5272.1 5329.7 5342.8 4862.1 4899.9 4942.5 4978.1 4984.4 4832.3 4874.4 4884.6 4888.4 4940.1 4776.6 4779.5 4831.1 4840.3 4858.9 4868.9 4869.8 4881.3 4903.0 4903.4 4895.6 4897.6 4898.0 4915.0 4939.8 4957.4 4988.2 5084.7 5099.8 5238.1 5642.4 5695.5 5742.0 5761.6 5793.3 5785.0 5787.3 5787.7 5788.4 5791.7 5251.2 5334.1 5394.1 5398.1 5404.4 5741.7 5868.0 5961.0 5968.9 5989.0 5659.4 5659.5 5659.8 5661.1 5680.3 5540.4 5693.9 5731.1 5766.0 5798.2 5584.5 5611.7 5626.5 5629.9 5731.2 5731.7 5750.7 5753.7 5760.6 5766.7 4416.2 4426.8 4447.7 4475.2 4477.1 3908.5 3923.6 3965.5 3977.8 4002.1 5279.1 5290.2 5331.3 5333.9 5373.6 5665.9 5694.5 5700.2 5706.8 5707.3 5318.0 5394.8 5412.0 5453.0 5487.9 4879.8 4927.1 4940.2 4942.9 4985.0 5751.8 5904.8 5960.4 5980.4 5998.7 5627.6 5697.5 5772.7 5799.4 5853.7 6005.0 6024.8 6040.9 6045.1 6051.2 5541.8 5726.5 5734.0 5749.4 5751.9 5648.8 5696.1 5710.4 5739.9 5780.0 5535.6 5550.1 5577.0 5581.0 5586.7 5456.8 5492.1 5565.3 5571.4 5578.9 5446.3 5469.9 5480.0 5492.3 5518.5 5534.5 5544.7 5621.4 5635.1 5664.6 5358.6 5488.3 5492.9 5508.6 5520.3 07:11:09 INFO - PROCESS | 21289 | 07:11:09 INFO - PROCESS | 21289 | [#1] ext.html Cycles:180 Average:44043.24 Median:35846.41 stddev:72811.78 (203.1%) stddev-sans-first:72942.70 07:11:09 INFO - PROCESS | 21289 | Values: 519.3 530.3 549.1 555.2 593.9 35457.5 36233.6 36250.8 36282.5 36376.0 38620.4 38779.0 38879.6 38945.2 38975.0 8385.5 8465.6 8545.8 8564.2 8578.8 8351.2 8403.4 8473.6 8474.6 8500.4 8639.6 8687.5 8744.4 8748.0 8755.0 8577.4 8594.0 8631.7 8637.0 8737.0 8570.7 8613.4 8663.0 8691.6 8701.8 39942.4 40218.6 40393.8 40490.2 40571.8 2619.4 2759.2 3024.3 3084.6 3172.9 26434.5 26453.0 26589.6 26601.6 26807.6 3667.8 3704.3 3733.3 3781.7 3850.8 173418.0 174782.0 175102.0 175256.0 175444.5 53438.0 54930.5 57423.4 61952.4 63368.7 55887.0 56003.8 56106.2 56132.4 56266.7 13417.3 13523.6 13545.5 13568.5 13731.1 10396.9 10420.5 10468.3 10473.4 10504.9 19903.4 20576.5 20599.5 20803.8 20879.5 7300.8 7513.2 7534.4 7560.7 7650.4 991.4 1018.4 1023.8 1025.6 1026.0 29103.0 29371.9 29469.3 29735.9 29935.7 1020.4 1081.3 1086.4 1128.3 1145.7 15209.7 15303.4 15422.5 15467.5 15488.7 328001.0 328457.0 329088.0 330463.0 330925.0 53624.5 53734.2 53913.2 53937.2 54043.0 1297.3 1304.1 1314.4 1328.6 1330.5 27733.6 28921.3 29034.4 29162.7 29585.1 47930.8 48186.8 48249.8 48534.0 48642.5 301545.0 303593.0 304124.0 304223.0 304418.0 32408.8 32654.3 32960.5 33170.0 33192.7 38590.8 41210.0 41604.6 42256.8 42604.0 35043.5 35846.0 35846.8 35947.3 36406.3 35716.3 35789.8 35827.6 35946.0 36509.5 35665.8 35935.8 36172.0 36454.0 36720.4 30604.0 32027.2 33241.8 33244.0 33312.0 24889.8 25382.9 25497.0 25607.5 25729.5 07:11:09 INFO - PROCESS | 21289 | 07:11:09 INFO - PROCESS | 21289 | [#2] jquery.html Cycles:180 Average:26940.66 Median:4845.52 stddev:84835.10 (1750.8%) stddev-sans-first:85049.61 07:11:09 INFO - PROCESS | 21289 | Values: 359.3 362.2 362.5 363.6 370.1 15535.8 15912.8 16713.3 16805.8 17757.2 10609.8 10745.7 10745.9 10883.4 10894.6 4676.5 4844.6 4846.5 4901.2 5397.5 5294.6 5344.3 5396.6 5399.1 5406.2 4921.9 5167.8 5348.0 5380.5 5389.8 5287.3 5301.0 5315.4 5334.9 5593.2 5323.2 5347.4 5351.4 5360.3 5387.6 18966.2 19137.7 19832.6 19856.9 19975.4 2076.1 2135.5 2222.2 2279.5 2292.9 9360.1 9398.8 9573.1 9713.5 12358.1 1781.3 1787.0 1787.7 1806.2 1839.7 56404.4 56811.7 56948.7 57854.7 58563.0 10066.7 10218.3 10238.3 10259.3 10337.0 13313.4 13491.1 13532.7 13598.3 13620.0 7301.8 7359.1 7376.0 7432.6 7499.4 7078.4 7081.6 7081.6 7142.3 7175.6 3962.7 4161.1 4379.0 4458.8 4510.2 1675.0 1712.4 1770.4 1799.6 1839.0 872.1 913.1 914.3 921.5 990.3 14966.6 15234.0 15555.5 15693.4 15817.6 896.3 922.8 929.9 929.9 937.1 8952.4 9380.8 9497.7 9995.5 10023.4 491804.0 495273.0 498873.0 543138.0 560811.0 70452.0 72919.6 73185.0 74725.0 74998.6 1128.6 1136.2 1145.9 1147.2 1148.0 15140.7 15291.7 15432.5 15467.4 15671.5 33602.7 34177.1 35175.1 35353.5 35519.8 45041.8 45558.9 45834.8 48590.0 49014.3 7211.7 7333.0 7355.1 7443.0 7444.4 7154.7 10840.3 11348.2 11390.1 11420.5 8965.9 8986.6 9879.2 10074.5 10094.4 9621.2 9668.0 10024.9 10207.7 10274.6 9432.5 9690.3 9780.6 10097.5 10152.8 7065.5 7385.0 7408.7 7478.3 7498.3 9480.0 9757.7 10057.6 10092.3 10129.4 07:11:09 INFO - PROCESS | 21289 | 07:11:09 INFO - PROCESS | 21289 | [#3] mootools.html Cycles:180 Average:5428.68 Median:6520.32 stddev:2755.84 (42.3%) stddev-sans-first:2747.63 07:11:09 INFO - PROCESS | 21289 | Values: 1484.9 1497.1 1644.4 1762.0 1803.1 7488.3 7506.3 7595.7 7650.2 7717.0 7611.7 7634.0 7692.1 7741.8 7749.9 2330.6 2331.7 2337.4 2352.3 2360.6 2314.3 2339.6 2383.4 2388.2 2398.2 2272.0 2312.4 2325.6 2327.8 2343.3 2318.1 2333.9 2335.5 2342.2 2344.9 2336.9 2349.7 2358.0 2359.2 2363.9 7654.6 7703.3 7704.2 7708.4 7730.5 4757.4 4887.8 4890.1 4902.2 4917.3 2966.5 3027.4 3059.8 3070.6 3088.2 933.5 960.2 999.0 1009.8 1022.1 10340.7 10357.1 10378.2 10461.8 10498.3 4172.7 4195.9 4277.8 4295.1 4311.1 8514.7 8530.2 8592.7 8600.1 8625.3 4731.5 4760.8 4783.4 4789.5 4794.6 4334.8 4362.1 4375.3 4377.2 4385.5 3466.8 3490.0 3502.7 3504.9 3508.8 1053.9 1071.7 1080.5 1082.7 1103.0 1042.4 1057.5 1069.6 1115.2 1146.8 7086.2 7115.5 7127.7 7160.4 7164.1 1184.9 1218.8 1244.4 1248.2 1261.7 5550.5 5698.3 5730.1 5771.0 5810.6 9082.7 9324.6 9363.3 9381.8 9427.6 9102.6 9127.5 9153.3 9221.3 9265.8 7292.9 7344.6 7349.0 7355.3 7370.9 6931.9 7050.8 7062.1 7092.8 7115.2 8355.1 8407.6 8457.1 8462.2 8603.9 8086.2 8413.0 8480.2 8484.7 8645.3 6915.6 6980.2 6988.7 7003.1 7041.8 7270.2 7308.6 7339.0 7345.9 7423.6 6844.6 6882.7 6898.7 7001.8 7271.6 6705.4 6736.5 6924.9 6943.9 7153.9 6949.7 6994.5 7039.8 7060.9 7069.8 6506.5 6509.6 6516.5 6524.1 6553.0 6474.8 6536.3 6589.4 6697.4 6702.3 07:11:09 INFO - PROCESS | 21289 | 07:11:09 INFO - PROCESS | 21289 | [#4] prototype.html Cycles:180 Average:5576.48 Median:6264.05 stddev:1695.95 (27.1%) stddev-sans-first:1654.40 07:11:09 INFO - PROCESS | 21289 | Values: 332.1 332.6 343.6 348.4 349.8 6135.2 6260.1 6282.0 6282.5 6295.9 6127.8 6258.5 6268.0 6272.6 6281.9 4810.0 4821.3 4822.6 4825.3 4831.7 4824.4 4825.3 4829.8 4830.4 4843.9 4705.6 4766.8 4772.3 4779.6 4780.9 4765.8 4769.2 4779.2 4784.1 4784.2 4134.1 4143.8 4157.3 4160.0 4180.3 5833.7 5850.8 5863.2 5885.6 5944.8 5432.9 5552.4 5556.1 5575.0 5580.6 6634.5 6646.4 6646.6 6647.2 6651.1 4610.0 4619.1 4623.2 4630.6 4642.5 6762.4 6911.9 6970.4 6987.7 6996.6 4689.3 4720.2 4734.0 4741.8 4755.1 4779.6 4787.1 4790.5 4801.1 4801.9 5489.6 5516.9 5522.4 5522.6 5531.5 6525.8 6672.2 6681.3 6713.1 6718.3 1633.7 1680.7 1684.7 1685.3 1705.2 1067.5 1072.9 1099.1 1125.1 1136.9 6214.8 6222.3 6278.3 6281.3 6289.0 6797.5 6811.8 6836.7 6842.8 6842.9 6083.2 6160.6 6194.8 6200.8 6217.9 3689.2 3698.8 3705.8 3712.3 3719.1 7034.9 7105.3 7118.2 7139.8 7151.2 6890.4 6910.7 6948.9 6959.1 6977.9 7236.5 7290.4 7296.3 7299.2 7303.0 6881.5 6923.2 6961.3 6962.3 6976.7 6780.3 6796.8 6861.8 6886.7 6903.6 7235.1 7247.3 7269.4 7271.1 7271.3 4616.6 4657.0 4663.0 4673.2 4681.9 6817.5 6842.4 6902.8 6922.8 7013.9 6754.4 6774.4 6780.9 6795.2 6798.8 6723.1 6774.5 6785.4 6804.5 6807.1 6520.9 6600.5 6629.6 6653.0 6653.2 6767.8 6792.9 6824.4 6830.2 6832.3 6576.8 6594.2 6612.8 6626.1 6633.1 07:11:09 INFO - PROCESS | 21289 | 07:11:09 INFO - PROCESS | 21289 | [#5] yui.html Cycles:180 Average:13271.99 Median:46288.31 stddev:15029.52 (32.5%) stddev-sans-first:15042.32 07:11:09 INFO - PROCESS | 21289 | Values: 760.2 829.9 837.9 856.2 868.1 12657.9 12728.2 12882.8 13321.6 13323.8 12944.5 12973.0 12979.3 12988.6 13012.1 798.9 810.6 820.4 822.8 823.3 815.1 815.9 819.6 821.3 834.9 857.6 858.0 860.8 863.8 874.5 844.6 846.5 849.9 857.0 861.9 634.2 639.3 639.4 639.6 639.9 13654.7 13682.5 13811.6 13812.9 13828.9 11062.8 11109.8 11162.2 11401.6 11507.5 10048.3 10101.8 10358.8 10557.4 10667.3 3384.6 3384.6 3491.0 3492.3 3550.3 46151.1 46425.5 46756.3 46874.0 47403.1 9675.5 9685.4 9799.8 9859.2 9890.2 17062.4 17206.1 17313.3 17324.1 17339.8 7060.3 7306.6 7373.1 7480.6 7577.8 4073.9 4095.7 4111.4 4140.0 4165.6 2985.0 3005.4 3005.7 3008.7 3012.8 576.2 586.4 596.6 597.4 600.0 510.9 640.3 645.6 658.3 668.8 8603.6 8606.4 8675.7 8745.1 8777.4 546.6 696.7 703.7 735.6 742.1 4056.6 4171.5 4261.8 4299.5 4375.8 51914.0 52197.7 52201.0 52348.7 52888.7 43330.6 43711.6 44895.8 44996.0 45181.5 47787.8 48632.8 49062.5 49573.8 50203.2 8253.7 8299.9 8319.9 8376.4 8458.1 32923.3 33171.8 33404.0 33643.0 34067.1 39243.0 41233.0 42636.0 43320.8 43893.0 11028.7 11029.0 11095.8 11109.8 11514.7 11705.1 11878.8 12132.8 12327.4 12719.7 10739.1 10969.5 11165.9 11230.9 11472.6 11466.3 11518.2 11970.0 12249.2 12284.3 9554.5 10681.6 10854.7 11004.1 11221.1 9015.2 9102.6 9123.5 9163.1 9319.2 8984.8 9228.9 9253.2 9425.8 10016.9 07:11:09 INFO - PROCESS | 21289 | -------- Summary: end -------- 07:11:09 INFO - PROCESS | 21289 | 07:11:09 INFO - TEST-INFO | 21289: exit 0 07:11:09 INFO - TEST-OK | dromaeo_css | took 1110579ms 07:11:09 INFO - TEST-START | kraken 07:11:09 INFO - operating with platform_type : linux_ 07:11:09 INFO - Initialising browser for kraken test... 07:11:09 INFO - TEST-INFO | started process 21536 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSPTzTW/profile http://localhost:57115/getInfo.html) 07:11:13 INFO - PROCESS | 21536 | 07:11:13 INFO - PROCESS | 21536 | (process:21607): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:11:14 INFO - PROCESS | 21536 | __metrics Screen width/height:1600/1200 07:11:14 INFO - PROCESS | 21536 | colorDepth:24 07:11:14 INFO - PROCESS | 21536 | Browser inner width/height: 1024/697 07:11:14 INFO - PROCESS | 21536 | __metrics 07:11:14 INFO - PROCESS | 21536 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:11:15 INFO - TEST-INFO | 21536: exit 0 07:11:15 INFO - Browser initialized. 07:11:15 INFO - Running cycle 1/1 for kraken test... 07:11:15 INFO - TEST-INFO | started process 21656 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSPTzTW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:16 INFO - PROCESS | 21656 | 07:11:16 INFO - PROCESS | 21656 | (process:21713): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:11:26 INFO - PROCESS | 21656 | RSS: Main: 150999040 07:11:26 INFO - PROCESS | 21656 | 07:11:29 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57115/tests/kraken/driver.html?testName=audio-beat-detection) 07:11:29 INFO - PROCESS | 21656 | RSS: Main: 151273472 07:11:29 INFO - PROCESS | 21656 | 07:11:32 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57115/tests/kraken/driver.html?testName=audio-dft) 07:11:33 INFO - PROCESS | 21656 | RSS: Main: 154685440 07:11:33 INFO - PROCESS | 21656 | 07:11:36 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57115/tests/kraken/driver.html?testName=audio-fft) 07:11:36 INFO - PROCESS | 21656 | RSS: Main: 146923520 07:11:36 INFO - PROCESS | 21656 | 07:11:38 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57115/tests/kraken/driver.html?testName=audio-oscillator) 07:11:39 INFO - PROCESS | 21656 | RSS: Main: 147492864 07:11:39 INFO - PROCESS | 21656 | 07:11:41 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57115/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:11:42 INFO - PROCESS | 21656 | RSS: Main: 148090880 07:11:42 INFO - PROCESS | 21656 | 07:11:45 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57115/tests/kraken/driver.html?testName=imaging-darkroom) 07:11:45 INFO - PROCESS | 21656 | RSS: Main: 147996672 07:11:45 INFO - PROCESS | 21656 | 07:11:49 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57115/tests/kraken/driver.html?testName=imaging-desaturate) 07:11:49 INFO - PROCESS | 21656 | RSS: Main: 148340736 07:11:49 INFO - PROCESS | 21656 | 07:11:52 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57115/tests/kraken/driver.html?testName=json-parse-financial) 07:11:53 INFO - PROCESS | 21656 | RSS: Main: 151056384 07:11:53 INFO - PROCESS | 21656 | 07:11:54 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57115/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:11:55 INFO - PROCESS | 21656 | RSS: Main: 150573056 07:11:55 INFO - PROCESS | 21656 | 07:11:57 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57115/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:57 INFO - PROCESS | 21656 | RSS: Main: 150863872 07:11:57 INFO - PROCESS | 21656 | 07:11:59 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57115/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:12:00 INFO - PROCESS | 21656 | RSS: Main: 151031808 07:12:00 INFO - PROCESS | 21656 | 07:12:02 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:12:03 INFO - PROCESS | 21656 | RSS: Main: 149344256 07:12:03 INFO - PROCESS | 21656 | 07:12:06 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:12:06 INFO - PROCESS | 21656 | RSS: Main: 150581248 07:12:06 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:57115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57115/tests/kraken/driver.html?testName=ai-astar) 07:12:08 INFO - PROCESS | 21656 | RSS: Main: 150921216 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | __start_tp_report 07:12:08 INFO - PROCESS | 21656 | _x_x_mozilla_page_load 07:12:08 INFO - PROCESS | 21656 | _x_x_mozilla_page_load_details 07:12:08 INFO - PROCESS | 21656 | |i|pagename|runs| 07:12:08 INFO - PROCESS | 21656 | |0;ai-astar;112;104;111;109;112;121;113;110;111;111 07:12:08 INFO - PROCESS | 21656 | |1;audio-beat-detection;161;134;152;159;151;153;148;130;166;128 07:12:08 INFO - PROCESS | 21656 | |2;audio-dft;163;164;162;164;169;166;160;165;170;162 07:12:08 INFO - PROCESS | 21656 | |3;audio-fft;72;73;72;74;75;143;74;75;72;75 07:12:08 INFO - PROCESS | 21656 | |4;audio-oscillator;95;96;142;96;96;97;148;96;96;136 07:12:08 INFO - PROCESS | 21656 | |5;imaging-gaussian-blur;109;109;110;110;110;110;115;111;110;111 07:12:08 INFO - PROCESS | 21656 | |6;imaging-darkroom;146;146;146;146;147;148;147;151;147;147 07:12:08 INFO - PROCESS | 21656 | |7;imaging-desaturate;96;97;96;96;96;97;96;96;96;97 07:12:08 INFO - PROCESS | 21656 | |8;json-parse-financial;60;59;62;57;57;58;57;57;56;62 07:12:08 INFO - PROCESS | 21656 | |9;json-stringify-tinderbox;69;68;68;68;69;69;69;69;68;69 07:12:08 INFO - PROCESS | 21656 | |10;stanford-crypto-aes;83;85;83;85;91;83;83;86;84;82 07:12:08 INFO - PROCESS | 21656 | |11;stanford-crypto-ccm;116;119;115;122;117;118;125;124;124;124 07:12:08 INFO - PROCESS | 21656 | |12;stanford-crypto-pbkdf2;138;146;150;145;146;139;144;147;145;137 07:12:08 INFO - PROCESS | 21656 | |13;stanford-crypto-sha256-iterative;66;66;70;67;67;66;66;67;67;66 07:12:08 INFO - PROCESS | 21656 | __end_tp_report 07:12:08 INFO - PROCESS | 21656 | __start_cc_report 07:12:08 INFO - PROCESS | 21656 | _x_x_mozilla_cycle_collect,745 07:12:08 INFO - PROCESS | 21656 | __end_cc_report 07:12:08 INFO - PROCESS | 21656 | __startTimestamp1452870728540__endTimestamp 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | ------- Summary: start ------- 07:12:08 INFO - PROCESS | 21656 | Number of tests: 14 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:4.20 (3.8%) stddev-sans-first:4.44 07:12:08 INFO - PROCESS | 21656 | Values: 112.0 104.0 111.0 109.0 112.0 121.0 113.0 110.0 111.0 111.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:152.50 stddev:13.26 (8.7%) stddev-sans-first:13.24 07:12:08 INFO - PROCESS | 21656 | Values: 161.0 134.0 152.0 159.0 151.0 153.0 148.0 130.0 166.0 128.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:3.14 (1.9%) stddev-sans-first:3.28 07:12:08 INFO - PROCESS | 21656 | Values: 163.0 164.0 162.0 164.0 169.0 166.0 160.0 165.0 170.0 162.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.00 stddev:22.00 (29.7%) stddev-sans-first:23.11 07:12:08 INFO - PROCESS | 21656 | Values: 72.0 73.0 72.0 74.0 75.0 143.0 74.0 75.0 72.0 75.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:96.00 stddev:22.40 (23.3%) stddev-sans-first:23.11 07:12:08 INFO - PROCESS | 21656 | Values: 95.0 96.0 142.0 96.0 96.0 97.0 148.0 96.0 96.0 136.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.00 stddev:1.72 (1.6%) stddev-sans-first:1.73 07:12:08 INFO - PROCESS | 21656 | Values: 109.0 109.0 110.0 110.0 110.0 110.0 115.0 111.0 110.0 111.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.52 (1.0%) stddev-sans-first:1.56 07:12:08 INFO - PROCESS | 21656 | Values: 146.0 146.0 146.0 146.0 147.0 148.0 147.0 151.0 147.0 147.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:12:08 INFO - PROCESS | 21656 | Values: 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.50 stddev:2.17 (3.7%) stddev-sans-first:2.24 07:12:08 INFO - PROCESS | 21656 | Values: 60.0 59.0 62.0 57.0 57.0 58.0 57.0 57.0 56.0 62.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 07:12:08 INFO - PROCESS | 21656 | Values: 69.0 68.0 68.0 68.0 69.0 69.0 69.0 69.0 68.0 69.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:2.59 (3.1%) stddev-sans-first:2.69 07:12:08 INFO - PROCESS | 21656 | Values: 83.0 85.0 83.0 85.0 91.0 83.0 83.0 86.0 84.0 82.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:123.00 stddev:3.81 (3.1%) stddev-sans-first:3.69 07:12:08 INFO - PROCESS | 21656 | Values: 116.0 119.0 115.0 122.0 117.0 118.0 125.0 124.0 124.0 124.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:145.50 stddev:4.27 (2.9%) stddev-sans-first:4.00 07:12:08 INFO - PROCESS | 21656 | Values: 138.0 146.0 150.0 145.0 146.0 139.0 144.0 147.0 145.0 137.0 07:12:08 INFO - PROCESS | 21656 | 07:12:08 INFO - PROCESS | 21656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 07:12:08 INFO - PROCESS | 21656 | Values: 66.0 66.0 70.0 67.0 67.0 66.0 66.0 67.0 67.0 66.0 07:12:08 INFO - PROCESS | 21656 | -------- Summary: end -------- 07:12:08 INFO - PROCESS | 21656 | 07:12:09 INFO - TEST-INFO | 21656: exit 0 07:12:09 INFO - TEST-OK | kraken | took 59567ms 07:12:09 INFO - TEST-START | v8_7 07:12:09 INFO - operating with platform_type : linux_ 07:12:09 INFO - Initialising browser for v8_7 test... 07:12:09 INFO - TEST-INFO | started process 21942 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcKrDDh/profile http://localhost:57115/getInfo.html) 07:12:12 INFO - PROCESS | 21942 | 07:12:12 INFO - PROCESS | 21942 | (process:22013): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:12:13 INFO - PROCESS | 21942 | __metrics Screen width/height:1600/1200 07:12:13 INFO - PROCESS | 21942 | colorDepth:24 07:12:13 INFO - PROCESS | 21942 | Browser inner width/height: 1024/697 07:12:13 INFO - PROCESS | 21942 | __metrics 07:12:13 INFO - PROCESS | 21942 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:12:14 INFO - TEST-INFO | 21942: exit 0 07:12:14 INFO - Browser initialized. 07:12:14 INFO - Running cycle 1/1 for v8_7 test... 07:12:14 INFO - TEST-INFO | started process 22062 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcKrDDh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:16 INFO - PROCESS | 22062 | 07:12:16 INFO - PROCESS | 22062 | (process:22121): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:12:26 INFO - PROCESS | 22062 | RSS: Main: 151220224 07:12:26 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:57115/tests/v8_7/run.html (next: http://localhost:57115/tests/v8_7/run.html) 07:12:49 INFO - PROCESS | 22062 | RSS: Main: 145387520 07:12:49 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | __start_tp_report 07:12:49 INFO - PROCESS | 22062 | _x_x_mozilla_page_load 07:12:49 INFO - PROCESS | 22062 | _x_x_mozilla_page_load_details 07:12:49 INFO - PROCESS | 22062 | |i|pagename|runs| 07:12:49 INFO - PROCESS | 22062 | |0;Richards;167.897918065816 07:12:49 INFO - PROCESS | 22062 | |1;DeltaBlue;188.14675446848543 07:12:49 INFO - PROCESS | 22062 | |2;Encrypt;281.61081385525205 07:12:49 INFO - PROCESS | 22062 | |3;Decrypt;5240.837696335078 07:12:49 INFO - PROCESS | 22062 | |4;RayTrace;1050.420168067227 07:12:49 INFO - PROCESS | 22062 | |5;Earley;705.4263565891473 07:12:49 INFO - PROCESS | 22062 | |6;Boyer;12329.268292682927 07:12:49 INFO - PROCESS | 22062 | |7;RegExp;41260 07:12:49 INFO - PROCESS | 22062 | |8;Splay;568.5048322910744 07:12:49 INFO - PROCESS | 22062 | |9;NavierStokes;4822.115384615385 07:12:49 INFO - PROCESS | 22062 | __end_tp_report 07:12:49 INFO - PROCESS | 22062 | __startTimestamp1452870769338__endTimestamp 07:12:49 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | ------- Summary: start ------- 07:12:49 INFO - PROCESS | 22062 | Number of tests: 10 07:12:49 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | [#0] Richards Cycles:1 Average:167.90 Median:167.90 stddev:0.00 (0.0%) 07:12:49 INFO - PROCESS | 22062 | Values: 167.9 07:12:49 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | [#1] DeltaBlue Cycles:1 Average:188.15 Median:188.15 stddev:0.00 (0.0%) 07:12:49 INFO - PROCESS | 22062 | Values: 188.1 07:12:49 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | [#2] Encrypt Cycles:1 Average:281.61 Median:281.61 stddev:0.00 (0.0%) 07:12:49 INFO - PROCESS | 22062 | Values: 281.6 07:12:49 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 07:12:49 INFO - PROCESS | 22062 | Values: 5240.8 07:12:49 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | [#4] RayTrace Cycles:1 Average:1050.42 Median:1050.42 stddev:0.00 (0.0%) 07:12:49 INFO - PROCESS | 22062 | Values: 1050.4 07:12:49 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | [#5] Earley Cycles:1 Average:705.43 Median:705.43 stddev:0.00 (0.0%) 07:12:49 INFO - PROCESS | 22062 | Values: 705.4 07:12:49 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | [#6] Boyer Cycles:1 Average:12329.27 Median:12329.27 stddev:0.00 (0.0%) 07:12:49 INFO - PROCESS | 22062 | Values: 12329.3 07:12:49 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | [#7] RegExp Cycles:1 Average:41260.00 Median:41260.00 stddev:0.00 (0.0%) 07:12:49 INFO - PROCESS | 22062 | Values: 41260.0 07:12:49 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | [#8] Splay Cycles:1 Average:568.50 Median:568.50 stddev:0.00 (0.0%) 07:12:49 INFO - PROCESS | 22062 | Values: 568.5 07:12:49 INFO - PROCESS | 22062 | 07:12:49 INFO - PROCESS | 22062 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 07:12:49 INFO - PROCESS | 22062 | Values: 4822.1 07:12:49 INFO - PROCESS | 22062 | -------- Summary: end -------- 07:12:49 INFO - PROCESS | 22062 | 07:12:50 INFO - TEST-INFO | 22062: exit 0 07:12:50 INFO - TEST-OK | v8_7 | took 40788ms 07:12:50 INFO - SUITE-END | took 1210s 07:12:50 INFO - Completed test suite (00:20:11) 07:12:50 INFO - Working with test: dromaeo_css 07:12:50 INFO - Generating results file: dromaeo_css 07:12:50 INFO - Working with test: kraken 07:12:50 INFO - Generating results file: kraken 07:12:50 INFO - javascript benchmark 07:12:50 INFO - Working with test: v8_7 07:12:50 INFO - Generating results file: v8_7 07:12:50 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:12:50 INFO - process_Request line: dromaeo_css 6890.32 graph.html#tests=[[72,1,43]] 07:12:50 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:50 INFO - process_Request line: kraken 1510.80 graph.html#tests=[[232,1,43]] 07:12:50 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:50 INFO - process_Request line: v8_7 20503.38 graph.html#tests=[[230,1,43]] 07:12:50 INFO - RETURN: dromaeo_css: 6890.32 07:12:50 INFO - RETURN: kraken: 1510.80 07:12:50 INFO - RETURN: v8_7: 20503.38 07:12:50 INFO - javascript benchmark 07:12:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3213.807171569706, 3237.9352412951744, 3278.2132288250828, 3282.277898862251, 3283.3433313337323, 5210.348706411699, 5354.116570765824, 5357.142857142862, 5375.354957405112, 5380.515753582186, 5222.268882356464, 5232.16285394337, 5272.1300985337375, 5329.680219186852, 5342.759575819087, 4862.076205520949, 4899.8775030624165, 4942.53045960635, 4978.103941290567, 4984.4018717753925, 4832.299316599091, 4874.390701162355, 4884.609231261508, 4888.388951381077, 4940.061388336223, 4776.5701086902345, 4779.474257831635, 4831.082094402088, 4840.346553215341, 4858.878528036809, 4868.853934381974, 4869.756512174377, 4881.292212629149, 4903.0, 4903.411590609114, 4895.559399654048, 4897.559219670211, 4898.0, 4915.041566894457, 4939.827106051307, 4957.355543779286, 4988.226824842155, 5084.694918304914, 5099.796008159669, 5238.135707608279, 5642.4357564243655, 5695.515881150066, 5741.971290143564, 5761.625494342854, 5793.304803423574, 5785.045467497858, 5787.276590426197, 5787.681677507735, 5788.392218817005, 5791.73937172824, 5251.2123181523075, 5334.093204155303, 5394.083005889008, 5398.082326004589, 5404.405515393303, 5741.684207368635, 5868.031774757117, 5961.046232602763, 5968.85077873048, 5989.0, 5659.377468478464, 5659.547236221092, 5659.801906933238, 5661.094224923992, 5680.289963754531, 5540.390557038722, 5693.914591281134, 5731.111677689964, 5765.971170144123, 5798.188253644493, 5584.46947539983, 5611.663300202001, 5626.493615574536, 5629.859253518613, 5731.197632331477, 5731.713414329267, 5750.741216645261, 5753.683547404933, 5760.567957403212, 5766.740496677659, 4416.183006143874, 4426.778661066934, 4447.688661793708, 4475.216837053567, 4477.1493416250805, 3908.511436070491, 3923.6272554107313, 3965.504311961005, 3977.840886364571, 4002.1195337025806, 5279.1289437243195, 5290.206469029599, 5331.253624492574, 5333.879885224069, 5373.596980226499, 5665.943340566624, 5694.5159661428415, 5700.201971723962, 5706.828795136153, 5707.315122185364, 5317.973410133002, 5394.811181608625, 5411.972940135274, 5452.972735136299, 5487.862803429946, 4879.756012199376, 4927.1131196384995, 4940.209566469348, 4942.92585611209, 4984.950150498521, 5751.769929202868, 5904.822855314347, 5960.374160713062, 5980.401959804072, 5998.670073146019, 5627.606067575394, 5697.515711164598, 5772.740226689725, 5799.449052340021, 5853.736581853912, 6004.969975150097, 6024.759009639565, 6040.909386359121, 6045.123457098608, 6051.243594550681, 5541.778328866801, 5726.455986681259, 5733.971330143323, 5749.396313387034, 5751.8562035949435, 5648.802291919763, 5696.11710184922, 5710.37185909558, 5739.856503587277, 5780.046292361713, 5535.612507124462, 5550.084236100998, 5576.972115139399, 5581.0, 5586.720663966867, 5456.809011684572, 5492.0663487206475, 5565.30433695788, 5571.415001424792, 5578.916316255179, 5446.264754258283, 5469.917951230815, 5480.013597552319, 5492.286002819608, 5518.530924871431, 5534.501894829324, 5544.7227638618715, 5621.381648018796, 5635.0702134147405, 5664.603477756517, 5358.598105142208, 5488.341399031982, 5492.917606235989, 5508.55931525469, 5520.254765606592], "unit": "score", "name": "dojo.html", "value": 5279.963838871744}, {"lowerIsBetter": false, "replicates": [519.2859817750593, 530.3211888782358, 549.1049589169653, 555.2337773872057, 593.9435753603406, 35457.46813797792, 36233.637663623354, 36250.81874590623, 36282.455763163576, 36376.0, 38620.42069368955, 38779.0, 38879.61120388795, 38945.22109557807, 38975.025624359405, 8385.538795366268, 8465.576721163949, 8545.829083418328, 8564.229219370256, 8578.785530361729, 8351.16488351163, 8403.41176117672, 8473.618687159062, 8474.576271186446, 8500.362472814533, 8639.611217495229, 8687.522186279784, 8744.387892847502, 8747.95626021869, 8754.956225218864, 8577.39958202926, 8594.0, 8631.741047768577, 8637.0499245083, 8736.956315218447, 8570.657173713043, 8613.397062205648, 8662.956685216534, 8691.565421728952, 8701.7824554386, 39942.400863987066, 40218.59781402178, 40393.798031009654, 40490.19019619591, 40571.7971410144, 2619.3975385661215, 2759.2412086676322, 3024.3195281061803, 3084.599002129709, 3172.904812855618, 26434.47131057368, 26453.0, 26589.601155982484, 26601.600975985377, 26807.597886031726, 3667.7615954963107, 3704.2961837250837, 3733.3466643337306, 3781.6596506314563, 3850.8074596270076, 173418.0, 174782.0, 175102.0, 175256.0, 175444.47333160051, 53438.0, 54930.45069549333, 57423.42576574264, 61952.38047619466, 63368.68315658484, 55887.0, 56003.79971502154, 56106.158407623916, 56132.43867561272, 56266.71866640722, 13417.262050587116, 13523.59429217125, 13545.45818167282, 13568.457261709618, 13731.107478013897, 10396.896031039592, 10420.531076101593, 10468.319559228627, 10473.423961682029, 10504.947475262576, 19903.402897913085, 20576.485587860425, 20599.4850128745, 20803.791962080184, 20879.478013049797, 7300.780976570712, 7513.2111128331835, 7534.3595794357, 7560.697572097055, 7650.42621803367, 991.4150651115876, 1018.3940555369543, 1023.7901230247782, 1025.5795123999123, 1025.9945253651463, 29103.0, 29371.853140734158, 29469.26326841846, 29735.85132074369, 29935.70064299329, 1020.4387586827215, 1081.259337353915, 1086.3807629651023, 1128.311729844794, 1145.7364806094645, 15209.695806083817, 15303.38786448552, 15422.537323880302, 15467.458638947583, 15488.690226195638, 328001.0, 328457.0, 329088.0, 330463.0, 330925.0, 53624.463755362725, 53734.19398709023, 53913.1913021305, 53937.1909421359, 54043.0, 1297.331874084847, 1304.0545604436898, 1314.3822403470353, 1328.5814968285154, 1330.481112366178, 27733.583996240475, 28921.276968075967, 29034.41931161407, 29162.708372916, 29585.112446626637, 47930.760346199444, 48186.759066204446, 48249.75875120602, 48534.0, 48642.5135748638, 301545.0, 303593.0, 304124.0, 304223.0, 304418.0, 32408.83795581007, 32654.34691306113, 32960.505592415655, 33170.0, 33192.66807331896, 38590.80704596459, 41210.0, 41604.58395416007, 42256.788716056224, 42604.0, 35043.47434788531, 35846.0, 35846.820765896, 35947.28105437929, 36406.27187456289, 35716.28567428689, 35789.82105089458, 35827.641723582434, 35946.0, 36509.45235821412, 35665.82167089148, 35935.82032089823, 36172.0, 36454.0, 36720.449193261586, 30604.0, 32027.199320017186, 33241.83379083186, 33244.0, 33312.0, 24889.751102488743, 25382.873085635194, 25497.0, 25607.48785024252, 25729.485410292065], "unit": "score", "name": "ext.html", "value": 17944.45660310336}, {"lowerIsBetter": false, "replicates": [359.26350980489997, 362.2121884900343, 362.53595397890695, 363.58551251573203, 370.1265014565623, 15535.844641553595, 15912.76130858038, 16713.331466741332, 16805.83194168058, 17757.200925958332, 10609.78780424393, 10745.731356716085, 10745.946270268638, 10883.401412922287, 10894.564217431312, 4676.532346765322, 4844.563989240967, 4846.466888642247, 4901.240307752286, 5397.514223719864, 5294.629375943686, 5344.251804747339, 5396.568274538027, 5399.136138217886, 5406.189071639266, 4921.901561968759, 5167.819126330579, 5347.973260133694, 5380.542653874425, 5389.838304850841, 5287.312649355578, 5301.045811753902, 5315.388730296027, 5334.853006603599, 5593.2449119368775, 5323.201519772027, 5347.358317001946, 5351.438098999627, 5360.303160589137, 5387.595930305243, 18966.24135034597, 19137.712934305997, 19832.60334793296, 19856.900715496475, 19975.400737977885, 2076.1280262289874, 2135.4661334666334, 2222.200007997136, 2279.4985103277254, 2292.873891935943, 9360.11078947499, 9398.765030874214, 9573.090556397132, 9713.514324283828, 12358.073144514197, 1781.2785821742216, 1786.9910650446664, 1787.6960916644202, 1806.151108978778, 1839.6596629623562, 56404.43595564033, 56811.71594142044, 56948.715256423864, 57854.710726446516, 58563.0, 10066.69799906004, 10218.284720069523, 10238.33450825694, 10259.281850270409, 10337.0, 13313.40089695966, 13491.123076999964, 13532.661683457796, 13598.252096134807, 13620.0, 7301.817454563678, 7359.059885567665, 7376.0411146550605, 7432.591207483641, 7499.362554182846, 7078.398336141486, 7081.610511421818, 7081.610511421921, 7142.321479459443, 7175.569465831963, 3962.663173630216, 4161.146964872194, 4379.0366119453665, 4458.799354029076, 4510.1656193604285, 1674.9748753768704, 1712.383541924906, 1770.4157627982993, 1799.631075629493, 1838.9977462283089, 872.0886673426285, 913.1370854542527, 914.2731528434911, 921.4517362169498, 990.346371394876, 14966.551003469913, 15234.009789363656, 15555.533333999998, 15693.372265109268, 15817.604559886095, 896.2919293757989, 922.7785331520387, 929.8884133903839, 929.9209567186865, 937.1097457415347, 8952.418092823946, 9380.812383752287, 9497.715068547956, 9995.450250236161, 10023.398596084258, 491804.0, 495273.0, 498873.0, 543138.0, 560811.0, 70452.0, 72919.63540182372, 73185.0, 74725.0, 74998.6250068757, 1128.610629332879, 1136.2046567402851, 1145.8796826333114, 1147.17976646698, 1148.035650053942, 15140.697186056437, 15291.694166116838, 15432.537023889301, 15467.381304747683, 15671.529854104396, 33602.66397335995, 34177.14557136092, 35175.12062198466, 35353.46969795404, 35519.82240088783, 45041.77479112714, 45558.86102847455, 45834.77082614566, 48590.0, 49014.26478602895, 7211.67547460376, 7332.96333518329, 7355.117385913724, 7443.0, 7444.441666875115, 7154.676384868816, 10840.349579025284, 11348.205625606459, 11390.088792896715, 11420.543178272776, 8965.865512017455, 8986.640534378552, 9879.160271376726, 10074.54664540112, 10094.394336339843, 9621.18219951312, 9667.951660241653, 10024.949875250577, 10207.693769186937, 10274.640387586398, 9432.481213533321, 9690.273229507957, 9780.559874805509, 10097.495125243855, 10152.796944061225, 7065.540739851893, 7385.0, 7408.703651853865, 7478.2521747824785, 7498.250174982458, 9480.0, 9757.707268781947, 10057.647982320585, 10092.34399764013, 10129.392236465836], "unit": "score", "name": "jquery.html", "value": 8077.6606212447}, {"lowerIsBetter": false, "replicates": [1484.8960572759904, 1497.0792962328171, 1644.3997940751622, 1761.964760704785, 1803.0533969665917, 7488.32605065544, 7506.286902744244, 7595.696172153107, 7650.196729343423, 7717.0, 7611.69553217872, 7633.961830190841, 7692.115406728228, 7741.845163096735, 7749.92250077499, 2330.615448451008, 2331.6619090231907, 2337.3922780077132, 2352.329586067971, 2360.586897292967, 2314.2941402872116, 2339.590571649963, 2383.4041489627593, 2388.176079252655, 2398.2325655790155, 2271.9886400568057, 2312.3525412884337, 2325.6046472099697, 2327.7555856635063, 2343.285297984114, 2318.084356679111, 2333.9183128590503, 2335.521218150275, 2342.1802369170823, 2344.8944797484155, 2336.918207862717, 2349.6945397098266, 2357.9528409431887, 2359.2214569192124, 2363.869987150706, 7654.578998155099, 7703.3067023968115, 7704.191059938737, 7708.38332933364, 7730.536167829948, 4757.381540399726, 4887.804487820483, 4890.119778439879, 4902.19113846215, 4917.336159618441, 2966.4512065267995, 3027.409655117253, 3059.7552195824283, 3070.570120183176, 3088.1970687621156, 933.5052422216236, 960.2462067277223, 999.0089592079688, 1009.8232809258424, 1022.0597050713361, 10340.689779306633, 10357.119644830198, 10378.169746420268, 10461.84307235392, 10498.317609355367, 4172.70791044624, 4195.895102622398, 4277.807498662568, 4295.098029413795, 4311.073119279307, 8514.70198543048, 8530.232279094911, 8592.65629374818, 8600.13998600135, 8625.266852317498, 4731.526847315241, 4760.785764640599, 4783.378160839138, 4789.521047895182, 4794.568488836021, 4334.804933777925, 4362.062156636275, 4375.27807911691, 4377.190219809346, 4385.495667998157, 3466.838609065991, 3489.982550087284, 3502.7372947029075, 3504.8773292934625, 3508.8421021054114, 1053.8998795114605, 1071.7320669832543, 1080.5353697909818, 1082.6697857153645, 1103.0458653264868, 1042.3797840285017, 1057.4659796802719, 1069.5828626835541, 1115.2137742891243, 1146.8050431426677, 7086.185088714864, 7115.501914866013, 7127.7148914042855, 7160.391366733886, 7164.104486939133, 1184.8696643369221, 1218.7623413434474, 1244.440001999104, 1248.1699669719717, 1261.6971926737517, 5550.5282051026115, 5698.287714035746, 5730.11183266586, 5771.018926782457, 5810.622309549865, 9082.727518174333, 9324.627014919328, 9363.25093992479, 9381.812363752686, 9427.575759090858, 9102.590383432762, 9127.543622818832, 9153.313501487415, 9221.262299016063, 9265.814683706289, 7292.8906066409045, 7344.596047217347, 7348.96325518369, 7355.301246381585, 7370.8894366584545, 6931.861362772817, 7050.823729406806, 7062.081929349357, 7092.751753688596, 7115.181754098345, 8355.12271211514, 8407.579621018802, 8457.112003239818, 8462.19609137131, 8603.870941935751, 8086.15095414973, 8412.957935210285, 8480.194381533991, 8484.703035393732, 8645.26515246211, 6915.550489218184, 6980.162380514371, 6988.685509152202, 7003.124609423822, 7041.823954401181, 7270.163931147774, 7308.59802710856, 7338.96330518344, 7345.889811652936, 7423.628818558943, 6844.589324640538, 6882.69027893756, 6898.724051037902, 7001.789946301619, 7271.60006199643, 6705.430038446787, 6736.528443008942, 6924.896126558207, 6943.930560694531, 7153.892691609734, 6949.722011119498, 6994.545354551938, 7039.824004399931, 7060.905559638264, 7069.752558660422, 6506.479481641362, 6509.641969691713, 6516.5112616553, 6524.119243902012, 6552.967235163794, 6474.773382931575, 6536.300561854047, 6589.374009469093, 6697.397234248941, 6702.296258892941], "unit": "score", "name": "mootools.html", "value": 4484.510238235101}, {"lowerIsBetter": false, "replicates": [332.1132576022021, 332.57430488974114, 343.60313837517674, 348.4494498692066, 349.7831344566369, 6135.233095863017, 6260.12358269842, 6282.0, 6282.465990390817, 6295.874082518352, 6127.7855275065385, 6258.499320054396, 6267.968660156705, 6272.592281501699, 6281.9057714134215, 4809.975950120253, 4821.252705830584, 4822.638302127337, 4825.324454576345, 4831.734254615994, 4824.4210694716685, 4825.25208592667, 4829.830955916544, 4830.420349558058, 4843.927341089887, 4705.623550116, 4766.809327626908, 4772.260299653542, 4779.64152688548, 4780.90438191236, 4765.761711914425, 4769.213079841822, 4779.235322348408, 4784.114938736345, 4784.210605250129, 4134.111166099303, 4143.834246630131, 4157.251694694954, 4159.958400416018, 4180.331147016494, 5833.7083145842535, 5850.795222167247, 5863.208466856962, 5885.61743486672, 5944.762209511614, 5432.91850622241, 5552.3892371839065, 5556.111022236423, 5575.0, 5580.581456390746, 6634.46924246064, 6646.401823835878, 6646.60120392778, 6647.169103862017, 6651.102101216322, 4610.0, 4619.076184763061, 4623.214053610895, 4630.606398456135, 4642.466116396624, 6762.391384775345, 6911.861762764716, 6970.372666460043, 6987.6855541500245, 6996.580205187654, 4689.320048592935, 4720.221163508051, 4734.0, 4741.786619602126, 4755.120302743934, 4779.641526885497, 4787.0904528139545, 4790.473047964721, 4801.087793319258, 4801.855944321676, 5489.615726899158, 5516.862078448071, 5522.420145884625, 5522.641028333145, 5531.502164805187, 6525.771597994048, 6672.199336079701, 6681.298463661343, 6713.1272934519175, 6718.294579069225, 1633.681432120749, 1680.655465629543, 1684.6630673865277, 1685.2837544043732, 1705.1815128738026, 1067.4502631144967, 1072.91953103516, 1099.1261946752352, 1125.139268459629, 1136.9147313951487, 6214.751409943642, 6222.315545290015, 6278.30938596754, 6281.277653069956, 6288.968555157195, 6797.490188235902, 6811.795646130624, 6836.726530938806, 6842.7605033823575, 6842.931570684329, 6083.209182806207, 6160.630362178284, 6194.81415557534, 6200.782972595937, 6217.875642487125, 3689.206820533598, 3698.7595806272507, 3705.7776533408082, 3712.2575484903127, 3719.1260053887313, 7034.929650703428, 7105.2894710528535, 7118.216996130422, 7139.750108746169, 7151.177614574391, 6890.44876409886, 6910.689018994158, 6948.861022779617, 6959.130108736408, 6977.860442791116, 7236.529625574321, 7290.4167666586545, 7296.343329100407, 7299.160596531467, 7302.96348518254, 6881.518293719391, 6923.238443771282, 6961.269066747918, 6962.294237911744, 6976.720931162697, 6780.32196780318, 6796.776580215609, 6861.759838405632, 6886.690098945459, 6903.6203008835, 7235.131784185932, 7247.347738703331, 7269.418446524372, 7271.054762880792, 7271.309225623558, 4616.561426664462, 4657.045305712389, 4663.044075964352, 4673.205555055717, 4681.859544213679, 6817.454603631797, 6842.384185423336, 6902.827429314308, 6922.7923162305215, 7013.894791578233, 6754.425873800782, 6774.42417394527, 6780.93219067803, 6795.218549866829, 6798.796036118924, 6723.1259936209935, 6774.525783195326, 6785.423239024541, 6804.523683342119, 6807.149106361705, 6520.902186467301, 6600.471962243105, 6629.635370054693, 6653.0, 6653.201615806134, 6767.796966091025, 6792.932070679428, 6824.351686589766, 6830.180378354629, 6832.282610325844, 6576.76981305652, 6594.241662208908, 6612.768553100618, 6626.072349871119, 6633.1045308882685], "unit": "score", "name": "prototype.html", "value": 5018.836900309899}, {"lowerIsBetter": false, "replicates": [760.1903972269532, 829.8878316089339, 837.882696422501, 856.1566856646205, 868.1015149320455, 12657.936710316448, 12728.236305821645, 12882.80675789864, 13321.600351989431, 13323.800142997863, 12944.546940857072, 12973.0, 12979.286139262336, 12988.61034168974, 13012.089153759242, 798.9480683755537, 810.5784991804259, 820.3724151024471, 822.8148666550038, 823.3043078598574, 815.0708192660372, 815.8939337886067, 819.573821612761, 821.2772759971247, 834.8872902158191, 857.648364170687, 857.9528125953101, 860.849351363512, 863.753830158405, 874.514644372373, 844.5608283692476, 846.5259454705354, 849.8512760266929, 856.9887532711398, 861.9439736417113, 634.1629049654458, 639.2776162935853, 639.4341008207723, 639.6098379988204, 639.9040143978394, 13654.726905461934, 13682.452701891913, 13811.585652430344, 13812.93093534536, 13828.861711382959, 11062.834057489064, 11109.777804443947, 11162.162837787198, 11401.600943967005, 11507.539698412054, 10048.296619236657, 10101.797964040677, 10358.844617330746, 10557.366558006544, 10667.253292269545, 3384.560007199073, 3384.644612315696, 3491.0, 3492.266624008961, 3550.343186510478, 46151.07697846058, 46425.535744642795, 46756.29865551985, 46874.0, 47403.05193896103, 9675.516224188763, 9685.370450920667, 9799.755006124762, 9859.211263098934, 9890.20878329732, 17062.402815901383, 17206.1396930153, 17313.268673132585, 17324.133793310284, 17339.826601734072, 7060.258672839278, 7306.561606303532, 7373.115226172787, 7480.551166930001, 7577.848443031219, 4073.898152546151, 4095.672346212296, 4111.403846442249, 4140.0, 4165.562615925284, 2984.985075074611, 3005.3838963012968, 3005.729484346419, 3008.669046404894, 3012.8041677290908, 576.1789450033768, 586.4311617730795, 596.6062398816761, 597.4175179200245, 600.0099835271836, 510.90548248574135, 640.2981450186101, 645.6416688737702, 658.256170527301, 668.7793028300649, 8603.569821509025, 8606.44058136219, 8675.696350627697, 8745.125487451203, 8777.363902555644, 546.6392181160415, 696.7317582730685, 703.6833424958687, 735.5917465806422, 742.1279996004673, 4056.6146216109423, 4171.541130475645, 4261.765602891809, 4299.484061912591, 4375.824967001285, 51914.0, 52197.7390113047, 52200.95598088093, 52348.738256308476, 52888.735556321975, 43330.56669433265, 43711.562884371386, 44895.775521122836, 44996.0, 45181.54818451839, 47787.76106119447, 48632.756836215594, 49062.50937490579, 49573.75213123983, 50203.24695129649, 8253.669853205805, 8299.875501867356, 8319.916800832156, 8376.371772116994, 8458.069612342515, 32923.34153316968, 33171.83414082914, 33403.99788006364, 33643.0, 34067.14832129217, 39243.0, 41233.0, 42636.0, 43320.78339608282, 43893.0, 11028.70266347178, 11029.0, 11095.778084438427, 11109.777804444027, 11514.733379328434, 11705.063594912557, 11878.821817672915, 12132.841474782179, 12327.445264962918, 12719.682007949876, 10739.140868730326, 10969.50637221343, 11165.944170279097, 11230.94384528072, 11472.598459053894, 11466.31202127875, 11518.193726439404, 11970.0, 12249.203801752858, 12284.262944223376, 9554.474503902075, 10681.57273709043, 10854.728631783953, 11004.119670426508, 11221.079500027521, 9015.233705135137, 9102.59038343263, 9123.5438228087, 9163.083194551518, 9319.16127548524, 8984.775380615536, 9228.861567076634, 9253.213476854542, 9425.764355891157, 10016.949915250378], "unit": "score", "name": "yui.html", "value": 6212.051240605593}], "name": "dromaeo_css", "value": 6890.317258727847}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 104.0, 111.0, 109.0, 112.0, 121.0, 113.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [161.0, 134.0, 152.0, 159.0, 151.0, 153.0, 148.0, 130.0, 166.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 162.0, 164.0, 169.0, 166.0, 160.0, 165.0, 170.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 74.0, 75.0, 143.0, 74.0, 75.0, 72.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 142.0, 96.0, 96.0, 97.0, 148.0, 96.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 115.0, 111.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 148.0, 147.0, 151.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 62.0, 57.0, 57.0, 58.0, 57.0, 57.0, 56.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 83.0, 85.0, 91.0, 83.0, 83.0, 86.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [116.0, 119.0, 115.0, 122.0, 117.0, 118.0, 125.0, 124.0, 124.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [138.0, 146.0, 150.0, 145.0, 146.0, 139.0, 144.0, 147.0, 145.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 70.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1510.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.897918065816], "unit": "score", "name": "Richards", "value": 210.25871200000006}, {"lowerIsBetter": false, "replicates": [188.14675446848543], "unit": "score", "name": "DeltaBlue", "value": 351.41717}, {"lowerIsBetter": false, "replicates": [281.61081385525205], "unit": "score", "name": "Encrypt", "value": 945.2087309999996}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1050.420168067227], "unit": "score", "name": "RayTrace", "value": 704.469528}, {"lowerIsBetter": false, "replicates": [705.4263565891473], "unit": "score", "name": "Earley", "value": 944.766230769231}, {"lowerIsBetter": false, "replicates": [12329.268292682927], "unit": "score", "name": "Boyer", "value": 54.05535707220569}, {"lowerIsBetter": false, "replicates": [41260.0], "unit": "score", "name": "RegExp", "value": 22.079132331555996}, {"lowerIsBetter": false, "replicates": [568.5048322910744], "unit": "score", "name": "Splay", "value": 143.34266900000006}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20503.375528823984}]} 07:12:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20503.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1510.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6890.32"}}} 07:12:50 INFO - Return code: 0 07:12:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:12:50 INFO - # TBPL SUCCESS # 07:12:50 INFO - Running post-action listener: _resource_record_post_action 07:12:50 INFO - Running post-run listener: _resource_record_post_run 07:12:51 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 512860160; Read time: 0; Write time: 329120 07:12:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 197955584; Read time: 0; Write time: 166440 07:12:51 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 314904576; Read time: 0; Write time: 162680 07:12:51 INFO - Running post-run listener: _upload_blobber_files 07:12:51 INFO - Blob upload gear active. 07:12:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:12:51 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:12:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:12:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:12:52 INFO - (blobuploader) - INFO - Open directory for files ... 07:12:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:12:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:12:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:53 INFO - (blobuploader) - INFO - Done attempting. 07:12:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:12:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:12:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:53 INFO - (blobuploader) - INFO - Done attempting. 07:12:53 INFO - (blobuploader) - INFO - Iteration through files over. 07:12:53 INFO - Return code: 0 07:12:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:12:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:12:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2a115430a98f0c5a7715d5dd5f790dd05698f553fcabc3f03506766640e45ef568143a138d5d5bc90d31524205d4caf2b5a0aa7a0bdeb42b430fe7f59eb9e5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd4ce9ef92cec4b3e9741b1d9d09935c42419c89c52c5b6b4192bacc82205df5eb7137e5104acc76e7630fb413f2bf98acdc779c96cc342d2aab6dbadcd1442c"} 07:12:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:12:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:12:53 INFO - Contents: 07:12:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2a115430a98f0c5a7715d5dd5f790dd05698f553fcabc3f03506766640e45ef568143a138d5d5bc90d31524205d4caf2b5a0aa7a0bdeb42b430fe7f59eb9e5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd4ce9ef92cec4b3e9741b1d9d09935c42419c89c52c5b6b4192bacc82205df5eb7137e5104acc76e7630fb413f2bf98acdc779c96cc342d2aab6dbadcd1442c"} 07:12:53 INFO - Running post-run listener: copy_logs_to_upload_dir 07:12:53 INFO - Copying logs to upload dir... 07:12:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:12:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.471150 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-15 07:12:53.828990) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:53.832964) ========= 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=337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2a115430a98f0c5a7715d5dd5f790dd05698f553fcabc3f03506766640e45ef568143a138d5d5bc90d31524205d4caf2b5a0aa7a0bdeb42b430fe7f59eb9e5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd4ce9ef92cec4b3e9741b1d9d09935c42419c89c52c5b6b4192bacc82205df5eb7137e5104acc76e7630fb413f2bf98acdc779c96cc342d2aab6dbadcd1442c"} build_url:https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2a115430a98f0c5a7715d5dd5f790dd05698f553fcabc3f03506766640e45ef568143a138d5d5bc90d31524205d4caf2b5a0aa7a0bdeb42b430fe7f59eb9e5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd4ce9ef92cec4b3e9741b1d9d09935c42419c89c52c5b6b4192bacc82205df5eb7137e5104acc76e7630fb413f2bf98acdc779c96cc342d2aab6dbadcd1442c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:53.861436) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:53.862181) ========= 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=337fe3f4b1febe37b85fccc40000019e-1452868446.816263-1711817444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:53.943375) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 07:12:53.943719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 07:12:53.944020) ========= ========= Total master_lag: 0.25 =========