builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1452570870.88 results: success (0) buildid: 20160111173004 builduid: 81693b2b09144eaa8a2b9358caac2b56 revision: b7d00293390bd54000b6dedc3e0d31020f2fd2b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:30.882747) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:30.883265) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:30.883579) ========= 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=920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006378 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:30.906570) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:30.906946) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:30.936224) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:30.936830) ========= 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=920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.011097 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:30.986449) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:30.986803) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:30.987174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:30.987444) ========= 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=920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 19:54:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-01-11 19:54:31 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182146 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:31.182884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:31.183271) ========= 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=920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.073492 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:31.268148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:31.268498) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b7d00293390bd54000b6dedc3e0d31020f2fd2b1 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b7d00293390bd54000b6dedc3e0d31020f2fd2b1 --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=920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 19:54:31,595 truncating revision to first 12 chars 2016-01-11 19:54:31,595 Setting DEBUG logging. 2016-01-11 19:54:31,595 attempt 1/10 2016-01-11 19:54:31,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b7d00293390b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 19:54:31,862 unpacking tar archive at: fx-team-b7d00293390b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560976 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:31.842409) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:31.842750) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:31.852736) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:31.853105) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 19:54:31.853620) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-11 19:54:31.853940) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:54:32 INFO - MultiFileLogger online at 20160111 19:54:32 in /builds/slave/test-pgo 19:54:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:54:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:54:32 INFO - {'append_to_log': False, 19:54:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:54:32 INFO - 'blob_upload_branch': 'Fx-Team', 19:54:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:54:32 INFO - 'branch': 'Fx-Team', 19:54:32 INFO - 'buildbot_json_path': 'buildprops.json', 19:54:32 INFO - 'config_files': ('talos/linux_config.py',), 19:54:32 INFO - 'default_actions': ('clobber', 19:54:32 INFO - 'read-buildbot-config', 19:54:32 INFO - 'download-and-extract', 19:54:32 INFO - 'populate-webroot', 19:54:32 INFO - 'create-virtualenv', 19:54:32 INFO - 'install', 19:54:32 INFO - 'run-tests'), 19:54:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:54:32 INFO - 'download_minidump_stackwalk': True, 19:54:32 INFO - 'download_symbols': 'ondemand', 19:54:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:54:32 INFO - 'tooltool.py': '/tools/tooltool.py', 19:54:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:54:32 INFO - '/tools/misc-python/virtualenv.py')}, 19:54:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:54:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:54:32 INFO - 'installer_path': 'installer.exe', 19:54:32 INFO - 'log_level': 'info', 19:54:32 INFO - 'log_name': 'talos', 19:54:32 INFO - 'log_to_console': True, 19:54:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:54:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:54:32 INFO - 'opt_config_files': (), 19:54:32 INFO - 'pip_index': False, 19:54:32 INFO - 'sps_profile': False, 19:54:32 INFO - 'sps_profile_interval': 0, 19:54:32 INFO - 'suite': 'dromaeojs', 19:54:32 INFO - 'system_bits': '32', 19:54:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:54:32 INFO - 'title': 'talos-linux64-ix-053', 19:54:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:54:32 INFO - 'use_talos_json': True, 19:54:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:54:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:54:32 INFO - 'work_dir': 'build'} 19:54:32 INFO - ##### 19:54:32 INFO - ##### Running clobber step. 19:54:32 INFO - ##### 19:54:32 INFO - Running pre-action listener: _resource_record_pre_action 19:54:32 INFO - Running main action method: clobber 19:54:32 INFO - rmtree: /builds/slave/test-pgo/build 19:54:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:54:33 INFO - Running post-action listener: _resource_record_post_action 19:54:33 INFO - ##### 19:54:33 INFO - ##### Running read-buildbot-config step. 19:54:33 INFO - ##### 19:54:33 INFO - Running pre-action listener: _resource_record_pre_action 19:54:33 INFO - Running main action method: read_buildbot_config 19:54:33 INFO - Using buildbot properties: 19:54:33 INFO - { 19:54:33 INFO - "project": "", 19:54:33 INFO - "product": "firefox", 19:54:33 INFO - "script_repo_revision": "production", 19:54:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:54:33 INFO - "repository": "", 19:54:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:54:33 INFO - "buildid": "20160111173004", 19:54:33 INFO - "pgo_build": "True", 19:54:33 INFO - "basedir": "/builds/slave/test-pgo", 19:54:33 INFO - "buildnumber": 412, 19:54:33 INFO - "slavename": "talos-linux64-ix-053", 19:54:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:54:33 INFO - "platform": "ubuntu64_hw", 19:54:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:54:33 INFO - "branch": "fx-team", 19:54:33 INFO - "repo_path": "integration/fx-team", 19:54:33 INFO - "revision": "b7d00293390bd54000b6dedc3e0d31020f2fd2b1", 19:54:33 INFO - "stage_platform": "linux64-pgo", 19:54:33 INFO - "builduid": "81693b2b09144eaa8a2b9358caac2b56", 19:54:33 INFO - "slavebuilddir": "test" 19:54:33 INFO - } 19:54:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:54:33 INFO - Running post-action listener: _resource_record_post_action 19:54:33 INFO - ##### 19:54:33 INFO - ##### Running download-and-extract step. 19:54:33 INFO - ##### 19:54:33 INFO - Running pre-action listener: _resource_record_pre_action 19:54:33 INFO - Running main action method: download_and_extract 19:54:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:33 INFO - https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/test_packages.json 19:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/test_packages.json 19:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:54:33 INFO - Downloaded 1302 bytes. 19:54:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:54:33 INFO - Using the following test package requirements: 19:54:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:54:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:54:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:33 INFO - u'jsshell-linux-x86_64.zip'], 19:54:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:54:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:54:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:54:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:54:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:54:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:54:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:54:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:33 INFO - https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/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 19:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/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 19:54:36 INFO - Downloaded 24025103 bytes. 19:54:36 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 19:54:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:54:36 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 19:54:37 INFO - Return code: 0 19:54:37 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 19:54: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')]} 19:54:37 INFO - https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:54:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:54:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:54:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/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 19:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/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 19:54:42 INFO - Downloaded 24025103 bytes. 19:54:42 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 19:54:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:54:42 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 19:54:43 INFO - Return code: 0 19:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:43 INFO - https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:54:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:54:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:54:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/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 19:54:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/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 19:54:46 INFO - Downloaded 11132285 bytes. 19:54:46 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 19:54:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:54:46 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 19:54:46 INFO - Return code: 0 19:54:46 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')]} 19:54:46 INFO - https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:54:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:54:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:54:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/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 19:54:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbj3tHSjSjamHhpEuq6-rQ/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 19:54:53 INFO - Downloaded 55801784 bytes. 19:54:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:54:53 INFO - mkdir: /builds/slave/test-pgo/properties 19:54:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:54:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:54:53 INFO - Contents: 19:54:53 INFO - build_url:https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:54:53 INFO - Running post-action listener: _resource_record_post_action 19:54:53 INFO - Running post-action listener: set_extra_try_arguments 19:54:53 INFO - ##### 19:54:53 INFO - ##### Running populate-webroot step. 19:54:53 INFO - ##### 19:54:53 INFO - Running pre-action listener: _resource_record_pre_action 19:54:53 INFO - Running main action method: populate_webroot 19:54:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:54:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:54:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:54:53 INFO - '--tppagecycles', 19:54:53 INFO - '7'], 19:54:53 INFO - 'tests': ['tsvgm']}}, 19:54:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:54:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:54:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:54:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:54:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:54:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:54:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:54:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:53 INFO - 'talos_options': ['--e10s'], 19:54:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:54:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:53 INFO - 'tests': ['damp', 'tps']}, 19:54:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:53 INFO - 'talos_options': ['--e10s'], 19:54:53 INFO - 'tests': ['damp', 'tps']}, 19:54:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:54:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:54:53 INFO - 'other': {'tests': ['a11yr', 19:54:53 INFO - 'ts_paint', 19:54:53 INFO - 'tpaint', 19:54:53 INFO - 'sessionrestore', 19:54:53 INFO - 'sessionrestore_no_auto_restore']}, 19:54:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:54:53 INFO - 'tests': ['a11yr', 19:54:53 INFO - 'ts_paint', 19:54:53 INFO - 'tpaint', 19:54:53 INFO - 'sessionrestore', 19:54:53 INFO - 'sessionrestore_no_auto_restore']}, 19:54:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:54:53 INFO - 'tests': ['a11yr', 19:54:53 INFO - 'ts_paint', 19:54:53 INFO - 'tpaint', 19:54:53 INFO - 'sessionrestore', 19:54:53 INFO - 'sessionrestore_no_auto_restore']}, 19:54:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:54:53 INFO - 'tests': ['a11yr', 19:54:53 INFO - 'ts_paint', 19:54:53 INFO - 'tpaint', 19:54:53 INFO - 'sessionrestore', 19:54:53 INFO - 'sessionrestore_no_auto_restore']}, 19:54:53 INFO - 'other_l64': {'tests': ['a11yr', 19:54:53 INFO - 'ts_paint', 19:54:53 INFO - 'tpaint', 19:54:53 INFO - 'sessionrestore', 19:54:53 INFO - 'sessionrestore_no_auto_restore']}, 19:54:53 INFO - 'other_nol64': {'tests': ['a11yr', 19:54:53 INFO - 'ts_paint', 19:54:53 INFO - 'tpaint', 19:54:53 INFO - 'sessionrestore', 19:54:53 INFO - 'sessionrestore_no_auto_restore']}, 19:54:53 INFO - 'svgr': {'tests': ['tsvgx', 19:54:53 INFO - 'tsvgr_opacity', 19:54:53 INFO - 'tart', 19:54:53 INFO - 'tscrollx', 19:54:53 INFO - 'cart']}, 19:54:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:54:53 INFO - 'tests': ['tsvgx', 19:54:53 INFO - 'tsvgr_opacity', 19:54:53 INFO - 'tart', 19:54:53 INFO - 'tscrollx', 19:54:53 INFO - 'cart']}, 19:54:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:53 INFO - 'tests': ['tp5o']}, 19:54:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:53 INFO - 'talos_options': ['--e10s'], 19:54:53 INFO - 'tests': ['tp5o']}, 19:54:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:53 INFO - 'talos_options': ['--xperf_path', 19:54:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:54:53 INFO - 'tests': ['tp5n']}, 19:54:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:53 INFO - 'talos_options': ['--e10s', 19:54:53 INFO - '--xperf_path', 19:54:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:54:53 INFO - 'tests': ['tp5n']}}, 19:54:53 INFO - 'talos.zip': {'path': '', 19:54:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:54:53 INFO - Running post-action listener: _resource_record_post_action 19:54:53 INFO - ##### 19:54:53 INFO - ##### Running create-virtualenv step. 19:54:53 INFO - ##### 19:54:53 INFO - Running pre-action listener: _resource_record_pre_action 19:54:53 INFO - Running main action method: create_virtualenv 19:54:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:54:53 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 19:54:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:54:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:54:53 INFO - Using real prefix '/usr' 19:54:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:54:54 INFO - Installing distribute.............................................................................................................................................................................................done. 19:54:56 INFO - Installing pip.................done. 19:54:56 INFO - Return code: 0 19:54:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:54:56 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')]} 19:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:56 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')]} 19:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:56 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 0x7f19c14dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f840>, '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 0x130c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130cb60>, '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': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', '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 19:54:56 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 19:54:56 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 19:54:56 INFO - Using env: {'DISPLAY': ':0', 19:54:56 INFO - 'HOME': '/home/cltbld', 19:54:56 INFO - 'LANG': 'en_US.UTF-8', 19:54:56 INFO - 'LANGUAGE': 'en_US:en', 19:54:56 INFO - 'LOGNAME': 'cltbld', 19:54:56 INFO - 'MAIL': '/var/mail/cltbld', 19:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:56 INFO - 'MOZ_NO_REMOTE': '1', 19:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:54:56 INFO - 'NO_EM_RESTART': '1', 19:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:54:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:54:56 INFO - 'SHELL': '/bin/bash', 19:54:56 INFO - 'SHLVL': '1', 19:54:56 INFO - 'TERM': 'linux', 19:54:56 INFO - 'TMOUT': '86400', 19:54:56 INFO - 'USER': 'cltbld', 19:54:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', 19:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:56 INFO - '_': '/tools/buildbot/bin/python'} 19:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:56 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 19:54:56 INFO - Cleaning up... 19:54:56 INFO - Return code: 0 19:54:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:54:56 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')]} 19:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:56 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')]} 19:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:56 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 0x7f19c14dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f840>, '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 0x130c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130cb60>, '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': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', '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 19:54:56 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 19:54:56 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 19:54:56 INFO - Using env: {'DISPLAY': ':0', 19:54:56 INFO - 'HOME': '/home/cltbld', 19:54:56 INFO - 'LANG': 'en_US.UTF-8', 19:54:56 INFO - 'LANGUAGE': 'en_US:en', 19:54:56 INFO - 'LOGNAME': 'cltbld', 19:54:56 INFO - 'MAIL': '/var/mail/cltbld', 19:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:56 INFO - 'MOZ_NO_REMOTE': '1', 19:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:54:56 INFO - 'NO_EM_RESTART': '1', 19:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:54:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:54:56 INFO - 'SHELL': '/bin/bash', 19:54:56 INFO - 'SHLVL': '1', 19:54:56 INFO - 'TERM': 'linux', 19:54:56 INFO - 'TMOUT': '86400', 19:54:56 INFO - 'USER': 'cltbld', 19:54:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', 19:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:56 INFO - '_': '/tools/buildbot/bin/python'} 19:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:56 INFO - Downloading/unpacking psutil>=0.7.1 19:54:56 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 19:54:56 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 19:54:56 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 19:54:56 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 19:54:56 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 19:54:56 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 19:54:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:54:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:54:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:54:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:54:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:54:58 INFO - Installing collected packages: psutil 19:54:58 INFO - Running setup.py install for psutil 19:54:58 INFO - building 'psutil._psutil_linux' extension 19:54:58 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 19:54:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:54:58 INFO - building 'psutil._psutil_posix' extension 19:54:58 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 19:54:59 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 19:54:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:54:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:54:59 INFO - Successfully installed psutil 19:54:59 INFO - Cleaning up... 19:54:59 INFO - Return code: 0 19:54:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:54: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')]} 19:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54: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')]} 19:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54: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', '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 0x7f19c14dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f840>, '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 0x130c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130cb60>, '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': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', '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 19:54: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:54: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 mozsystemmonitor==0.0.0 19:54:59 INFO - Using env: {'DISPLAY': ':0', 19:54:59 INFO - 'HOME': '/home/cltbld', 19:54:59 INFO - 'LANG': 'en_US.UTF-8', 19:54:59 INFO - 'LANGUAGE': 'en_US:en', 19:54:59 INFO - 'LOGNAME': 'cltbld', 19:54:59 INFO - 'MAIL': '/var/mail/cltbld', 19:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:59 INFO - 'MOZ_NO_REMOTE': '1', 19:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:54:59 INFO - 'NO_EM_RESTART': '1', 19:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:54:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:54:59 INFO - 'SHELL': '/bin/bash', 19:54:59 INFO - 'SHLVL': '1', 19:54:59 INFO - 'TERM': 'linux', 19:54:59 INFO - 'TMOUT': '86400', 19:54:59 INFO - 'USER': 'cltbld', 19:54:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', 19:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:59 INFO - '_': '/tools/buildbot/bin/python'} 19:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:54:59 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 19:54:59 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 19:54:59 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 19:54:59 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 19:54:59 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 19:54:59 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 19:55:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:55:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:55:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:55:01 INFO - Installing collected packages: mozsystemmonitor 19:55:01 INFO - Running setup.py install for mozsystemmonitor 19:55:01 INFO - Successfully installed mozsystemmonitor 19:55:01 INFO - Cleaning up... 19:55:01 INFO - Return code: 0 19:55:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f19c14dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f840>, '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 0x130c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130cb60>, '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': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', '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 19:55:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:55:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:55:01 INFO - Using env: {'DISPLAY': ':0', 19:55:01 INFO - 'HOME': '/home/cltbld', 19:55:01 INFO - 'LANG': 'en_US.UTF-8', 19:55:01 INFO - 'LANGUAGE': 'en_US:en', 19:55:01 INFO - 'LOGNAME': 'cltbld', 19:55:01 INFO - 'MAIL': '/var/mail/cltbld', 19:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:01 INFO - 'MOZ_NO_REMOTE': '1', 19:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:01 INFO - 'NO_EM_RESTART': '1', 19:55:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:55:01 INFO - 'PWD': '/builds/slave/test-pgo', 19:55:01 INFO - 'SHELL': '/bin/bash', 19:55:01 INFO - 'SHLVL': '1', 19:55:01 INFO - 'TERM': 'linux', 19:55:01 INFO - 'TMOUT': '86400', 19:55:01 INFO - 'USER': 'cltbld', 19:55:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', 19:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:01 INFO - '_': '/tools/buildbot/bin/python'} 19:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:01 INFO - Downloading/unpacking blobuploader==1.2.4 19:55: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 19:55: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 19:55: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 19:55: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 19:55: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 19:55: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 19:55:03 INFO - Downloading blobuploader-1.2.4.tar.gz 19:55:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:55:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:55:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:55:03 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 19:55:03 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 19:55:03 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 19:55:03 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 19:55:03 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 19:55:03 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 19:55:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:55:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:55:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:55:03 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 19:55:03 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 19:55:03 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 19:55:03 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 19:55:03 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 19:55:03 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 19:55:03 INFO - Downloading docopt-0.6.1.tar.gz 19:55:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:55:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:55:04 INFO - Installing collected packages: blobuploader, requests, docopt 19:55:04 INFO - Running setup.py install for blobuploader 19:55:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:55:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:55:04 INFO - Running setup.py install for requests 19:55:04 INFO - Running setup.py install for docopt 19:55:04 INFO - Successfully installed blobuploader requests docopt 19:55:04 INFO - Cleaning up... 19:55:04 INFO - Return code: 0 19:55:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:55:04 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')]} 19:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:04 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')]} 19:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:04 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 0x7f19c14dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f840>, '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 0x130c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130cb60>, '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': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', '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 19:55:04 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 19:55:04 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 19:55:04 INFO - Using env: {'DISPLAY': ':0', 19:55:04 INFO - 'HOME': '/home/cltbld', 19:55:04 INFO - 'LANG': 'en_US.UTF-8', 19:55:04 INFO - 'LANGUAGE': 'en_US:en', 19:55:04 INFO - 'LOGNAME': 'cltbld', 19:55:04 INFO - 'MAIL': '/var/mail/cltbld', 19:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:04 INFO - 'MOZ_NO_REMOTE': '1', 19:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:04 INFO - 'NO_EM_RESTART': '1', 19:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:55:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:55:04 INFO - 'SHELL': '/bin/bash', 19:55:04 INFO - 'SHLVL': '1', 19:55:04 INFO - 'TERM': 'linux', 19:55:04 INFO - 'TMOUT': '86400', 19:55:04 INFO - 'USER': 'cltbld', 19:55:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', 19:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:04 INFO - '_': '/tools/buildbot/bin/python'} 19:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:55:04 INFO - Running setup.py (path:/tmp/pip-XMfBu3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:55:04 INFO - Running setup.py (path:/tmp/pip-rfCU4y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:55:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:55:04 INFO - Running setup.py (path:/tmp/pip-tA6eWm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:55:05 INFO - Running setup.py (path:/tmp/pip-ouVuQ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:55:05 INFO - Running setup.py (path:/tmp/pip-ACfmX6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:55:05 INFO - Running setup.py (path:/tmp/pip-MJqWjC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:55:05 INFO - Running setup.py (path:/tmp/pip-CYsFkz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:55:05 INFO - Running setup.py (path:/tmp/pip-iVO_P6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:55:05 INFO - Running setup.py (path:/tmp/pip-zmSmaS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:55:05 INFO - Running setup.py (path:/tmp/pip-otM2fo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:55:05 INFO - Running setup.py (path:/tmp/pip-0DopgI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:55:05 INFO - Running setup.py (path:/tmp/pip-87DOl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:55:05 INFO - Running setup.py (path:/tmp/pip-EFCyjA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:55:05 INFO - Running setup.py (path:/tmp/pip-WQtC_X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:55:05 INFO - Running setup.py (path:/tmp/pip-HhlSJS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:55:05 INFO - Running setup.py (path:/tmp/pip-PF2dli-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:55:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:55:05 INFO - Running setup.py (path:/tmp/pip-_UKs_M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:55:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:55:06 INFO - Running setup.py install for manifestparser 19:55:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:55:06 INFO - Running setup.py install for mozcrash 19:55:06 INFO - Running setup.py install for mozdebug 19:55:06 INFO - Running setup.py install for mozdevice 19:55:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:55:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:55:06 INFO - Running setup.py install for mozfile 19:55:06 INFO - Running setup.py install for mozhttpd 19:55:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:55:06 INFO - Running setup.py install for mozinfo 19:55:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:55:06 INFO - Running setup.py install for mozInstall 19:55:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:55:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:55:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:55:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:55:06 INFO - Running setup.py install for mozleak 19:55:06 INFO - Running setup.py install for mozlog 19:55:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:55:07 INFO - Running setup.py install for moznetwork 19:55:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:55:07 INFO - Running setup.py install for mozprocess 19:55:07 INFO - Running setup.py install for mozprofile 19:55:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:55:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:55:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:55:07 INFO - Running setup.py install for mozrunner 19:55:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:55:07 INFO - Running setup.py install for mozscreenshot 19:55:07 INFO - Running setup.py install for moztest 19:55:07 INFO - Running setup.py install for mozversion 19:55:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:55:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:55:07 INFO - Cleaning up... 19:55:07 INFO - Return code: 0 19:55:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:55:07 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')]} 19:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:07 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')]} 19:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:07 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 0x7f19c14dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f840>, '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 0x130c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130cb60>, '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': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', '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 19:55:07 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 19:55:07 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 19:55:07 INFO - Using env: {'DISPLAY': ':0', 19:55:07 INFO - 'HOME': '/home/cltbld', 19:55:07 INFO - 'LANG': 'en_US.UTF-8', 19:55:07 INFO - 'LANGUAGE': 'en_US:en', 19:55:07 INFO - 'LOGNAME': 'cltbld', 19:55:07 INFO - 'MAIL': '/var/mail/cltbld', 19:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:07 INFO - 'MOZ_NO_REMOTE': '1', 19:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:07 INFO - 'NO_EM_RESTART': '1', 19:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:55:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:55:07 INFO - 'SHELL': '/bin/bash', 19:55:07 INFO - 'SHLVL': '1', 19:55:07 INFO - 'TERM': 'linux', 19:55:07 INFO - 'TMOUT': '86400', 19:55:07 INFO - 'USER': 'cltbld', 19:55:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', 19:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:07 INFO - '_': '/tools/buildbot/bin/python'} 19:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:55:08 INFO - Running setup.py (path:/tmp/pip-pdC4XK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:55:08 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)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:55:08 INFO - Running setup.py (path:/tmp/pip-0w9pIm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:55:08 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)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:55:08 INFO - Running setup.py (path:/tmp/pip-9k3dzC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:55:08 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)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:55:08 INFO - Running setup.py (path:/tmp/pip-uDA0jd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:55:08 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)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:55:08 INFO - Running setup.py (path:/tmp/pip-2YR59Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:55:08 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)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:55:08 INFO - Running setup.py (path:/tmp/pip-jJ1Jng-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:55:08 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)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:55:08 INFO - Running setup.py (path:/tmp/pip-2tkqO7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:55:08 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)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:55:08 INFO - Running setup.py (path:/tmp/pip-ZU0vKM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:55:08 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)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:55:08 INFO - Running setup.py (path:/tmp/pip-YfrKxb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:55:08 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)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:55:08 INFO - Running setup.py (path:/tmp/pip-o_q4d9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:55:08 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)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:55:08 INFO - Running setup.py (path:/tmp/pip-fhl0cl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:55:08 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)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:55:08 INFO - Running setup.py (path:/tmp/pip-MOJxjW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:55:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:55:08 INFO - Running setup.py (path:/tmp/pip-hNI_T6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:55:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:55:08 INFO - Running setup.py (path:/tmp/pip-gIHzCN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:55:09 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)) 19:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:55:09 INFO - Running setup.py (path:/tmp/pip-G_4xuv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:55:09 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)) 19:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:55:09 INFO - Running setup.py (path:/tmp/pip-HdXCDP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:55:09 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)) 19:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:55:09 INFO - Running setup.py (path:/tmp/pip-MHm0im-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:55:09 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)) 19:55:09 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)) 19:55:09 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)) 19:55:09 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)) 19:55:09 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)) 19:55:09 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)) 19:55:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:55:09 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 19:55:09 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 19:55:09 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 19:55:09 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 19:55:09 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 19:55:09 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 19:55:10 INFO - Downloading blessings-1.5.1.tar.gz 19:55:10 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:55:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:55:11 INFO - Installing collected packages: blessings 19:55:11 INFO - Running setup.py install for blessings 19:55:11 INFO - Successfully installed blessings 19:55:11 INFO - Cleaning up... 19:55:11 INFO - Return code: 0 19:55:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:55:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:55:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:55:11 INFO - Reading from file tmpfile_stdout 19:55:11 INFO - Current package versions: 19:55:11 INFO - argparse == 1.2.1 19:55:11 INFO - blessings == 1.5.1 19:55:11 INFO - blobuploader == 1.2.4 19:55:11 INFO - docopt == 0.6.1 19:55:11 INFO - manifestparser == 1.1 19:55:11 INFO - mozInstall == 1.12 19:55:11 INFO - mozcrash == 0.16 19:55:11 INFO - mozdebug == 0.1 19:55:11 INFO - mozdevice == 0.47 19:55:11 INFO - mozfile == 1.2 19:55:11 INFO - mozhttpd == 0.7 19:55:11 INFO - mozinfo == 0.9 19:55:11 INFO - mozleak == 0.1 19:55:11 INFO - mozlog == 3.1 19:55:11 INFO - moznetwork == 0.27 19:55:11 INFO - mozprocess == 0.22 19:55:11 INFO - mozprofile == 0.28 19:55:11 INFO - mozrunner == 6.11 19:55:11 INFO - mozscreenshot == 0.1 19:55:11 INFO - mozsystemmonitor == 0.0 19:55:11 INFO - moztest == 0.7 19:55:11 INFO - mozversion == 1.4 19:55:11 INFO - psutil == 3.1.1 19:55:11 INFO - requests == 1.2.3 19:55:11 INFO - wsgiref == 0.1.2 19:55:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:55:11 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')]} 19:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:11 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')]} 19:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:11 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 0x7f19c14dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f840>, '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 0x130c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130cb60>, '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': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', '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 19:55:11 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 19:55:11 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 19:55:11 INFO - Using env: {'DISPLAY': ':0', 19:55:11 INFO - 'HOME': '/home/cltbld', 19:55:11 INFO - 'LANG': 'en_US.UTF-8', 19:55:11 INFO - 'LANGUAGE': 'en_US:en', 19:55:11 INFO - 'LOGNAME': 'cltbld', 19:55:11 INFO - 'MAIL': '/var/mail/cltbld', 19:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:11 INFO - 'MOZ_NO_REMOTE': '1', 19:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:11 INFO - 'NO_EM_RESTART': '1', 19:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:55:11 INFO - 'PWD': '/builds/slave/test-pgo', 19:55:11 INFO - 'SHELL': '/bin/bash', 19:55:11 INFO - 'SHLVL': '1', 19:55:11 INFO - 'TERM': 'linux', 19:55:11 INFO - 'TMOUT': '86400', 19:55:11 INFO - 'USER': 'cltbld', 19:55:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', 19:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:11 INFO - '_': '/tools/buildbot/bin/python'} 19:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:11 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)) 19:55:11 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)) 19:55:11 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)) 19:55:11 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)) 19:55:11 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)) 19:55:11 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)) 19:55:11 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)) 19:55:11 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)) 19:55:11 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)) 19:55:11 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)) 19:55:11 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)) 19:55:11 INFO - Cleaning up... 19:55:11 INFO - Return code: 0 19:55:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:55:11 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')]} 19:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:11 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')]} 19:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:11 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 0x7f19c14dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f840>, '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 0x130c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130cb60>, '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': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', '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 19:55:11 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 19:55:11 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 19:55:11 INFO - Using env: {'DISPLAY': ':0', 19:55:11 INFO - 'HOME': '/home/cltbld', 19:55:11 INFO - 'LANG': 'en_US.UTF-8', 19:55:11 INFO - 'LANGUAGE': 'en_US:en', 19:55:11 INFO - 'LOGNAME': 'cltbld', 19:55:11 INFO - 'MAIL': '/var/mail/cltbld', 19:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:11 INFO - 'MOZ_NO_REMOTE': '1', 19:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:11 INFO - 'NO_EM_RESTART': '1', 19:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:55:11 INFO - 'PWD': '/builds/slave/test-pgo', 19:55:11 INFO - 'SHELL': '/bin/bash', 19:55:11 INFO - 'SHLVL': '1', 19:55:11 INFO - 'TERM': 'linux', 19:55:11 INFO - 'TMOUT': '86400', 19:55:11 INFO - 'USER': 'cltbld', 19:55:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', 19:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:11 INFO - '_': '/tools/buildbot/bin/python'} 19:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:11 INFO - Downloading/unpacking jsonschema 19:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:55:13 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 19:55:13 INFO - Downloading/unpacking functools32 (from jsonschema) 19:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:13 INFO - Downloading functools32-3.2.3-2.tar.gz 19:55:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:55:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:55:13 INFO - warning: no files found matching '*.txt' 19:55:13 INFO - no previously-included directories found matching 'build' 19:55:13 INFO - no previously-included directories found matching 'dist' 19:55:13 INFO - no previously-included directories found matching '.git*' 19:55:13 INFO - Installing collected packages: jsonschema, functools32 19:55:13 INFO - Running setup.py install for functools32 19:55:13 INFO - warning: no files found matching '*.txt' 19:55:13 INFO - no previously-included directories found matching 'build' 19:55:13 INFO - no previously-included directories found matching 'dist' 19:55:13 INFO - no previously-included directories found matching '.git*' 19:55:13 INFO - Successfully installed jsonschema functools32 19:55:13 INFO - Cleaning up... 19:55:14 INFO - Return code: 0 19:55:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:55:14 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')]} 19:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:14 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')]} 19:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:14 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 0x7f19c14dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f840>, '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 0x130c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130cb60>, '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': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', '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 19:55:14 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 19:55:14 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 19:55:14 INFO - Using env: {'DISPLAY': ':0', 19:55:14 INFO - 'HOME': '/home/cltbld', 19:55:14 INFO - 'LANG': 'en_US.UTF-8', 19:55:14 INFO - 'LANGUAGE': 'en_US:en', 19:55:14 INFO - 'LOGNAME': 'cltbld', 19:55:14 INFO - 'MAIL': '/var/mail/cltbld', 19:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:14 INFO - 'MOZ_NO_REMOTE': '1', 19:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:14 INFO - 'NO_EM_RESTART': '1', 19:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:55:14 INFO - 'PWD': '/builds/slave/test-pgo', 19:55:14 INFO - 'SHELL': '/bin/bash', 19:55:14 INFO - 'SHLVL': '1', 19:55:14 INFO - 'TERM': 'linux', 19:55:14 INFO - 'TMOUT': '86400', 19:55:14 INFO - 'USER': 'cltbld', 19:55:14 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', 19:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:14 INFO - '_': '/tools/buildbot/bin/python'} 19:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:14 INFO - Downloading/unpacking flake8 19:55: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 19:55: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 19:55: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 19:55: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 19:55: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 19:55: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 19:55:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:55:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 19:55:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:55: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 19:55: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 19:55: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 19:55: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 19:55: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 19:55: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 19:55:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:55:16 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 19:55:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:16 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 19:55:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:55:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:55:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:55:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:55:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:55:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:55:16 INFO - no previously-included directories found matching 'docs/_build' 19:55:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:55:16 INFO - Running setup.py install for pep8 19:55:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:55:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:55:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:55:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:55:16 INFO - no previously-included directories found matching 'docs/_build' 19:55:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:55:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:55:16 INFO - Cleaning up... 19:55:16 INFO - Return code: 0 19:55:16 INFO - Running post-action listener: _resource_record_post_action 19:55:16 INFO - Running post-action listener: _start_resource_monitoring 19:55:16 INFO - Starting resource monitoring. 19:55:16 INFO - ##### 19:55:16 INFO - ##### Running install step. 19:55:16 INFO - ##### 19:55:16 INFO - Running pre-action listener: _resource_record_pre_action 19:55:16 INFO - Running main action method: install 19:55:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:55:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:55:17 INFO - Reading from file tmpfile_stdout 19:55:17 INFO - Detecting whether we're running mozinstall >=1.0... 19:55:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:55:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:55:17 INFO - Reading from file tmpfile_stdout 19:55:17 INFO - Output received: 19:55:17 INFO - Usage: mozinstall [options] installer 19:55:17 INFO - Options: 19:55:17 INFO - -h, --help show this help message and exit 19:55:17 INFO - -d DEST, --destination=DEST 19:55:17 INFO - Directory to install application into. [default: 19:55:17 INFO - "/builds/slave/test-pgo"] 19:55:17 INFO - --app=APP Application being installed. [default: firefox] 19:55:17 INFO - mkdir: /builds/slave/test-pgo/build/application 19:55:17 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'] 19:55:17 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 19:55:33 INFO - Reading from file tmpfile_stdout 19:55:33 INFO - Output received: 19:55:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:55:33 INFO - Running post-action listener: _resource_record_post_action 19:55:33 INFO - ##### 19:55:33 INFO - ##### Running run-tests step. 19:55:33 INFO - ##### 19:55:33 INFO - Running pre-action listener: _resource_record_pre_action 19:55:33 INFO - Running main action method: run_tests 19:55:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:55:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:55:33 INFO - Python 2.7.3 19:55:33 INFO - Return code: 0 19:55:33 INFO - grabbing minidump binary from tooltool 19:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:33 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 0x139f840>, '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 0x130c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:55:33 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 19:55:33 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 19:55:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:55:33 INFO - Return code: 0 19:55:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:55:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:55:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:55:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:55:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:55:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:55:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:55:34 INFO - Return code: 0 19:55:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 19:55:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 19:55:34 INFO - Using env: {'DISPLAY': ':0', 19:55:34 INFO - 'HOME': '/home/cltbld', 19:55:34 INFO - 'LANG': 'en_US.UTF-8', 19:55:34 INFO - 'LANGUAGE': 'en_US:en', 19:55:34 INFO - 'LOGNAME': 'cltbld', 19:55:34 INFO - 'MAIL': '/var/mail/cltbld', 19:55:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:55:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:34 INFO - 'MOZ_NO_REMOTE': '1', 19:55:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:55:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:34 INFO - 'NO_EM_RESTART': '1', 19:55:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:55:34 INFO - 'PWD': '/builds/slave/test-pgo', 19:55:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:55:34 INFO - 'SHELL': '/bin/bash', 19:55:34 INFO - 'SHLVL': '1', 19:55:34 INFO - 'TERM': 'linux', 19:55:34 INFO - 'TMOUT': '86400', 19:55:34 INFO - 'USER': 'cltbld', 19:55:34 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941', 19:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:34 INFO - '_': '/tools/buildbot/bin/python'} 19:55:34 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:55:34 INFO - mozversion application_buildid: 20160111173004 19:55:34 INFO - mozversion application_changeset: b7d00293390bd54000b6dedc3e0d31020f2fd2b1 19:55:34 INFO - mozversion application_display_name: Nightly 19:55:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:55:34 INFO - mozversion application_name: Firefox 19:55:34 INFO - mozversion application_remotingname: firefox 19:55:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:55:34 INFO - mozversion application_vendor: Mozilla 19:55:34 INFO - mozversion application_version: 46.0a1 19:55:34 INFO - mozversion platform_buildid: 20160111173004 19:55:34 INFO - mozversion platform_changeset: b7d00293390bd54000b6dedc3e0d31020f2fd2b1 19:55:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:55:34 INFO - mozversion platform_version: 46.0a1 19:55:34 INFO - using testdate: 1452570934 19:55:34 INFO - actual date: 1452570934 19:55:34 INFO - starting webserver on 'localhost:36054' 19:55:34 INFO - SUITE-START | Running 3 tests 19:55:34 INFO - TEST-START | dromaeo_css 19:55:34 INFO - operating with platform_type : linux_ 19:55:34 INFO - Initialising browser for dromaeo_css test... 19:55:34 INFO - TEST-INFO | started process 7356 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxRdkRl/profile http://localhost:36054/getInfo.html) 19:55:39 INFO - PROCESS | 7356 | __metrics Screen width/height:1600/1200 19:55:39 INFO - PROCESS | 7356 | colorDepth:24 19:55:39 INFO - PROCESS | 7356 | Browser inner width/height: 1024/697 19:55:39 INFO - PROCESS | 7356 | __metrics 19:55:39 INFO - PROCESS | 7356 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:55:39 INFO - PROCESS | 7356 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:55:39 INFO - TEST-INFO | 7356: exit 0 19:55:39 INFO - Browser initialized. 19:55:39 INFO - Running cycle 1/1 for dromaeo_css test... 19:55:39 INFO - TEST-INFO | started process 7454 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxRdkRl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:55:51 INFO - PROCESS | 7454 | RSS: Main: 148283392 19:55:51 INFO - PROCESS | 7454 | 19:56:43 INFO - PROCESS | 7454 | 1452571003422 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] 19:58:51 INFO - PROCESS | 7454 | Cycle 1(1): loaded http://localhost:36054/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36054/tests/dromaeo/cssquery-ext.html) 19:58:52 INFO - PROCESS | 7454 | RSS: Main: 268550144 19:58:52 INFO - PROCESS | 7454 | 20:01:55 INFO - PROCESS | 7454 | Cycle 1(1): loaded http://localhost:36054/tests/dromaeo/cssquery-ext.html (next: http://localhost:36054/tests/dromaeo/cssquery-jquery.html) 20:01:55 INFO - PROCESS | 7454 | RSS: Main: 229871616 20:01:55 INFO - PROCESS | 7454 | 20:04:57 INFO - PROCESS | 7454 | Cycle 1(1): loaded http://localhost:36054/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36054/tests/dromaeo/cssquery-mootools.html) 20:04:58 INFO - PROCESS | 7454 | RSS: Main: 242769920 20:04:58 INFO - PROCESS | 7454 | 20:08:00 INFO - PROCESS | 7454 | Cycle 1(1): loaded http://localhost:36054/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36054/tests/dromaeo/cssquery-prototype.html) 20:08:00 INFO - PROCESS | 7454 | RSS: Main: 212545536 20:08:00 INFO - PROCESS | 7454 | 20:11:03 INFO - PROCESS | 7454 | Cycle 1(1): loaded http://localhost:36054/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36054/tests/dromaeo/cssquery-yui.html) 20:11:03 INFO - PROCESS | 7454 | RSS: Main: 216129536 20:11:03 INFO - PROCESS | 7454 | 20:14:06 INFO - PROCESS | 7454 | Cycle 1(1): loaded http://localhost:36054/tests/dromaeo/cssquery-yui.html (next: http://localhost:36054/tests/dromaeo/cssquery-dojo.html) 20:14:06 INFO - PROCESS | 7454 | RSS: Main: 300339200 20:14:06 INFO - PROCESS | 7454 | 20:14:06 INFO - PROCESS | 7454 | __start_tp_report 20:14:06 INFO - PROCESS | 7454 | _x_x_mozilla_page_load 20:14:06 INFO - PROCESS | 7454 | _x_x_mozilla_page_load_details 20:14:06 INFO - PROCESS | 7454 | |i|pagename|runs| 20:14:06 INFO - PROCESS | 7454 | |0;dojo.html;3081.722644961954;3152.7635427342957;3189.4737368334227;3190.489521676532;3217.533457648641;4940.135476291653;4998.500149985;5074.999999999995;5091.058154241463;5136.794528218871;5025.447200807908;5038.067957427878;5060.165072762989;5156.948430515694;5170.922436163461;4592.471865735433;4594.770261486929;4598.540145985391;4641.651876109288;4675.438947326325;4553.521880202581;4650.488446270908;4675.368825208604;4735.029318989599;4736.8578942631775;4587.357769912215;4596.747178905159;4597.241455159895;4645.674802763791;4679.344891715128;4642.0715856828765;4650.279206722963;4650.930236046462;4666.23007203811;4668.719876807369;4627.329037289608;4630.189716799547;4632.351470794091;4633.837815676469;4667.789949452283;4806.7836947337455;4896.045271172123;4938.80244790208;4982.277569752366;4989.875253118665;5404.270423492818;5456.863578410532;5462.6995515247045;5465.098258787295;5518.448155184489;5434.3207099112615;5464.726763661801;5464.9453505464835;5465.6447330923365;5478.479544443271;4978.751062446863;5055.848324550269;5069.923951140736;5093.898122037575;5167.302414174076;5482.0406428874785;5491;5503.229547863302;5513.09034009392;5562.193481945095;5318.175682769177;5323.334583177103;5324.334458192726;5337.546308563816;5370.382406023279;5296.629235953524;5371.140617501181;5396.1905714143195;5411.998780225671;5462.371827239839;5362.061639213122;5379.973100134474;5380.650257733235;5390.272313237662;5398;5383.2194331821665;5398.676079435247;5401.405845357008;5408.02655522002;5453.209284653703;4233.957660423418;4234.894127646833;4310.978445107754;4314.7411155330155;4317.050248945227;3808.5048943637703;3841.3469710149343;3845.9615403846165;3878.631530004645;3885.1258466844733;5075.187969924795;5108.948910510921;5121.234533351948;5121.667091639031;5124.590032797368;5237.8428647140645;5359.410464848941;5413.2150838128255;5471.23402723619;5524.364698059694;5051.1413059779925;5100.719460429637;5105.795768169306;5107.795688172431;5150.356205474316;4624.237000894882;4706.152892479318;4726.243800991893;4727.929081063787;4734.26618874075;5632.718364081779;5672.064109421899;5679.488846003879;5700.372958974593;5743.368229494752;5435.510804027656;5441;5441.238226648194;5443.346798384219;5446.046941785251;5595.608307418604;5689.023845672889;5694.943050569441;5696.544276457957;5700.828975130753;5324.307839980777;5372.5433338166695;5373.435789242073;5378.112611419228;5422.918656220081;5380.139177731544;5400.83797486076;5405.837824865261;5417.052015897123;5439.945600543944;5169.638125331191;5259.789608415621;5268.81559145428;5286.603504737237;5300.893982120258;5312.4156342803035;5319.547838433777;5334.039872822929;5335.653182543122;5337.332833395825;5219.321488206509;5222.55608273301;5233.816816411408;5238.973805131102;5268.262443258023;5132.46109158533;5256.947430525645;5257.053730328577;5303.496167864047;5312.760925758427;5207.932373863425;5295.099833028471;5297.205419187153;5299.125644268653;5336 20:14:06 INFO - PROCESS | 7454 | |1;ext.html;506.9493050694931;515.6287473019427;520.9270702101704;534.7566857080029;546.1371033766649;28091;28672.283192920186;28682.13953581396;28723.71276287234;28732.13803585896;35441.82279088607;35568.2886342273;35568.644313556855;35625.46561801569;35686.286274274564;8376.581170941443;8577;8578.828423431527;8579.099194584542;8584;8297.211764882326;8440.662373505053;8443.451175673592;8444.57777111145;8448.74653760385;8376.748697539084;8467.872981905277;8476.110008449117;8480.957595212016;8484;8342.332613390914;8406.537640429744;8409.579521023985;8424.199701028392;8425.662973481054;8262.669493220264;8391.244787969112;8566.229039386486;8582.828343433159;8587.785305367353;39211;39642.40536391956;39651.40522892159;39718.20563588741;39748;3406.8466918988706;3574.946375804365;3887.3974533947285;3958.2281455116263;4022.1352409232154;29556.556651650244;29758.256043598867;29978.70021299781;30031.69968300311;31153.532697009563;3494.178867966026;3647.1793846384617;3653.2510835278704;3719.609441008682;3782.3569993101237;257139;258576;258838;259345;259647.70176149186;57428.42571574314;57732.422675773545;57799;57951.71024144852;57964.71017644885;60097.699511502164;60336;60468.39531604716;60654;60667.39332606706;14321.427142914376;14429.711405772036;14645.633859153393;14666.85333146655;14770.26148692561;11255.943720281346;11259.211855170222;11262.549498020151;11263.774724505463;11296.887031129749;17866.11212557908;19386;19408.320708775125;19463.416097517096;19493.122809473607;6183.81448556544;7008.719651213996;7357.411407087528;7375.11498620169;7469.290417410446;958.4393130018877;979.9576745923067;1034.6239501463187;1096.4188979840696;1107.479484642217;31547.84226078901;32201;32458.508125027747;34755.652443475745;35014.47478287828;950.2208189284859;1015.4161357219629;1038.717184277417;1054.8734151901667;1115.8437818705388;12806.61580152597;15092.622684432978;15517.224138793015;16044.753734477183;16060.134836373049;411488;415791;417551;417804;418013;54552.72723636436;55441.168382474294;55470.44529554733;55574.16638750422;55636;1350.8649135086412;1351.2770667692737;1380.9102408343626;1384.729977654368;1393.9721205575831;28971.42057158887;30153.698463015087;30432.84783576068;31023.84488077545;31309.53035704421;45533.31700024436;46119.76940115278;46122.53877461182;46167.76916115398;46173.30740038969;289226;291365;291470;291527;292273;39765;40946.59053409428;41459.37810932778;41719;41734.373984389655;44688.32967505555;44901.1019779596;44930.77534612306;45778.31332529948;45905.540944590124;32527.837360813046;37277.4408383869;37669.81165094157;38791.41812872753;39558.40662390009;31874.681253187173;35901.28197436089;36027.63972360243;36342.454863177605;36928.81535592305;32961.83519082389;33170.66829331772;33267.66732332743;33277.50083748794;33292.833535832164;26005.869970650027;30277.697223028368;30681.232969175056;30761.692383075882;30844.22889427782;24484.755152448248;24805;24921.501569968135;24963.251102466955;25219 20:14:06 INFO - PROCESS | 7454 | |2;jquery.html;361.58417819507565;361.86249225294387;363.73810856183553;364.4114754671207;365.4317536231159;13435.865641343584;13917.443302267922;15860.206989650515;16128.516144515668;16948.491545253648;14634.414623415078;15358.616034599141;15778.21108944551;15783;16216;5189.377274727038;5383.4616538346045;5383.703896285702;5386.218998245252;5386.353637563498;3971.8212680429306;4113.465249517559;5269.341332333458;5375.0593646111965;5673.943260567383;5789.884202315951;5984.401559844003;6026.608270462428;6034.909476357858;6042.546808989321;5879.88240235195;5929.347771745104;5933.169356290123;5941.643501389887;5944.910826337608;5235.659682120688;5238.345206849144;6134.570580059398;6375.362463753634;6380.425761681471;20329;20695;20997.5800483991;22645.547089058127;22668.546629067492;2005.9699104513445;2089.5716378142442;2157.5792720419527;2177.7604463509;2271.7387500437494;13034.80447793284;13178.34108294591;13609.931950340186;13842.515511957134;14258.572242832732;1900.3348827910258;1910.3695780392436;1931.7102434634917;1958.0014192761653;2028.3407892435018;60519;64861.67569162124;64938.350616493706;64961.35038649647;65708.67145664289;14535.854641453661;14772.778408323884;14773.409063637335;14781.26093695311;14831.555053348417;22465.550688986128;22595.43511412228;22596.774032259465;22770.31689049331;23012.539749204923;8662.436941598777;8723;8725.738227853175;8736.170063843925;8758.605862736193;7687.154413014564;7698.846023079507;7710.845783084307;7773.067231932205;7786.883196752054;7569.962150189324;7612.276833700789;7616.01983484287;7618.238176182337;7626.618669066635;2539.7333280005705;2971.5877991740317;3036.8633411496535;3037.635483741921;3042.6653068162927;409.9672026237894;417.7305637863561;417.7785773540029;435.7603318174991;808.4664121679663;9846;10247.846282305622;10328.793424131476;10339.276250662531;10418.583256669648;429.6992105526082;432.1788601656877;435.7211384713786;440.5748452743118;442.99335509967375;5074.771635276422;5668.178114173505;5699.088145896637;5709.3434255060365;5788.160716696139;447350;497457;522472;538576;541069;73068.99999999894;73378;73863.63068184625;74290;74518.6274068637;1008.1732978957331;1052.3790963331824;1085.066842515436;1116.826891831751;1117.2905205194759;13935.58193254204;14169.36237869319;14353;14441.711165776836;14694.706105878036;30351.696483034888;30540.847295764266;30643.387132256783;31202.531962020134;31338.843305783324;40064.99837504086;40373.1925361497;40424.59575404326;40430.393544096274;40556.59443405646;2940.220841477053;2960.259935016246;4885.706857588556;6960.025596416607;7204.9913012177285;10578.523966421375;10705.732356691145;10896.782064358827;11192.104631629612;11368.374739389414;9268.424367857346;9412.95293523528;9592.616295348387;9613.471259080818;9682.85475717879;9749.830020397598;9866.35868668563;9915.95042024814;9944.701658950244;9978.301518893608;7571.690634356574;9492.85760713576;9693.176080033276;9779.60881564758;9847;7377.889331660137;9378.765530861783;9430.858537122085;9722.659706910224;9747.902520974983;9585.472798996123;9948.55231514598;9960.850587241343;10154;10568.10171135462 20:14:06 INFO - PROCESS | 7454 | |3;mootools.html;1265.6519457149277;1404.2487269310918;1411.3437251677972;1522.4595268679618;1734.9653006939855;6791.354821291976;7338.853222935538;7451.664675089621;7510.474266801326;7516.661750221239;7123.180834204068;7237.601931893743;7245.384142347907;7317.853642927138;7326.670299836507;2268.0474200835647;2278.8176945844293;2286.531261091472;2287.7712228777154;2288.5651726171973;2239.8656080635133;2250.0999600159985;2296.5980953333183;2301.6777651128773;2317.478567322356;2259.604569200392;2273.3975496493445;2277.077783497686;2280.8631482111127;2286.5655525450193;2222.7443843957826;2250.1674380479244;2263.649134384173;2264.7961683448484;2267.8299127565497;2217.124235926816;2220.489287463892;2221.1781640792847;2223.1552010236005;2223.1774243529835;7677.692892284358;7717.073951125844;7720.459567830254;7725.4205934554575;7738.729144479972;4592.471865735416;4722.456917454502;4726.385569875929;4731.124741922756;4750.691205071659;3042.4523585754555;3087.552304915797;3154.5899033125775;3181.7136457718916;3194.073718621597;959.3284700709462;962.2782912815388;966.1160038564705;971.7667759737612;1010.3988127064385;10440.164786817037;10513.84229236562;10514.579416823395;10528.684139475828;10552.419616921066;4242.596953289432;4278.89302767427;4316.827326906951;4327.913441731148;4332.805023773938;9086.81826363469;9087.636494540144;9101.81796364069;9103.453792772454;9103.90896091044;4795.568398844121;4798.088363210979;4804.375431193923;4808.591269742111;4811.446683631357;3813.618638136164;3873.477080594084;4228.238916994909;4330.372096046119;4380.8685739427865;3708.2583483302906;3750.6999440044733;3764.322421964018;3769.2838360711376;3772.1701225730294;1179.3277831636058;1214.9514019439123;1219.469565695047;1220.798568236249;1238.238483332762;970.6020531582018;979.153032626787;980.4607465893872;1074.2802322443981;1305.034274636762;7138.072050633385;7256.709731610782;7267.709291628382;7267.7819665410125;7279.090113735783;464.1830378533805;476.5877515948749;486.72013592184635;487.55875932280634;489.2685435274217;5431.945680543144;5469.808556700496;5470.179473078991;5472.72636368188;5473.972630136824;8912.376133670581;8947.731568052968;9117.954410227907;9127.22418594427;9134.81730365389;9046.321525885585;9099.727008189764;9109.90890091104;9118.40730352525;9119.772005699779;7004.089468369079;7116.430685545248;7174.533655312388;7191.64041797908;7203.351698347279;6836.077129587442;6904.620245886324;6910.585364878123;6914.827129321807;6925.099737034153;7994.640241189044;8151.592420378839;8179.468334558234;8306.750797476085;8308.252257296872;8124.8781268279845;8382.119877412784;8513.148685131437;8552.187542183483;8587.22714955632;5908.113782932594;6314.179156709598;6608.4052435281055;6852.5203235773015;6969.58182509051;7059.929400705927;7072.646367681698;7097.361237488651;7132.500724949411;7146.285371462812;6503.187101612299;6714.362135597111;6728.091707619409;6850.9314906850295;6864.38220560152;6529.477641788741;6566.9014964776525;6581.638009909501;6594.604323740591;6743.089682892943;6421.646809425526;6451.806445806634;6465.870682586228;6468.773592924414;6476.676166191766;6283.622982621057;6434.581752186093;6434.742610295536;6435.195600549931;6435.4529864962005;6456.451201647725;6529.967350163219;6530.216374035146;6533.150690410216;6540.444062254762 20:14:06 INFO - PROCESS | 7454 | |4;prototype.html;331.7545016687651;340.14284004309144;343.23287452543576;345.5197275786656;352.6649682801338;5661.094224924013;5785.27684039495;5794.0729483282685;5803.071508558632;5846.64920104793;5666.178404131399;5700.002499562581;5798.768049278035;5807.361190269067;5823.475887170154;4474.418325617665;4474.910501789954;4475.172093162759;4482.775861206943;4487.887802804923;4278.657707383418;4356.041670832412;4381.16757816014;4479.798409071584;4493.0564581437775;4449.532799056101;4461.040876211614;4472.1055788842195;4480.48474425442;4481.843135490259;4454.8886277842985;4475.5748203920575;4479.932801007955;4481.955180448203;4482.350059241425;3912.921741565181;3961.722679412442;3962.1085255817497;3966.8214930328204;3969.4839670842894;5341.572674186055;5493.862653433696;5496.1755736639425;5497.092979658351;5507.7246137693355;5103.923441148386;5111.386633603955;5146.974265128651;5147.922781158286;5150.3047088642925;6110.297315808694;6125.601835880653;6126.142340072393;6131.110988906628;6136.570440069197;4100.610442008005;4172.102997855445;4184.28867092595;4245.554216807222;4253.1706317268145;6230.813075607739;6309.495240380758;6361.809145725636;6362.395572420613;6368.363163683594;4354.455693038371;4356.041670832412;4362.672799540047;4369.541198174209;4373.147236288957;4328.285832837547;4416.580424859633;4418.955810441918;4428.645708343325;4437.5784300491405;5084.644074914794;5085.949140508622;5096.133657278272;5096.235564665256;5096.464871188472;6132.386761323832;6133.1413602095745;6134.141220229171;6135.233095863017;6137.631742095488;1550.7518796992426;1565.763047192705;1574.8031496062993;1577.7869987551762;1578.4633224703655;1038.6883934819523;1047.994760026195;1050.6112738286884;1054.6045233037612;1076.7308172956762;5839.299284085937;5842.970785146132;5848.239728835224;5848.941510584925;5859.53123750099;6274.937250627435;6283.434490895841;6283.717232724538;6283.905741413882;6286.528510361742;5835.620684655484;5846.649201047951;5847.415258474119;5874.236349274567;5906.675132867734;3276.6231883333244;3406.386850366908;3410.198603328216;3410.5054767058637;3412.5563676721868;6617.941129419366;6620.5034622402545;6624.668766561653;6628;6637;6435.099086127946;6443.548951573345;6447.516436267299;6449.774257900951;6462.386073323027;6491.7078731457195;6592.9340706593275;6624.900626490607;6650.567713098633;6730.091437655854;6353.7140828661895;6354.142190804182;6354.205724284465;6357.491400688026;6357.809265722036;6064.48451881595;6162.969185154046;6196.783112591038;6293.118963345227;6351.872962540816;6661.067450557023;6674.199096108498;6676.265610782907;6680.799576012533;6695.196576410862;4405.80173892182;4435.711678740871;4440.489343725384;4444.400005999278;4444.511103778517;6178.227721534809;6313.147725057059;6346.809595712136;6352.110704501281;6358.046293056079;6153.907691384722;6155.107509411021;6171.6297022178815;6172.537059720449;6172.938270617236;6155.2613686356135;6168.568200225941;6172.475339596184;6175.62946223228;6179.474744646755;5930.555208359304;6062.939370606237;6072.90890636632;6073.969630151821;6077.4226448487325;6195.81412557624;6206.472449841814;6206.503479721701;6207.6275423474735;6207.906881396873;6060.666663333559;6070.605410648293;6074.088886667036;6075.665838378754;6076.088586712029 20:14:06 INFO - PROCESS | 7454 | |5;yui.html;688.366702633577;774.0208636075364;783.1620166421927;797.5095316380427;835.4694768821798;13228.140170888897;13362.064655474122;13366.465341386345;13382.063255572113;13394.93302533486;10525.263231573794;12274.693132671688;12465.439055242514;12560.246385216893;12668.936655316711;769.3575864153438;786.7482405630201;787.3976408047848;787.9015123109612;787.9763607091768;764.025867019549;765.865973454646;766.0654002117408;766.9118051424074;767.6852490478905;806.1454857850667;815.7471183933;815.8327542853701;820.0487434575894;820.7989042684521;803.5941849366092;813.5525460996429;813.6989313953816;814.6822739131743;815.0097631377874;600.2167171840746;605.4067014325941;606.8270542895253;606.9605475644113;607.3895734786511;12030.27818330903;12071.034317254687;12081.637550873487;12108.394580271039;12126.151169418144;10076.848847267296;10754.300970436896;10926.617568385147;10974.231803773739;11230.3261804292;8682.789293940126;8880.689175878813;9031.909680903238;9634.13292803644;9982.450965196911;3489.4242449995722;3530.3115892400992;3543.1850674345046;3549.503069570236;3686.7419280650365;37906.24187516234;40038.79980600107;41471.1705765886;45002;45140.548594513966;9489.952550237205;9585.472798995983;9713.36863103896;9815.067568580973;9992.550335234931;17955.910220448815;17979.10104494796;18007.549811254823;18033.549161271072;18040;7143.107111611049;7364.116306043309;7809.921900781033;7829.217078292239;7844.294013538809;4274.935875961863;4354.912901742011;4360.171567402183;4380.102079073782;4405.713628614194;2875.683674795771;2883.5098033334384;2885.653721553427;2889.0321742216593;2891.840948747839;553.6733327336891;555.1478480532363;561.2759540193186;565.7171414292853;571.0321005894968;489.8040783686554;514.2308667823796;538.9919151212735;561.6854561445522;617.0559044661675;7365.98361676161;7439.739609113655;7524;7729.690812367555;7774.766756997299;480.72358393922934;496.2407516499761;500.5313179664957;566.2214455124205;570.1874828369639;3587.65917237862;3668.834902429397;3710.6845918096724;4029.5768944261017;4047.170330082326;47380.526194738304;47683;47779;47830;47918.76040619775;46363.536364636595;47004;47155.76422117867;47184.05631887343;48878.51121488811;41513.58486415158;42622.36066459006;44146.337804932955;44929.55070449319;45566.77216613896;7936.246056624612;8133.1053584106885;8164.7958801030445;8195.795105122419;8220.794480138044;30622.540661889645;32324.191895202806;32430;32956.34087318192;33073.669263307056;41210;41780;42161.57838421699;42215.57784422117;42471.78764106159;9134.497602631918;9319.254459643347;9368.203702685076;9564.091411315914;10407.531661075118;12055.336956467128;12182.208156469802;12285;12977.935110324388;13396.196228226338;10071.69784906454;10446.947765261126;10659.14726821868;10776.838347424951;10802.72993175177;10136.543855526666;10458.738531536772;10826.89173108259;10840.837387439353;10850.782984340427;10106.19150467946;10420.270581059556;10813.729656758644;10831;10834.620788272372;9675.172166713142;9905.158061564847;9915.950420247853;9924.603015879284;10148.695539133838;8423.4945903246;8624.353173511887;8926.241269492166;9196.540172991457;9210.125038121369 20:14:06 INFO - PROCESS | 7454 | __end_tp_report 20:14:06 INFO - PROCESS | 7454 | __start_cc_report 20:14:06 INFO - PROCESS | 7454 | _x_x_mozilla_cycle_collect,1016 20:14:06 INFO - PROCESS | 7454 | __end_cc_report 20:14:06 INFO - PROCESS | 7454 | __startTimestamp1452572046565__endTimestamp 20:14:06 INFO - PROCESS | 7454 | 20:14:06 INFO - PROCESS | 7454 | ------- Summary: start ------- 20:14:06 INFO - PROCESS | 7454 | Number of tests: 6 20:14:06 INFO - PROCESS | 7454 | 20:14:06 INFO - PROCESS | 7454 | [#0] dojo.html Cycles:165 Average:5056.16 Median:5238.97 stddev:528.36 (10.1%) stddev-sans-first:506.77 20:14:06 INFO - PROCESS | 7454 | Values: 3081.7 3152.8 3189.5 3190.5 3217.5 4940.1 4998.5 5075.0 5091.1 5136.8 5025.4 5038.1 5060.2 5156.9 5170.9 4592.5 4594.8 4598.5 4641.7 4675.4 4553.5 4650.5 4675.4 4735.0 4736.9 4587.4 4596.7 4597.2 4645.7 4679.3 4642.1 4650.3 4650.9 4666.2 4668.7 4627.3 4630.2 4632.4 4633.8 4667.8 4806.8 4896.0 4938.8 4982.3 4989.9 5404.3 5456.9 5462.7 5465.1 5518.4 5434.3 5464.7 5464.9 5465.6 5478.5 4978.8 5055.8 5069.9 5093.9 5167.3 5482.0 5491.0 5503.2 5513.1 5562.2 5318.2 5323.3 5324.3 5337.5 5370.4 5296.6 5371.1 5396.2 5412.0 5462.4 5362.1 5380.0 5380.7 5390.3 5398.0 5383.2 5398.7 5401.4 5408.0 5453.2 4234.0 4234.9 4311.0 4314.7 4317.1 3808.5 3841.3 3846.0 3878.6 3885.1 5075.2 5108.9 5121.2 5121.7 5124.6 5237.8 5359.4 5413.2 5471.2 5524.4 5051.1 5100.7 5105.8 5107.8 5150.4 4624.2 4706.2 4726.2 4727.9 4734.3 5632.7 5672.1 5679.5 5700.4 5743.4 5435.5 5441.0 5441.2 5443.3 5446.0 5595.6 5689.0 5694.9 5696.5 5700.8 5324.3 5372.5 5373.4 5378.1 5422.9 5380.1 5400.8 5405.8 5417.1 5439.9 5169.6 5259.8 5268.8 5286.6 5300.9 5312.4 5319.5 5334.0 5335.7 5337.3 5219.3 5222.6 5233.8 5239.0 5268.3 5132.5 5256.9 5257.1 5303.5 5312.8 5207.9 5295.1 5297.2 5299.1 5336.0 20:14:06 INFO - PROCESS | 7454 | 20:14:06 INFO - PROCESS | 7454 | [#1] ext.html Cycles:180 Average:48627.01 Median:3650.22 stddev:86663.75 (2374.2%) stddev-sans-first:86831.55 20:14:06 INFO - PROCESS | 7454 | Values: 506.9 515.6 520.9 534.8 546.1 28091.0 28672.3 28682.1 28723.7 28732.1 35441.8 35568.3 35568.6 35625.5 35686.3 8376.6 8577.0 8578.8 8579.1 8584.0 8297.2 8440.7 8443.5 8444.6 8448.7 8376.7 8467.9 8476.1 8481.0 8484.0 8342.3 8406.5 8409.6 8424.2 8425.7 8262.7 8391.2 8566.2 8582.8 8587.8 39211.0 39642.4 39651.4 39718.2 39748.0 3406.8 3574.9 3887.4 3958.2 4022.1 29556.6 29758.3 29978.7 30031.7 31153.5 3494.2 3647.2 3653.3 3719.6 3782.4 257139.0 258576.0 258838.0 259345.0 259647.7 57428.4 57732.4 57799.0 57951.7 57964.7 60097.7 60336.0 60468.4 60654.0 60667.4 14321.4 14429.7 14645.6 14666.9 14770.3 11255.9 11259.2 11262.5 11263.8 11296.9 17866.1 19386.0 19408.3 19463.4 19493.1 6183.8 7008.7 7357.4 7375.1 7469.3 958.4 980.0 1034.6 1096.4 1107.5 31547.8 32201.0 32458.5 34755.7 35014.5 950.2 1015.4 1038.7 1054.9 1115.8 12806.6 15092.6 15517.2 16044.8 16060.1 411488.0 415791.0 417551.0 417804.0 418013.0 54552.7 55441.2 55470.4 55574.2 55636.0 1350.9 1351.3 1380.9 1384.7 1394.0 28971.4 30153.7 30432.8 31023.8 31309.5 45533.3 46119.8 46122.5 46167.8 46173.3 289226.0 291365.0 291470.0 291527.0 292273.0 39765.0 40946.6 41459.4 41719.0 41734.4 44688.3 44901.1 44930.8 45778.3 45905.5 32527.8 37277.4 37669.8 38791.4 39558.4 31874.7 35901.3 36027.6 36342.5 36928.8 32961.8 33170.7 33267.7 33277.5 33292.8 26005.9 30277.7 30681.2 30761.7 30844.2 24484.8 24805.0 24921.5 24963.3 25219.0 20:14:06 INFO - PROCESS | 7454 | 20:14:06 INFO - PROCESS | 7454 | [#2] jquery.html Cycles:180 Average:27146.36 Median:435.74 stddev:83478.49 (19157.8%) stddev-sans-first:83688.44 20:14:06 INFO - PROCESS | 7454 | Values: 361.6 361.9 363.7 364.4 365.4 13435.9 13917.4 15860.2 16128.5 16948.5 14634.4 15358.6 15778.2 15783.0 16216.0 5189.4 5383.5 5383.7 5386.2 5386.4 3971.8 4113.5 5269.3 5375.1 5673.9 5789.9 5984.4 6026.6 6034.9 6042.5 5879.9 5929.3 5933.2 5941.6 5944.9 5235.7 5238.3 6134.6 6375.4 6380.4 20329.0 20695.0 20997.6 22645.5 22668.5 2006.0 2089.6 2157.6 2177.8 2271.7 13034.8 13178.3 13609.9 13842.5 14258.6 1900.3 1910.4 1931.7 1958.0 2028.3 60519.0 64861.7 64938.4 64961.4 65708.7 14535.9 14772.8 14773.4 14781.3 14831.6 22465.6 22595.4 22596.8 22770.3 23012.5 8662.4 8723.0 8725.7 8736.2 8758.6 7687.2 7698.8 7710.8 7773.1 7786.9 7570.0 7612.3 7616.0 7618.2 7626.6 2539.7 2971.6 3036.9 3037.6 3042.7 410.0 417.7 417.8 435.8 808.5 9846.0 10247.8 10328.8 10339.3 10418.6 429.7 432.2 435.7 440.6 443.0 5074.8 5668.2 5699.1 5709.3 5788.2 447350.0 497457.0 522472.0 538576.0 541069.0 73069.0 73378.0 73863.6 74290.0 74518.6 1008.2 1052.4 1085.1 1116.8 1117.3 13935.6 14169.4 14353.0 14441.7 14694.7 30351.7 30540.8 30643.4 31202.5 31338.8 40065.0 40373.2 40424.6 40430.4 40556.6 2940.2 2960.3 4885.7 6960.0 7205.0 10578.5 10705.7 10896.8 11192.1 11368.4 9268.4 9413.0 9592.6 9613.5 9682.9 9749.8 9866.4 9916.0 9944.7 9978.3 7571.7 9492.9 9693.2 9779.6 9847.0 7377.9 9378.8 9430.9 9722.7 9747.9 9585.5 9948.6 9960.9 10154.0 10568.1 20:14:06 INFO - PROCESS | 7454 | 20:14:06 INFO - PROCESS | 7454 | [#3] mootools.html Cycles:180 Average:5307.82 Median:6443.63 stddev:2756.92 (42.8%) stddev-sans-first:2747.91 20:14:06 INFO - PROCESS | 7454 | Values: 1265.7 1404.2 1411.3 1522.5 1735.0 6791.4 7338.9 7451.7 7510.5 7516.7 7123.2 7237.6 7245.4 7317.9 7326.7 2268.0 2278.8 2286.5 2287.8 2288.6 2239.9 2250.1 2296.6 2301.7 2317.5 2259.6 2273.4 2277.1 2280.9 2286.6 2222.7 2250.2 2263.6 2264.8 2267.8 2217.1 2220.5 2221.2 2223.2 2223.2 7677.7 7717.1 7720.5 7725.4 7738.7 4592.5 4722.5 4726.4 4731.1 4750.7 3042.5 3087.6 3154.6 3181.7 3194.1 959.3 962.3 966.1 971.8 1010.4 10440.2 10513.8 10514.6 10528.7 10552.4 4242.6 4278.9 4316.8 4327.9 4332.8 9086.8 9087.6 9101.8 9103.5 9103.9 4795.6 4798.1 4804.4 4808.6 4811.4 3813.6 3873.5 4228.2 4330.4 4380.9 3708.3 3750.7 3764.3 3769.3 3772.2 1179.3 1215.0 1219.5 1220.8 1238.2 970.6 979.2 980.5 1074.3 1305.0 7138.1 7256.7 7267.7 7267.8 7279.1 464.2 476.6 486.7 487.6 489.3 5431.9 5469.8 5470.2 5472.7 5474.0 8912.4 8947.7 9118.0 9127.2 9134.8 9046.3 9099.7 9109.9 9118.4 9119.8 7004.1 7116.4 7174.5 7191.6 7203.4 6836.1 6904.6 6910.6 6914.8 6925.1 7994.6 8151.6 8179.5 8306.8 8308.3 8124.9 8382.1 8513.1 8552.2 8587.2 5908.1 6314.2 6608.4 6852.5 6969.6 7059.9 7072.6 7097.4 7132.5 7146.3 6503.2 6714.4 6728.1 6850.9 6864.4 6529.5 6566.9 6581.6 6594.6 6743.1 6421.6 6451.8 6465.9 6468.8 6476.7 6283.6 6434.6 6434.7 6435.2 6435.5 6456.5 6530.0 6530.2 6533.2 6540.4 20:14:06 INFO - PROCESS | 7454 | 20:14:06 INFO - PROCESS | 7454 | [#4] prototype.html Cycles:180 Average:5145.28 Median:5841.14 stddev:1544.67 (26.4%) stddev-sans-first:1506.16 20:14:06 INFO - PROCESS | 7454 | Values: 331.8 340.1 343.2 345.5 352.7 5661.1 5785.3 5794.1 5803.1 5846.6 5666.2 5700.0 5798.8 5807.4 5823.5 4474.4 4474.9 4475.2 4482.8 4487.9 4278.7 4356.0 4381.2 4479.8 4493.1 4449.5 4461.0 4472.1 4480.5 4481.8 4454.9 4475.6 4479.9 4482.0 4482.4 3912.9 3961.7 3962.1 3966.8 3969.5 5341.6 5493.9 5496.2 5497.1 5507.7 5103.9 5111.4 5147.0 5147.9 5150.3 6110.3 6125.6 6126.1 6131.1 6136.6 4100.6 4172.1 4184.3 4245.6 4253.2 6230.8 6309.5 6361.8 6362.4 6368.4 4354.5 4356.0 4362.7 4369.5 4373.1 4328.3 4416.6 4419.0 4428.6 4437.6 5084.6 5085.9 5096.1 5096.2 5096.5 6132.4 6133.1 6134.1 6135.2 6137.6 1550.8 1565.8 1574.8 1577.8 1578.5 1038.7 1048.0 1050.6 1054.6 1076.7 5839.3 5843.0 5848.2 5848.9 5859.5 6274.9 6283.4 6283.7 6283.9 6286.5 5835.6 5846.6 5847.4 5874.2 5906.7 3276.6 3406.4 3410.2 3410.5 3412.6 6617.9 6620.5 6624.7 6628.0 6637.0 6435.1 6443.5 6447.5 6449.8 6462.4 6491.7 6592.9 6624.9 6650.6 6730.1 6353.7 6354.1 6354.2 6357.5 6357.8 6064.5 6163.0 6196.8 6293.1 6351.9 6661.1 6674.2 6676.3 6680.8 6695.2 4405.8 4435.7 4440.5 4444.4 4444.5 6178.2 6313.1 6346.8 6352.1 6358.0 6153.9 6155.1 6171.6 6172.5 6172.9 6155.3 6168.6 6172.5 6175.6 6179.5 5930.6 6062.9 6072.9 6074.0 6077.4 6195.8 6206.5 6206.5 6207.6 6207.9 6060.7 6070.6 6074.1 6075.7 6076.1 20:14:06 INFO - PROCESS | 7454 | 20:14:06 INFO - PROCESS | 7454 | [#5] yui.html Cycles:180 Average:12695.37 Median:47282.29 stddev:14276.19 (30.2%) stddev-sans-first:14287.77 20:14:06 INFO - PROCESS | 7454 | Values: 688.4 774.0 783.2 797.5 835.5 13228.1 13362.1 13366.5 13382.1 13394.9 10525.3 12274.7 12465.4 12560.2 12668.9 769.4 786.7 787.4 787.9 788.0 764.0 765.9 766.1 766.9 767.7 806.1 815.7 815.8 820.0 820.8 803.6 813.6 813.7 814.7 815.0 600.2 605.4 606.8 607.0 607.4 12030.3 12071.0 12081.6 12108.4 12126.2 10076.8 10754.3 10926.6 10974.2 11230.3 8682.8 8880.7 9031.9 9634.1 9982.5 3489.4 3530.3 3543.2 3549.5 3686.7 37906.2 40038.8 41471.2 45002.0 45140.5 9490.0 9585.5 9713.4 9815.1 9992.6 17955.9 17979.1 18007.5 18033.5 18040.0 7143.1 7364.1 7809.9 7829.2 7844.3 4274.9 4354.9 4360.2 4380.1 4405.7 2875.7 2883.5 2885.7 2889.0 2891.8 553.7 555.1 561.3 565.7 571.0 489.8 514.2 539.0 561.7 617.1 7366.0 7439.7 7524.0 7729.7 7774.8 480.7 496.2 500.5 566.2 570.2 3587.7 3668.8 3710.7 4029.6 4047.2 47380.5 47683.0 47779.0 47830.0 47918.8 46363.5 47004.0 47155.8 47184.1 48878.5 41513.6 42622.4 44146.3 44929.6 45566.8 7936.2 8133.1 8164.8 8195.8 8220.8 30622.5 32324.2 32430.0 32956.3 33073.7 41210.0 41780.0 42161.6 42215.6 42471.8 9134.5 9319.3 9368.2 9564.1 10407.5 12055.3 12182.2 12285.0 12977.9 13396.2 10071.7 10446.9 10659.1 10776.8 10802.7 10136.5 10458.7 10826.9 10840.8 10850.8 10106.2 10420.3 10813.7 10831.0 10834.6 9675.2 9905.2 9916.0 9924.6 10148.7 8423.5 8624.4 8926.2 9196.5 9210.1 20:14:06 INFO - PROCESS | 7454 | -------- Summary: end -------- 20:14:06 INFO - PROCESS | 7454 | 20:14:07 INFO - TEST-INFO | 7454: exit 0 20:14:07 INFO - TEST-OK | dromaeo_css | took 1112719ms 20:14:07 INFO - TEST-START | kraken 20:14:07 INFO - operating with platform_type : linux_ 20:14:07 INFO - Initialising browser for kraken test... 20:14:07 INFO - TEST-INFO | started process 7640 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBNih1P/profile http://localhost:36054/getInfo.html) 20:14:11 INFO - PROCESS | 7640 | __metrics Screen width/height:1600/1200 20:14:11 INFO - PROCESS | 7640 | colorDepth:24 20:14:11 INFO - PROCESS | 7640 | Browser inner width/height: 1024/697 20:14:11 INFO - PROCESS | 7640 | __metrics 20:14:11 INFO - PROCESS | 7640 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:14:11 INFO - PROCESS | 7640 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:14:12 INFO - TEST-INFO | 7640: exit 0 20:14:12 INFO - Browser initialized. 20:14:12 INFO - Running cycle 1/1 for kraken test... 20:14:12 INFO - TEST-INFO | started process 7720 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBNih1P/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:14:24 INFO - PROCESS | 7720 | RSS: Main: 148733952 20:14:24 INFO - PROCESS | 7720 | 20:14:26 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36054/tests/kraken/driver.html?testName=audio-beat-detection) 20:14:27 INFO - PROCESS | 7720 | RSS: Main: 184958976 20:14:27 INFO - PROCESS | 7720 | 20:14:30 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36054/tests/kraken/driver.html?testName=audio-dft) 20:14:30 INFO - PROCESS | 7720 | RSS: Main: 172650496 20:14:30 INFO - PROCESS | 7720 | 20:14:33 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36054/tests/kraken/driver.html?testName=audio-fft) 20:14:34 INFO - PROCESS | 7720 | RSS: Main: 159399936 20:14:34 INFO - PROCESS | 7720 | 20:14:36 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36054/tests/kraken/driver.html?testName=audio-oscillator) 20:14:36 INFO - PROCESS | 7720 | RSS: Main: 160645120 20:14:36 INFO - PROCESS | 7720 | 20:14:38 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36054/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:14:39 INFO - PROCESS | 7720 | RSS: Main: 164032512 20:14:39 INFO - PROCESS | 7720 | 20:14:42 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36054/tests/kraken/driver.html?testName=imaging-darkroom) 20:14:42 INFO - PROCESS | 7720 | RSS: Main: 163954688 20:14:42 INFO - PROCESS | 7720 | 20:14:46 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36054/tests/kraken/driver.html?testName=imaging-desaturate) 20:14:46 INFO - PROCESS | 7720 | RSS: Main: 165634048 20:14:46 INFO - PROCESS | 7720 | 20:14:49 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36054/tests/kraken/driver.html?testName=json-parse-financial) 20:14:50 INFO - PROCESS | 7720 | RSS: Main: 164589568 20:14:50 INFO - PROCESS | 7720 | 20:14:51 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36054/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:14:52 INFO - PROCESS | 7720 | RSS: Main: 175554560 20:14:52 INFO - PROCESS | 7720 | 20:14:53 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36054/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:14:54 INFO - PROCESS | 7720 | RSS: Main: 172404736 20:14:54 INFO - PROCESS | 7720 | 20:14:56 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36054/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:14:57 INFO - PROCESS | 7720 | RSS: Main: 185335808 20:14:57 INFO - PROCESS | 7720 | 20:14:59 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36054/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:15:00 INFO - PROCESS | 7720 | RSS: Main: 189882368 20:15:00 INFO - PROCESS | 7720 | 20:15:02 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36054/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:15:03 INFO - PROCESS | 7720 | RSS: Main: 189292544 20:15:03 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36054/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36054/tests/kraken/driver.html?testName=ai-astar) 20:15:05 INFO - PROCESS | 7720 | RSS: Main: 247889920 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | __start_tp_report 20:15:05 INFO - PROCESS | 7720 | _x_x_mozilla_page_load 20:15:05 INFO - PROCESS | 7720 | _x_x_mozilla_page_load_details 20:15:05 INFO - PROCESS | 7720 | |i|pagename|runs| 20:15:05 INFO - PROCESS | 7720 | |0;ai-astar;112;114;106;112;112;113;101;112;111;112 20:15:05 INFO - PROCESS | 7720 | |1;audio-beat-detection;151;126;164;167;127;156;148;126;164;126 20:15:05 INFO - PROCESS | 7720 | |2;audio-dft;163;161;159;160;160;158;160;162;162;161 20:15:05 INFO - PROCESS | 7720 | |3;audio-fft;73;71;88;95;74;72;74;126;90;72 20:15:05 INFO - PROCESS | 7720 | |4;audio-oscillator;96;97;142;97;97;97;140;97;97;138 20:15:05 INFO - PROCESS | 7720 | |5;imaging-gaussian-blur;109;109;109;110;110;110;109;109;109;110 20:15:05 INFO - PROCESS | 7720 | |6;imaging-darkroom;145;146;146;146;146;145;145;146;146;145 20:15:05 INFO - PROCESS | 7720 | |7;imaging-desaturate;95;96;95;96;95;96;96;95;95;96 20:15:05 INFO - PROCESS | 7720 | |8;json-parse-financial;56;55;54;55;56;56;55;64;52;52 20:15:05 INFO - PROCESS | 7720 | |9;json-stringify-tinderbox;67;69;68;68;68;68;68;68;67;68 20:15:05 INFO - PROCESS | 7720 | |10;stanford-crypto-aes;84;86;94;87;100;86;86;87;87;88 20:15:05 INFO - PROCESS | 7720 | |11;stanford-crypto-ccm;125;114;116;117;126;131;119;121;115;115 20:15:05 INFO - PROCESS | 7720 | |12;stanford-crypto-pbkdf2;144;142;154;151;154;142;158;152;161;141 20:15:05 INFO - PROCESS | 7720 | |13;stanford-crypto-sha256-iterative;70;73;74;69;71;68;70;69;69;68 20:15:05 INFO - PROCESS | 7720 | __end_tp_report 20:15:05 INFO - PROCESS | 7720 | __start_cc_report 20:15:05 INFO - PROCESS | 7720 | _x_x_mozilla_cycle_collect,940 20:15:05 INFO - PROCESS | 7720 | __end_cc_report 20:15:05 INFO - PROCESS | 7720 | __startTimestamp1452572105344__endTimestamp 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | ------- Summary: start ------- 20:15:05 INFO - PROCESS | 7720 | Number of tests: 14 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.95 (3.5%) stddev-sans-first:4.15 20:15:05 INFO - PROCESS | 7720 | Values: 112.0 114.0 106.0 112.0 112.0 113.0 101.0 112.0 111.0 112.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:153.50 stddev:17.56 (11.4%) stddev-sans-first:18.52 20:15:05 INFO - PROCESS | 7720 | Values: 151.0 126.0 164.0 167.0 127.0 156.0 148.0 126.0 164.0 126.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.51 (0.9%) stddev-sans-first:1.32 20:15:05 INFO - PROCESS | 7720 | Values: 163.0 161.0 159.0 160.0 160.0 158.0 160.0 162.0 162.0 161.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#3] audio-fft Cycles:10 Average:83.50 Median:74.00 stddev:17.36 (23.5%) stddev-sans-first:17.99 20:15:05 INFO - PROCESS | 7720 | Values: 73.0 71.0 88.0 95.0 74.0 72.0 74.0 126.0 90.0 72.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:97.00 stddev:20.86 (21.5%) stddev-sans-first:21.52 20:15:05 INFO - PROCESS | 7720 | Values: 96.0 97.0 142.0 97.0 97.0 97.0 140.0 97.0 97.0 138.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:15:05 INFO - PROCESS | 7720 | Values: 109.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 110.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 20:15:05 INFO - PROCESS | 7720 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:15:05 INFO - PROCESS | 7720 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:3.34 (6.0%) stddev-sans-first:3.54 20:15:05 INFO - PROCESS | 7720 | Values: 56.0 55.0 54.0 55.0 56.0 56.0 55.0 64.0 52.0 52.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 20:15:05 INFO - PROCESS | 7720 | Values: 67.0 69.0 68.0 68.0 68.0 68.0 68.0 68.0 67.0 68.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:87.00 stddev:4.81 (5.5%) stddev-sans-first:4.82 20:15:05 INFO - PROCESS | 7720 | Values: 84.0 86.0 94.0 87.0 100.0 86.0 86.0 87.0 87.0 88.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:120.00 stddev:5.72 (4.8%) stddev-sans-first:5.77 20:15:05 INFO - PROCESS | 7720 | Values: 125.0 114.0 116.0 117.0 126.0 131.0 119.0 121.0 115.0 115.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:153.00 stddev:7.20 (4.7%) stddev-sans-first:7.32 20:15:05 INFO - PROCESS | 7720 | Values: 144.0 142.0 154.0 151.0 154.0 142.0 158.0 152.0 161.0 141.0 20:15:05 INFO - PROCESS | 7720 | 20:15:05 INFO - PROCESS | 7720 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:2.02 (2.9%) stddev-sans-first:2.15 20:15:05 INFO - PROCESS | 7720 | Values: 70.0 73.0 74.0 69.0 71.0 68.0 70.0 69.0 69.0 68.0 20:15:05 INFO - PROCESS | 7720 | -------- Summary: end -------- 20:15:05 INFO - PROCESS | 7720 | 20:15:06 INFO - TEST-INFO | 7720: exit 0 20:15:06 INFO - TEST-OK | kraken | took 58952ms 20:15:06 INFO - TEST-START | v8_7 20:15:06 INFO - operating with platform_type : linux_ 20:15:06 INFO - Initialising browser for v8_7 test... 20:15:06 INFO - TEST-INFO | started process 7966 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLBLoeQ/profile http://localhost:36054/getInfo.html) 20:15:10 INFO - PROCESS | 7966 | __metrics Screen width/height:1600/1200 20:15:10 INFO - PROCESS | 7966 | colorDepth:24 20:15:10 INFO - PROCESS | 7966 | Browser inner width/height: 1024/697 20:15:10 INFO - PROCESS | 7966 | __metrics 20:15:10 INFO - PROCESS | 7966 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:15:10 INFO - PROCESS | 7966 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:15:11 INFO - TEST-INFO | 7966: exit 0 20:15:11 INFO - Browser initialized. 20:15:11 INFO - Running cycle 1/1 for v8_7 test... 20:15:11 INFO - TEST-INFO | started process 8049 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLBLoeQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:23 INFO - PROCESS | 8049 | RSS: Main: 148709376 20:15:23 INFO - PROCESS | 8049 | 20:15:45 INFO - PROCESS | 8049 | Cycle 1(1): loaded http://localhost:36054/tests/v8_7/run.html (next: http://localhost:36054/tests/v8_7/run.html) 20:15:46 INFO - PROCESS | 8049 | RSS: Main: 546304000 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - PROCESS | 8049 | __start_tp_report 20:15:46 INFO - PROCESS | 8049 | _x_x_mozilla_page_load 20:15:46 INFO - PROCESS | 8049 | _x_x_mozilla_page_load_details 20:15:46 INFO - PROCESS | 8049 | |i|pagename|runs| 20:15:46 INFO - PROCESS | 8049 | |0;Richards;166.27868307283006 20:15:46 INFO - PROCESS | 8049 | |1;DeltaBlue;191.2411550965768 20:15:46 INFO - PROCESS | 8049 | |2;Encrypt;281.0567734682406 20:15:46 INFO - PROCESS | 8049 | |3;Decrypt;5175.257731958763 20:15:46 INFO - PROCESS | 8049 | |4;RayTrace;1945.5252918287938 20:15:46 INFO - PROCESS | 8049 | |5;Earley;825.0825082508251 20:15:46 INFO - PROCESS | 8049 | |6;Boyer;12207.317073170732 20:15:46 INFO - PROCESS | 8049 | |7;RegExp;42979.166666666664 20:15:46 INFO - PROCESS | 8049 | |8;Splay;583.4305717619603 20:15:46 INFO - PROCESS | 8049 | |9;NavierStokes;4840.579710144928 20:15:46 INFO - PROCESS | 8049 | __end_tp_report 20:15:46 INFO - PROCESS | 8049 | __startTimestamp1452572146051__endTimestamp 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - PROCESS | 8049 | ------- Summary: start ------- 20:15:46 INFO - PROCESS | 8049 | Number of tests: 10 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - PROCESS | 8049 | [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 20:15:46 INFO - PROCESS | 8049 | Values: 166.3 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - PROCESS | 8049 | [#1] DeltaBlue Cycles:1 Average:191.24 Median:191.24 stddev:0.00 (0.0%) 20:15:46 INFO - PROCESS | 8049 | Values: 191.2 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - PROCESS | 8049 | [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 20:15:46 INFO - PROCESS | 8049 | Values: 281.1 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - PROCESS | 8049 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 20:15:46 INFO - PROCESS | 8049 | Values: 5175.3 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - PROCESS | 8049 | [#4] RayTrace Cycles:1 Average:1945.53 Median:1945.53 stddev:0.00 (0.0%) 20:15:46 INFO - PROCESS | 8049 | Values: 1945.5 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - PROCESS | 8049 | [#5] Earley Cycles:1 Average:825.08 Median:825.08 stddev:0.00 (0.0%) 20:15:46 INFO - PROCESS | 8049 | Values: 825.1 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - PROCESS | 8049 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 20:15:46 INFO - PROCESS | 8049 | Values: 12207.3 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - PROCESS | 8049 | [#7] RegExp Cycles:1 Average:42979.17 Median:42979.17 stddev:0.00 (0.0%) 20:15:46 INFO - PROCESS | 8049 | Values: 42979.2 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - PROCESS | 8049 | [#8] Splay Cycles:1 Average:583.43 Median:583.43 stddev:0.00 (0.0%) 20:15:46 INFO - PROCESS | 8049 | Values: 583.4 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - PROCESS | 8049 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:15:46 INFO - PROCESS | 8049 | Values: 4840.6 20:15:46 INFO - PROCESS | 8049 | -------- Summary: end -------- 20:15:46 INFO - PROCESS | 8049 | 20:15:46 INFO - TEST-INFO | 8049: exit 0 20:15:46 INFO - TEST-OK | v8_7 | took 40752ms 20:15:46 INFO - SUITE-END | took 1212s 20:15:47 INFO - Completed test suite (00:20:12) 20:15:47 INFO - Working with test: dromaeo_css 20:15:47 INFO - Generating results file: dromaeo_css 20:15:47 INFO - Working with test: kraken 20:15:47 INFO - Generating results file: kraken 20:15:47 INFO - javascript benchmark 20:15:47 INFO - Working with test: v8_7 20:15:47 INFO - Generating results file: v8_7 20:15:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:15:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:15:47 INFO - process_Request line: dromaeo_css 6681.08 graph.html#tests=[[72,64,35]] 20:15:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:15:47 INFO - process_Request line: kraken 1512.20 graph.html#tests=[[232,64,35]] 20:15:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:15:47 INFO - process_Request line: v8_7 18876.11 graph.html#tests=[[230,64,35]] 20:15:47 INFO - RETURN: dromaeo_css: 6681.08 20:15:47 INFO - RETURN: kraken: 1512.20 20:15:47 INFO - RETURN: v8_7: 18876.11 20:15:47 INFO - javascript benchmark 20:15:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3081.722644961954, 3152.7635427342957, 3189.4737368334227, 3190.489521676532, 3217.533457648641, 4940.135476291653, 4998.500149985, 5074.999999999995, 5091.058154241463, 5136.794528218871, 5025.447200807908, 5038.067957427878, 5060.165072762989, 5156.948430515694, 5170.922436163461, 4592.471865735433, 4594.770261486929, 4598.540145985391, 4641.651876109288, 4675.438947326325, 4553.521880202581, 4650.488446270908, 4675.368825208604, 4735.029318989599, 4736.8578942631775, 4587.357769912215, 4596.747178905159, 4597.241455159895, 4645.674802763791, 4679.344891715128, 4642.0715856828765, 4650.279206722963, 4650.930236046462, 4666.23007203811, 4668.719876807369, 4627.329037289608, 4630.189716799547, 4632.351470794091, 4633.837815676469, 4667.789949452283, 4806.7836947337455, 4896.045271172123, 4938.80244790208, 4982.277569752366, 4989.875253118665, 5404.270423492818, 5456.863578410532, 5462.6995515247045, 5465.098258787295, 5518.448155184489, 5434.3207099112615, 5464.726763661801, 5464.9453505464835, 5465.6447330923365, 5478.479544443271, 4978.751062446863, 5055.848324550269, 5069.923951140736, 5093.898122037575, 5167.302414174076, 5482.0406428874785, 5491.0, 5503.229547863302, 5513.09034009392, 5562.193481945095, 5318.175682769177, 5323.334583177103, 5324.334458192726, 5337.546308563816, 5370.382406023279, 5296.629235953524, 5371.140617501181, 5396.1905714143195, 5411.998780225671, 5462.371827239839, 5362.061639213122, 5379.973100134474, 5380.650257733235, 5390.272313237662, 5398.0, 5383.2194331821665, 5398.676079435247, 5401.405845357008, 5408.02655522002, 5453.209284653703, 4233.957660423418, 4234.894127646833, 4310.978445107754, 4314.7411155330155, 4317.050248945227, 3808.5048943637703, 3841.3469710149343, 3845.9615403846165, 3878.631530004645, 3885.1258466844733, 5075.187969924795, 5108.948910510921, 5121.234533351948, 5121.667091639031, 5124.590032797368, 5237.8428647140645, 5359.410464848941, 5413.2150838128255, 5471.23402723619, 5524.364698059694, 5051.1413059779925, 5100.719460429637, 5105.795768169306, 5107.795688172431, 5150.356205474316, 4624.237000894882, 4706.152892479318, 4726.243800991893, 4727.929081063787, 4734.26618874075, 5632.718364081779, 5672.064109421899, 5679.488846003879, 5700.372958974593, 5743.368229494752, 5435.510804027656, 5441.0, 5441.238226648194, 5443.346798384219, 5446.046941785251, 5595.608307418604, 5689.023845672889, 5694.943050569441, 5696.544276457957, 5700.828975130753, 5324.307839980777, 5372.5433338166695, 5373.435789242073, 5378.112611419228, 5422.918656220081, 5380.139177731544, 5400.83797486076, 5405.837824865261, 5417.052015897123, 5439.945600543944, 5169.638125331191, 5259.789608415621, 5268.81559145428, 5286.603504737237, 5300.893982120258, 5312.4156342803035, 5319.547838433777, 5334.039872822929, 5335.653182543122, 5337.332833395825, 5219.321488206509, 5222.55608273301, 5233.816816411408, 5238.973805131102, 5268.262443258023, 5132.46109158533, 5256.947430525645, 5257.053730328577, 5303.496167864047, 5312.760925758427, 5207.932373863425, 5295.099833028471, 5297.205419187153, 5299.125644268653, 5336.0], "unit": "score", "name": "dojo.html", "value": 5024.443987472265}, {"lowerIsBetter": false, "replicates": [506.9493050694931, 515.6287473019427, 520.9270702101704, 534.7566857080029, 546.1371033766649, 28091.0, 28672.283192920186, 28682.13953581396, 28723.71276287234, 28732.13803585896, 35441.82279088607, 35568.2886342273, 35568.644313556855, 35625.46561801569, 35686.286274274564, 8376.581170941443, 8577.0, 8578.828423431527, 8579.099194584542, 8584.0, 8297.211764882326, 8440.662373505053, 8443.451175673592, 8444.57777111145, 8448.74653760385, 8376.748697539084, 8467.872981905277, 8476.110008449117, 8480.957595212016, 8484.0, 8342.332613390914, 8406.537640429744, 8409.579521023985, 8424.199701028392, 8425.662973481054, 8262.669493220264, 8391.244787969112, 8566.229039386486, 8582.828343433159, 8587.785305367353, 39211.0, 39642.40536391956, 39651.40522892159, 39718.20563588741, 39748.0, 3406.8466918988706, 3574.946375804365, 3887.3974533947285, 3958.2281455116263, 4022.1352409232154, 29556.556651650244, 29758.256043598867, 29978.70021299781, 30031.69968300311, 31153.532697009563, 3494.178867966026, 3647.1793846384617, 3653.2510835278704, 3719.609441008682, 3782.3569993101237, 257139.0, 258576.0, 258838.0, 259345.0, 259647.70176149186, 57428.42571574314, 57732.422675773545, 57799.0, 57951.71024144852, 57964.71017644885, 60097.699511502164, 60336.0, 60468.39531604716, 60654.0, 60667.39332606706, 14321.427142914376, 14429.711405772036, 14645.633859153393, 14666.85333146655, 14770.26148692561, 11255.943720281346, 11259.211855170222, 11262.549498020151, 11263.774724505463, 11296.887031129749, 17866.11212557908, 19386.0, 19408.320708775125, 19463.416097517096, 19493.122809473607, 6183.81448556544, 7008.719651213996, 7357.411407087528, 7375.11498620169, 7469.290417410446, 958.4393130018877, 979.9576745923067, 1034.6239501463187, 1096.4188979840696, 1107.479484642217, 31547.84226078901, 32201.0, 32458.508125027747, 34755.652443475745, 35014.47478287828, 950.2208189284859, 1015.4161357219629, 1038.717184277417, 1054.8734151901667, 1115.8437818705388, 12806.61580152597, 15092.622684432978, 15517.224138793015, 16044.753734477183, 16060.134836373049, 411488.0, 415791.0, 417551.0, 417804.0, 418013.0, 54552.72723636436, 55441.168382474294, 55470.44529554733, 55574.16638750422, 55636.0, 1350.8649135086412, 1351.2770667692737, 1380.9102408343626, 1384.729977654368, 1393.9721205575831, 28971.42057158887, 30153.698463015087, 30432.84783576068, 31023.84488077545, 31309.53035704421, 45533.31700024436, 46119.76940115278, 46122.53877461182, 46167.76916115398, 46173.30740038969, 289226.0, 291365.0, 291470.0, 291527.0, 292273.0, 39765.0, 40946.59053409428, 41459.37810932778, 41719.0, 41734.373984389655, 44688.32967505555, 44901.1019779596, 44930.77534612306, 45778.31332529948, 45905.540944590124, 32527.837360813046, 37277.4408383869, 37669.81165094157, 38791.41812872753, 39558.40662390009, 31874.681253187173, 35901.28197436089, 36027.63972360243, 36342.454863177605, 36928.81535592305, 32961.83519082389, 33170.66829331772, 33267.66732332743, 33277.50083748794, 33292.833535832164, 26005.869970650027, 30277.697223028368, 30681.232969175056, 30761.692383075882, 30844.22889427782, 24484.755152448248, 24805.0, 24921.501569968135, 24963.251102466955, 25219.0], "unit": "score", "name": "ext.html", "value": 18363.730808954075}, {"lowerIsBetter": false, "replicates": [361.58417819507565, 361.86249225294387, 363.73810856183553, 364.4114754671207, 365.4317536231159, 13435.865641343584, 13917.443302267922, 15860.206989650515, 16128.516144515668, 16948.491545253648, 14634.414623415078, 15358.616034599141, 15778.21108944551, 15783.0, 16216.0, 5189.377274727038, 5383.4616538346045, 5383.703896285702, 5386.218998245252, 5386.353637563498, 3971.8212680429306, 4113.465249517559, 5269.341332333458, 5375.0593646111965, 5673.943260567383, 5789.884202315951, 5984.401559844003, 6026.608270462428, 6034.909476357858, 6042.546808989321, 5879.88240235195, 5929.347771745104, 5933.169356290123, 5941.643501389887, 5944.910826337608, 5235.659682120688, 5238.345206849144, 6134.570580059398, 6375.362463753634, 6380.425761681471, 20329.0, 20695.0, 20997.5800483991, 22645.547089058127, 22668.546629067492, 2005.9699104513445, 2089.5716378142442, 2157.5792720419527, 2177.7604463509, 2271.7387500437494, 13034.80447793284, 13178.34108294591, 13609.931950340186, 13842.515511957134, 14258.572242832732, 1900.3348827910258, 1910.3695780392436, 1931.7102434634917, 1958.0014192761653, 2028.3407892435018, 60519.0, 64861.67569162124, 64938.350616493706, 64961.35038649647, 65708.67145664289, 14535.854641453661, 14772.778408323884, 14773.409063637335, 14781.26093695311, 14831.555053348417, 22465.550688986128, 22595.43511412228, 22596.774032259465, 22770.31689049331, 23012.539749204923, 8662.436941598777, 8723.0, 8725.738227853175, 8736.170063843925, 8758.605862736193, 7687.154413014564, 7698.846023079507, 7710.845783084307, 7773.067231932205, 7786.883196752054, 7569.962150189324, 7612.276833700789, 7616.01983484287, 7618.238176182337, 7626.618669066635, 2539.7333280005705, 2971.5877991740317, 3036.8633411496535, 3037.635483741921, 3042.6653068162927, 409.9672026237894, 417.7305637863561, 417.7785773540029, 435.7603318174991, 808.4664121679663, 9846.0, 10247.846282305622, 10328.793424131476, 10339.276250662531, 10418.583256669648, 429.6992105526082, 432.1788601656877, 435.7211384713786, 440.5748452743118, 442.99335509967375, 5074.771635276422, 5668.178114173505, 5699.088145896637, 5709.3434255060365, 5788.160716696139, 447350.0, 497457.0, 522472.0, 538576.0, 541069.0, 73068.99999999894, 73378.0, 73863.63068184625, 74290.0, 74518.6274068637, 1008.1732978957331, 1052.3790963331824, 1085.066842515436, 1116.826891831751, 1117.2905205194759, 13935.58193254204, 14169.36237869319, 14353.0, 14441.711165776836, 14694.706105878036, 30351.696483034888, 30540.847295764266, 30643.387132256783, 31202.531962020134, 31338.843305783324, 40064.99837504086, 40373.1925361497, 40424.59575404326, 40430.393544096274, 40556.59443405646, 2940.220841477053, 2960.259935016246, 4885.706857588556, 6960.025596416607, 7204.9913012177285, 10578.523966421375, 10705.732356691145, 10896.782064358827, 11192.104631629612, 11368.374739389414, 9268.424367857346, 9412.95293523528, 9592.616295348387, 9613.471259080818, 9682.85475717879, 9749.830020397598, 9866.35868668563, 9915.95042024814, 9944.701658950244, 9978.301518893608, 7571.690634356574, 9492.85760713576, 9693.176080033276, 9779.60881564758, 9847.0, 7377.889331660137, 9378.765530861783, 9430.858537122085, 9722.659706910224, 9747.902520974983, 9585.472798996123, 9948.55231514598, 9960.850587241343, 10154.0, 10568.10171135462], "unit": "score", "name": "jquery.html", "value": 8180.011523308181}, {"lowerIsBetter": false, "replicates": [1265.6519457149277, 1404.2487269310918, 1411.3437251677972, 1522.4595268679618, 1734.9653006939855, 6791.354821291976, 7338.853222935538, 7451.664675089621, 7510.474266801326, 7516.661750221239, 7123.180834204068, 7237.601931893743, 7245.384142347907, 7317.853642927138, 7326.670299836507, 2268.0474200835647, 2278.8176945844293, 2286.531261091472, 2287.7712228777154, 2288.5651726171973, 2239.8656080635133, 2250.0999600159985, 2296.5980953333183, 2301.6777651128773, 2317.478567322356, 2259.604569200392, 2273.3975496493445, 2277.077783497686, 2280.8631482111127, 2286.5655525450193, 2222.7443843957826, 2250.1674380479244, 2263.649134384173, 2264.7961683448484, 2267.8299127565497, 2217.124235926816, 2220.489287463892, 2221.1781640792847, 2223.1552010236005, 2223.1774243529835, 7677.692892284358, 7717.073951125844, 7720.459567830254, 7725.4205934554575, 7738.729144479972, 4592.471865735416, 4722.456917454502, 4726.385569875929, 4731.124741922756, 4750.691205071659, 3042.4523585754555, 3087.552304915797, 3154.5899033125775, 3181.7136457718916, 3194.073718621597, 959.3284700709462, 962.2782912815388, 966.1160038564705, 971.7667759737612, 1010.3988127064385, 10440.164786817037, 10513.84229236562, 10514.579416823395, 10528.684139475828, 10552.419616921066, 4242.596953289432, 4278.89302767427, 4316.827326906951, 4327.913441731148, 4332.805023773938, 9086.81826363469, 9087.636494540144, 9101.81796364069, 9103.453792772454, 9103.90896091044, 4795.568398844121, 4798.088363210979, 4804.375431193923, 4808.591269742111, 4811.446683631357, 3813.618638136164, 3873.477080594084, 4228.238916994909, 4330.372096046119, 4380.8685739427865, 3708.2583483302906, 3750.6999440044733, 3764.322421964018, 3769.2838360711376, 3772.1701225730294, 1179.3277831636058, 1214.9514019439123, 1219.469565695047, 1220.798568236249, 1238.238483332762, 970.6020531582018, 979.153032626787, 980.4607465893872, 1074.2802322443981, 1305.034274636762, 7138.072050633385, 7256.709731610782, 7267.709291628382, 7267.7819665410125, 7279.090113735783, 464.1830378533805, 476.5877515948749, 486.72013592184635, 487.55875932280634, 489.2685435274217, 5431.945680543144, 5469.808556700496, 5470.179473078991, 5472.72636368188, 5473.972630136824, 8912.376133670581, 8947.731568052968, 9117.954410227907, 9127.22418594427, 9134.81730365389, 9046.321525885585, 9099.727008189764, 9109.90890091104, 9118.40730352525, 9119.772005699779, 7004.089468369079, 7116.430685545248, 7174.533655312388, 7191.64041797908, 7203.351698347279, 6836.077129587442, 6904.620245886324, 6910.585364878123, 6914.827129321807, 6925.099737034153, 7994.640241189044, 8151.592420378839, 8179.468334558234, 8306.750797476085, 8308.252257296872, 8124.8781268279845, 8382.119877412784, 8513.148685131437, 8552.187542183483, 8587.22714955632, 5908.113782932594, 6314.179156709598, 6608.4052435281055, 6852.5203235773015, 6969.58182509051, 7059.929400705927, 7072.646367681698, 7097.361237488651, 7132.500724949411, 7146.285371462812, 6503.187101612299, 6714.362135597111, 6728.091707619409, 6850.9314906850295, 6864.38220560152, 6529.477641788741, 6566.9014964776525, 6581.638009909501, 6594.604323740591, 6743.089682892943, 6421.646809425526, 6451.806445806634, 6465.870682586228, 6468.773592924414, 6476.676166191766, 6283.622982621057, 6434.581752186093, 6434.742610295536, 6435.195600549931, 6435.4529864962005, 6456.451201647725, 6529.967350163219, 6530.216374035146, 6533.150690410216, 6540.444062254762], "unit": "score", "name": "mootools.html", "value": 4292.481783343278}, {"lowerIsBetter": false, "replicates": [331.7545016687651, 340.14284004309144, 343.23287452543576, 345.5197275786656, 352.6649682801338, 5661.094224924013, 5785.27684039495, 5794.0729483282685, 5803.071508558632, 5846.64920104793, 5666.178404131399, 5700.002499562581, 5798.768049278035, 5807.361190269067, 5823.475887170154, 4474.418325617665, 4474.910501789954, 4475.172093162759, 4482.775861206943, 4487.887802804923, 4278.657707383418, 4356.041670832412, 4381.16757816014, 4479.798409071584, 4493.0564581437775, 4449.532799056101, 4461.040876211614, 4472.1055788842195, 4480.48474425442, 4481.843135490259, 4454.8886277842985, 4475.5748203920575, 4479.932801007955, 4481.955180448203, 4482.350059241425, 3912.921741565181, 3961.722679412442, 3962.1085255817497, 3966.8214930328204, 3969.4839670842894, 5341.572674186055, 5493.862653433696, 5496.1755736639425, 5497.092979658351, 5507.7246137693355, 5103.923441148386, 5111.386633603955, 5146.974265128651, 5147.922781158286, 5150.3047088642925, 6110.297315808694, 6125.601835880653, 6126.142340072393, 6131.110988906628, 6136.570440069197, 4100.610442008005, 4172.102997855445, 4184.28867092595, 4245.554216807222, 4253.1706317268145, 6230.813075607739, 6309.495240380758, 6361.809145725636, 6362.395572420613, 6368.363163683594, 4354.455693038371, 4356.041670832412, 4362.672799540047, 4369.541198174209, 4373.147236288957, 4328.285832837547, 4416.580424859633, 4418.955810441918, 4428.645708343325, 4437.5784300491405, 5084.644074914794, 5085.949140508622, 5096.133657278272, 5096.235564665256, 5096.464871188472, 6132.386761323832, 6133.1413602095745, 6134.141220229171, 6135.233095863017, 6137.631742095488, 1550.7518796992426, 1565.763047192705, 1574.8031496062993, 1577.7869987551762, 1578.4633224703655, 1038.6883934819523, 1047.994760026195, 1050.6112738286884, 1054.6045233037612, 1076.7308172956762, 5839.299284085937, 5842.970785146132, 5848.239728835224, 5848.941510584925, 5859.53123750099, 6274.937250627435, 6283.434490895841, 6283.717232724538, 6283.905741413882, 6286.528510361742, 5835.620684655484, 5846.649201047951, 5847.415258474119, 5874.236349274567, 5906.675132867734, 3276.6231883333244, 3406.386850366908, 3410.198603328216, 3410.5054767058637, 3412.5563676721868, 6617.941129419366, 6620.5034622402545, 6624.668766561653, 6628.0, 6637.0, 6435.099086127946, 6443.548951573345, 6447.516436267299, 6449.774257900951, 6462.386073323027, 6491.7078731457195, 6592.9340706593275, 6624.900626490607, 6650.567713098633, 6730.091437655854, 6353.7140828661895, 6354.142190804182, 6354.205724284465, 6357.491400688026, 6357.809265722036, 6064.48451881595, 6162.969185154046, 6196.783112591038, 6293.118963345227, 6351.872962540816, 6661.067450557023, 6674.199096108498, 6676.265610782907, 6680.799576012533, 6695.196576410862, 4405.80173892182, 4435.711678740871, 4440.489343725384, 4444.400005999278, 4444.511103778517, 6178.227721534809, 6313.147725057059, 6346.809595712136, 6352.110704501281, 6358.046293056079, 6153.907691384722, 6155.107509411021, 6171.6297022178815, 6172.537059720449, 6172.938270617236, 6155.2613686356135, 6168.568200225941, 6172.475339596184, 6175.62946223228, 6179.474744646755, 5930.555208359304, 6062.939370606237, 6072.90890636632, 6073.969630151821, 6077.4226448487325, 6195.81412557624, 6206.472449841814, 6206.503479721701, 6207.6275423474735, 6207.906881396873, 6060.666663333559, 6070.605410648293, 6074.088886667036, 6075.665838378754, 6076.088586712029], "unit": "score", "name": "prototype.html", "value": 4649.2900821829935}, {"lowerIsBetter": false, "replicates": [688.366702633577, 774.0208636075364, 783.1620166421927, 797.5095316380427, 835.4694768821798, 13228.140170888897, 13362.064655474122, 13366.465341386345, 13382.063255572113, 13394.93302533486, 10525.263231573794, 12274.693132671688, 12465.439055242514, 12560.246385216893, 12668.936655316711, 769.3575864153438, 786.7482405630201, 787.3976408047848, 787.9015123109612, 787.9763607091768, 764.025867019549, 765.865973454646, 766.0654002117408, 766.9118051424074, 767.6852490478905, 806.1454857850667, 815.7471183933, 815.8327542853701, 820.0487434575894, 820.7989042684521, 803.5941849366092, 813.5525460996429, 813.6989313953816, 814.6822739131743, 815.0097631377874, 600.2167171840746, 605.4067014325941, 606.8270542895253, 606.9605475644113, 607.3895734786511, 12030.27818330903, 12071.034317254687, 12081.637550873487, 12108.394580271039, 12126.151169418144, 10076.848847267296, 10754.300970436896, 10926.617568385147, 10974.231803773739, 11230.3261804292, 8682.789293940126, 8880.689175878813, 9031.909680903238, 9634.13292803644, 9982.450965196911, 3489.4242449995722, 3530.3115892400992, 3543.1850674345046, 3549.503069570236, 3686.7419280650365, 37906.24187516234, 40038.79980600107, 41471.1705765886, 45002.0, 45140.548594513966, 9489.952550237205, 9585.472798995983, 9713.36863103896, 9815.067568580973, 9992.550335234931, 17955.910220448815, 17979.10104494796, 18007.549811254823, 18033.549161271072, 18040.0, 7143.107111611049, 7364.116306043309, 7809.921900781033, 7829.217078292239, 7844.294013538809, 4274.935875961863, 4354.912901742011, 4360.171567402183, 4380.102079073782, 4405.713628614194, 2875.683674795771, 2883.5098033334384, 2885.653721553427, 2889.0321742216593, 2891.840948747839, 553.6733327336891, 555.1478480532363, 561.2759540193186, 565.7171414292853, 571.0321005894968, 489.8040783686554, 514.2308667823796, 538.9919151212735, 561.6854561445522, 617.0559044661675, 7365.98361676161, 7439.739609113655, 7524.0, 7729.690812367555, 7774.766756997299, 480.72358393922934, 496.2407516499761, 500.5313179664957, 566.2214455124205, 570.1874828369639, 3587.65917237862, 3668.834902429397, 3710.6845918096724, 4029.5768944261017, 4047.170330082326, 47380.526194738304, 47683.0, 47779.0, 47830.0, 47918.76040619775, 46363.536364636595, 47004.0, 47155.76422117867, 47184.05631887343, 48878.51121488811, 41513.58486415158, 42622.36066459006, 44146.337804932955, 44929.55070449319, 45566.77216613896, 7936.246056624612, 8133.1053584106885, 8164.7958801030445, 8195.795105122419, 8220.794480138044, 30622.540661889645, 32324.191895202806, 32430.0, 32956.34087318192, 33073.669263307056, 41210.0, 41780.0, 42161.57838421699, 42215.57784422117, 42471.78764106159, 9134.497602631918, 9319.254459643347, 9368.203702685076, 9564.091411315914, 10407.531661075118, 12055.336956467128, 12182.208156469802, 12285.0, 12977.935110324388, 13396.196228226338, 10071.69784906454, 10446.947765261126, 10659.14726821868, 10776.838347424951, 10802.72993175177, 10136.543855526666, 10458.738531536772, 10826.89173108259, 10840.837387439353, 10850.782984340427, 10106.19150467946, 10420.270581059556, 10813.729656758644, 10831.0, 10834.620788272372, 9675.172166713142, 9905.158061564847, 9915.950420247853, 9924.603015879284, 10148.695539133838, 8423.4945903246, 8624.353173511887, 8926.241269492166, 9196.540172991457, 9210.125038121369], "unit": "score", "name": "yui.html", "value": 5903.907445760368}], "name": "dromaeo_css", "value": 6681.076787095682}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 106.0, 112.0, 112.0, 113.0, 101.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [151.0, 126.0, 164.0, 167.0, 127.0, 156.0, 148.0, 126.0, 164.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 159.0, 160.0, 160.0, 158.0, 160.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 88.0, 95.0, 74.0, 72.0, 74.0, 126.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 142.0, 97.0, 97.0, 97.0, 140.0, 97.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 54.0, 55.0, 56.0, 56.0, 55.0, 64.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 94.0, 87.0, 100.0, 86.0, 86.0, 87.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.5}, {"lowerIsBetter": true, "replicates": [125.0, 114.0, 116.0, 117.0, 126.0, 131.0, 119.0, 121.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [144.0, 142.0, 154.0, 151.0, 154.0, 142.0, 158.0, 152.0, 161.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.9}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 74.0, 69.0, 71.0, 68.0, 70.0, 69.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1512.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "Richards", "value": 212.306228}, {"lowerIsBetter": false, "replicates": [191.2411550965768], "unit": "score", "name": "DeltaBlue", "value": 345.7310220000001}, {"lowerIsBetter": false, "replicates": [281.0567734682406], "unit": "score", "name": "Encrypt", "value": 947.0719979999998}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1945.5252918287938], "unit": "score", "name": "RayTrace", "value": 380.354346}, {"lowerIsBetter": false, "replicates": [825.0825082508251], "unit": "score", "name": "Earley", "value": 807.7531559999996}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [42979.166666666664], "unit": "score", "name": "RegExp", "value": 21.19596703829373}, {"lowerIsBetter": false, "replicates": [583.4305717619603], "unit": "score", "name": "Splay", "value": 139.67557399999995}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 18876.11187165574}]} 20:15:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18876.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1512.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6681.08"}}} 20:15:47 INFO - Return code: 0 20:15:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:15:47 INFO - # TBPL SUCCESS # 20:15:47 INFO - Running post-action listener: _resource_record_post_action 20:15:47 INFO - Running post-run listener: _resource_record_post_run 20:15:48 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 24576; Write bytes: 409980928; Read time: 368; Write time: 363644 20:15:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107483136; Read time: 148; Write time: 75896 20:15:48 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 20480; Write bytes: 302497792; Read time: 220; Write time: 287748 20:15:48 INFO - Running post-run listener: _upload_blobber_files 20:15:48 INFO - Blob upload gear active. 20:15:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:15:48 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 20:15:48 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:15:48 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:15:48 INFO - (blobuploader) - INFO - Open directory for files ... 20:15:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:15:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:15:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:15:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:15:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:15:49 INFO - (blobuploader) - INFO - Done attempting. 20:15:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:15:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:15:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:15:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:15:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:15:50 INFO - (blobuploader) - INFO - Done attempting. 20:15:50 INFO - (blobuploader) - INFO - Iteration through files over. 20:15:50 INFO - Return code: 0 20:15:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:15:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:15:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/587954ed6de8f33707f243226abd979565f40093c9a517d26cd4a592ceab710f7d555d7b28bad17c88279ceff3057a9e56866950f02962fb4a353e6ee47f6290", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cae71f5a58b8e4ba90a74dccd3d6c59e7aa1e53d7f5b367500c6dcaf67ad99dd736c20b5d16eb6f30ef1e8a2c0c007e561e4c6c776616fef0fb1532985d48487"} 20:15:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:15:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:15:50 INFO - Contents: 20:15:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/587954ed6de8f33707f243226abd979565f40093c9a517d26cd4a592ceab710f7d555d7b28bad17c88279ceff3057a9e56866950f02962fb4a353e6ee47f6290", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cae71f5a58b8e4ba90a74dccd3d6c59e7aa1e53d7f5b367500c6dcaf67ad99dd736c20b5d16eb6f30ef1e8a2c0c007e561e4c6c776616fef0fb1532985d48487"} 20:15:50 INFO - Copying logs to upload dir... 20:15:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.344342 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-11 20:15:50.204890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 20:15:50.208092) ========= 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=920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/587954ed6de8f33707f243226abd979565f40093c9a517d26cd4a592ceab710f7d555d7b28bad17c88279ceff3057a9e56866950f02962fb4a353e6ee47f6290", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cae71f5a58b8e4ba90a74dccd3d6c59e7aa1e53d7f5b367500c6dcaf67ad99dd736c20b5d16eb6f30ef1e8a2c0c007e561e4c6c776616fef0fb1532985d48487"} build_url:https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/cbj3tHSjSjamHhpEuq6-rQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/587954ed6de8f33707f243226abd979565f40093c9a517d26cd4a592ceab710f7d555d7b28bad17c88279ceff3057a9e56866950f02962fb4a353e6ee47f6290", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cae71f5a58b8e4ba90a74dccd3d6c59e7aa1e53d7f5b367500c6dcaf67ad99dd736c20b5d16eb6f30ef1e8a2c0c007e561e4c6c776616fef0fb1532985d48487"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 20:15:50.233712) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 20:15:50.234091) ========= 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=920470bf432669ad7e3a5387000001ca-1452568392.959839-999545941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004841 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 20:15:50.317564) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 20:15:50.318132) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 20:15:50.318726) ========= ========= Total master_lag: 0.19 =========