builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1452432804.78 results: success (0) buildid: 20160110030214 builduid: afe8b182359548a7a562d1d6774cf1fb revision: c33f30666b37dbceffb9fbe5089a668db8893a85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.780186) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.780654) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.781009) ========= 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=1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006341 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.829584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.829908) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.882301) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.882591) ========= 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=1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.938307) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.938600) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.939014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:24.939328) ========= 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=1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-10 05:33:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-01-10 05:33:25 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117457 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.081983) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.082294) ========= 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=1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022590 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.140304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.140648) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c33f30666b37dbceffb9fbe5089a668db8893a85 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c33f30666b37dbceffb9fbe5089a668db8893a85 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-10 05:33:25,656 truncating revision to first 12 chars 2016-01-10 05:33:25,656 Setting DEBUG logging. 2016-01-10 05:33:25,656 attempt 1/10 2016-01-10 05:33:25,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c33f30666b37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-10 05:33:25,997 unpacking tar archive at: mozilla-central-c33f30666b37/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622391 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.780226) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.780555) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.817579) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.817880) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 05:33:25.818296) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-10 05:33:25.818643) ========= /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=1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:33:26 INFO - MultiFileLogger online at 20160110 05:33:26 in /builds/slave/test-pgo 05:33:26 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 05:33:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:33:26 INFO - {'append_to_log': False, 05:33:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:33:26 INFO - 'blob_upload_branch': 'Firefox', 05:33:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:33:26 INFO - 'branch': 'Firefox', 05:33:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:33:26 INFO - 'config_files': ('talos/linux_config.py',), 05:33:26 INFO - 'default_actions': ('clobber', 05:33:26 INFO - 'read-buildbot-config', 05:33:26 INFO - 'download-and-extract', 05:33:26 INFO - 'populate-webroot', 05:33:26 INFO - 'create-virtualenv', 05:33:26 INFO - 'install', 05:33:26 INFO - 'run-tests'), 05:33:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:33:26 INFO - 'download_minidump_stackwalk': True, 05:33:26 INFO - 'download_symbols': 'ondemand', 05:33:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:33:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:33:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:33:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:33:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:33:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:33:26 INFO - 'installer_path': 'installer.exe', 05:33:26 INFO - 'log_level': 'info', 05:33:26 INFO - 'log_name': 'talos', 05:33:26 INFO - 'log_to_console': True, 05:33:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:33:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:33:26 INFO - 'opt_config_files': (), 05:33:26 INFO - 'pip_index': False, 05:33:26 INFO - 'sps_profile': False, 05:33:26 INFO - 'sps_profile_interval': 0, 05:33:26 INFO - 'suite': 'dromaeojs-e10s', 05:33:26 INFO - 'system_bits': '32', 05:33:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:33:26 INFO - 'title': 'talos-linux64-ix-027', 05:33:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:33:26 INFO - 'use_talos_json': True, 05:33:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:33:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:33:26 INFO - 'work_dir': 'build'} 05:33:26 INFO - ##### 05:33:26 INFO - ##### Running clobber step. 05:33:26 INFO - ##### 05:33:26 INFO - Running pre-action listener: _resource_record_pre_action 05:33:26 INFO - Running main action method: clobber 05:33:26 INFO - rmtree: /builds/slave/test-pgo/build 05:33:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:33:27 INFO - Running post-action listener: _resource_record_post_action 05:33:27 INFO - ##### 05:33:27 INFO - ##### Running read-buildbot-config step. 05:33:27 INFO - ##### 05:33:27 INFO - Running pre-action listener: _resource_record_pre_action 05:33:27 INFO - Running main action method: read_buildbot_config 05:33:27 INFO - Using buildbot properties: 05:33:27 INFO - { 05:33:27 INFO - "project": "", 05:33:27 INFO - "product": "firefox", 05:33:27 INFO - "script_repo_revision": "production", 05:33:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:33:27 INFO - "repository": "", 05:33:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:33:27 INFO - "buildid": "20160110030214", 05:33:27 INFO - "stage_platform": "linux64-pgo", 05:33:27 INFO - "basedir": "/builds/slave/test-pgo", 05:33:27 INFO - "nightly_build": "True", 05:33:27 INFO - "buildnumber": 609, 05:33:27 INFO - "slavename": "talos-linux64-ix-027", 05:33:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:33:27 INFO - "platform": "ubuntu64_hw", 05:33:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:33:27 INFO - "branch": "mozilla-central", 05:33:27 INFO - "repo_path": "mozilla-central", 05:33:27 INFO - "revision": "c33f30666b37dbceffb9fbe5089a668db8893a85", 05:33:27 INFO - "pgo_build": "True", 05:33:27 INFO - "builduid": "afe8b182359548a7a562d1d6774cf1fb", 05:33:27 INFO - "slavebuilddir": "test" 05:33:27 INFO - } 05:33:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:33:27 INFO - Running post-action listener: _resource_record_post_action 05:33:27 INFO - ##### 05:33:27 INFO - ##### Running download-and-extract step. 05:33:27 INFO - ##### 05:33:27 INFO - Running pre-action listener: _resource_record_pre_action 05:33:27 INFO - Running main action method: download_and_extract 05:33:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:27 INFO - https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:33:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/test_packages.json 05:33:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/test_packages.json 05:33:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:33:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:33:37 INFO - Downloaded 1302 bytes. 05:33:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:33:37 INFO - Using the following test package requirements: 05:33:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:33:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:33:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:37 INFO - u'jsshell-linux-x86_64.zip'], 05:33:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:33:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:33:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:33:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:33:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:33:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:33:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:33:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:33:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:37 INFO - https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:33:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:33:46 INFO - Downloaded 24028434 bytes. 05:33:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:33:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:33:47 INFO - Return code: 0 05:33:47 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:47 INFO - https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:33:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:33:48 INFO - Downloaded 24028434 bytes. 05:33:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:33:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:33:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:33:49 INFO - Return code: 0 05:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:49 INFO - https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:33:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:33:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:33:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:33:50 INFO - Downloaded 11132285 bytes. 05:33:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:33:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:33:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:33:51 INFO - Return code: 0 05:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:51 INFO - https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:33:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:33:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:33:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:33:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:33:52 INFO - Downloaded 55925742 bytes. 05:33:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:33:52 INFO - mkdir: /builds/slave/test-pgo/properties 05:33:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:33:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:33:52 INFO - Contents: 05:33:52 INFO - build_url:https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:33:52 INFO - Running post-action listener: _resource_record_post_action 05:33:52 INFO - Running post-action listener: set_extra_try_arguments 05:33:52 INFO - ##### 05:33:52 INFO - ##### Running populate-webroot step. 05:33:52 INFO - ##### 05:33:52 INFO - Running pre-action listener: _resource_record_pre_action 05:33:52 INFO - Running main action method: populate_webroot 05:33:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:33:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:33:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:33:52 INFO - '--tppagecycles', 05:33:52 INFO - '7'], 05:33:52 INFO - 'tests': ['tsvgm']}}, 05:33:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:33:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:33:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:33:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:33:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:33:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:33:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:52 INFO - 'talos_options': ['--e10s'], 05:33:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:52 INFO - 'tests': ['damp', 'tps']}, 05:33:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:52 INFO - 'talos_options': ['--e10s'], 05:33:52 INFO - 'tests': ['damp', 'tps']}, 05:33:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:33:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:33:52 INFO - 'other': {'tests': ['a11yr', 05:33:52 INFO - 'ts_paint', 05:33:52 INFO - 'tpaint', 05:33:52 INFO - 'sessionrestore', 05:33:52 INFO - 'sessionrestore_no_auto_restore']}, 05:33:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:33:52 INFO - 'tests': ['a11yr', 05:33:52 INFO - 'ts_paint', 05:33:52 INFO - 'tpaint', 05:33:52 INFO - 'sessionrestore', 05:33:52 INFO - 'sessionrestore_no_auto_restore']}, 05:33:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:33:52 INFO - 'tests': ['a11yr', 05:33:52 INFO - 'ts_paint', 05:33:52 INFO - 'tpaint', 05:33:52 INFO - 'sessionrestore', 05:33:52 INFO - 'sessionrestore_no_auto_restore']}, 05:33:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:33:52 INFO - 'tests': ['a11yr', 05:33:52 INFO - 'ts_paint', 05:33:52 INFO - 'tpaint', 05:33:52 INFO - 'sessionrestore', 05:33:52 INFO - 'sessionrestore_no_auto_restore']}, 05:33:52 INFO - 'other_l64': {'tests': ['a11yr', 05:33:52 INFO - 'ts_paint', 05:33:52 INFO - 'tpaint', 05:33:52 INFO - 'sessionrestore', 05:33:52 INFO - 'sessionrestore_no_auto_restore']}, 05:33:52 INFO - 'other_nol64': {'tests': ['a11yr', 05:33:52 INFO - 'ts_paint', 05:33:52 INFO - 'tpaint', 05:33:52 INFO - 'sessionrestore', 05:33:52 INFO - 'sessionrestore_no_auto_restore']}, 05:33:52 INFO - 'svgr': {'tests': ['tsvgx', 05:33:52 INFO - 'tsvgr_opacity', 05:33:52 INFO - 'tart', 05:33:52 INFO - 'tscrollx', 05:33:52 INFO - 'cart']}, 05:33:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:33:52 INFO - 'tests': ['tsvgx', 05:33:52 INFO - 'tsvgr_opacity', 05:33:52 INFO - 'tart', 05:33:52 INFO - 'tscrollx', 05:33:52 INFO - 'cart']}, 05:33:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:52 INFO - 'tests': ['tp5o']}, 05:33:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:52 INFO - 'talos_options': ['--e10s'], 05:33:52 INFO - 'tests': ['tp5o']}, 05:33:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:52 INFO - 'talos_options': ['--xperf_path', 05:33:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:52 INFO - 'tests': ['tp5n']}, 05:33:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:52 INFO - 'talos_options': ['--e10s', 05:33:52 INFO - '--xperf_path', 05:33:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:52 INFO - 'tests': ['tp5n']}}, 05:33:52 INFO - 'talos.zip': {'path': '', 05:33:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:33:52 INFO - Running post-action listener: _resource_record_post_action 05:33:52 INFO - ##### 05:33:52 INFO - ##### Running create-virtualenv step. 05:33:52 INFO - ##### 05:33:52 INFO - Running pre-action listener: _resource_record_pre_action 05:33:52 INFO - Running main action method: create_virtualenv 05:33:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:33:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:33:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:33:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:33:52 INFO - Using real prefix '/usr' 05:33:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:33:52 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:54 INFO - Installing pip.................done. 05:33:54 INFO - Return code: 0 05:33:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:54 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 0x7f84f7f42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b31840>, '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 0x1a9e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9eb60>, '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': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:33:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:33:54 INFO - Using env: {'DISPLAY': ':0', 05:33:54 INFO - 'HOME': '/home/cltbld', 05:33:54 INFO - 'LANG': 'en_US.UTF-8', 05:33:54 INFO - 'LANGUAGE': 'en_US:en', 05:33:54 INFO - 'LOGNAME': 'cltbld', 05:33:54 INFO - 'MAIL': '/var/mail/cltbld', 05:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:54 INFO - 'MOZ_NO_REMOTE': '1', 05:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:54 INFO - 'NO_EM_RESTART': '1', 05:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:54 INFO - 'SHELL': '/bin/bash', 05:33:54 INFO - 'SHLVL': '1', 05:33:54 INFO - 'TERM': 'linux', 05:33:54 INFO - 'TMOUT': '86400', 05:33:54 INFO - 'USER': 'cltbld', 05:33:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 05:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:54 INFO - '_': '/tools/buildbot/bin/python'} 05:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:33:55 INFO - Cleaning up... 05:33:55 INFO - Return code: 0 05:33:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:33: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')]} 05:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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')]} 05:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f7f42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b31840>, '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 0x1a9e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9eb60>, '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': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:33:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:33:55 INFO - Using env: {'DISPLAY': ':0', 05:33:55 INFO - 'HOME': '/home/cltbld', 05:33:55 INFO - 'LANG': 'en_US.UTF-8', 05:33:55 INFO - 'LANGUAGE': 'en_US:en', 05:33:55 INFO - 'LOGNAME': 'cltbld', 05:33:55 INFO - 'MAIL': '/var/mail/cltbld', 05:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:55 INFO - 'MOZ_NO_REMOTE': '1', 05:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:55 INFO - 'NO_EM_RESTART': '1', 05:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:55 INFO - 'SHELL': '/bin/bash', 05:33:55 INFO - 'SHLVL': '1', 05:33:55 INFO - 'TERM': 'linux', 05:33:55 INFO - 'TMOUT': '86400', 05:33:55 INFO - 'USER': 'cltbld', 05:33:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 05:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:55 INFO - '_': '/tools/buildbot/bin/python'} 05:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:55 INFO - Downloading/unpacking psutil>=0.7.1 05:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:33:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:33:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:57 INFO - Installing collected packages: psutil 05:33:57 INFO - Running setup.py install for psutil 05:33:57 INFO - building 'psutil._psutil_linux' extension 05:33:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:33:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:33:57 INFO - building 'psutil._psutil_posix' extension 05:33:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:33:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:33:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:57 INFO - Successfully installed psutil 05:33:57 INFO - Cleaning up... 05:33:57 INFO - Return code: 0 05:33:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f84f7f42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b31840>, '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 0x1a9e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9eb60>, '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': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:33:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:33:57 INFO - Using env: {'DISPLAY': ':0', 05:33:57 INFO - 'HOME': '/home/cltbld', 05:33:57 INFO - 'LANG': 'en_US.UTF-8', 05:33:57 INFO - 'LANGUAGE': 'en_US:en', 05:33:57 INFO - 'LOGNAME': 'cltbld', 05:33:57 INFO - 'MAIL': '/var/mail/cltbld', 05:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:57 INFO - 'MOZ_NO_REMOTE': '1', 05:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:57 INFO - 'NO_EM_RESTART': '1', 05:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:57 INFO - 'SHELL': '/bin/bash', 05:33:57 INFO - 'SHLVL': '1', 05:33:57 INFO - 'TERM': 'linux', 05:33:57 INFO - 'TMOUT': '86400', 05:33:57 INFO - 'USER': 'cltbld', 05:33:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 05:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:57 INFO - '_': '/tools/buildbot/bin/python'} 05:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:33:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:33:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:33:59 INFO - Installing collected packages: mozsystemmonitor 05:33:59 INFO - Running setup.py install for mozsystemmonitor 05:33:59 INFO - Successfully installed mozsystemmonitor 05:33:59 INFO - Cleaning up... 05:33:59 INFO - Return code: 0 05:33:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:59 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 0x7f84f7f42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b31840>, '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 0x1a9e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9eb60>, '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': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:33:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:33:59 INFO - Using env: {'DISPLAY': ':0', 05:33:59 INFO - 'HOME': '/home/cltbld', 05:33:59 INFO - 'LANG': 'en_US.UTF-8', 05:33:59 INFO - 'LANGUAGE': 'en_US:en', 05:33:59 INFO - 'LOGNAME': 'cltbld', 05:33:59 INFO - 'MAIL': '/var/mail/cltbld', 05:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:59 INFO - 'MOZ_NO_REMOTE': '1', 05:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:59 INFO - 'NO_EM_RESTART': '1', 05:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:59 INFO - 'SHELL': '/bin/bash', 05:33:59 INFO - 'SHLVL': '1', 05:33:59 INFO - 'TERM': 'linux', 05:33:59 INFO - 'TMOUT': '86400', 05:33:59 INFO - 'USER': 'cltbld', 05:33:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 05:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:59 INFO - '_': '/tools/buildbot/bin/python'} 05:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:34:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:34:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:34:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:34: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 05:34: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 05:34: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 05:34: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 05:34: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 05:34: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 05:34:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:34:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:34:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:02 INFO - Downloading docopt-0.6.1.tar.gz 05:34:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:34:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:34:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:34:02 INFO - Running setup.py install for blobuploader 05:34:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:34:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:34:02 INFO - Running setup.py install for requests 05:34:02 INFO - Running setup.py install for docopt 05:34:03 INFO - Successfully installed blobuploader requests docopt 05:34:03 INFO - Cleaning up... 05:34:03 INFO - Return code: 0 05:34:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:34: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')]} 05:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34: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')]} 05:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f7f42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b31840>, '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 0x1a9e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9eb60>, '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': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:34:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:34:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:34:03 INFO - Using env: {'DISPLAY': ':0', 05:34:03 INFO - 'HOME': '/home/cltbld', 05:34:03 INFO - 'LANG': 'en_US.UTF-8', 05:34:03 INFO - 'LANGUAGE': 'en_US:en', 05:34:03 INFO - 'LOGNAME': 'cltbld', 05:34:03 INFO - 'MAIL': '/var/mail/cltbld', 05:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:03 INFO - 'MOZ_NO_REMOTE': '1', 05:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:03 INFO - 'NO_EM_RESTART': '1', 05:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:03 INFO - 'SHELL': '/bin/bash', 05:34:03 INFO - 'SHLVL': '1', 05:34:03 INFO - 'TERM': 'linux', 05:34:03 INFO - 'TMOUT': '86400', 05:34:03 INFO - 'USER': 'cltbld', 05:34:03 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 05:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:03 INFO - '_': '/tools/buildbot/bin/python'} 05:34:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:34:03 INFO - Running setup.py (path:/tmp/pip-BQp_H8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:34:03 INFO - Running setup.py (path:/tmp/pip-TFE64s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:34:03 INFO - Running setup.py (path:/tmp/pip-91IG0X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:34:03 INFO - Running setup.py (path:/tmp/pip-sUEWO1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:34:03 INFO - Running setup.py (path:/tmp/pip-eQRf9a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:34:03 INFO - Running setup.py (path:/tmp/pip-t6Rv28-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:34:03 INFO - Running setup.py (path:/tmp/pip-58g52Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:34:03 INFO - Running setup.py (path:/tmp/pip-VE5c7y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:34:03 INFO - Running setup.py (path:/tmp/pip-ZmddlZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:34:03 INFO - Running setup.py (path:/tmp/pip-meWKhK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:34:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:34:03 INFO - Running setup.py (path:/tmp/pip-WNPPEA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:34:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:34:04 INFO - Running setup.py (path:/tmp/pip-6tNNxu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:34:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:34:04 INFO - Running setup.py (path:/tmp/pip-Ig5deB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:34:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:34:04 INFO - Running setup.py (path:/tmp/pip-i3xsNJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:34:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:34:04 INFO - Running setup.py (path:/tmp/pip-QbSsPk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:34:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:34:04 INFO - Running setup.py (path:/tmp/pip-VrVhC4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:34:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:34:04 INFO - Running setup.py (path:/tmp/pip-Ld9YaD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:34:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:34:04 INFO - Running setup.py install for manifestparser 05:34:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:34:04 INFO - Running setup.py install for mozcrash 05:34:04 INFO - Running setup.py install for mozdebug 05:34:04 INFO - Running setup.py install for mozdevice 05:34:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:34:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:34:04 INFO - Running setup.py install for mozfile 05:34:05 INFO - Running setup.py install for mozhttpd 05:34:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:34:05 INFO - Running setup.py install for mozinfo 05:34:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:34:05 INFO - Running setup.py install for mozInstall 05:34:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:34:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:34:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:34:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:34:05 INFO - Running setup.py install for mozleak 05:34:05 INFO - Running setup.py install for mozlog 05:34:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:34:05 INFO - Running setup.py install for moznetwork 05:34:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:34:05 INFO - Running setup.py install for mozprocess 05:34:05 INFO - Running setup.py install for mozprofile 05:34:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:34:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:34:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:34:05 INFO - Running setup.py install for mozrunner 05:34:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:34:05 INFO - Running setup.py install for mozscreenshot 05:34:06 INFO - Running setup.py install for moztest 05:34:06 INFO - Running setup.py install for mozversion 05:34:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:34:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:34:06 INFO - Cleaning up... 05:34:06 INFO - Return code: 0 05:34:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:34: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')]} 05:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34: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')]} 05:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f7f42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b31840>, '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 0x1a9e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9eb60>, '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': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:34:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:34:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:34:06 INFO - Using env: {'DISPLAY': ':0', 05:34:06 INFO - 'HOME': '/home/cltbld', 05:34:06 INFO - 'LANG': 'en_US.UTF-8', 05:34:06 INFO - 'LANGUAGE': 'en_US:en', 05:34:06 INFO - 'LOGNAME': 'cltbld', 05:34:06 INFO - 'MAIL': '/var/mail/cltbld', 05:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:06 INFO - 'MOZ_NO_REMOTE': '1', 05:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:06 INFO - 'NO_EM_RESTART': '1', 05:34:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:06 INFO - 'SHELL': '/bin/bash', 05:34:06 INFO - 'SHLVL': '1', 05:34:06 INFO - 'TERM': 'linux', 05:34:06 INFO - 'TMOUT': '86400', 05:34:06 INFO - 'USER': 'cltbld', 05:34:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 05:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:06 INFO - '_': '/tools/buildbot/bin/python'} 05:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:34:06 INFO - Running setup.py (path:/tmp/pip-b6JCbM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:34:06 INFO - Running setup.py (path:/tmp/pip-D5yQN1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:34:06 INFO - Running setup.py (path:/tmp/pip-VqdEqW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:34:06 INFO - Running setup.py (path:/tmp/pip-myUOil-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:34:06 INFO - Running setup.py (path:/tmp/pip-OlQtE9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:34:06 INFO - Running setup.py (path:/tmp/pip-PIi0bM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:34:06 INFO - Running setup.py (path:/tmp/pip-AWFtnF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:34:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:34:06 INFO - Running setup.py (path:/tmp/pip-13FCGZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:34:07 INFO - Running setup.py (path:/tmp/pip-zQDlAe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:34:07 INFO - Running setup.py (path:/tmp/pip-o1LEBd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:34:07 INFO - Running setup.py (path:/tmp/pip-ayebUh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:34:07 INFO - Running setup.py (path:/tmp/pip-RtaEQy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:34:07 INFO - Running setup.py (path:/tmp/pip-vFGRsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:34:07 INFO - Running setup.py (path:/tmp/pip-m92qx7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:34:07 INFO - Running setup.py (path:/tmp/pip-qZ0ATu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:34:07 INFO - Running setup.py (path:/tmp/pip-iM3buv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:34:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:34:07 INFO - Running setup.py (path:/tmp/pip-1SnWMa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:34:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:09 INFO - Downloading blessings-1.5.1.tar.gz 05:34:09 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:34:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:34:09 INFO - Installing collected packages: blessings 05:34:09 INFO - Running setup.py install for blessings 05:34:09 INFO - Successfully installed blessings 05:34:09 INFO - Cleaning up... 05:34:09 INFO - Return code: 0 05:34:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:34:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:34:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:34:10 INFO - Reading from file tmpfile_stdout 05:34:10 INFO - Current package versions: 05:34:10 INFO - argparse == 1.2.1 05:34:10 INFO - blessings == 1.5.1 05:34:10 INFO - blobuploader == 1.2.4 05:34:10 INFO - docopt == 0.6.1 05:34:10 INFO - manifestparser == 1.1 05:34:10 INFO - mozInstall == 1.12 05:34:10 INFO - mozcrash == 0.16 05:34:10 INFO - mozdebug == 0.1 05:34:10 INFO - mozdevice == 0.47 05:34:10 INFO - mozfile == 1.2 05:34:10 INFO - mozhttpd == 0.7 05:34:10 INFO - mozinfo == 0.9 05:34:10 INFO - mozleak == 0.1 05:34:10 INFO - mozlog == 3.1 05:34:10 INFO - moznetwork == 0.27 05:34:10 INFO - mozprocess == 0.22 05:34:10 INFO - mozprofile == 0.28 05:34:10 INFO - mozrunner == 6.11 05:34:10 INFO - mozscreenshot == 0.1 05:34:10 INFO - mozsystemmonitor == 0.0 05:34:10 INFO - moztest == 0.7 05:34:10 INFO - mozversion == 1.4 05:34:10 INFO - psutil == 3.1.1 05:34:10 INFO - requests == 1.2.3 05:34:10 INFO - wsgiref == 0.1.2 05:34:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f7f42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b31840>, '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 0x1a9e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9eb60>, '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': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:34:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:34:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:34:10 INFO - Using env: {'DISPLAY': ':0', 05:34:10 INFO - 'HOME': '/home/cltbld', 05:34:10 INFO - 'LANG': 'en_US.UTF-8', 05:34:10 INFO - 'LANGUAGE': 'en_US:en', 05:34:10 INFO - 'LOGNAME': 'cltbld', 05:34:10 INFO - 'MAIL': '/var/mail/cltbld', 05:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:10 INFO - 'MOZ_NO_REMOTE': '1', 05:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:10 INFO - 'NO_EM_RESTART': '1', 05:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:10 INFO - 'SHELL': '/bin/bash', 05:34:10 INFO - 'SHLVL': '1', 05:34:10 INFO - 'TERM': 'linux', 05:34:10 INFO - 'TMOUT': '86400', 05:34:10 INFO - 'USER': 'cltbld', 05:34:10 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 05:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:10 INFO - '_': '/tools/buildbot/bin/python'} 05:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:34:10 INFO - Cleaning up... 05:34:10 INFO - Return code: 0 05:34:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f7f42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b31840>, '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 0x1a9e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9eb60>, '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': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:34:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:34:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:34:10 INFO - Using env: {'DISPLAY': ':0', 05:34:10 INFO - 'HOME': '/home/cltbld', 05:34:10 INFO - 'LANG': 'en_US.UTF-8', 05:34:10 INFO - 'LANGUAGE': 'en_US:en', 05:34:10 INFO - 'LOGNAME': 'cltbld', 05:34:10 INFO - 'MAIL': '/var/mail/cltbld', 05:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:10 INFO - 'MOZ_NO_REMOTE': '1', 05:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:10 INFO - 'NO_EM_RESTART': '1', 05:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:10 INFO - 'SHELL': '/bin/bash', 05:34:10 INFO - 'SHLVL': '1', 05:34:10 INFO - 'TERM': 'linux', 05:34:10 INFO - 'TMOUT': '86400', 05:34:10 INFO - 'USER': 'cltbld', 05:34:10 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 05:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:10 INFO - '_': '/tools/buildbot/bin/python'} 05:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:10 INFO - Downloading/unpacking jsonschema 05:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:34:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:34:12 INFO - Downloading/unpacking functools32 (from jsonschema) 05:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:12 INFO - Downloading functools32-3.2.3-2.tar.gz 05:34:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:34:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:34:12 INFO - warning: no files found matching '*.txt' 05:34:12 INFO - no previously-included directories found matching 'build' 05:34:12 INFO - no previously-included directories found matching 'dist' 05:34:12 INFO - no previously-included directories found matching '.git*' 05:34:12 INFO - Installing collected packages: jsonschema, functools32 05:34:12 INFO - Running setup.py install for functools32 05:34:12 INFO - warning: no files found matching '*.txt' 05:34:12 INFO - no previously-included directories found matching 'build' 05:34:12 INFO - no previously-included directories found matching 'dist' 05:34:12 INFO - no previously-included directories found matching '.git*' 05:34:12 INFO - Successfully installed jsonschema functools32 05:34:12 INFO - Cleaning up... 05:34:12 INFO - Return code: 0 05:34:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f7f42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b31840>, '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 0x1a9e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9eb60>, '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': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:34:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:34:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:34:12 INFO - Using env: {'DISPLAY': ':0', 05:34:12 INFO - 'HOME': '/home/cltbld', 05:34:12 INFO - 'LANG': 'en_US.UTF-8', 05:34:12 INFO - 'LANGUAGE': 'en_US:en', 05:34:12 INFO - 'LOGNAME': 'cltbld', 05:34:12 INFO - 'MAIL': '/var/mail/cltbld', 05:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:12 INFO - 'MOZ_NO_REMOTE': '1', 05:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:12 INFO - 'NO_EM_RESTART': '1', 05:34:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:12 INFO - 'SHELL': '/bin/bash', 05:34:12 INFO - 'SHLVL': '1', 05:34:12 INFO - 'TERM': 'linux', 05:34:12 INFO - 'TMOUT': '86400', 05:34:12 INFO - 'USER': 'cltbld', 05:34:12 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 05:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:12 INFO - '_': '/tools/buildbot/bin/python'} 05:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:12 INFO - Downloading/unpacking flake8 05:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:34:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:34:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:34:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:34:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:34:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:34:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:34:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:34:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:34:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:34:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:34:15 INFO - no previously-included directories found matching 'docs/_build' 05:34:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:34:15 INFO - Running setup.py install for pep8 05:34:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:34:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:34:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:34:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:34:15 INFO - no previously-included directories found matching 'docs/_build' 05:34:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:34:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:34:15 INFO - Cleaning up... 05:34:15 INFO - Return code: 0 05:34:15 INFO - Running post-action listener: _resource_record_post_action 05:34:15 INFO - Running post-action listener: _start_resource_monitoring 05:34:15 INFO - Starting resource monitoring. 05:34:15 INFO - ##### 05:34:15 INFO - ##### Running install step. 05:34:15 INFO - ##### 05:34:15 INFO - Running pre-action listener: _resource_record_pre_action 05:34:15 INFO - Running main action method: install 05:34:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:34:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:34:15 INFO - Reading from file tmpfile_stdout 05:34:15 INFO - Detecting whether we're running mozinstall >=1.0... 05:34:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:34:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:34:15 INFO - Reading from file tmpfile_stdout 05:34:15 INFO - Output received: 05:34:15 INFO - Usage: mozinstall [options] installer 05:34:15 INFO - Options: 05:34:15 INFO - -h, --help show this help message and exit 05:34:15 INFO - -d DEST, --destination=DEST 05:34:15 INFO - Directory to install application into. [default: 05:34:15 INFO - "/builds/slave/test-pgo"] 05:34:15 INFO - --app=APP Application being installed. [default: firefox] 05:34:15 INFO - mkdir: /builds/slave/test-pgo/build/application 05:34:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:34:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:34:31 INFO - Reading from file tmpfile_stdout 05:34:31 INFO - Output received: 05:34:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:34:31 INFO - Running post-action listener: _resource_record_post_action 05:34:31 INFO - ##### 05:34:31 INFO - ##### Running run-tests step. 05:34:31 INFO - ##### 05:34:31 INFO - Running pre-action listener: _resource_record_pre_action 05:34:31 INFO - Running main action method: run_tests 05:34:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:34:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:34:31 INFO - Python 2.7.3 05:34:31 INFO - Return code: 0 05:34:31 INFO - grabbing minidump binary from tooltool 05:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:31 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 0x1b31840>, '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 0x1a9e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:34:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:34:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:34:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:34:32 INFO - Return code: 0 05:34:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:34:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:34:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:34:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:34:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:34:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:34:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:34:32 INFO - Return code: 0 05:34:32 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/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 05:34:32 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/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 05:34:32 INFO - Using env: {'DISPLAY': ':0', 05:34:32 INFO - 'HOME': '/home/cltbld', 05:34:32 INFO - 'LANG': 'en_US.UTF-8', 05:34:32 INFO - 'LANGUAGE': 'en_US:en', 05:34:32 INFO - 'LOGNAME': 'cltbld', 05:34:32 INFO - 'MAIL': '/var/mail/cltbld', 05:34:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:34:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:32 INFO - 'MOZ_NO_REMOTE': '1', 05:34:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:32 INFO - 'NO_EM_RESTART': '1', 05:34:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:34:32 INFO - 'SHELL': '/bin/bash', 05:34:32 INFO - 'SHLVL': '1', 05:34:32 INFO - 'TERM': 'linux', 05:34:32 INFO - 'TMOUT': '86400', 05:34:32 INFO - 'USER': 'cltbld', 05:34:32 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942', 05:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:32 INFO - '_': '/tools/buildbot/bin/python'} 05:34:32 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/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 05:34:33 INFO - mozversion application_buildid: 20160110030214 05:34:33 INFO - mozversion application_changeset: c33f30666b37dbceffb9fbe5089a668db8893a85 05:34:33 INFO - mozversion application_display_name: Nightly 05:34:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:34:33 INFO - mozversion application_name: Firefox 05:34:33 INFO - mozversion application_remotingname: firefox 05:34:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:34:33 INFO - mozversion application_vendor: Mozilla 05:34:33 INFO - mozversion application_version: 46.0a1 05:34:33 INFO - mozversion platform_buildid: 20160110030214 05:34:33 INFO - mozversion platform_changeset: c33f30666b37dbceffb9fbe5089a668db8893a85 05:34:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:34:33 INFO - mozversion platform_version: 46.0a1 05:34:33 INFO - using testdate: 1452432873 05:34:33 INFO - actual date: 1452432873 05:34:33 INFO - starting webserver on 'localhost:47000' 05:34:33 INFO - SUITE-START | Running 3 tests 05:34:33 INFO - TEST-START | dromaeo_css 05:34:33 INFO - operating with platform_type : linux_ 05:34:33 INFO - Initialising browser for dromaeo_css test... 05:34:33 INFO - TEST-INFO | started process 489 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkuEHfy/profile http://localhost:47000/getInfo.html) 05:34:36 INFO - PROCESS | 489 | 05:34:36 INFO - PROCESS | 489 | (process:571): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:34:36 INFO - PROCESS | 489 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 05:34:37 INFO - PROCESS | 489 | __metrics Screen width/height:1600/1200 05:34:37 INFO - PROCESS | 489 | colorDepth:24 05:34:37 INFO - PROCESS | 489 | Browser inner width/height: 1024/670 05:34:37 INFO - PROCESS | 489 | __metrics 05:34:37 INFO - PROCESS | 489 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:34:38 INFO - TEST-INFO | 489: exit 0 05:34:38 INFO - Browser initialized. 05:34:38 INFO - Running cycle 1/1 for dromaeo_css test... 05:34:38 INFO - TEST-INFO | started process 621 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkuEHfy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:39 INFO - PROCESS | 621 | 05:34:39 INFO - PROCESS | 621 | (process:681): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:34:50 INFO - PROCESS | 621 | RSS: Main: 150577152 05:34:50 INFO - PROCESS | 621 | 05:35:39 INFO - PROCESS | 621 | 1452432939865 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:37:48 INFO - PROCESS | 621 | Cycle 1(1): loaded http://localhost:47000/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47000/tests/dromaeo/cssquery-ext.html) 05:37:49 INFO - PROCESS | 621 | RSS: Main: 156905472 05:37:49 INFO - PROCESS | 621 | 05:40:51 INFO - PROCESS | 621 | Cycle 1(1): loaded http://localhost:47000/tests/dromaeo/cssquery-ext.html (next: http://localhost:47000/tests/dromaeo/cssquery-jquery.html) 05:40:52 INFO - PROCESS | 621 | RSS: Main: 153636864 05:40:52 INFO - PROCESS | 621 | 05:43:54 INFO - PROCESS | 621 | Cycle 1(1): loaded http://localhost:47000/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47000/tests/dromaeo/cssquery-mootools.html) 05:43:54 INFO - PROCESS | 621 | RSS: Main: 153366528 05:43:54 INFO - PROCESS | 621 | 05:46:56 INFO - PROCESS | 621 | Cycle 1(1): loaded http://localhost:47000/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47000/tests/dromaeo/cssquery-prototype.html) 05:46:57 INFO - PROCESS | 621 | RSS: Main: 152064000 05:46:57 INFO - PROCESS | 621 | 05:49:59 INFO - PROCESS | 621 | Cycle 1(1): loaded http://localhost:47000/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47000/tests/dromaeo/cssquery-yui.html) 05:50:00 INFO - PROCESS | 621 | RSS: Main: 151863296 05:50:00 INFO - PROCESS | 621 | 05:53:02 INFO - PROCESS | 621 | Cycle 1(1): loaded http://localhost:47000/tests/dromaeo/cssquery-yui.html (next: http://localhost:47000/tests/dromaeo/cssquery-dojo.html) 05:53:02 INFO - PROCESS | 621 | RSS: Main: 155328512 05:53:02 INFO - PROCESS | 621 | 05:53:02 INFO - PROCESS | 621 | __start_tp_report 05:53:02 INFO - PROCESS | 621 | _x_x_mozilla_page_load 05:53:02 INFO - PROCESS | 621 | _x_x_mozilla_page_load_details 05:53:02 INFO - PROCESS | 621 | |i|pagename|runs| 05:53:02 INFO - PROCESS | 621 | |0;dojo.html;3141.890033848815;3195.137312925509;3239.1740106272896;3252.983735081326;3255.2024753935284;5226.163813789794;5382.327209098863;5385.919211211835;5397.136458166694;5405.702686352249;5253.4221235664045;5272.499112584308;5310.8141215057385;5382.354117505895;5406.83779486615;4851.345068415754;4913.582345500618;4965.230389289648;4992.800287988476;5003.2245002024565;4849.078675051729;4966.602671786249;4984.725840078794;4991.650584459071;5010.549050585447;4777.80888764449;4831.951680483186;4884.902301953976;4907.337509436216;4924.384451943507;4907.141250281186;4919.311296418468;4934.481879402647;4937.432195297515;4942.777575009133;4842;4908.631852611033;4923.77842997066;4943;4945.357103576548;5090.643654944155;5117.7185254810975;5204.219367094928;5272.024675435056;5325.8934821303355;5687.4881260686325;5728.25532680753;5744;5749.453801888856;5763.971180144114;5724.141378793172;5759.366469688331;5761.5678824087945;5761.654300741969;5768.480836724673;5235.73821308933;5317.46825317469;5353.4646535346155;5375.838724838261;5420.295361603005;5820.3888591698105;5823.621464604787;5826.76692932278;5840.824775256664;5855.912161317584;5558.527525160326;5607.887842243133;5619.297587801525;5626.409227031185;5630.352509461464;5665.631733937281;5715.457031581993;5766.509846662997;5769.624974376736;5772.365039845614;5617.129344951539;5632.070708333161;5648.4633959773755;5715.228444160069;5735.569832262597;5622.943770562242;5629.352624448159;5629.802956896489;5632.887342253214;5647.124695672177;4316.287812510964;4390.934135987899;4396.912061758747;4404.53752355998;4405.118976204708;3923.6861051115843;3990.8004599769897;4004.979975100164;4026.899327516777;4047.210793895162;5290.312259406252;5294.841154765363;5299.788008479694;5306.044911915892;5323.254744335719;5601.327840659147;5659.6321239119325;5660.264165658438;5661.46216109469;5687.829365119053;5314.415414304423;5352.598555108382;5409.945900541023;5469.288992430958;5516.3380394352935;4882.292067650242;4887.266909963534;4889.926651100165;4896.951030489649;4910.48439913811;5899.380565040609;5909.763609455574;5924.992751232301;5939.643621382731;5941.1385349125;5658.179563963285;5727.799527016535;5811.883762324815;5835.766569337179;5876.529877609866;5984.940150598438;5985.371535988833;5988.580799344004;5993.460588547052;6000;5495.6153069284765;5705.201271822031;5711.029125048669;5715.257016587817;5735.082386818089;5677.51741102011;5747.109198074305;5803.941960580509;5830.271216097988;5846;5621.634593751393;5637.351704554028;5645.125005624135;5654.264945557051;5656.321241451053;5515.336444497486;5622.971885140548;5626.887462250814;5628.183913332462;5644.322681278273;5371.382291036581;5422.918656220081;5447.891042179213;5458.918116228339;5505.834824955257;5512.751926163252;5528.06022976103;5543.750531226024;5552.639078459887;5567.638103523258;5429.972850135724;5448.727563621724;5457.072297709478;5514.503694667499;5552.833414997556 05:53:02 INFO - PROCESS | 621 | |1;ext.html;542.4467043615513;551.9972400137999;564.14250339484;566.6628356128102;575.9078547432412;35042;35857.46213806789;35877.64122358776;35879.641203587955;35976;38603.227935441275;38833.611663883356;39094.60905390945;39199.41200881989;39323.21353572934;8674.219320261176;8860.778480538005;8965.506897120657;8967.730968070968;8974.237189838872;8617.741467755946;8699.52152631605;8780.780480487974;8787.428817126898;8791.428557143798;8797.340199485032;8812.471251724917;8871.645134194625;8882.600282987249;8892.911070889273;8723.21491065804;8740.344474164463;8741.475511469269;8794.076621954666;8810.515421651806;8580.957095214546;8773.385862989593;8790.736277911672;8791.164839340252;8822.779430514225;38599.61400385988;38650;38967.220655587014;38970.80514597437;39119.41320880189;2587.8964841406323;3011.9698803011906;3074.784765066446;3171.682831716833;3282.5404443377947;25889.352766180808;26184.73815261861;26642.600360994602;26781.330466738487;26927.865360673266;3407.897763067112;3456.2578235212245;3482.564679415073;3737.9813100934593;3869.494322913276;217427;220022;220348;220427;221691;52338.73830630822;53334.399968001024;53531.73234133804;54674.72662636741;54943;64075.35924640787;64560;64982.101073935715;65057;65285.673571631836;15012.924935375253;15195.240237988057;15210.16344101085;15210.771838422432;15226.162561059247;11392.829107563393;11437.885621143849;11440.370779607036;11452.656420307405;11471.197016208953;18256.269749210147;18399.908000459913;18542.536436589195;18547.35084272071;19061.332853350064;7680.577568233689;7792.922070779219;7831.412644051719;7893.921060789434;8020.879686804703;915.6108653822099;1012.5544760305442;1048.6329784575337;1069.561479793281;1119.1494464207099;28734.568981465294;29614.407711846074;29881.35652539088;30064.398712026075;30185.849070754506;956.3879117364892;977.8386566216636;1075.0109898893038;1075.4945175767377;1113.4766659669942;13980.231087290093;14147.575572732834;14166;14169;14275.78586321206;245906;247218;248811;249239;315394;50609.493905061216;50744.492555074714;50752.746236268584;50922.74538627357;50939.74530127326;1279.411470723459;1283.5635883799553;1293.792993121096;1297.5199176304639;1298.577962162301;26976.595351069358;27909.302267442665;28460.146195614165;28528.286792830346;29588.408231834812;42619.360709588764;42661.36007959821;42704;42797.57202427936;42859.35710964401;199954;200275;200384;200843;201271;27784.86107569449;31127.221819454695;31242;31387.215319617193;31773.841130794197;37883.62116378801;38327.61672383352;38440.61559384482;38691.80654096712;38805.41791873068;33179.50230746492;35621;38135.237295253384;38501.4224786634;38527.807360963016;35472;36043.81978090093;36248.456273155396;37119.257614848095;37536.2492750138;37442.812785936985;38040.619593803705;38293;38376.80811595924;38547.614523855525;34398;36287.27425451529;38553;38660;38673.80663096667;26184.083557076174;26821.731782682706;26959.86520067387;27064.32339191457;27317.45365092727 05:53:02 INFO - PROCESS | 621 | |2;jquery.html;356.5899215901713;361.3261267735673;362.3351150638578;364.6809042088174;364.84129403709375;16196.514104576867;16669.749953750703;16956.57608559785;17416.303347866102;18203.362882299105;10535.525901334438;10833.0250277475;15395.615109622266;15668.764968525482;15710.371585136609;4789.4492133404665;5029.84910452687;5394.433584473632;5394.9190762138405;5397.2443857859935;4445.22208613493;5317.388500322474;5411.891762164754;5420.430854760252;5429.701366424845;5065.7467126643705;5280.788768449257;5397.811076612319;5404.486573775504;5405.864853378657;5153.484651534835;5164.122099243119;5171.327727395452;5199.428062913076;5463.7814487420455;5255.237990491396;5269.841904742864;5282.867928301785;5294.788208471657;5307.336582927134;12153.513859445611;16514.58713532159;19443.31948381814;19792.505187370287;19970.30103946355;1724.4395571439206;1957.1290775604862;1978.436145698469;2081.6149012432747;2110.725605671268;9129.132732390412;9510.1440870322;9712.660056898045;10776.29954052984;13101.279429631366;1732.1079643983358;1819.7452356670076;1833.8074502177212;1856.860735444847;1858.962820743591;52990.735046324524;54873.176902346895;55617;55667.16499252515;56647;9758.609655613838;9940.602375905028;10067.093961543349;10077.848832267522;10088.949555252177;13046.086773925925;13138.934305328603;13162;13169.73660526784;13213.801792973112;7338.119425668954;7404.777856664201;7414.258574142543;7441.739539116105;7465.178830328659;7160.391366733886;7183.748568800172;7185.748498802517;7210.711571537185;7220.241874603196;4359.847405340798;4387.517373088957;4416;4434.068845542408;4482.462104547475;1795.8563314934775;1811.2664370929795;1834.1654547181001;1864.0772817455174;1872.550587858904;443.16021139939636;456.05141306083266;886.7206829848577;892.4154678685471;949.1647350331664;10308.742281442874;10740.087092597061;10767.300125491818;11022.283551569122;11352.262102963281;436.3040949685247;440.110975828824;444.5709889956208;462.44737538641675;822.1819289806681;9477.767890174233;9630.855537166948;10011.099001089937;10051.748706282402;10184.490775461198;457946;462468;464535;464674;499403.03581785207;66163;69140.6542967282;72596.63701681563;73184.63407682927;73259;1140.1961617059953;1155.393418455301;1169.0705888818409;1170.9355985420714;1175.2008634128704;15124.168170750714;15303.77044344358;15476.303566339317;15483.148426836633;15955.760663589823;26700.93196272205;32936.505952411215;33132.66867331296;34281.82859085689;34575.30849382948;43754.12491750211;44949.325760114276;44989.100217996114;45093.09813803771;46063.76968115138;7272.600006999666;7478.70085196586;7521.247875212435;7553.433492488195;7634.160242373446;10138.493075346056;11281.492332844877;11332.583427071617;11423.143264255048;11752.412379381169;9119.452832830051;9590.376625519319;9677.758056048655;9791.804163916824;9823.508824558887;3221.855016524215;3884.6892248620607;9568.22987747269;10034;10340.844887326546;10206.387616743019;10389.9480502597;10429.9478502607;10674.786504270027;10680.519376628226;7331.266873312626;7578.242175782378;7606.239376062349;7653;7715.1513333534385;8018.919810801817;10007.449590272605;10075.395476271447;10134.087932086148;10317.587296508056 05:53:02 INFO - PROCESS | 621 | |3;mootools.html;1431.7995480632712;1433.3621538415407;1542.6991736611358;1684.1915880377426;1689.8986060836344;7575.848483030336;7636.9618151909235;7689.346405555528;7699.037620297463;7859.489133206338;7723.575203363826;7754.418418618612;7783.066032076144;7793.961030194855;7837.529748215111;2291.0721157931025;2325.94185145371;2326.09282379872;2326.8022218111482;2327.697399338084;2342.320726989171;2344.120954642009;2384.5111752090866;2391.175044609607;2391.6771235883193;2245.191730976847;2306.400335912658;2311.924954895973;2329.9301020969315;2343.718753749544;2341.4497593065616;2345.9530809383887;2366.3847399676124;2366.905323787055;2375.1924345722537;2351.58847201739;2373.0151986925407;2375.2755409600063;2381.868997205153;2388.295452841416;7652.2347765223585;7726.459147859652;7737.0715514138665;7766.689332426696;7768.339691126261;4768.642351823592;4926.1625523660705;4926.507349265081;4934.80260789568;4956.529129732669;3028.439738648357;3072.6620071792086;3128.2961333699964;3140.764442666809;3181.7772755907095;952.5332587032374;966.0966995858824;989.7278248481725;989.9802003959952;1002.8194924913513;10437.373757574569;10511.84232236517;10519.053285204292;10552.366857988545;10552.788944221149;4148.834046638161;4161.895952601149;4226.535081141072;4241.724287921275;4272.060146767706;8619.439736417113;8693.913060869438;8703.869441958375;8719.564021798884;8731.388802783744;4646.070785842845;4675.6727029108315;4676.111538807616;4685.578297953132;4701.036287561042;4223.366495025771;4260.275753121915;4266.08279219963;4275.46556680415;4279.529251782302;3395.7962522248745;3415.351083294166;3440.2947395783804;3442.9311413771584;3462.9826850865584;1071.3518321415431;1104.5305745058479;1106.1151079136819;1114;1137.852079229695;1317.7166909114587;1318.3474180280823;1344.327836081959;1350.1224204267305;1356.85752995936;7151.427885769126;7299.817504562428;7314.817129571803;7359.6688149033425;7384.298491643285;1092.8961748633867;1103.5751235774285;1112.5438570186348;1122.9213955023233;1136.6987748246722;5565.053940830068;5582.888342233133;5641.379448260688;5643.35101463337;5645.830625081254;8976.41653292547;9022.097790220925;9304.581293841658;9328.580213890391;9364.438133712;9390.389624674373;9453.810923781624;9513.429194248367;9541.141297283279;9582.472963986907;7235.89146162808;7405.740799072007;7445.032145821008;7527.774166775005;7533.698652053966;7181.533200341961;7202.243764404662;7209.819754506179;7211.747588834365;7215.567065976058;8312.376571757022;8416.831663366576;8477.237048665404;8548.700795472128;8674.479531227895;8638.093000234885;8682.609282582425;8688.695895643623;8694.04365519805;8729.825403491768;6453.806385808433;6720.8319792005595;6725.428338591275;6758.763443279461;6769.120014398097;7421.851562968603;7435.962820185864;7444.888326674996;7474.364679002346;7491.175970643334;6675.0654908313845;6768.424683901923;6883.827904302432;7089.716411343695;7113.0753002109395;6494.447971922251;6520.217573891164;6568.671566421755;6607.438367738796;6726.663666816542;6725.159355080615;6735.326467353226;6737.66311684404;6756.628385438848;6777.762778302736;6254.9687251563455;6268.6552239625435;6320.747170113328;6480.967595161994;6539.542232043711;6512.641804700597;6537.477001839937;6538.771143009972;6561.868762624626;6567.2447668518735 05:53:02 INFO - PROCESS | 621 | |4;prototype.html;335.7045799696267;339.49245877413273;339.74519110667;342.1173372698437;350.2574541971021;6210.875782484348;6211.285702144249;6247.437730604244;6271.811845644632;6301.527385446087;6130.908036379458;6186.907196392047;6191;6219.720112594933;6249.093881387207;4758.904821903559;4766.451858036318;4768.90462190756;4771.737554434505;4774.713517188962;4774.641901857357;4775.355327030841;4779.139754844126;4785.3300537924715;4788.497207793183;4538.319252112176;4642.721436713791;4654.930176047362;4682.227432473638;4694.3662605548325;4646.697964632322;4679.532046795327;4681.672282940179;4682.578567928886;4684.180268453007;4042.191561687645;4064.451299074646;4065.695072869517;4070.3690927906223;4074.0629655179473;5818.5636077294375;5867.090600956859;5877.177195192677;5889.969255380334;5895.55783316253;5324.8136315228785;5429.511343979021;5430.972845135789;5464.26232458617;5472.315960504937;6524;6544.574602650812;6555.475561955032;6574.178227721535;6584.242812076624;4508.2561377372695;4512.751798651073;4524;4525.140223357585;4534.047849951514;6776.356246156607;6822.931770682279;6831.146106736658;6883.414909732679;6902.965485172592;4551.408316918845;4568.063546972929;4570.542945705402;4578.908421831611;4591.449026116888;4612.630989520831;4614.676972611885;4631.58315751584;4631.861044168681;4634.721916684943;5357.303550538483;5367.838964831061;5372;5388.272583201296;5398.78404863801;6483.935160648428;6609.107770450928;6615.305392933769;6615.503837212132;6620.933790662128;1637.6233466302817;1651.3559711712442;1651.983480165183;1655.1227849239922;1659.6348803263263;1098.3464838421128;1106.6403418888892;1107.595727559451;1119.485036883043;1129.7796929598649;6213.068039794067;6235;6248.218972628421;6251.812445626639;6267.2792628847355;6784.864302713918;6793.422559082534;6800.727970881109;6802.877525208384;6816.250212476623;6141.508679305645;6198.690065496708;6230.906536401958;6245.656488893154;6321.8735625288155;3681.1901381695984;3685.594584595692;3692.5015122958594;3697.9815100924325;3720.7023438124884;7117.608531530712;7195.748148814766;7218.963905180441;7231.059962204985;7259.782206533812;6940.305969403019;7009.859802803915;7012.144859042654;7048.436125110082;7057.258987806206;7177.174624918097;7193.5324203926575;7196.856062878713;7223.747168849065;7243.058402407653;6822.931770682429;6846.828829279308;6858.897116543156;6860.656967151523;6863.897041544481;6711.63086030273;6753.020811982334;6789.456843452611;6808.489363297674;6823.147106611674;7221.855562888818;7236.276372362721;7239.963800180965;7246.130464344313;7250.746223882139;4645.094206629675;4674.415698037746;4678.508756580646;4681.274402467623;4685.6251499879245;6704.4301234395625;6771.898421523582;6859.862802744017;6863.828404289733;6872.41584465326;6628.403443690091;6649.534532582673;6665.300143484864;6669.699863506251;6685;6619.3049729779605;6625.602463852184;6681.064650948774;6683.465322774264;6686.297938716365;6382.808515744535;6530.836729081621;6543.345665433609;6583.506237032338;6589.27517973013;6687.76592819249;6712.295209002984;6732.192136943598;6733.158355205599;6734.292899245705;6423.389777971085;6545.8690826184165;6548.050532672831;6566.24488183865;6567.343265673395 05:53:02 INFO - PROCESS | 621 | |5;yui.html;726.8037629839944;801.5030680977791;859.5315553023605;862.5988915154452;863.8099618084021;11905.821412678806;12024.819627705592;12026.69933251667;12027.398630068494;12056.758864822697;12342.876571234285;12364.690882727937;12405.689857753561;12464.875351246485;12476.750464990695;782.7808213700173;784.1648644193915;812.8780682897553;816.0207750699155;820.7004443378183;812.1391325195311;814.3037702764141;816.5753808019826;818.0837462042521;820.1757233979841;843.7890527368158;846.5640195299395;848.7156802471179;850.2390360627235;853.6116067189414;838.1869586501084;838.9916100839035;842.0442797424905;844.4468872888268;846.4794151596785;614.4469977020673;615.5229696984873;620.1008537620469;621.7792683597348;622.9127922090911;12948.546800861925;13446.932765336209;13461.865381346159;13517.121387109806;13538.120022198624;11390.658280251606;12100.334481603508;12364.75270494594;12699.238045717286;13082.018848586395;9081.818363632756;9211.263098952068;9236.21492173166;9269.304802139866;9509.286803489766;3391.4743214801747;3437.364087643794;3446.551948246737;3453.2748122894222;3458.5503884495106;47194.29208561874;47516.762416188045;48165.51834481645;48200.75899620514;48331.27503087457;8427.536485493356;8547.829043419097;8938.68714594986;9112.95443522778;9626.855597166048;17138.143092845556;17340.653186936444;17342.479725608253;17372.3051077958;17390.21744021522;7151.642417879085;7411.814704632319;7495.700171993169;7689.50018248812;7985.5208687478935;4017.196560687874;4021.638052575224;4100.487439070116;4115.485564304462;4181.665466762652;3045.6192975878016;3075.5694202811624;3081.306705991134;3082.1832214463184;3096.5200393938976;561.1330494386183;586.003793550965;588.1648059755158;598.5480961873758;603.3694788945562;633.5565104426828;672.3847679373416;672.6670298202421;679.3342524326188;707.1973310292855;8116.188381161836;8137.715179968673;8373.204545568162;8391;8444.02324115922;518.2174915877052;549;554.523110125292;606.6542071019477;609.2962628164477;3677.5219221501034;3953.525576930787;4067.613576710208;4182.895427614273;4201.117765269328;55631.443685563434;56778.716106419204;57070.143947840814;57110.42889571134;57325.71337143371;50142;50747.746261268454;51023.48976510262;51203.487965120614;53227.467725322254;45754.08491830145;46217.30674039892;46446.5355346449;46873.29690054652;47081;8439.493630382196;8504.149585041447;8510.191531804468;8584.527850968258;9005.504697241715;31563.053108406784;31936;32110.357792843544;32113.67886321107;32158.19604509906;38371.23257534778;39210.411843822934;39744.2051158981;39817.80091099526;39850.60149398585;10553;10593.735156621146;10635.14918806478;10678.199135064746;10932.234743567873;11477.713057173638;11538.59614913474;11660;12362.258264504158;12366.319852408204;10834.486397164881;10987.945060274647;11003.724906877393;11299.887001130212;11421.31472111676;10598.364098154136;10763.784724305626;10832.566697332333;10933.507992140214;10959.506822192861;10586.629467968583;10615;10746.46267686597;11088.445577721242;11170.497327620114;9005.369624126248;9060.728178154666;9218.124278193562;9322.580483878106;9797.608095676092;7902.091259505;8576.65693372283;8656.567171641518;9027.45835249887;9295.581698823435 05:53:02 INFO - PROCESS | 621 | __end_tp_report 05:53:02 INFO - PROCESS | 621 | __start_cc_report 05:53:02 INFO - PROCESS | 621 | _x_x_mozilla_cycle_collect,311 05:53:02 INFO - PROCESS | 621 | __end_cc_report 05:53:02 INFO - PROCESS | 621 | __startTimestamp1452433982668__endTimestamp 05:53:02 INFO - PROCESS | 621 | 05:53:02 INFO - PROCESS | 621 | ------- Summary: start ------- 05:53:02 INFO - PROCESS | 621 | Number of tests: 6 05:53:02 INFO - PROCESS | 621 | 05:53:02 INFO - PROCESS | 621 | [#0] dojo.html Cycles:165 Average:5319.22 Median:5505.83 stddev:578.50 (10.5%) stddev-sans-first:554.48 05:53:02 INFO - PROCESS | 621 | Values: 3141.9 3195.1 3239.2 3253.0 3255.2 5226.2 5382.3 5385.9 5397.1 5405.7 5253.4 5272.5 5310.8 5382.4 5406.8 4851.3 4913.6 4965.2 4992.8 5003.2 4849.1 4966.6 4984.7 4991.7 5010.5 4777.8 4832.0 4884.9 4907.3 4924.4 4907.1 4919.3 4934.5 4937.4 4942.8 4842.0 4908.6 4923.8 4943.0 4945.4 5090.6 5117.7 5204.2 5272.0 5325.9 5687.5 5728.3 5744.0 5749.5 5764.0 5724.1 5759.4 5761.6 5761.7 5768.5 5235.7 5317.5 5353.5 5375.8 5420.3 5820.4 5823.6 5826.8 5840.8 5855.9 5558.5 5607.9 5619.3 5626.4 5630.4 5665.6 5715.5 5766.5 5769.6 5772.4 5617.1 5632.1 5648.5 5715.2 5735.6 5622.9 5629.4 5629.8 5632.9 5647.1 4316.3 4390.9 4396.9 4404.5 4405.1 3923.7 3990.8 4005.0 4026.9 4047.2 5290.3 5294.8 5299.8 5306.0 5323.3 5601.3 5659.6 5660.3 5661.5 5687.8 5314.4 5352.6 5409.9 5469.3 5516.3 4882.3 4887.3 4889.9 4897.0 4910.5 5899.4 5909.8 5925.0 5939.6 5941.1 5658.2 5727.8 5811.9 5835.8 5876.5 5984.9 5985.4 5988.6 5993.5 6000.0 5495.6 5705.2 5711.0 5715.3 5735.1 5677.5 5747.1 5803.9 5830.3 5846.0 5621.6 5637.4 5645.1 5654.3 5656.3 5515.3 5623.0 5626.9 5628.2 5644.3 5371.4 5422.9 5447.9 5458.9 5505.8 5512.8 5528.1 5543.8 5552.6 5567.6 5430.0 5448.7 5457.1 5514.5 5552.8 05:53:02 INFO - PROCESS | 621 | 05:53:02 INFO - PROCESS | 621 | [#1] ext.html Cycles:180 Average:40510.54 Median:36267.87 stddev:59514.29 (164.1%) stddev-sans-first:59605.58 05:53:02 INFO - PROCESS | 621 | Values: 542.4 552.0 564.1 566.7 575.9 35042.0 35857.5 35877.6 35879.6 35976.0 38603.2 38833.6 39094.6 39199.4 39323.2 8674.2 8860.8 8965.5 8967.7 8974.2 8617.7 8699.5 8780.8 8787.4 8791.4 8797.3 8812.5 8871.6 8882.6 8892.9 8723.2 8740.3 8741.5 8794.1 8810.5 8581.0 8773.4 8790.7 8791.2 8822.8 38599.6 38650.0 38967.2 38970.8 39119.4 2587.9 3012.0 3074.8 3171.7 3282.5 25889.4 26184.7 26642.6 26781.3 26927.9 3407.9 3456.3 3482.6 3738.0 3869.5 217427.0 220022.0 220348.0 220427.0 221691.0 52338.7 53334.4 53531.7 54674.7 54943.0 64075.4 64560.0 64982.1 65057.0 65285.7 15012.9 15195.2 15210.2 15210.8 15226.2 11392.8 11437.9 11440.4 11452.7 11471.2 18256.3 18399.9 18542.5 18547.4 19061.3 7680.6 7792.9 7831.4 7893.9 8020.9 915.6 1012.6 1048.6 1069.6 1119.1 28734.6 29614.4 29881.4 30064.4 30185.8 956.4 977.8 1075.0 1075.5 1113.5 13980.2 14147.6 14166.0 14169.0 14275.8 245906.0 247218.0 248811.0 249239.0 315394.0 50609.5 50744.5 50752.7 50922.7 50939.7 1279.4 1283.6 1293.8 1297.5 1298.6 26976.6 27909.3 28460.1 28528.3 29588.4 42619.4 42661.4 42704.0 42797.6 42859.4 199954.0 200275.0 200384.0 200843.0 201271.0 27784.9 31127.2 31242.0 31387.2 31773.8 37883.6 38327.6 38440.6 38691.8 38805.4 33179.5 35621.0 38135.2 38501.4 38527.8 35472.0 36043.8 36248.5 37119.3 37536.2 37442.8 38040.6 38293.0 38376.8 38547.6 34398.0 36287.3 38553.0 38660.0 38673.8 26184.1 26821.7 26959.9 27064.3 27317.5 05:53:02 INFO - PROCESS | 621 | 05:53:02 INFO - PROCESS | 621 | [#2] jquery.html Cycles:180 Average:25229.90 Median:2428.06 stddev:76897.67 (3167.0%) stddev-sans-first:77090.71 05:53:02 INFO - PROCESS | 621 | Values: 356.6 361.3 362.3 364.7 364.8 16196.5 16669.7 16956.6 17416.3 18203.4 10535.5 10833.0 15395.6 15668.8 15710.4 4789.4 5029.8 5394.4 5394.9 5397.2 4445.2 5317.4 5411.9 5420.4 5429.7 5065.7 5280.8 5397.8 5404.5 5405.9 5153.5 5164.1 5171.3 5199.4 5463.8 5255.2 5269.8 5282.9 5294.8 5307.3 12153.5 16514.6 19443.3 19792.5 19970.3 1724.4 1957.1 1978.4 2081.6 2110.7 9129.1 9510.1 9712.7 10776.3 13101.3 1732.1 1819.7 1833.8 1856.9 1859.0 52990.7 54873.2 55617.0 55667.2 56647.0 9758.6 9940.6 10067.1 10077.8 10088.9 13046.1 13138.9 13162.0 13169.7 13213.8 7338.1 7404.8 7414.3 7441.7 7465.2 7160.4 7183.7 7185.7 7210.7 7220.2 4359.8 4387.5 4416.0 4434.1 4482.5 1795.9 1811.3 1834.2 1864.1 1872.6 443.2 456.1 886.7 892.4 949.2 10308.7 10740.1 10767.3 11022.3 11352.3 436.3 440.1 444.6 462.4 822.2 9477.8 9630.9 10011.1 10051.7 10184.5 457946.0 462468.0 464535.0 464674.0 499403.0 66163.0 69140.7 72596.6 73184.6 73259.0 1140.2 1155.4 1169.1 1170.9 1175.2 15124.2 15303.8 15476.3 15483.1 15955.8 26700.9 32936.5 33132.7 34281.8 34575.3 43754.1 44949.3 44989.1 45093.1 46063.8 7272.6 7478.7 7521.2 7553.4 7634.2 10138.5 11281.5 11332.6 11423.1 11752.4 9119.5 9590.4 9677.8 9791.8 9823.5 3221.9 3884.7 9568.2 10034.0 10340.8 10206.4 10389.9 10429.9 10674.8 10680.5 7331.3 7578.2 7606.2 7653.0 7715.2 8018.9 10007.4 10075.4 10134.1 10317.6 05:53:02 INFO - PROCESS | 621 | 05:53:02 INFO - PROCESS | 621 | [#3] mootools.html Cycles:180 Average:5431.62 Median:6487.71 stddev:2779.22 (42.8%) stddev-sans-first:2770.75 05:53:02 INFO - PROCESS | 621 | Values: 1431.8 1433.4 1542.7 1684.2 1689.9 7575.8 7637.0 7689.3 7699.0 7859.5 7723.6 7754.4 7783.1 7794.0 7837.5 2291.1 2325.9 2326.1 2326.8 2327.7 2342.3 2344.1 2384.5 2391.2 2391.7 2245.2 2306.4 2311.9 2329.9 2343.7 2341.4 2346.0 2366.4 2366.9 2375.2 2351.6 2373.0 2375.3 2381.9 2388.3 7652.2 7726.5 7737.1 7766.7 7768.3 4768.6 4926.2 4926.5 4934.8 4956.5 3028.4 3072.7 3128.3 3140.8 3181.8 952.5 966.1 989.7 990.0 1002.8 10437.4 10511.8 10519.1 10552.4 10552.8 4148.8 4161.9 4226.5 4241.7 4272.1 8619.4 8693.9 8703.9 8719.6 8731.4 4646.1 4675.7 4676.1 4685.6 4701.0 4223.4 4260.3 4266.1 4275.5 4279.5 3395.8 3415.4 3440.3 3442.9 3463.0 1071.4 1104.5 1106.1 1114.0 1137.9 1317.7 1318.3 1344.3 1350.1 1356.9 7151.4 7299.8 7314.8 7359.7 7384.3 1092.9 1103.6 1112.5 1122.9 1136.7 5565.1 5582.9 5641.4 5643.4 5645.8 8976.4 9022.1 9304.6 9328.6 9364.4 9390.4 9453.8 9513.4 9541.1 9582.5 7235.9 7405.7 7445.0 7527.8 7533.7 7181.5 7202.2 7209.8 7211.7 7215.6 8312.4 8416.8 8477.2 8548.7 8674.5 8638.1 8682.6 8688.7 8694.0 8729.8 6453.8 6720.8 6725.4 6758.8 6769.1 7421.9 7436.0 7444.9 7474.4 7491.2 6675.1 6768.4 6883.8 7089.7 7113.1 6494.4 6520.2 6568.7 6607.4 6726.7 6725.2 6735.3 6737.7 6756.6 6777.8 6255.0 6268.7 6320.7 6481.0 6539.5 6512.6 6537.5 6538.8 6561.9 6567.2 05:53:02 INFO - PROCESS | 621 | 05:53:02 INFO - PROCESS | 621 | [#4] prototype.html Cycles:180 Average:5519.35 Median:6240.33 stddev:1691.65 (27.1%) stddev-sans-first:1651.05 05:53:02 INFO - PROCESS | 621 | Values: 335.7 339.5 339.7 342.1 350.3 6210.9 6211.3 6247.4 6271.8 6301.5 6130.9 6186.9 6191.0 6219.7 6249.1 4758.9 4766.5 4768.9 4771.7 4774.7 4774.6 4775.4 4779.1 4785.3 4788.5 4538.3 4642.7 4654.9 4682.2 4694.4 4646.7 4679.5 4681.7 4682.6 4684.2 4042.2 4064.5 4065.7 4070.4 4074.1 5818.6 5867.1 5877.2 5890.0 5895.6 5324.8 5429.5 5431.0 5464.3 5472.3 6524.0 6544.6 6555.5 6574.2 6584.2 4508.3 4512.8 4524.0 4525.1 4534.0 6776.4 6822.9 6831.1 6883.4 6903.0 4551.4 4568.1 4570.5 4578.9 4591.4 4612.6 4614.7 4631.6 4631.9 4634.7 5357.3 5367.8 5372.0 5388.3 5398.8 6483.9 6609.1 6615.3 6615.5 6620.9 1637.6 1651.4 1652.0 1655.1 1659.6 1098.3 1106.6 1107.6 1119.5 1129.8 6213.1 6235.0 6248.2 6251.8 6267.3 6784.9 6793.4 6800.7 6802.9 6816.3 6141.5 6198.7 6230.9 6245.7 6321.9 3681.2 3685.6 3692.5 3698.0 3720.7 7117.6 7195.7 7219.0 7231.1 7259.8 6940.3 7009.9 7012.1 7048.4 7057.3 7177.2 7193.5 7196.9 7223.7 7243.1 6822.9 6846.8 6858.9 6860.7 6863.9 6711.6 6753.0 6789.5 6808.5 6823.1 7221.9 7236.3 7240.0 7246.1 7250.7 4645.1 4674.4 4678.5 4681.3 4685.6 6704.4 6771.9 6859.9 6863.8 6872.4 6628.4 6649.5 6665.3 6669.7 6685.0 6619.3 6625.6 6681.1 6683.5 6686.3 6382.8 6530.8 6543.3 6583.5 6589.3 6687.8 6712.3 6732.2 6733.2 6734.3 6423.4 6545.9 6548.1 6566.2 6567.3 05:53:02 INFO - PROCESS | 621 | 05:53:02 INFO - PROCESS | 621 | [#5] yui.html Cycles:180 Average:13287.99 Median:50444.87 stddev:15549.16 (30.8%) stddev-sans-first:15564.17 05:53:02 INFO - PROCESS | 621 | Values: 726.8 801.5 859.5 862.6 863.8 11905.8 12024.8 12026.7 12027.4 12056.8 12342.9 12364.7 12405.7 12464.9 12476.8 782.8 784.2 812.9 816.0 820.7 812.1 814.3 816.6 818.1 820.2 843.8 846.6 848.7 850.2 853.6 838.2 839.0 842.0 844.4 846.5 614.4 615.5 620.1 621.8 622.9 12948.5 13446.9 13461.9 13517.1 13538.1 11390.7 12100.3 12364.8 12699.2 13082.0 9081.8 9211.3 9236.2 9269.3 9509.3 3391.5 3437.4 3446.6 3453.3 3458.6 47194.3 47516.8 48165.5 48200.8 48331.3 8427.5 8547.8 8938.7 9113.0 9626.9 17138.1 17340.7 17342.5 17372.3 17390.2 7151.6 7411.8 7495.7 7689.5 7985.5 4017.2 4021.6 4100.5 4115.5 4181.7 3045.6 3075.6 3081.3 3082.2 3096.5 561.1 586.0 588.2 598.5 603.4 633.6 672.4 672.7 679.3 707.2 8116.2 8137.7 8373.2 8391.0 8444.0 518.2 549.0 554.5 606.7 609.3 3677.5 3953.5 4067.6 4182.9 4201.1 55631.4 56778.7 57070.1 57110.4 57325.7 50142.0 50747.7 51023.5 51203.5 53227.5 45754.1 46217.3 46446.5 46873.3 47081.0 8439.5 8504.1 8510.2 8584.5 9005.5 31563.1 31936.0 32110.4 32113.7 32158.2 38371.2 39210.4 39744.2 39817.8 39850.6 10553.0 10593.7 10635.1 10678.2 10932.2 11477.7 11538.6 11660.0 12362.3 12366.3 10834.5 10987.9 11003.7 11299.9 11421.3 10598.4 10763.8 10832.6 10933.5 10959.5 10586.6 10615.0 10746.5 11088.4 11170.5 9005.4 9060.7 9218.1 9322.6 9797.6 7902.1 8576.7 8656.6 9027.5 9295.6 05:53:02 INFO - PROCESS | 621 | -------- Summary: end -------- 05:53:02 INFO - PROCESS | 621 | 05:53:03 INFO - TEST-INFO | 621: exit 0 05:53:03 INFO - TEST-OK | dromaeo_css | took 1110071ms 05:53:03 INFO - TEST-START | kraken 05:53:03 INFO - operating with platform_type : linux_ 05:53:03 INFO - Initialising browser for kraken test... 05:53:03 INFO - TEST-INFO | started process 873 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5wedNE/profile http://localhost:47000/getInfo.html) 05:53:06 INFO - PROCESS | 873 | 05:53:06 INFO - PROCESS | 873 | (process:946): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:53:06 INFO - PROCESS | 873 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 05:53:07 INFO - PROCESS | 873 | __metrics Screen width/height:1600/1200 05:53:07 INFO - PROCESS | 873 | colorDepth:24 05:53:07 INFO - PROCESS | 873 | Browser inner width/height: 1024/670 05:53:07 INFO - PROCESS | 873 | __metrics 05:53:07 INFO - PROCESS | 873 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:53:08 INFO - TEST-INFO | 873: exit 0 05:53:08 INFO - Browser initialized. 05:53:08 INFO - Running cycle 1/1 for kraken test... 05:53:08 INFO - TEST-INFO | started process 996 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5wedNE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:09 INFO - PROCESS | 996 | 05:53:09 INFO - PROCESS | 996 | (process:1059): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:53:20 INFO - PROCESS | 996 | RSS: Main: 150454272 05:53:20 INFO - PROCESS | 996 | 05:53:22 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47000/tests/kraken/driver.html?testName=audio-beat-detection) 05:53:23 INFO - PROCESS | 996 | RSS: Main: 151011328 05:53:23 INFO - PROCESS | 996 | 05:53:25 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47000/tests/kraken/driver.html?testName=audio-dft) 05:53:26 INFO - PROCESS | 996 | RSS: Main: 151982080 05:53:26 INFO - PROCESS | 996 | 05:53:29 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47000/tests/kraken/driver.html?testName=audio-fft) 05:53:29 INFO - PROCESS | 996 | RSS: Main: 145596416 05:53:29 INFO - PROCESS | 996 | 05:53:32 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47000/tests/kraken/driver.html?testName=audio-oscillator) 05:53:32 INFO - PROCESS | 996 | RSS: Main: 146948096 05:53:32 INFO - PROCESS | 996 | 05:53:35 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47000/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:53:35 INFO - PROCESS | 996 | RSS: Main: 146800640 05:53:35 INFO - PROCESS | 996 | 05:53:38 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47000/tests/kraken/driver.html?testName=imaging-darkroom) 05:53:39 INFO - PROCESS | 996 | RSS: Main: 149213184 05:53:39 INFO - PROCESS | 996 | 05:53:42 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47000/tests/kraken/driver.html?testName=imaging-desaturate) 05:53:43 INFO - PROCESS | 996 | RSS: Main: 149581824 05:53:43 INFO - PROCESS | 996 | 05:53:45 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47000/tests/kraken/driver.html?testName=json-parse-financial) 05:53:46 INFO - PROCESS | 996 | RSS: Main: 147357696 05:53:46 INFO - PROCESS | 996 | 05:53:48 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47000/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:48 INFO - PROCESS | 996 | RSS: Main: 148647936 05:53:48 INFO - PROCESS | 996 | 05:53:50 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:51 INFO - PROCESS | 996 | RSS: Main: 148967424 05:53:51 INFO - PROCESS | 996 | 05:53:53 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:53 INFO - PROCESS | 996 | RSS: Main: 149102592 05:53:53 INFO - PROCESS | 996 | 05:53:56 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:56 INFO - PROCESS | 996 | RSS: Main: 147554304 05:53:56 INFO - PROCESS | 996 | 05:53:59 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:54:00 INFO - PROCESS | 996 | RSS: Main: 148860928 05:54:00 INFO - PROCESS | 996 | 05:54:01 INFO - PROCESS | 996 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47000/tests/kraken/driver.html?testName=ai-astar) 05:54:02 INFO - PROCESS | 996 | RSS: Main: 149463040 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | __start_tp_report 05:54:02 INFO - PROCESS | 996 | _x_x_mozilla_page_load 05:54:02 INFO - PROCESS | 996 | _x_x_mozilla_page_load_details 05:54:02 INFO - PROCESS | 996 | |i|pagename|runs| 05:54:02 INFO - PROCESS | 996 | |0;ai-astar;113;106;112;109;110;123;110;111;111;112 05:54:02 INFO - PROCESS | 996 | |1;audio-beat-detection;150;129;160;165;126;153;159;135;163;130 05:54:02 INFO - PROCESS | 996 | |2;audio-dft;163;162;163;161;163;162;162;174;166;163 05:54:02 INFO - PROCESS | 996 | |3;audio-fft;75;75;73;72;76;74;139;72;71;71 05:54:02 INFO - PROCESS | 996 | |4;audio-oscillator;97;96;142;96;96;97;140;96;98;149 05:54:02 INFO - PROCESS | 996 | |5;imaging-gaussian-blur;110;111;109;110;109;110;110;110;110;110 05:54:02 INFO - PROCESS | 996 | |6;imaging-darkroom;147;146;147;147;146;146;147;146;148;147 05:54:02 INFO - PROCESS | 996 | |7;imaging-desaturate;96;96;97;97;96;96;96;97;96;96 05:54:02 INFO - PROCESS | 996 | |8;json-parse-financial;57;58;57;58;60;61;56;61;56;54 05:54:02 INFO - PROCESS | 996 | |9;json-stringify-tinderbox;69;69;68;69;69;69;68;71;69;68 05:54:02 INFO - PROCESS | 996 | |10;stanford-crypto-aes;86;86;88;87;87;93;85;87;88;87 05:54:02 INFO - PROCESS | 996 | |11;stanford-crypto-ccm;128;125;125;125;120;120;124;116;115;121 05:54:02 INFO - PROCESS | 996 | |12;stanford-crypto-pbkdf2;151;156;154;142;153;138;157;153;150;139 05:54:02 INFO - PROCESS | 996 | |13;stanford-crypto-sha256-iterative;69;74;70;69;70;68;69;70;68;70 05:54:02 INFO - PROCESS | 996 | __end_tp_report 05:54:02 INFO - PROCESS | 996 | __start_cc_report 05:54:02 INFO - PROCESS | 996 | _x_x_mozilla_cycle_collect,747 05:54:02 INFO - PROCESS | 996 | __end_cc_report 05:54:02 INFO - PROCESS | 996 | __startTimestamp1452434042004__endTimestamp 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | ------- Summary: start ------- 05:54:02 INFO - PROCESS | 996 | Number of tests: 14 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:4.42 (4.0%) stddev-sans-first:4.67 05:54:02 INFO - PROCESS | 996 | Values: 113.0 106.0 112.0 109.0 110.0 123.0 110.0 111.0 111.0 112.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:156.00 stddev:15.41 (9.9%) stddev-sans-first:16.30 05:54:02 INFO - PROCESS | 996 | Values: 150.0 129.0 160.0 165.0 126.0 153.0 159.0 135.0 163.0 130.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:3.78 (2.3%) stddev-sans-first:4.00 05:54:02 INFO - PROCESS | 996 | Values: 163.0 162.0 163.0 161.0 163.0 162.0 162.0 174.0 166.0 163.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#3] audio-fft Cycles:10 Average:79.80 Median:73.50 stddev:20.87 (28.4%) stddev-sans-first:22.07 05:54:02 INFO - PROCESS | 996 | Values: 75.0 75.0 73.0 72.0 76.0 74.0 139.0 72.0 71.0 71.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:96.00 stddev:22.87 (23.8%) stddev-sans-first:23.71 05:54:02 INFO - PROCESS | 996 | Values: 97.0 96.0 142.0 96.0 96.0 97.0 140.0 96.0 98.0 149.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:54:02 INFO - PROCESS | 996 | Values: 110.0 111.0 109.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:54:02 INFO - PROCESS | 996 | Values: 147.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 148.0 147.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:54:02 INFO - PROCESS | 996 | Values: 96.0 96.0 97.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:2.30 (4.0%) stddev-sans-first:2.42 05:54:02 INFO - PROCESS | 996 | Values: 57.0 58.0 57.0 58.0 60.0 61.0 56.0 61.0 56.0 54.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 05:54:02 INFO - PROCESS | 996 | Values: 69.0 69.0 68.0 69.0 69.0 69.0 68.0 71.0 69.0 68.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:2.17 (2.5%) stddev-sans-first:2.24 05:54:02 INFO - PROCESS | 996 | Values: 86.0 86.0 88.0 87.0 87.0 93.0 85.0 87.0 88.0 87.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:124.50 stddev:4.23 (3.4%) stddev-sans-first:3.87 05:54:02 INFO - PROCESS | 996 | Values: 128.0 125.0 125.0 125.0 120.0 120.0 124.0 116.0 115.0 121.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:153.00 stddev:7.02 (4.6%) stddev-sans-first:7.42 05:54:02 INFO - PROCESS | 996 | Values: 151.0 156.0 154.0 142.0 153.0 138.0 157.0 153.0 150.0 139.0 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - PROCESS | 996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.70 (2.4%) stddev-sans-first:1.79 05:54:02 INFO - PROCESS | 996 | Values: 69.0 74.0 70.0 69.0 70.0 68.0 69.0 70.0 68.0 70.0 05:54:02 INFO - PROCESS | 996 | -------- Summary: end -------- 05:54:02 INFO - PROCESS | 996 | 05:54:02 INFO - TEST-INFO | 996: exit 0 05:54:02 INFO - TEST-OK | kraken | took 59583ms 05:54:02 INFO - TEST-START | v8_7 05:54:02 INFO - operating with platform_type : linux_ 05:54:02 INFO - Initialising browser for v8_7 test... 05:54:02 INFO - TEST-INFO | started process 1364 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPGpj6c/profile http://localhost:47000/getInfo.html) 05:54:06 INFO - PROCESS | 1364 | 05:54:06 INFO - PROCESS | 1364 | (process:1435): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:54:06 INFO - PROCESS | 1364 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 05:54:06 INFO - PROCESS | 1364 | __metrics Screen width/height:1600/1200 05:54:06 INFO - PROCESS | 1364 | colorDepth:24 05:54:06 INFO - PROCESS | 1364 | Browser inner width/height: 1024/670 05:54:06 INFO - PROCESS | 1364 | __metrics 05:54:06 INFO - PROCESS | 1364 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:54:07 INFO - TEST-INFO | 1364: exit 0 05:54:07 INFO - Browser initialized. 05:54:07 INFO - Running cycle 1/1 for v8_7 test... 05:54:07 INFO - TEST-INFO | started process 1484 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPGpj6c/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:09 INFO - PROCESS | 1484 | 05:54:09 INFO - PROCESS | 1484 | (process:1543): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:54:19 INFO - PROCESS | 1484 | RSS: Main: 151109632 05:54:19 INFO - PROCESS | 1484 | 05:54:41 INFO - PROCESS | 1484 | Cycle 1(1): loaded http://localhost:47000/tests/v8_7/run.html (next: http://localhost:47000/tests/v8_7/run.html) 05:54:42 INFO - PROCESS | 1484 | RSS: Main: 146157568 05:54:42 INFO - PROCESS | 1484 | 05:54:42 INFO - PROCESS | 1484 | __start_tp_report 05:54:42 INFO - PROCESS | 1484 | _x_x_mozilla_page_load 05:54:42 INFO - PROCESS | 1484 | _x_x_mozilla_page_load_details 05:54:42 INFO - PROCESS | 1484 | |i|pagename|runs| 05:54:42 INFO - PROCESS | 1484 | |0;Richards;166.36167027116952 05:54:42 INFO - PROCESS | 1484 | |1;DeltaBlue;197.1608832807571 05:54:42 INFO - PROCESS | 1484 | |2;Encrypt;285.06271379703537 05:54:42 INFO - PROCESS | 1484 | |3;Decrypt;5208.333333333333 05:54:42 INFO - PROCESS | 1484 | |4;RayTrace;1058.2010582010582 05:54:42 INFO - PROCESS | 1484 | |5;Earley;720.9805335255949 05:54:42 INFO - PROCESS | 1484 | |6;Boyer;12195.121951219513 05:54:42 INFO - PROCESS | 1484 | |7;RegExp;40640 05:54:42 INFO - PROCESS | 1484 | |8;Splay;623.0529595015577 05:54:42 INFO - PROCESS | 1484 | |9;NavierStokes;4840.579710144928 05:54:42 INFO - PROCESS | 1484 | __end_tp_report 05:54:42 INFO - PROCESS | 1484 | __startTimestamp1452434082221__endTimestamp 05:54:42 INFO - PROCESS | 1484 | 05:54:42 INFO - PROCESS | 1484 | ------- Summary: start ------- 05:54:42 INFO - PROCESS | 1484 | Number of tests: 10 05:54:42 INFO - PROCESS | 1484 | 05:54:42 INFO - PROCESS | 1484 | [#0] Richards Cycles:1 Average:166.36 Median:166.36 stddev:0.00 (0.0%) 05:54:42 INFO - PROCESS | 1484 | Values: 166.4 05:54:42 INFO - PROCESS | 1484 | 05:54:42 INFO - PROCESS | 1484 | [#1] DeltaBlue Cycles:1 Average:197.16 Median:197.16 stddev:0.00 (0.0%) 05:54:42 INFO - PROCESS | 1484 | Values: 197.2 05:54:42 INFO - PROCESS | 1484 | 05:54:42 INFO - PROCESS | 1484 | [#2] Encrypt Cycles:1 Average:285.06 Median:285.06 stddev:0.00 (0.0%) 05:54:42 INFO - PROCESS | 1484 | Values: 285.1 05:54:42 INFO - PROCESS | 1484 | 05:54:42 INFO - PROCESS | 1484 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 05:54:42 INFO - PROCESS | 1484 | Values: 5208.3 05:54:42 INFO - PROCESS | 1484 | 05:54:42 INFO - PROCESS | 1484 | [#4] RayTrace Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 05:54:42 INFO - PROCESS | 1484 | Values: 1058.2 05:54:42 INFO - PROCESS | 1484 | 05:54:42 INFO - PROCESS | 1484 | [#5] Earley Cycles:1 Average:720.98 Median:720.98 stddev:0.00 (0.0%) 05:54:42 INFO - PROCESS | 1484 | Values: 721.0 05:54:42 INFO - PROCESS | 1484 | 05:54:42 INFO - PROCESS | 1484 | [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 05:54:42 INFO - PROCESS | 1484 | Values: 12195.1 05:54:42 INFO - PROCESS | 1484 | 05:54:42 INFO - PROCESS | 1484 | [#7] RegExp Cycles:1 Average:40640.00 Median:40640.00 stddev:0.00 (0.0%) 05:54:42 INFO - PROCESS | 1484 | Values: 40640.0 05:54:42 INFO - PROCESS | 1484 | 05:54:42 INFO - PROCESS | 1484 | [#8] Splay Cycles:1 Average:623.05 Median:623.05 stddev:0.00 (0.0%) 05:54:42 INFO - PROCESS | 1484 | Values: 623.1 05:54:42 INFO - PROCESS | 1484 | 05:54:42 INFO - PROCESS | 1484 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:54:42 INFO - PROCESS | 1484 | Values: 4840.6 05:54:42 INFO - PROCESS | 1484 | -------- Summary: end -------- 05:54:42 INFO - PROCESS | 1484 | 05:54:43 INFO - TEST-INFO | 1484: exit 0 05:54:43 INFO - TEST-OK | v8_7 | took 40187ms 05:54:43 INFO - SUITE-END | took 1209s 05:54:43 INFO - Completed test suite (00:20:10) 05:54:43 INFO - Working with test: dromaeo_css 05:54:43 INFO - Generating results file: dromaeo_css 05:54:43 INFO - Working with test: kraken 05:54:43 INFO - Generating results file: kraken 05:54:43 INFO - javascript benchmark 05:54:43 INFO - Working with test: v8_7 05:54:43 INFO - Generating results file: v8_7 05:54:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:54:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 05:54:43 INFO - process_Request line: dromaeo_css 6805.89 graph.html#tests=[[72,1,43]] 05:54:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:54:43 INFO - process_Request line: kraken 1521.00 graph.html#tests=[[232,1,43]] 05:54:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:54:43 INFO - process_Request line: v8_7 20212.32 graph.html#tests=[[230,1,43]] 05:54:43 INFO - RETURN: dromaeo_css: 6805.89 05:54:43 INFO - RETURN: kraken: 1521.00 05:54:43 INFO - RETURN: v8_7: 20212.32 05:54:43 INFO - javascript benchmark 05:54:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3141.890033848815, 3195.137312925509, 3239.1740106272896, 3252.983735081326, 3255.2024753935284, 5226.163813789794, 5382.327209098863, 5385.919211211835, 5397.136458166694, 5405.702686352249, 5253.4221235664045, 5272.499112584308, 5310.8141215057385, 5382.354117505895, 5406.83779486615, 4851.345068415754, 4913.582345500618, 4965.230389289648, 4992.800287988476, 5003.2245002024565, 4849.078675051729, 4966.602671786249, 4984.725840078794, 4991.650584459071, 5010.549050585447, 4777.80888764449, 4831.951680483186, 4884.902301953976, 4907.337509436216, 4924.384451943507, 4907.141250281186, 4919.311296418468, 4934.481879402647, 4937.432195297515, 4942.777575009133, 4842.0, 4908.631852611033, 4923.77842997066, 4943.0, 4945.357103576548, 5090.643654944155, 5117.7185254810975, 5204.219367094928, 5272.024675435056, 5325.8934821303355, 5687.4881260686325, 5728.25532680753, 5744.0, 5749.453801888856, 5763.971180144114, 5724.141378793172, 5759.366469688331, 5761.5678824087945, 5761.654300741969, 5768.480836724673, 5235.73821308933, 5317.46825317469, 5353.4646535346155, 5375.838724838261, 5420.295361603005, 5820.3888591698105, 5823.621464604787, 5826.76692932278, 5840.824775256664, 5855.912161317584, 5558.527525160326, 5607.887842243133, 5619.297587801525, 5626.409227031185, 5630.352509461464, 5665.631733937281, 5715.457031581993, 5766.509846662997, 5769.624974376736, 5772.365039845614, 5617.129344951539, 5632.070708333161, 5648.4633959773755, 5715.228444160069, 5735.569832262597, 5622.943770562242, 5629.352624448159, 5629.802956896489, 5632.887342253214, 5647.124695672177, 4316.287812510964, 4390.934135987899, 4396.912061758747, 4404.53752355998, 4405.118976204708, 3923.6861051115843, 3990.8004599769897, 4004.979975100164, 4026.899327516777, 4047.210793895162, 5290.312259406252, 5294.841154765363, 5299.788008479694, 5306.044911915892, 5323.254744335719, 5601.327840659147, 5659.6321239119325, 5660.264165658438, 5661.46216109469, 5687.829365119053, 5314.415414304423, 5352.598555108382, 5409.945900541023, 5469.288992430958, 5516.3380394352935, 4882.292067650242, 4887.266909963534, 4889.926651100165, 4896.951030489649, 4910.48439913811, 5899.380565040609, 5909.763609455574, 5924.992751232301, 5939.643621382731, 5941.1385349125, 5658.179563963285, 5727.799527016535, 5811.883762324815, 5835.766569337179, 5876.529877609866, 5984.940150598438, 5985.371535988833, 5988.580799344004, 5993.460588547052, 6000.0, 5495.6153069284765, 5705.201271822031, 5711.029125048669, 5715.257016587817, 5735.082386818089, 5677.51741102011, 5747.109198074305, 5803.941960580509, 5830.271216097988, 5846.0, 5621.634593751393, 5637.351704554028, 5645.125005624135, 5654.264945557051, 5656.321241451053, 5515.336444497486, 5622.971885140548, 5626.887462250814, 5628.183913332462, 5644.322681278273, 5371.382291036581, 5422.918656220081, 5447.891042179213, 5458.918116228339, 5505.834824955257, 5512.751926163252, 5528.06022976103, 5543.750531226024, 5552.639078459887, 5567.638103523258, 5429.972850135724, 5448.727563621724, 5457.072297709478, 5514.503694667499, 5552.833414997556], "unit": "score", "name": "dojo.html", "value": 5282.477173611249}, {"lowerIsBetter": false, "replicates": [542.4467043615513, 551.9972400137999, 564.14250339484, 566.6628356128102, 575.9078547432412, 35042.0, 35857.46213806789, 35877.64122358776, 35879.641203587955, 35976.0, 38603.227935441275, 38833.611663883356, 39094.60905390945, 39199.41200881989, 39323.21353572934, 8674.219320261176, 8860.778480538005, 8965.506897120657, 8967.730968070968, 8974.237189838872, 8617.741467755946, 8699.52152631605, 8780.780480487974, 8787.428817126898, 8791.428557143798, 8797.340199485032, 8812.471251724917, 8871.645134194625, 8882.600282987249, 8892.911070889273, 8723.21491065804, 8740.344474164463, 8741.475511469269, 8794.076621954666, 8810.515421651806, 8580.957095214546, 8773.385862989593, 8790.736277911672, 8791.164839340252, 8822.779430514225, 38599.61400385988, 38650.0, 38967.220655587014, 38970.80514597437, 39119.41320880189, 2587.8964841406323, 3011.9698803011906, 3074.784765066446, 3171.682831716833, 3282.5404443377947, 25889.352766180808, 26184.73815261861, 26642.600360994602, 26781.330466738487, 26927.865360673266, 3407.897763067112, 3456.2578235212245, 3482.564679415073, 3737.9813100934593, 3869.494322913276, 217427.0, 220022.0, 220348.0, 220427.0, 221691.0, 52338.73830630822, 53334.399968001024, 53531.73234133804, 54674.72662636741, 54943.0, 64075.35924640787, 64560.0, 64982.101073935715, 65057.0, 65285.673571631836, 15012.924935375253, 15195.240237988057, 15210.16344101085, 15210.771838422432, 15226.162561059247, 11392.829107563393, 11437.885621143849, 11440.370779607036, 11452.656420307405, 11471.197016208953, 18256.269749210147, 18399.908000459913, 18542.536436589195, 18547.35084272071, 19061.332853350064, 7680.577568233689, 7792.922070779219, 7831.412644051719, 7893.921060789434, 8020.879686804703, 915.6108653822099, 1012.5544760305442, 1048.6329784575337, 1069.561479793281, 1119.1494464207099, 28734.568981465294, 29614.407711846074, 29881.35652539088, 30064.398712026075, 30185.849070754506, 956.3879117364892, 977.8386566216636, 1075.0109898893038, 1075.4945175767377, 1113.4766659669942, 13980.231087290093, 14147.575572732834, 14166.0, 14169.0, 14275.78586321206, 245906.0, 247218.0, 248811.0, 249239.0, 315394.0, 50609.493905061216, 50744.492555074714, 50752.746236268584, 50922.74538627357, 50939.74530127326, 1279.411470723459, 1283.5635883799553, 1293.792993121096, 1297.5199176304639, 1298.577962162301, 26976.595351069358, 27909.302267442665, 28460.146195614165, 28528.286792830346, 29588.408231834812, 42619.360709588764, 42661.36007959821, 42704.0, 42797.57202427936, 42859.35710964401, 199954.0, 200275.0, 200384.0, 200843.0, 201271.0, 27784.86107569449, 31127.221819454695, 31242.0, 31387.215319617193, 31773.841130794197, 37883.62116378801, 38327.61672383352, 38440.61559384482, 38691.80654096712, 38805.41791873068, 33179.50230746492, 35621.0, 38135.237295253384, 38501.4224786634, 38527.807360963016, 35472.0, 36043.81978090093, 36248.456273155396, 37119.257614848095, 37536.2492750138, 37442.812785936985, 38040.619593803705, 38293.0, 38376.80811595924, 38547.614523855525, 34398.0, 36287.27425451529, 38553.0, 38660.0, 38673.80663096667, 26184.083557076174, 26821.731782682706, 26959.86520067387, 27064.32339191457, 27317.45365092727], "unit": "score", "name": "ext.html", "value": 17789.935244040636}, {"lowerIsBetter": false, "replicates": [356.5899215901713, 361.3261267735673, 362.3351150638578, 364.6809042088174, 364.84129403709375, 16196.514104576867, 16669.749953750703, 16956.57608559785, 17416.303347866102, 18203.362882299105, 10535.525901334438, 10833.0250277475, 15395.615109622266, 15668.764968525482, 15710.371585136609, 4789.4492133404665, 5029.84910452687, 5394.433584473632, 5394.9190762138405, 5397.2443857859935, 4445.22208613493, 5317.388500322474, 5411.891762164754, 5420.430854760252, 5429.701366424845, 5065.7467126643705, 5280.788768449257, 5397.811076612319, 5404.486573775504, 5405.864853378657, 5153.484651534835, 5164.122099243119, 5171.327727395452, 5199.428062913076, 5463.7814487420455, 5255.237990491396, 5269.841904742864, 5282.867928301785, 5294.788208471657, 5307.336582927134, 12153.513859445611, 16514.58713532159, 19443.31948381814, 19792.505187370287, 19970.30103946355, 1724.4395571439206, 1957.1290775604862, 1978.436145698469, 2081.6149012432747, 2110.725605671268, 9129.132732390412, 9510.1440870322, 9712.660056898045, 10776.29954052984, 13101.279429631366, 1732.1079643983358, 1819.7452356670076, 1833.8074502177212, 1856.860735444847, 1858.962820743591, 52990.735046324524, 54873.176902346895, 55617.0, 55667.16499252515, 56647.0, 9758.609655613838, 9940.602375905028, 10067.093961543349, 10077.848832267522, 10088.949555252177, 13046.086773925925, 13138.934305328603, 13162.0, 13169.73660526784, 13213.801792973112, 7338.119425668954, 7404.777856664201, 7414.258574142543, 7441.739539116105, 7465.178830328659, 7160.391366733886, 7183.748568800172, 7185.748498802517, 7210.711571537185, 7220.241874603196, 4359.847405340798, 4387.517373088957, 4416.0, 4434.068845542408, 4482.462104547475, 1795.8563314934775, 1811.2664370929795, 1834.1654547181001, 1864.0772817455174, 1872.550587858904, 443.16021139939636, 456.05141306083266, 886.7206829848577, 892.4154678685471, 949.1647350331664, 10308.742281442874, 10740.087092597061, 10767.300125491818, 11022.283551569122, 11352.262102963281, 436.3040949685247, 440.110975828824, 444.5709889956208, 462.44737538641675, 822.1819289806681, 9477.767890174233, 9630.855537166948, 10011.099001089937, 10051.748706282402, 10184.490775461198, 457946.0, 462468.0, 464535.0, 464674.0, 499403.03581785207, 66163.0, 69140.6542967282, 72596.63701681563, 73184.63407682927, 73259.0, 1140.1961617059953, 1155.393418455301, 1169.0705888818409, 1170.9355985420714, 1175.2008634128704, 15124.168170750714, 15303.77044344358, 15476.303566339317, 15483.148426836633, 15955.760663589823, 26700.93196272205, 32936.505952411215, 33132.66867331296, 34281.82859085689, 34575.30849382948, 43754.12491750211, 44949.325760114276, 44989.100217996114, 45093.09813803771, 46063.76968115138, 7272.600006999666, 7478.70085196586, 7521.247875212435, 7553.433492488195, 7634.160242373446, 10138.493075346056, 11281.492332844877, 11332.583427071617, 11423.143264255048, 11752.412379381169, 9119.452832830051, 9590.376625519319, 9677.758056048655, 9791.804163916824, 9823.508824558887, 3221.855016524215, 3884.6892248620607, 9568.22987747269, 10034.0, 10340.844887326546, 10206.387616743019, 10389.9480502597, 10429.9478502607, 10674.786504270027, 10680.519376628226, 7331.266873312626, 7578.242175782378, 7606.239376062349, 7653.0, 7715.1513333534385, 8018.919810801817, 10007.449590272605, 10075.395476271447, 10134.087932086148, 10317.587296508056], "unit": "score", "name": "jquery.html", "value": 7767.759138860006}, {"lowerIsBetter": false, "replicates": [1431.7995480632712, 1433.3621538415407, 1542.6991736611358, 1684.1915880377426, 1689.8986060836344, 7575.848483030336, 7636.9618151909235, 7689.346405555528, 7699.037620297463, 7859.489133206338, 7723.575203363826, 7754.418418618612, 7783.066032076144, 7793.961030194855, 7837.529748215111, 2291.0721157931025, 2325.94185145371, 2326.09282379872, 2326.8022218111482, 2327.697399338084, 2342.320726989171, 2344.120954642009, 2384.5111752090866, 2391.175044609607, 2391.6771235883193, 2245.191730976847, 2306.400335912658, 2311.924954895973, 2329.9301020969315, 2343.718753749544, 2341.4497593065616, 2345.9530809383887, 2366.3847399676124, 2366.905323787055, 2375.1924345722537, 2351.58847201739, 2373.0151986925407, 2375.2755409600063, 2381.868997205153, 2388.295452841416, 7652.2347765223585, 7726.459147859652, 7737.0715514138665, 7766.689332426696, 7768.339691126261, 4768.642351823592, 4926.1625523660705, 4926.507349265081, 4934.80260789568, 4956.529129732669, 3028.439738648357, 3072.6620071792086, 3128.2961333699964, 3140.764442666809, 3181.7772755907095, 952.5332587032374, 966.0966995858824, 989.7278248481725, 989.9802003959952, 1002.8194924913513, 10437.373757574569, 10511.84232236517, 10519.053285204292, 10552.366857988545, 10552.788944221149, 4148.834046638161, 4161.895952601149, 4226.535081141072, 4241.724287921275, 4272.060146767706, 8619.439736417113, 8693.913060869438, 8703.869441958375, 8719.564021798884, 8731.388802783744, 4646.070785842845, 4675.6727029108315, 4676.111538807616, 4685.578297953132, 4701.036287561042, 4223.366495025771, 4260.275753121915, 4266.08279219963, 4275.46556680415, 4279.529251782302, 3395.7962522248745, 3415.351083294166, 3440.2947395783804, 3442.9311413771584, 3462.9826850865584, 1071.3518321415431, 1104.5305745058479, 1106.1151079136819, 1114.0, 1137.852079229695, 1317.7166909114587, 1318.3474180280823, 1344.327836081959, 1350.1224204267305, 1356.85752995936, 7151.427885769126, 7299.817504562428, 7314.817129571803, 7359.6688149033425, 7384.298491643285, 1092.8961748633867, 1103.5751235774285, 1112.5438570186348, 1122.9213955023233, 1136.6987748246722, 5565.053940830068, 5582.888342233133, 5641.379448260688, 5643.35101463337, 5645.830625081254, 8976.41653292547, 9022.097790220925, 9304.581293841658, 9328.580213890391, 9364.438133712, 9390.389624674373, 9453.810923781624, 9513.429194248367, 9541.141297283279, 9582.472963986907, 7235.89146162808, 7405.740799072007, 7445.032145821008, 7527.774166775005, 7533.698652053966, 7181.533200341961, 7202.243764404662, 7209.819754506179, 7211.747588834365, 7215.567065976058, 8312.376571757022, 8416.831663366576, 8477.237048665404, 8548.700795472128, 8674.479531227895, 8638.093000234885, 8682.609282582425, 8688.695895643623, 8694.04365519805, 8729.825403491768, 6453.806385808433, 6720.8319792005595, 6725.428338591275, 6758.763443279461, 6769.120014398097, 7421.851562968603, 7435.962820185864, 7444.888326674996, 7474.364679002346, 7491.175970643334, 6675.0654908313845, 6768.424683901923, 6883.827904302432, 7089.716411343695, 7113.0753002109395, 6494.447971922251, 6520.217573891164, 6568.671566421755, 6607.438367738796, 6726.663666816542, 6725.159355080615, 6735.326467353226, 6737.66311684404, 6756.628385438848, 6777.762778302736, 6254.9687251563455, 6268.6552239625435, 6320.747170113328, 6480.967595161994, 6539.542232043711, 6512.641804700597, 6537.477001839937, 6538.771143009972, 6561.868762624626, 6567.2447668518735], "unit": "score", "name": "mootools.html", "value": 4488.776157383399}, {"lowerIsBetter": false, "replicates": [335.7045799696267, 339.49245877413273, 339.74519110667, 342.1173372698437, 350.2574541971021, 6210.875782484348, 6211.285702144249, 6247.437730604244, 6271.811845644632, 6301.527385446087, 6130.908036379458, 6186.907196392047, 6191.0, 6219.720112594933, 6249.093881387207, 4758.904821903559, 4766.451858036318, 4768.90462190756, 4771.737554434505, 4774.713517188962, 4774.641901857357, 4775.355327030841, 4779.139754844126, 4785.3300537924715, 4788.497207793183, 4538.319252112176, 4642.721436713791, 4654.930176047362, 4682.227432473638, 4694.3662605548325, 4646.697964632322, 4679.532046795327, 4681.672282940179, 4682.578567928886, 4684.180268453007, 4042.191561687645, 4064.451299074646, 4065.695072869517, 4070.3690927906223, 4074.0629655179473, 5818.5636077294375, 5867.090600956859, 5877.177195192677, 5889.969255380334, 5895.55783316253, 5324.8136315228785, 5429.511343979021, 5430.972845135789, 5464.26232458617, 5472.315960504937, 6524.0, 6544.574602650812, 6555.475561955032, 6574.178227721535, 6584.242812076624, 4508.2561377372695, 4512.751798651073, 4524.0, 4525.140223357585, 4534.047849951514, 6776.356246156607, 6822.931770682279, 6831.146106736658, 6883.414909732679, 6902.965485172592, 4551.408316918845, 4568.063546972929, 4570.542945705402, 4578.908421831611, 4591.449026116888, 4612.630989520831, 4614.676972611885, 4631.58315751584, 4631.861044168681, 4634.721916684943, 5357.303550538483, 5367.838964831061, 5372.0, 5388.272583201296, 5398.78404863801, 6483.935160648428, 6609.107770450928, 6615.305392933769, 6615.503837212132, 6620.933790662128, 1637.6233466302817, 1651.3559711712442, 1651.983480165183, 1655.1227849239922, 1659.6348803263263, 1098.3464838421128, 1106.6403418888892, 1107.595727559451, 1119.485036883043, 1129.7796929598649, 6213.068039794067, 6235.0, 6248.218972628421, 6251.812445626639, 6267.2792628847355, 6784.864302713918, 6793.422559082534, 6800.727970881109, 6802.877525208384, 6816.250212476623, 6141.508679305645, 6198.690065496708, 6230.906536401958, 6245.656488893154, 6321.8735625288155, 3681.1901381695984, 3685.594584595692, 3692.5015122958594, 3697.9815100924325, 3720.7023438124884, 7117.608531530712, 7195.748148814766, 7218.963905180441, 7231.059962204985, 7259.782206533812, 6940.305969403019, 7009.859802803915, 7012.144859042654, 7048.436125110082, 7057.258987806206, 7177.174624918097, 7193.5324203926575, 7196.856062878713, 7223.747168849065, 7243.058402407653, 6822.931770682429, 6846.828829279308, 6858.897116543156, 6860.656967151523, 6863.897041544481, 6711.63086030273, 6753.020811982334, 6789.456843452611, 6808.489363297674, 6823.147106611674, 7221.855562888818, 7236.276372362721, 7239.963800180965, 7246.130464344313, 7250.746223882139, 4645.094206629675, 4674.415698037746, 4678.508756580646, 4681.274402467623, 4685.6251499879245, 6704.4301234395625, 6771.898421523582, 6859.862802744017, 6863.828404289733, 6872.41584465326, 6628.403443690091, 6649.534532582673, 6665.300143484864, 6669.699863506251, 6685.0, 6619.3049729779605, 6625.602463852184, 6681.064650948774, 6683.465322774264, 6686.297938716365, 6382.808515744535, 6530.836729081621, 6543.345665433609, 6583.506237032338, 6589.27517973013, 6687.76592819249, 6712.295209002984, 6732.192136943598, 6733.158355205599, 6734.292899245705, 6423.389777971085, 6545.8690826184165, 6548.050532672831, 6566.24488183865, 6567.343265673395], "unit": "score", "name": "prototype.html", "value": 4966.859351718923}, {"lowerIsBetter": false, "replicates": [726.8037629839944, 801.5030680977791, 859.5315553023605, 862.5988915154452, 863.8099618084021, 11905.821412678806, 12024.819627705592, 12026.69933251667, 12027.398630068494, 12056.758864822697, 12342.876571234285, 12364.690882727937, 12405.689857753561, 12464.875351246485, 12476.750464990695, 782.7808213700173, 784.1648644193915, 812.8780682897553, 816.0207750699155, 820.7004443378183, 812.1391325195311, 814.3037702764141, 816.5753808019826, 818.0837462042521, 820.1757233979841, 843.7890527368158, 846.5640195299395, 848.7156802471179, 850.2390360627235, 853.6116067189414, 838.1869586501084, 838.9916100839035, 842.0442797424905, 844.4468872888268, 846.4794151596785, 614.4469977020673, 615.5229696984873, 620.1008537620469, 621.7792683597348, 622.9127922090911, 12948.546800861925, 13446.932765336209, 13461.865381346159, 13517.121387109806, 13538.120022198624, 11390.658280251606, 12100.334481603508, 12364.75270494594, 12699.238045717286, 13082.018848586395, 9081.818363632756, 9211.263098952068, 9236.21492173166, 9269.304802139866, 9509.286803489766, 3391.4743214801747, 3437.364087643794, 3446.551948246737, 3453.2748122894222, 3458.5503884495106, 47194.29208561874, 47516.762416188045, 48165.51834481645, 48200.75899620514, 48331.27503087457, 8427.536485493356, 8547.829043419097, 8938.68714594986, 9112.95443522778, 9626.855597166048, 17138.143092845556, 17340.653186936444, 17342.479725608253, 17372.3051077958, 17390.21744021522, 7151.642417879085, 7411.814704632319, 7495.700171993169, 7689.50018248812, 7985.5208687478935, 4017.196560687874, 4021.638052575224, 4100.487439070116, 4115.485564304462, 4181.665466762652, 3045.6192975878016, 3075.5694202811624, 3081.306705991134, 3082.1832214463184, 3096.5200393938976, 561.1330494386183, 586.003793550965, 588.1648059755158, 598.5480961873758, 603.3694788945562, 633.5565104426828, 672.3847679373416, 672.6670298202421, 679.3342524326188, 707.1973310292855, 8116.188381161836, 8137.715179968673, 8373.204545568162, 8391.0, 8444.02324115922, 518.2174915877052, 549.0, 554.523110125292, 606.6542071019477, 609.2962628164477, 3677.5219221501034, 3953.525576930787, 4067.613576710208, 4182.895427614273, 4201.117765269328, 55631.443685563434, 56778.716106419204, 57070.143947840814, 57110.42889571134, 57325.71337143371, 50142.0, 50747.746261268454, 51023.48976510262, 51203.487965120614, 53227.467725322254, 45754.08491830145, 46217.30674039892, 46446.5355346449, 46873.29690054652, 47081.0, 8439.493630382196, 8504.149585041447, 8510.191531804468, 8584.527850968258, 9005.504697241715, 31563.053108406784, 31936.0, 32110.357792843544, 32113.67886321107, 32158.19604509906, 38371.23257534778, 39210.411843822934, 39744.2051158981, 39817.80091099526, 39850.60149398585, 10553.0, 10593.735156621146, 10635.14918806478, 10678.199135064746, 10932.234743567873, 11477.713057173638, 11538.59614913474, 11660.0, 12362.258264504158, 12366.319852408204, 10834.486397164881, 10987.945060274647, 11003.724906877393, 11299.887001130212, 11421.31472111676, 10598.364098154136, 10763.784724305626, 10832.566697332333, 10933.507992140214, 10959.506822192861, 10586.629467968583, 10615.0, 10746.46267686597, 11088.445577721242, 11170.497327620114, 9005.369624126248, 9060.728178154666, 9218.124278193562, 9322.580483878106, 9797.608095676092, 7902.091259505, 8576.65693372283, 8656.567171641518, 9027.45835249887, 9295.581698823435], "unit": "score", "name": "yui.html", "value": 6106.010429047726}], "name": "dromaeo_css", "value": 6805.891356965004}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 112.0, 109.0, 110.0, 123.0, 110.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [150.0, 129.0, 160.0, 165.0, 126.0, 153.0, 159.0, 135.0, 163.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 161.0, 163.0, 162.0, 162.0, 174.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 73.0, 72.0, 76.0, 74.0, 139.0, 72.0, 71.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 142.0, 96.0, 96.0, 97.0, 140.0, 96.0, 98.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 57.0, 58.0, 60.0, 61.0, 56.0, 61.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 71.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 88.0, 87.0, 87.0, 93.0, 85.0, 87.0, 88.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [128.0, 125.0, 125.0, 125.0, 120.0, 120.0, 124.0, 116.0, 115.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [151.0, 156.0, 154.0, 142.0, 153.0, 138.0, 157.0, 153.0, 150.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [69.0, 74.0, 70.0, 69.0, 70.0, 68.0, 69.0, 70.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1521.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.36167027116952], "unit": "score", "name": "Richards", "value": 212.20032200000009}, {"lowerIsBetter": false, "replicates": [197.1608832807571], "unit": "score", "name": "DeltaBlue", "value": 335.35049599999996}, {"lowerIsBetter": false, "replicates": [285.06271379703537], "unit": "score", "name": "Encrypt", "value": 933.7629479999997}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1058.2010582010582], "unit": "score", "name": "RayTrace", "value": 699.2896049999997}, {"lowerIsBetter": false, "replicates": [720.9805335255949], "unit": "score", "name": "Earley", "value": 924.3841810000001}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [40640.0], "unit": "score", "name": "RegExp", "value": 22.41596948818897}, {"lowerIsBetter": false, "replicates": [623.0529595015577], "unit": "score", "name": "Splay", "value": 130.793055}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20212.32125148531}]} 05:54:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20212.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1521.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6805.89"}}} 05:54:43 INFO - Return code: 0 05:54:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:54:43 INFO - # TBPL SUCCESS # 05:54:43 INFO - Running post-action listener: _resource_record_post_action 05:54:43 INFO - Running post-run listener: _resource_record_post_run 05:54:44 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 562819072; Read time: 0; Write time: 418564 05:54:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 239390720; Read time: 0; Write time: 214920 05:54:44 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 323428352; Read time: 0; Write time: 203644 05:54:44 INFO - Running post-run listener: _upload_blobber_files 05:54:44 INFO - Blob upload gear active. 05:54:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:54:44 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:54:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:54:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:54:45 INFO - (blobuploader) - INFO - Open directory for files ... 05:54:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:54:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:54:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:45 INFO - (blobuploader) - INFO - Done attempting. 05:54:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:54:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:54:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:46 INFO - (blobuploader) - INFO - Done attempting. 05:54:46 INFO - (blobuploader) - INFO - Iteration through files over. 05:54:46 INFO - Return code: 0 05:54:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:54:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:54:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3824e07e6a12225d76934776c641349ae6156d641380f559abe954a6afdebcf261a5beae35d3631e80e103700f72303e9b02edd1cbde5852c94677b25b57f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/287b115dfafa1201f886af57674102f55784258ab6873419c757a63ca92061702676a37f0e874c7f677645f37d9f653cd488ecb1691d46308a99f5250ded73f6"} 05:54:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:54:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:54:46 INFO - Contents: 05:54:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3824e07e6a12225d76934776c641349ae6156d641380f559abe954a6afdebcf261a5beae35d3631e80e103700f72303e9b02edd1cbde5852c94677b25b57f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/287b115dfafa1201f886af57674102f55784258ab6873419c757a63ca92061702676a37f0e874c7f677645f37d9f653cd488ecb1691d46308a99f5250ded73f6"} 05:54:46 INFO - Copying logs to upload dir... 05:54:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1280.466478 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-10 05:54:46.307594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 05:54:46.311203) ========= 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=1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942 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/bc3824e07e6a12225d76934776c641349ae6156d641380f559abe954a6afdebcf261a5beae35d3631e80e103700f72303e9b02edd1cbde5852c94677b25b57f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/287b115dfafa1201f886af57674102f55784258ab6873419c757a63ca92061702676a37f0e874c7f677645f37d9f653cd488ecb1691d46308a99f5250ded73f6"} build_url:https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/G2I-WV6FRT6jVTrRyOrN3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3824e07e6a12225d76934776c641349ae6156d641380f559abe954a6afdebcf261a5beae35d3631e80e103700f72303e9b02edd1cbde5852c94677b25b57f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/287b115dfafa1201f886af57674102f55784258ab6873419c757a63ca92061702676a37f0e874c7f677645f37d9f653cd488ecb1691d46308a99f5250ded73f6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 05:54:46.336028) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:54:46.336374) ========= 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=1f5564757af27664ca02d71f000001b0-1452425046.527169-641926942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 05:54:46.418832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 05:54:46.419156) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 05:54:46.419508) ========= ========= Total master_lag: 0.29 =========