builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1451620830.51 results: success (0) buildid: 20151231173004 builduid: b7cb4c5930c44d42a0871f9ce26ac5a2 revision: 6786ccb1dba475cb92f0a69b8daf544d4213c8da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.512618) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.513135) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.513471) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004532 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.532150) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.532534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.548837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.549249) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004674 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.599776) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.600101) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.600534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.600832) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 20:00: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% 43.2M=0s 2015-12-31 20:00:32 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168014 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.866093) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.866498) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016054 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.908231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:30.908603) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6786ccb1dba475cb92f0a69b8daf544d4213c8da --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 6786ccb1dba475cb92f0a69b8daf544d4213c8da --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=8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 20:00:32,246 truncating revision to first 12 chars 2015-12-31 20:00:32,246 Setting DEBUG logging. 2015-12-31 20:00:32,246 attempt 1/10 2015-12-31 20:00:32,246 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6786ccb1dba4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 20:00:32,501 unpacking tar archive at: fx-team-6786ccb1dba4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559793 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.484331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.484669) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.495019) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.495446) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.496003) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-31 20:00:31.496331) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:00:32 INFO - MultiFileLogger online at 20151231 20:00:32 in /builds/slave/test-pgo 20:00:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:00:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:00:32 INFO - {'append_to_log': False, 20:00:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:00:32 INFO - 'blob_upload_branch': 'Fx-Team', 20:00:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:00:32 INFO - 'branch': 'Fx-Team', 20:00:32 INFO - 'buildbot_json_path': 'buildprops.json', 20:00:32 INFO - 'config_files': ('talos/linux_config.py',), 20:00:32 INFO - 'default_actions': ('clobber', 20:00:32 INFO - 'read-buildbot-config', 20:00:32 INFO - 'download-and-extract', 20:00:32 INFO - 'populate-webroot', 20:00:32 INFO - 'create-virtualenv', 20:00:32 INFO - 'install', 20:00:32 INFO - 'run-tests'), 20:00:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:00:32 INFO - 'download_minidump_stackwalk': True, 20:00:32 INFO - 'download_symbols': 'ondemand', 20:00:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:00:32 INFO - 'tooltool.py': '/tools/tooltool.py', 20:00:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:00:32 INFO - '/tools/misc-python/virtualenv.py')}, 20:00:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:00:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:00:32 INFO - 'installer_path': 'installer.exe', 20:00:32 INFO - 'log_level': 'info', 20:00:32 INFO - 'log_name': 'talos', 20:00:32 INFO - 'log_to_console': True, 20:00:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:00:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:00:32 INFO - 'opt_config_files': (), 20:00:32 INFO - 'pip_index': False, 20:00:32 INFO - 'sps_profile': False, 20:00:32 INFO - 'sps_profile_interval': 0, 20:00:32 INFO - 'suite': 'dromaeojs-e10s', 20:00:32 INFO - 'system_bits': '32', 20:00:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:00:32 INFO - 'title': 'talos-linux64-ix-004', 20:00:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:00:32 INFO - 'use_talos_json': True, 20:00:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:00:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:00:32 INFO - 'work_dir': 'build'} 20:00:32 INFO - ##### 20:00:32 INFO - ##### Running clobber step. 20:00:32 INFO - ##### 20:00:32 INFO - Running pre-action listener: _resource_record_pre_action 20:00:32 INFO - Running main action method: clobber 20:00:32 INFO - rmtree: /builds/slave/test-pgo/build 20:00:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:00:33 INFO - Running post-action listener: _resource_record_post_action 20:00:33 INFO - ##### 20:00:33 INFO - ##### Running read-buildbot-config step. 20:00:33 INFO - ##### 20:00:33 INFO - Running pre-action listener: _resource_record_pre_action 20:00:33 INFO - Running main action method: read_buildbot_config 20:00:33 INFO - Using buildbot properties: 20:00:33 INFO - { 20:00:33 INFO - "project": "", 20:00:33 INFO - "product": "firefox", 20:00:33 INFO - "script_repo_revision": "production", 20:00:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:00:33 INFO - "repository": "", 20:00:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:00:33 INFO - "buildid": "20151231173004", 20:00:33 INFO - "pgo_build": "True", 20:00:33 INFO - "basedir": "/builds/slave/test-pgo", 20:00:33 INFO - "buildnumber": 168, 20:00:33 INFO - "slavename": "talos-linux64-ix-004", 20:00:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:00:33 INFO - "platform": "ubuntu64_hw", 20:00:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:00:33 INFO - "branch": "fx-team", 20:00:33 INFO - "repo_path": "integration/fx-team", 20:00:33 INFO - "revision": "6786ccb1dba475cb92f0a69b8daf544d4213c8da", 20:00:33 INFO - "stage_platform": "linux64-pgo", 20:00:33 INFO - "builduid": "b7cb4c5930c44d42a0871f9ce26ac5a2", 20:00:33 INFO - "slavebuilddir": "test" 20:00:33 INFO - } 20:00:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:00:33 INFO - Running post-action listener: _resource_record_post_action 20:00:33 INFO - ##### 20:00:33 INFO - ##### Running download-and-extract step. 20:00:33 INFO - ##### 20:00:33 INFO - Running pre-action listener: _resource_record_pre_action 20:00:33 INFO - Running main action method: download_and_extract 20:00:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:00: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')]} 20:00:33 INFO - https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/test_packages.json 20:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/test_packages.json 20:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:00:34 INFO - Downloaded 1302 bytes. 20:00:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:00:34 INFO - Using the following test package requirements: 20:00:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:00:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:00:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:34 INFO - u'jsshell-linux-x86_64.zip'], 20:00:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:00:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:00:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:00:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:00:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:00:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:00:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:00:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:34 INFO - https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:35 INFO - Downloaded 23195603 bytes. 20:00:35 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 20:00:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:00:35 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 20:00:36 INFO - Return code: 0 20:00:36 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 20:00:36 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')]} 20:00:36 INFO - https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:44 INFO - Downloaded 23195603 bytes. 20:00:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 20:00:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:00:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:00:45 INFO - Return code: 0 20:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:45 INFO - https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:00:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:00:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:00:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:46 INFO - Downloaded 11132285 bytes. 20:00: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 20:00:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:00: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 20:00:47 INFO - Return code: 0 20:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:47 INFO - https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:00:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:00:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:00:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:48 INFO - Downloaded 54943697 bytes. 20:00:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:00:48 INFO - mkdir: /builds/slave/test-pgo/properties 20:00:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:00:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:00:48 INFO - Contents: 20:00:48 INFO - build_url:https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:00:48 INFO - Running post-action listener: _resource_record_post_action 20:00:48 INFO - Running post-action listener: set_extra_try_arguments 20:00:48 INFO - ##### 20:00:48 INFO - ##### Running populate-webroot step. 20:00:48 INFO - ##### 20:00:48 INFO - Running pre-action listener: _resource_record_pre_action 20:00:48 INFO - Running main action method: populate_webroot 20:00:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:00:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:00:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:00:48 INFO - '--tppagecycles', 20:00:48 INFO - '7'], 20:00:48 INFO - 'tests': ['tsvgm']}}, 20:00:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:00:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:00:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:00:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:00:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:00:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:00:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:00:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:48 INFO - 'talos_options': ['--e10s'], 20:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:00:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:48 INFO - 'tests': ['damp', 'tps']}, 20:00:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:48 INFO - 'talos_options': ['--e10s'], 20:00:48 INFO - 'tests': ['damp', 'tps']}, 20:00:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:00:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:00:48 INFO - 'other': {'tests': ['a11yr', 20:00:48 INFO - 'ts_paint', 20:00:48 INFO - 'tpaint', 20:00:48 INFO - 'sessionrestore', 20:00:48 INFO - 'sessionrestore_no_auto_restore']}, 20:00:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:00:48 INFO - 'tests': ['a11yr', 20:00:48 INFO - 'ts_paint', 20:00:48 INFO - 'tpaint', 20:00:48 INFO - 'sessionrestore', 20:00:48 INFO - 'sessionrestore_no_auto_restore']}, 20:00:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:00:48 INFO - 'tests': ['a11yr', 20:00:48 INFO - 'ts_paint', 20:00:48 INFO - 'tpaint', 20:00:48 INFO - 'sessionrestore', 20:00:48 INFO - 'sessionrestore_no_auto_restore']}, 20:00:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:00:48 INFO - 'tests': ['a11yr', 20:00:48 INFO - 'ts_paint', 20:00:48 INFO - 'tpaint', 20:00:48 INFO - 'sessionrestore', 20:00:48 INFO - 'sessionrestore_no_auto_restore']}, 20:00:48 INFO - 'other_l64': {'tests': ['a11yr', 20:00:48 INFO - 'ts_paint', 20:00:48 INFO - 'tpaint', 20:00:48 INFO - 'sessionrestore', 20:00:48 INFO - 'sessionrestore_no_auto_restore']}, 20:00:48 INFO - 'other_nol64': {'tests': ['a11yr', 20:00:48 INFO - 'ts_paint', 20:00:48 INFO - 'tpaint', 20:00:48 INFO - 'sessionrestore', 20:00:48 INFO - 'sessionrestore_no_auto_restore']}, 20:00:48 INFO - 'svgr': {'tests': ['tsvgx', 20:00:48 INFO - 'tsvgr_opacity', 20:00:48 INFO - 'tart', 20:00:48 INFO - 'tscrollx', 20:00:48 INFO - 'cart']}, 20:00:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:00:48 INFO - 'tests': ['tsvgx', 20:00:48 INFO - 'tsvgr_opacity', 20:00:48 INFO - 'tart', 20:00:48 INFO - 'tscrollx', 20:00:48 INFO - 'cart']}, 20:00:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:48 INFO - 'tests': ['tp5o']}, 20:00:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:48 INFO - 'talos_options': ['--e10s'], 20:00:48 INFO - 'tests': ['tp5o']}, 20:00:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:48 INFO - 'talos_options': ['--xperf_path', 20:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:00:48 INFO - 'tests': ['tp5n']}, 20:00:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:48 INFO - 'talos_options': ['--e10s', 20:00:48 INFO - '--xperf_path', 20:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:00:48 INFO - 'tests': ['tp5n']}}, 20:00:48 INFO - 'talos.zip': {'path': '', 20:00:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:00:48 INFO - Running post-action listener: _resource_record_post_action 20:00:48 INFO - ##### 20:00:48 INFO - ##### Running create-virtualenv step. 20:00:48 INFO - ##### 20:00:48 INFO - Running pre-action listener: _resource_record_pre_action 20:00:48 INFO - Running main action method: create_virtualenv 20:00:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:00:48 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 20:00:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:00:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:00:48 INFO - Using real prefix '/usr' 20:00:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:00:48 INFO - Installing distribute.............................................................................................................................................................................................done. 20:00:51 INFO - Installing pip.................done. 20:00:51 INFO - Return code: 0 20:00:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:51 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 0x7fdf1cddbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876840>, '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 0x17e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', '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 20:00:51 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 20:00:51 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 20:00:51 INFO - Using env: {'DISPLAY': ':0', 20:00:51 INFO - 'HOME': '/home/cltbld', 20:00:51 INFO - 'LANG': 'en_US.UTF-8', 20:00:51 INFO - 'LANGUAGE': 'en_US:en', 20:00:51 INFO - 'LOGNAME': 'cltbld', 20:00:51 INFO - 'MAIL': '/var/mail/cltbld', 20:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:51 INFO - 'MOZ_NO_REMOTE': '1', 20:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:51 INFO - 'NO_EM_RESTART': '1', 20:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:51 INFO - 'SHELL': '/bin/bash', 20:00:51 INFO - 'SHLVL': '1', 20:00:51 INFO - 'TERM': 'linux', 20:00:51 INFO - 'TMOUT': '86400', 20:00:51 INFO - 'USER': 'cltbld', 20:00:51 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', 20:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:51 INFO - '_': '/tools/buildbot/bin/python'} 20:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:51 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 20:00:51 INFO - Cleaning up... 20:00:51 INFO - Return code: 0 20:00:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:51 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 0x7fdf1cddbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876840>, '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 0x17e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', '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 20:00:51 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 20:00:51 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 20:00:51 INFO - Using env: {'DISPLAY': ':0', 20:00:51 INFO - 'HOME': '/home/cltbld', 20:00:51 INFO - 'LANG': 'en_US.UTF-8', 20:00:51 INFO - 'LANGUAGE': 'en_US:en', 20:00:51 INFO - 'LOGNAME': 'cltbld', 20:00:51 INFO - 'MAIL': '/var/mail/cltbld', 20:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:51 INFO - 'MOZ_NO_REMOTE': '1', 20:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:51 INFO - 'NO_EM_RESTART': '1', 20:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:51 INFO - 'SHELL': '/bin/bash', 20:00:51 INFO - 'SHLVL': '1', 20:00:51 INFO - 'TERM': 'linux', 20:00:51 INFO - 'TMOUT': '86400', 20:00:51 INFO - 'USER': 'cltbld', 20:00:51 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', 20:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:51 INFO - '_': '/tools/buildbot/bin/python'} 20:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:51 INFO - Downloading/unpacking psutil>=0.7.1 20:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:00:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:00:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:00:53 INFO - Installing collected packages: psutil 20:00:53 INFO - Running setup.py install for psutil 20:00:53 INFO - building 'psutil._psutil_linux' extension 20:00:53 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 20:00:53 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 20:00:53 INFO - building 'psutil._psutil_posix' extension 20:00:53 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 20:00:53 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 20:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:00:53 INFO - Successfully installed psutil 20:00:53 INFO - Cleaning up... 20:00:53 INFO - Return code: 0 20:00:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:53 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 0x7fdf1cddbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876840>, '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 0x17e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', '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 20:00:53 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 20:00:53 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 20:00:53 INFO - Using env: {'DISPLAY': ':0', 20:00:53 INFO - 'HOME': '/home/cltbld', 20:00:53 INFO - 'LANG': 'en_US.UTF-8', 20:00:53 INFO - 'LANGUAGE': 'en_US:en', 20:00:53 INFO - 'LOGNAME': 'cltbld', 20:00:53 INFO - 'MAIL': '/var/mail/cltbld', 20:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:53 INFO - 'MOZ_NO_REMOTE': '1', 20:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:53 INFO - 'NO_EM_RESTART': '1', 20:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:53 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:53 INFO - 'SHELL': '/bin/bash', 20:00:53 INFO - 'SHLVL': '1', 20:00:53 INFO - 'TERM': 'linux', 20:00:53 INFO - 'TMOUT': '86400', 20:00:53 INFO - 'USER': 'cltbld', 20:00:53 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', 20:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:53 INFO - '_': '/tools/buildbot/bin/python'} 20:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:00:54 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 20:00:54 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 20:00:54 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 20:00:54 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 20:00:54 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 20:00:54 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 20:00:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:00:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:00:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:00:55 INFO - Installing collected packages: mozsystemmonitor 20:00:55 INFO - Running setup.py install for mozsystemmonitor 20:00:55 INFO - Successfully installed mozsystemmonitor 20:00:55 INFO - Cleaning up... 20:00:55 INFO - Return code: 0 20:00:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdf1cddbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876840>, '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 0x17e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', '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 20:00:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 20:00:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:00:55 INFO - Using env: {'DISPLAY': ':0', 20:00:55 INFO - 'HOME': '/home/cltbld', 20:00:55 INFO - 'LANG': 'en_US.UTF-8', 20:00:55 INFO - 'LANGUAGE': 'en_US:en', 20:00:55 INFO - 'LOGNAME': 'cltbld', 20:00:55 INFO - 'MAIL': '/var/mail/cltbld', 20:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:55 INFO - 'MOZ_NO_REMOTE': '1', 20:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:55 INFO - 'NO_EM_RESTART': '1', 20:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:55 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:55 INFO - 'SHELL': '/bin/bash', 20:00:55 INFO - 'SHLVL': '1', 20:00:55 INFO - 'TERM': 'linux', 20:00:55 INFO - 'TMOUT': '86400', 20:00:55 INFO - 'USER': 'cltbld', 20:00:55 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', 20:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:55 INFO - '_': '/tools/buildbot/bin/python'} 20:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:56 INFO - Downloading/unpacking blobuploader==1.2.4 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00:57 INFO - Downloading blobuploader-1.2.4.tar.gz 20:00:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:00:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:00:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:00:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:00:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:58 INFO - Downloading docopt-0.6.1.tar.gz 20:00:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:00:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:00:58 INFO - Installing collected packages: blobuploader, requests, docopt 20:00:58 INFO - Running setup.py install for blobuploader 20:00:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:00:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:00:58 INFO - Running setup.py install for requests 20:00:59 INFO - Running setup.py install for docopt 20:00:59 INFO - Successfully installed blobuploader requests docopt 20:00:59 INFO - Cleaning up... 20:00:59 INFO - Return code: 0 20:00:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:00: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')]} 20:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00: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')]} 20:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:59 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 0x7fdf1cddbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876840>, '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 0x17e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', '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 20:00:59 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 20:00:59 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 20:00:59 INFO - Using env: {'DISPLAY': ':0', 20:00:59 INFO - 'HOME': '/home/cltbld', 20:00:59 INFO - 'LANG': 'en_US.UTF-8', 20:00:59 INFO - 'LANGUAGE': 'en_US:en', 20:00:59 INFO - 'LOGNAME': 'cltbld', 20:00:59 INFO - 'MAIL': '/var/mail/cltbld', 20:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:59 INFO - 'MOZ_NO_REMOTE': '1', 20:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:59 INFO - 'NO_EM_RESTART': '1', 20:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:59 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:59 INFO - 'SHELL': '/bin/bash', 20:00:59 INFO - 'SHLVL': '1', 20:00:59 INFO - 'TERM': 'linux', 20:00:59 INFO - 'TMOUT': '86400', 20:00:59 INFO - 'USER': 'cltbld', 20:00:59 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', 20:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:59 INFO - '_': '/tools/buildbot/bin/python'} 20:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:00:59 INFO - Running setup.py (path:/tmp/pip-G7zV0N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:00:59 INFO - Running setup.py (path:/tmp/pip-SjbDWf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:00:59 INFO - Running setup.py (path:/tmp/pip-mRxDkO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:00:59 INFO - Running setup.py (path:/tmp/pip-5o2a44-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:59 INFO - Running setup.py (path:/tmp/pip-k5x5y9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:59 INFO - Running setup.py (path:/tmp/pip-394hL7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:59 INFO - Running setup.py (path:/tmp/pip-sZBvcK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:59 INFO - Running setup.py (path:/tmp/pip-q1KOTL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:59 INFO - Running setup.py (path:/tmp/pip-kvoggF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:01:00 INFO - Running setup.py (path:/tmp/pip-JF5cYy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:01:00 INFO - Running setup.py (path:/tmp/pip-mXsUxS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:01:00 INFO - Running setup.py (path:/tmp/pip-MdwXtL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:01:00 INFO - Running setup.py (path:/tmp/pip-PGywKc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:01:00 INFO - Running setup.py (path:/tmp/pip-nNuxxu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:01:00 INFO - Running setup.py (path:/tmp/pip-dNhbmN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:01:00 INFO - Running setup.py (path:/tmp/pip-a7dRlD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:01:00 INFO - Running setup.py (path:/tmp/pip-7kSStg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:01:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:01:00 INFO - Running setup.py install for manifestparser 20:01:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:01:00 INFO - Running setup.py install for mozcrash 20:01:00 INFO - Running setup.py install for mozdebug 20:01:00 INFO - Running setup.py install for mozdevice 20:01:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Running setup.py install for mozfile 20:01:01 INFO - Running setup.py install for mozhttpd 20:01:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Running setup.py install for mozinfo 20:01:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Running setup.py install for mozInstall 20:01:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Running setup.py install for mozleak 20:01:01 INFO - Running setup.py install for mozlog 20:01:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Running setup.py install for moznetwork 20:01:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Running setup.py install for mozprocess 20:01:01 INFO - Running setup.py install for mozprofile 20:01:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:01:01 INFO - Running setup.py install for mozrunner 20:01:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:01:02 INFO - Running setup.py install for mozscreenshot 20:01:02 INFO - Running setup.py install for moztest 20:01:02 INFO - Running setup.py install for mozversion 20:01:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:01:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:01:02 INFO - Cleaning up... 20:01:02 INFO - Return code: 0 20:01:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fdf1cddbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876840>, '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 0x17e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', '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 20:01:02 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 20:01:02 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 20:01:02 INFO - Using env: {'DISPLAY': ':0', 20:01:02 INFO - 'HOME': '/home/cltbld', 20:01:02 INFO - 'LANG': 'en_US.UTF-8', 20:01:02 INFO - 'LANGUAGE': 'en_US:en', 20:01:02 INFO - 'LOGNAME': 'cltbld', 20:01:02 INFO - 'MAIL': '/var/mail/cltbld', 20:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:02 INFO - 'MOZ_NO_REMOTE': '1', 20:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:02 INFO - 'NO_EM_RESTART': '1', 20:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:02 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:02 INFO - 'SHELL': '/bin/bash', 20:01:02 INFO - 'SHLVL': '1', 20:01:02 INFO - 'TERM': 'linux', 20:01:02 INFO - 'TMOUT': '86400', 20:01:02 INFO - 'USER': 'cltbld', 20:01:02 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', 20:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:02 INFO - '_': '/tools/buildbot/bin/python'} 20:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:01:02 INFO - Running setup.py (path:/tmp/pip-WmkjGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:01:02 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)) 20:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:01:02 INFO - Running setup.py (path:/tmp/pip-KlQtnD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:01:02 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)) 20:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:01:02 INFO - Running setup.py (path:/tmp/pip-qyzqKf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:01:02 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)) 20:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:01:02 INFO - Running setup.py (path:/tmp/pip-pfe5Fq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:01:02 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)) 20:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:01:02 INFO - Running setup.py (path:/tmp/pip-zVqJVZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:01:02 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)) 20:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:01:02 INFO - Running setup.py (path:/tmp/pip-P0DOXC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:01:03 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)) 20:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:01:03 INFO - Running setup.py (path:/tmp/pip-E4IRBL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:01:03 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)) 20:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:01:03 INFO - Running setup.py (path:/tmp/pip-pLbhCu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:01:03 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)) 20:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:01:03 INFO - Running setup.py (path:/tmp/pip-xgs0c9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:01:03 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)) 20:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:01:03 INFO - Running setup.py (path:/tmp/pip-g2IzZa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:01:03 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)) 20:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:01:03 INFO - Running setup.py (path:/tmp/pip-0kwcFk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:01:03 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)) 20:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:01:03 INFO - Running setup.py (path:/tmp/pip-cj22yI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:01:03 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)) 20:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:01:03 INFO - Running setup.py (path:/tmp/pip-C8XuCl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:01:03 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)) 20:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:01:03 INFO - Running setup.py (path:/tmp/pip-E4wUg4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:01:03 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)) 20:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:01:03 INFO - Running setup.py (path:/tmp/pip-G2uG22-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:01:03 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)) 20:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:01:03 INFO - Running setup.py (path:/tmp/pip-PH5hcK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:01:03 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)) 20:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:01:03 INFO - Running setup.py (path:/tmp/pip-sXgvI0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:01:03 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)) 20:01:03 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)) 20:01:03 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)) 20:01:03 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)) 20:01:03 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)) 20:01:03 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)) 20:01:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:01: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 20:01: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 20:01: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 20:01: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 20:01: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 20:01: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 20:01:05 INFO - Downloading blessings-1.5.1.tar.gz 20:01:05 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 20:01:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:01:05 INFO - Installing collected packages: blessings 20:01:05 INFO - Running setup.py install for blessings 20:01:05 INFO - Successfully installed blessings 20:01:05 INFO - Cleaning up... 20:01:05 INFO - Return code: 0 20:01:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:01:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:01:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:01:06 INFO - Reading from file tmpfile_stdout 20:01:06 INFO - Current package versions: 20:01:06 INFO - argparse == 1.2.1 20:01:06 INFO - blessings == 1.5.1 20:01:06 INFO - blobuploader == 1.2.4 20:01:06 INFO - docopt == 0.6.1 20:01:06 INFO - manifestparser == 1.1 20:01:06 INFO - mozInstall == 1.12 20:01:06 INFO - mozcrash == 0.16 20:01:06 INFO - mozdebug == 0.1 20:01:06 INFO - mozdevice == 0.47 20:01:06 INFO - mozfile == 1.2 20:01:06 INFO - mozhttpd == 0.7 20:01:06 INFO - mozinfo == 0.9 20:01:06 INFO - mozleak == 0.1 20:01:06 INFO - mozlog == 3.1 20:01:06 INFO - moznetwork == 0.27 20:01:06 INFO - mozprocess == 0.22 20:01:06 INFO - mozprofile == 0.28 20:01:06 INFO - mozrunner == 6.11 20:01:06 INFO - mozscreenshot == 0.1 20:01:06 INFO - mozsystemmonitor == 0.0 20:01:06 INFO - moztest == 0.7 20:01:06 INFO - mozversion == 1.4 20:01:06 INFO - psutil == 3.1.1 20:01:06 INFO - requests == 1.2.3 20:01:06 INFO - wsgiref == 0.1.2 20:01:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fdf1cddbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876840>, '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 0x17e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', '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 20:01:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 20:01:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 20:01:06 INFO - Using env: {'DISPLAY': ':0', 20:01:06 INFO - 'HOME': '/home/cltbld', 20:01:06 INFO - 'LANG': 'en_US.UTF-8', 20:01:06 INFO - 'LANGUAGE': 'en_US:en', 20:01:06 INFO - 'LOGNAME': 'cltbld', 20:01:06 INFO - 'MAIL': '/var/mail/cltbld', 20:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:06 INFO - 'MOZ_NO_REMOTE': '1', 20:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:06 INFO - 'NO_EM_RESTART': '1', 20:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:06 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:06 INFO - 'SHELL': '/bin/bash', 20:01:06 INFO - 'SHLVL': '1', 20:01:06 INFO - 'TERM': 'linux', 20:01:06 INFO - 'TMOUT': '86400', 20:01:06 INFO - 'USER': 'cltbld', 20:01:06 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', 20:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:06 INFO - '_': '/tools/buildbot/bin/python'} 20:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:06 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)) 20:01:06 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)) 20:01:06 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)) 20:01:06 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)) 20:01:06 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)) 20:01:06 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)) 20:01:06 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)) 20:01:06 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)) 20:01:06 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)) 20:01:06 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)) 20:01:06 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)) 20:01:06 INFO - Cleaning up... 20:01:06 INFO - Return code: 0 20:01:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1cddbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876840>, '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 0x17e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', '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 20:01:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 20:01:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:01:06 INFO - Using env: {'DISPLAY': ':0', 20:01:06 INFO - 'HOME': '/home/cltbld', 20:01:06 INFO - 'LANG': 'en_US.UTF-8', 20:01:06 INFO - 'LANGUAGE': 'en_US:en', 20:01:06 INFO - 'LOGNAME': 'cltbld', 20:01:06 INFO - 'MAIL': '/var/mail/cltbld', 20:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:06 INFO - 'MOZ_NO_REMOTE': '1', 20:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:06 INFO - 'NO_EM_RESTART': '1', 20:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:06 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:06 INFO - 'SHELL': '/bin/bash', 20:01:06 INFO - 'SHLVL': '1', 20:01:06 INFO - 'TERM': 'linux', 20:01:06 INFO - 'TMOUT': '86400', 20:01:06 INFO - 'USER': 'cltbld', 20:01:06 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', 20:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:06 INFO - '_': '/tools/buildbot/bin/python'} 20:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:06 INFO - Downloading/unpacking jsonschema 20:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:01:08 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 20:01:08 INFO - Downloading/unpacking functools32 (from jsonschema) 20:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:08 INFO - Downloading functools32-3.2.3-2.tar.gz 20:01:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:01:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:01:08 INFO - warning: no files found matching '*.txt' 20:01:08 INFO - no previously-included directories found matching 'build' 20:01:08 INFO - no previously-included directories found matching 'dist' 20:01:08 INFO - no previously-included directories found matching '.git*' 20:01:08 INFO - Installing collected packages: jsonschema, functools32 20:01:08 INFO - Running setup.py install for functools32 20:01:08 INFO - warning: no files found matching '*.txt' 20:01:08 INFO - no previously-included directories found matching 'build' 20:01:08 INFO - no previously-included directories found matching 'dist' 20:01:08 INFO - no previously-included directories found matching '.git*' 20:01:08 INFO - Successfully installed jsonschema functools32 20:01:08 INFO - Cleaning up... 20:01:08 INFO - Return code: 0 20:01:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:01:08 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')]} 20:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:08 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')]} 20:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:08 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 0x7fdf1cddbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876840>, '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 0x17e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3b60>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', '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 20:01:08 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 20:01:08 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 20:01:08 INFO - Using env: {'DISPLAY': ':0', 20:01:08 INFO - 'HOME': '/home/cltbld', 20:01:08 INFO - 'LANG': 'en_US.UTF-8', 20:01:08 INFO - 'LANGUAGE': 'en_US:en', 20:01:08 INFO - 'LOGNAME': 'cltbld', 20:01:08 INFO - 'MAIL': '/var/mail/cltbld', 20:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:08 INFO - 'MOZ_NO_REMOTE': '1', 20:01:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:08 INFO - 'NO_EM_RESTART': '1', 20:01:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:08 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:08 INFO - 'SHELL': '/bin/bash', 20:01:08 INFO - 'SHLVL': '1', 20:01:08 INFO - 'TERM': 'linux', 20:01:08 INFO - 'TMOUT': '86400', 20:01:08 INFO - 'USER': 'cltbld', 20:01:08 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', 20:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:08 INFO - '_': '/tools/buildbot/bin/python'} 20:01:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:08 INFO - Downloading/unpacking flake8 20:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:01:10 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 20:01:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:01:10 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 20:01:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:10 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 20:01:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:01:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:01:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:01:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:01:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:01:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:01:11 INFO - no previously-included directories found matching 'docs/_build' 20:01:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:01:11 INFO - Running setup.py install for pep8 20:01:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:01:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:01:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:01:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:01:11 INFO - no previously-included directories found matching 'docs/_build' 20:01:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:01:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:01:11 INFO - Cleaning up... 20:01:11 INFO - Return code: 0 20:01:11 INFO - Running post-action listener: _resource_record_post_action 20:01:11 INFO - Running post-action listener: _start_resource_monitoring 20:01:11 INFO - Starting resource monitoring. 20:01:11 INFO - ##### 20:01:11 INFO - ##### Running install step. 20:01:11 INFO - ##### 20:01:11 INFO - Running pre-action listener: _resource_record_pre_action 20:01:11 INFO - Running main action method: install 20:01:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:01:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:01:11 INFO - Reading from file tmpfile_stdout 20:01:11 INFO - Detecting whether we're running mozinstall >=1.0... 20:01:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:01:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:01:11 INFO - Reading from file tmpfile_stdout 20:01:11 INFO - Output received: 20:01:11 INFO - Usage: mozinstall [options] installer 20:01:11 INFO - Options: 20:01:11 INFO - -h, --help show this help message and exit 20:01:11 INFO - -d DEST, --destination=DEST 20:01:11 INFO - Directory to install application into. [default: 20:01:11 INFO - "/builds/slave/test-pgo"] 20:01:11 INFO - --app=APP Application being installed. [default: firefox] 20:01:11 INFO - mkdir: /builds/slave/test-pgo/build/application 20:01:11 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'] 20:01:11 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 20:01:27 INFO - Reading from file tmpfile_stdout 20:01:27 INFO - Output received: 20:01:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:01:27 INFO - Running post-action listener: _resource_record_post_action 20:01:27 INFO - ##### 20:01:27 INFO - ##### Running run-tests step. 20:01:27 INFO - ##### 20:01:27 INFO - Running pre-action listener: _resource_record_pre_action 20:01:27 INFO - Running main action method: run_tests 20:01:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:01:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:01:27 INFO - Python 2.7.3 20:01:27 INFO - Return code: 0 20:01:27 INFO - grabbing minidump binary from tooltool 20:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:27 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 0x1876840>, '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 0x17e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:01:27 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 20:01:27 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 20:01:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:01:27 INFO - Return code: 0 20:01:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:01:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:01:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:01:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:01:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:01:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:01:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:01:28 INFO - Return code: 0 20:01:28 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 20:01:28 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:01:28 INFO - Using env: {'DISPLAY': ':0', 20:01:28 INFO - 'HOME': '/home/cltbld', 20:01:28 INFO - 'LANG': 'en_US.UTF-8', 20:01:28 INFO - 'LANGUAGE': 'en_US:en', 20:01:28 INFO - 'LOGNAME': 'cltbld', 20:01:28 INFO - 'MAIL': '/var/mail/cltbld', 20:01:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:01:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:28 INFO - 'MOZ_NO_REMOTE': '1', 20:01:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:28 INFO - 'NO_EM_RESTART': '1', 20:01:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:28 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:01:28 INFO - 'SHELL': '/bin/bash', 20:01:28 INFO - 'SHLVL': '1', 20:01:28 INFO - 'TERM': 'linux', 20:01:28 INFO - 'TMOUT': '86400', 20:01:28 INFO - 'USER': 'cltbld', 20:01:28 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223', 20:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:28 INFO - '_': '/tools/buildbot/bin/python'} 20:01:28 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:01:28 INFO - mozversion application_buildid: 20151231173004 20:01:28 INFO - mozversion application_changeset: 6786ccb1dba475cb92f0a69b8daf544d4213c8da 20:01:28 INFO - mozversion application_display_name: Nightly 20:01:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:01:28 INFO - mozversion application_name: Firefox 20:01:28 INFO - mozversion application_remotingname: firefox 20:01:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:01:28 INFO - mozversion application_vendor: Mozilla 20:01:28 INFO - mozversion application_version: 46.0a1 20:01:28 INFO - mozversion platform_buildid: 20151231173004 20:01:28 INFO - mozversion platform_changeset: 6786ccb1dba475cb92f0a69b8daf544d4213c8da 20:01:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:01:28 INFO - mozversion platform_version: 46.0a1 20:01:28 INFO - using testdate: 1451620888 20:01:28 INFO - actual date: 1451620888 20:01:28 INFO - starting webserver on 'localhost:38791' 20:01:28 INFO - SUITE-START | Running 3 tests 20:01:28 INFO - TEST-START | dromaeo_css 20:01:28 INFO - operating with platform_type : linux_ 20:01:28 INFO - Initialising browser for dromaeo_css test... 20:01:28 INFO - TEST-INFO | started process 14995 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUvtH96/profile http://localhost:38791/getInfo.html) 20:01:33 INFO - PROCESS | 14995 | __metrics Screen width/height:1600/1200 20:01:33 INFO - PROCESS | 14995 | colorDepth:24 20:01:33 INFO - PROCESS | 14995 | Browser inner width/height: 1024/697 20:01:33 INFO - PROCESS | 14995 | __metrics 20:01:33 INFO - PROCESS | 14995 | 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:01:34 INFO - TEST-INFO | 14995: exit 0 20:01:34 INFO - Browser initialized. 20:01:34 INFO - Running cycle 1/1 for dromaeo_css test... 20:01:34 INFO - TEST-INFO | started process 15128 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUvtH96/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:01:45 INFO - PROCESS | 15128 | RSS: Main: 150519808 20:01:45 INFO - PROCESS | 15128 | 20:02:35 INFO - PROCESS | 15128 | 1451620955393 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] 20:04:44 INFO - PROCESS | 15128 | Cycle 1(1): loaded http://localhost:38791/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38791/tests/dromaeo/cssquery-ext.html) 20:04:45 INFO - PROCESS | 15128 | RSS: Main: 157843456 20:04:45 INFO - PROCESS | 15128 | 20:07:47 INFO - PROCESS | 15128 | Cycle 1(1): loaded http://localhost:38791/tests/dromaeo/cssquery-ext.html (next: http://localhost:38791/tests/dromaeo/cssquery-jquery.html) 20:07:48 INFO - PROCESS | 15128 | RSS: Main: 154685440 20:07:48 INFO - PROCESS | 15128 | 20:10:50 INFO - PROCESS | 15128 | Cycle 1(1): loaded http://localhost:38791/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38791/tests/dromaeo/cssquery-mootools.html) 20:10:50 INFO - PROCESS | 15128 | RSS: Main: 153292800 20:10:50 INFO - PROCESS | 15128 | 20:13:52 INFO - PROCESS | 15128 | Cycle 1(1): loaded http://localhost:38791/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38791/tests/dromaeo/cssquery-prototype.html) 20:13:53 INFO - PROCESS | 15128 | RSS: Main: 151695360 20:13:53 INFO - PROCESS | 15128 | 20:16:55 INFO - PROCESS | 15128 | Cycle 1(1): loaded http://localhost:38791/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38791/tests/dromaeo/cssquery-yui.html) 20:16:56 INFO - PROCESS | 15128 | RSS: Main: 152821760 20:16:56 INFO - PROCESS | 15128 | 20:19:58 INFO - PROCESS | 15128 | Cycle 1(1): loaded http://localhost:38791/tests/dromaeo/cssquery-yui.html (next: http://localhost:38791/tests/dromaeo/cssquery-dojo.html) 20:19:58 INFO - PROCESS | 15128 | RSS: Main: 155312128 20:19:58 INFO - PROCESS | 15128 | 20:19:58 INFO - PROCESS | 15128 | __start_tp_report 20:19:58 INFO - PROCESS | 15128 | _x_x_mozilla_page_load 20:19:58 INFO - PROCESS | 15128 | _x_x_mozilla_page_load_details 20:19:58 INFO - PROCESS | 15128 | |i|pagename|runs| 20:19:58 INFO - PROCESS | 15128 | |0;dojo.html;3237.8381080945956;3261.86952521899;3315.1214928044055;3317.8838740644073;3321.15310595798;5384.40771515134;5511.751971161298;5514.172874068887;5514.310711161105;5535.335759708831;5381.865453363668;5402.945970540293;5489.64317319374;5563.13771365438;5580.944190558093;4968.652194346406;5019.874503137433;5068.315777370063;5084.847454576368;5187.948120518784;4992.725400102993;5012.298278241031;5085.949140508585;5102.030614183312;5102.540771330579;4919.606431485473;4928.852134435972;5022.698638081709;5030.723310217936;5060.240963855451;4984.526469985346;4986.326845875833;4994.175960966436;5010.2735103409805;5059.974700126476;4932.753362331869;4966.975165124188;4968.453470118284;4974.552290293855;5061.924071138936;5268.4994925482015;5312.681239125664;5394.946050539484;5402.729863506809;5437.13005919051;5905.763769449217;5912.822615321547;5957.791477298274;5970.313413957407;5986.161937328778;5867.618604790675;5981.0729336952845;5991.490723288525;5998.25021872266;6013.969930150365;5492.368377636583;5560.888782224333;5629.915551266693;5642.435756424325;5682.573806964453;6097.542684298695;6107.725152368154;6108.786192483241;6115.969420152871;6124.38756124384;5586.050371436784;5699.202111704365;5873.383294754075;5886.323072846678;5903.793367232212;5903.881922361528;5942.346341902387;5977.462028417376;5980.252468441445;5986.760529578768;5848.093545500455;5880.088586269135;5907.645541267538;5921.111833225051;5923.08192230205;5719.685417302005;5814.418558144152;5863.970680146572;5908.497777688859;5917.733701983421;4533;4551.749653769075;4567.703099298535;4578.244589642738;4583.243764778841;4039.071013666873;4048.2713111640187;4063.593640635913;4079.9592004080173;4099.733517321364;5384.9461505385225;5385.27298814655;5416.431274716098;5422.1053526168525;5556.444355564411;5928.911066334009;5943.435373639497;5979.820605381846;6015.458608725148;6060.969695151584;5412.458754124635;5417.83746487606;5458.263134476874;5474.534664553557;5535.308086489189;4954.380702412199;4993.350864387607;5044.344235249394;5079.31429257053;5096.770645320969;6101.725422356005;6107.531162142591;6135.361474963699;6167.475764559973;6170.382961703884;5882.088276317178;5936.970315148396;5942.346341902301;5942.702864856654;5978.222831031938;5970.940290597038;6052.122442245938;6084.817455476343;6105.877882442237;6159.19930409044;5843.094320380178;5862.179294898632;5903.881922361443;5908.970455147697;5937.703114844327;5964.7912323068485;5990.4908082813445;5998.610090344114;6002.219711437485;6008.369121242382;5628.465295796893;5689.374168841507;5762.625429347079;5780.132980052857;5812.273465816773;5727.885442291047;5762.4525670061275;5768.394318596487;5790.710464476843;5795.130730390475;5524.779008839601;5665.915011274917;5682.77268909239;5687.0616348302065;5690.743916523684;5716.342620598518;5769.8557536061935;5776.046952252831;5820.854478638068;5849.590528663123;5535;5590.608657393944;5600.187972744011;5614.07367784311;5665 20:19:58 INFO - PROCESS | 15128 | |1;ext.html;522.9163333866583;582.8309790160854;594.3759052994358;598.2491972574419;605.4581149870866;36375.454368184466;37115.257694846085;37218.627813721854;37243.813780931094;37432.625673743256;39724.80137599315;39822.40266395999;40147.19705605886;40160.19679606406;40347;8566.999999999984;8688.087750786171;8698.043215246349;8738.781530461725;8754.824903501925;8470.915290847104;8624.35317351198;8634.093420190884;8668.956655216714;8772.956135219314;8795.648174073029;8896.243819275369;8899.37704360695;8900.8664870027;8902.554872256394;8636.913630863673;8674;8740.431871928336;8797.648094076229;8801.823963520726;8553.95723021381;8702.651893924236;8744.606492707844;8745.081766414562;8759.912400876037;39531.209375812614;39734.20531589381;39819.60180398217;40186.19627607461;40214.396784048266;3346.682065203802;3374.3926093303194;3464.8094354810473;3478.234788346585;3681.723870709681;29927.700722992708;29950.55074173889;30137;30320.696793032228;31312;2967.2730181105767;3032.7270545650777;3070.7082827131385;3098.101550550338;3149.826759528225;254295;254432;254732;254950.72524637444;255450;53246;54323.18515222275;65580.67209663922;66813.33186668072;66881.33118668849;59346.406535934955;59759;59768.70115649481;59773;59885.40687558761;14307.64230894236;14538.41846326135;14572.781408278885;14579.635509112144;14592.927035364968;10685.83971240432;10703.143748500257;10752.139828813833;10922.836157457645;10977.725556861142;19736.11187496566;19859.60280794376;20128.89935550342;20137.49656258576;20379.184832606825;7712.251779692769;7812.687492500237;7963.673420453197;8031.1567285434185;8040.517568945882;918.42598376015;990.8612794208816;1027.9434631095362;1043.7286305560608;1127.1827924754487;25485.61771573428;26193;26822.5976610351;26887.984069902126;27114.5932811008;1015.9441230732381;1021.8927012663712;1033.0857191385678;1066.0458889294193;1098.6594155811724;13981.23103229332;14094.577162685136;14143.434262629586;14204.431822726976;15433.151176685391;319250;320162;320974;321522;321771;51794.22308665373;51922;52241.7387913058;52303;52454.47545524572;1374.223563686514;1380.6459985724316;1381.1022835157028;1394.6652803327129;1489.1883923261848;28723.28191795222;29160;29649.25876853096;29881.850590746908;30216.69783302139;46114.769426152656;46378.304325434474;46585.301220481044;46636.7668161657;46848.59454216379;290520;292809.53595231887;295043;295998;296536;30479.390412192075;31282.21794455157;31821.681783182798;31930.52104218485;32060.19849503781;38131.237375252895;38515.6148438512;38758.61241387663;39140;39359.212815742954;34639.653603463645;34794.43425045828;35413.29173416569;35458.93623191308;35911.82044089763;34928.476072859434;35534.822325888206;35975.460368095024;36057.639423605426;36121.27757444889;32408.35183296368;32795.18012049718;32887.17782055372;32970.340593188484;35322.470162947066;31222.531662025543;31823.36353272968;32611.510827338083;32618.184545386554;32745.50881736728;24640.630390544517;24903.252902412958;25235.11677091293;25397.238082857544;25460.872695636404 20:19:58 INFO - PROCESS | 15128 | |2;jquery.html;357.52092196456744;359.71582449864604;360.35136753843074;361.37482155870345;361.98552057917675;16820.990740555575;17037.82962170378;17535.561610959732;17918.372856949976;18503.444896653087;14020.789688154686;14178.929105354484;14230.146191228534;14299.49951751689;14310.71378572428;4688.062387522501;4881.511848815107;4897.216445368742;4898.142825005628;4929.630277729185;4802.23164293713;4809.903801923977;4831.782569784351;4833.564979151875;4865.562099411052;4744.4306683198065;4840.540148685886;5031.144705400073;5185.066687996159;5189.870253243661;5084.288199652052;5140.126178549637;5153.304303918961;5155.200943853709;5159.948400516003;5061;5061.974690126563;5065.189569668835;5068.315777370081;5078.568321692624;12408.441620127116;12482.687932801662;12675.492980280778;12868.420921058481;12882.162659427107;2009.2465325502938;2014.1540552967788;2148.881811500367;2180.6292930201903;2279.920202792894;9555.569999350046;9784.706458806248;9823.214142868625;9954;11308.830367544493;1840.6134711710556;1842.5867617380516;1895.5545446819986;1897.297999740105;1950.3271371376852;56375.43624563743;61443;63417.68291158561;63732.68133659349;63775.681121594556;10292.485375731183;10415.16678665705;10451.425171615634;10485.9475702621;10523.421211833269;13544.864551354558;13565.186088834702;13612.659683507793;13636.65908352299;13686.589402317946;7493.66278517468;7511.737089201852;7565;7581.658825352873;7616.9238307616215;7141.9642901785155;7194.712211511481;7206.855862882818;7222.422206223489;7228.168760592494;4491.820327186876;4548.559689249899;4550.681452298373;4564.132814765184;4568.794404251817;1804.5578833185953;1816.1827177770056;1847.4919397165618;1865.32848174657;1894.8389386901993;441.88510987143576;447.14595123314314;460.2429004287928;818.6561644109488;944.4427787605208;10709.78580428387;10936.726581835517;16772;17536.91231543834;18429.72355414643;903.6837107012625;933.3699752666922;971.9308760363543;1000.1598657128047;1014.6651604970342;9579.329446938787;9708.563114659857;9862.556184971694;9909.157721593745;10042.548085336177;374638;379588;388518;390134;391933;78023;79798;82587.76118358229;82891;83279;1110.539126262592;1117.3184357541893;1126.4367816091954;1131.2703306367348;1141.9885801142048;15450.22748862575;15610.297536611108;15715.607109822346;15761.921190393974;15772.842271577138;18325.633487330444;18471;31259.437028148957;32095.518567221978;33456.83271583724;44724.55275447204;44825.32762008638;44971.32543011923;45300.546994529635;47958.28062579134;9538.904610953801;9540.141387275178;9698.563564639468;9778.55996480146;9803.411795292306;11763.588274410355;11773.646790596296;11806.35065071395;17545.56136096608;17690.91154544219;14046.719065618834;14348.426062957366;14514.85485145135;14524.49164279245;14867.330970106588;13518.864811352154;14161.716765664834;14458.132512049311;14545.490907818175;14624.780628290797;14418;14461.276936153361;14507.274636267934;14640.633984150056;14654.267286635411;9717.805643887225;9762;9887.901120988985;9948.154406875206;10061.647842325483;14603.634909127357;14826.40694372213;14828.481003165269;15002.174880381684;15005.924970375077 20:19:58 INFO - PROCESS | 15128 | |3;mootools.html;1318.9208647481153;1353.593921823453;1377.4765589076155;1538.9153596552185;1562.3594326326208;7260.854782904339;7378.631068446583;7383.593902335363;7673.577953212571;7756.301932826044;7776.222377762221;7847.960760196205;7857.1357150713375;7872.5276483411035;7950.840983180333;2248.9437764055865;2282.7374851891996;2282.7945484906354;2285.851419657717;2287.005152758555;2218.3455880515285;2225.5771403433378;2314.4098254944965;2314.849534780234;2315.351701523576;2097.6538871086254;2176.9564608707815;2184.4102092435032;2244.1584405847807;2265.614845476273;2267.954640907181;2272.818174546049;2318.211807985285;2326.336993956723;2331.1258278145697;2285.268714011517;2337.590921588715;2338.088145623208;2339.7075365579303;2341.94145146371;7759.612019399064;7769.184235655288;7787.8442431151625;7809.609519524001;7814.648340824677;4458.1306645204195;4485.2599321111975;4490.3488994096;4490.775461226958;4509.413776209105;3068;3086.737627301682;3159.7314228290625;3202.087405089538;3213.3091385352027;980.7302991677275;986.9309148359617;1011.3476807459222;1014.4015031131594;1025.9897401026044;9805;9888.456134912576;9904.108630223242;9917.305788594802;9936.155426788804;3937.3503371943307;4005.839766409369;4027.5972402760076;4036.798160091984;4045.211183819127;8037.799055023671;8107.067687215927;8120.959395202986;8122.796930076795;8142.877856832152;4288.24955632763;4305.138972205571;4323.610875021263;4329.134173165379;4346.7609281489185;3920.7843568604;3970.9602903971168;3975.8012099394914;3977.8209980550946;3998.8400463981698;3307.7188438982957;3353.245519758035;3359.714424273964;3367.6632336766615;3401.3707464119216;1023.8259495885717;1032.7160030991388;1036.8859425463193;1046.4453839465095;1048.2766890845292;1034.7878684869584;1043.1706793099504;1095.4194277033184;1185.5376403202758;1324.973500529984;6865.176178858569;7115.501914865909;7137.536060156073;7142.607156606437;7168.964155179295;1102.5534658463334;1104.6465131157952;1105.8285965675334;1114.7436089699415;1139.2594813371375;5824.621399609012;5857.765689372377;5881.588288819741;5888.116782482576;5937.198478205473;9259.30555208362;9418.858717119248;9553.42679439222;9559.713208603753;9712.077352651488;9386.812263754686;9394.859077113848;9395.060493950687;9413.952930235306;9466.668666596635;7153.463490238253;7300.342969132697;7343.8898416522725;7406.629668516553;7473.252674732484;7156.248593897566;7157.355837974607;7234.89147662796;7248;7254.927450725425;8070.49814557489;8193;8333.499990000619;8428.831423371375;8442.620082096444;8571.142885711628;8584.527850968258;8650.697225597074;8701.086385929639;8752;6672.332766723289;6789.728410863708;6851.3491218334175;6860.382565568923;6863.07348507965;7095.0421693070775;7118.679659415235;7124.536905101152;7146.285371462812;7158.391536719437;6416.711247993758;6657.3009833966735;6829.692663830239;6901.999210114405;6960.060391847036;6784.525083244323;6858.451323894176;6860.794176174722;6914.0666010088;6916.308369163044;6755.831104222434;6910.2398736137975;6912.101426814683;6922.653867306715;6927.445804335742;6221.160143380766;6459.9031014533875;6476.481881449567;6487.286398496256;6491.805245842632;6452.322506136976;6475.125858009108;6497.610143391412;6559.180102487189;6593.307702691149 20:19:58 INFO - PROCESS | 15128 | |4;prototype.html;345.81671713991585;348.75412833952066;349.40775385721196;350.4462948541305;351.3324683102106;6286.465650419708;6321.241451025878;6358.713857876395;6378.831197392886;6453.193350831146;6274.090256912745;6287.245530536342;6328.5760703841615;6355.110284560154;6410.615363078218;4841.515848415148;4841.540053694894;4847.830325938593;4853.490383509742;4878.926816097762;4866.975665121669;4884.3406140171155;4884.535969082932;4886.486918873503;4888;4629.8842528936875;4763.54746299101;4771.928421073687;4782.736949467778;4813.735244561548;4752.5485078917445;4756.7859446324655;4769.689970151963;4789.976050119744;4793.18515852306;4137.358709400048;4141.958580414218;4150.107726838714;4150.439690641755;4159.064210552601;6032.547558933097;6056.757729690807;6063.787242551507;6110.847228819271;6121.143039974407;5474.562035037187;5572.58205634579;5574.163875418679;5576.275084239023;5600.159976003632;6694.7656832011135;6720.126383570154;6722.93277067228;6724.428423584001;6733.966330168367;4573.428321459817;4586.105709386671;4586.334981427708;4608.28571571407;4608.677392582521;6751.932480675179;6955.269696681826;6988.825279368006;6998.055262539543;7037.331453511908;4696.272077827942;4714.245720684674;4715.81136754526;4720.409948756405;4723.5984941279685;4781.641376896747;4790.041991601694;4802.8799280018275;4806.423229212517;4807.903841923142;5592.245046918695;5621.325440947113;5625;5633.887322253532;5645.858853528694;6636.601803891782;6779.559328643622;6781.694823732944;6782.966085169543;6796;1658.991705041467;1684.5114916674272;1703.3782669325856;1705.718556438174;1708.103245795967;1120.4173829608558;1128.0806142993433;1132.841402203692;1138.032672228599;1142.0863309352485;6260.186175797117;6292.370762923762;6307.432331090132;6317.936820631827;6322.589031712924;6933.479989000845;6945.7221711132;6952.270011648805;6958;6971.6862741176765;6214.906776398358;6260.373962603794;6284.748610055638;6309.053641953652;6320.652364119926;3784.526934133233;3804.630333080089;3822.904427389282;3836.4245363195746;3848.1534062506203;7323.816904577428;7346.926530734731;7360.153582337993;7382;7388.076490438695;7149;7269.563826170341;7297.671604777798;7316;7325.743598974011;7249.710011599583;7288.161861386008;7313.378362839112;7326.487145899842;7341.339279464767;6998.055262539492;7031.542949708252;7037.824054398477;7043.542169758949;7065.940108983488;6750.1562304711915;6923;7010.193827709879;7033.191183014019;7033.753818616324;7279.563226206445;7335.1197856257595;7356.485046046725;7364.189939106587;7369.705211791468;4749.762511874462;4777.259524773665;4779.283107533759;4781.808727650855;4785.712857228577;6897.379235868595;6916.066331045245;7064.434845212473;7078.327558881898;7109.573425594481;6808.183018037867;6839.829004274933;6873.140857392826;6883.724651013903;6895.103636527219;6805.115335006615;6807.829804254933;6809.182898052265;6817;6825.522213445011;6529.347065293433;6707.463402927657;6718.462522998051;6721.260661327348;6738.35985581369;6890;6896;6901.516893817385;6907.654617269016;6919.273476284918;6673.366030227121;6679.165104361955;6707.832304192434;6710.396064354036;6710.932890671226 20:19:58 INFO - PROCESS | 15128 | |5;yui.html;794.8012996750813;838.9077201507829;841.5960339037262;843.6709683223544;845.2435070611803;11737.47181376838;11820.172587918849;11861.347625880573;11893.643190704282;12021.978131858792;11508.769824603503;11867.881321186807;11875.81241875812;11881.702957426069;11908.404579770999;683.9384455399013;694.8297667071574;816.9632366543505;826.1862065865148;838.2790799912101;826.8718348655968;839.4207996482438;843.9029511606152;845.2561745663808;851.0638297872352;874.204473928725;881.2817553693719;884.7080463447079;884.7876509637705;887.6759982606335;872.1060912564609;873.4890089297768;878.4070752242211;880.6917578847416;880.9559522023937;644.4264604501997;646.993530064698;647.184547470191;651.495091304243;652.5693042591867;11828.34944078084;11963.102767292401;11980.460879260367;11987.280763154238;12030.27818330903;12459.875401246052;12782.808257876139;12914.289714065722;13225.206487610678;13242.073054886161;10063.597456101747;10328.58685652573;10434.89565104347;10972.670819875417;11044.116470682406;3730.0488375464356;3738.4579236010627;3753.6997040236715;3778.282126395976;3897.590752970954;46683;47824.521754782356;48478.51521484775;48972.75513622409;48978.7551062246;10716.94641526803;10735.248532602644;10766.78466430667;10813.783724325627;10977.28647637901;18745;18796.81203187978;18802;18822.623547529245;18837.905810471133;7153.89269160963;7200.243974382719;7229.49393542447;7235.312645298688;7259.9274007259255;4024.7585144890813;4043.5956404359918;4105.117399759066;4116.91766164675;4253.957460425418;3127.8592463339205;3138.5292206169256;3170.651228364878;3177.9046628601177;3185.4266232077985;579.4118969246218;590.515777062813;593.6705128653552;594.8661551151043;603.4508597176548;557.9972100139554;559.1221781802612;584.386394285998;589.7464090441066;664.757363562306;7874;8167.101618821925;8248.216419440143;8298.21166989135;8454.87317690235;638.8434833465737;668.1180841289548;688.4526801193064;691.339770519163;708.7731925783803;3885.9611403886165;4081.4898137732785;4230.323148296257;4410.33844923264;4436.534163912807;51431.485685143416;53514.7324263384;53941.46058539443;54175.18737218945;54232.18651720227;48896;49554.50445495571;49701;50010.49989500131;50409.49590504048;43031;43968.78015609901;44220.336694949605;44405.77797111058;47137.76431117891;8554.529500877512;8586.441881277697;8602.311815054656;8879.511626860585;8969.641214351353;33650;33957.49063763996;34509;34577.82711086429;34985.65014349824;40328.79835600803;41425.585744142176;43854;44345.55654443414;44893;10298.330608510423;10356.326838755456;10415.114715248985;10510.159187264848;10819.675409737405;12175.695607609881;12454.501819927102;12490.125691201529;12576;12715.173513721578;11134.443277836237;11247.100231981258;11529.711757206136;11639.301641901175;11943.761124777282;11197.66407007791;11516.596919107791;11551.76896462083;11565.421728913689;11854.644360669194;11647.359395233343;11648.825267620823;11727.41362931833;11978.76042479163;12009.099317551043;9047.773805654911;9069.591868365807;9459.148676619137;9652.372595781251;9716.951415242878;8010.399220058635;8507.319414446953;8646.870296945677;9260.861087083835;9629.614815407305 20:19:58 INFO - PROCESS | 15128 | __end_tp_report 20:19:58 INFO - PROCESS | 15128 | __start_cc_report 20:19:58 INFO - PROCESS | 15128 | _x_x_mozilla_cycle_collect,319 20:19:58 INFO - PROCESS | 15128 | __end_cc_report 20:19:58 INFO - PROCESS | 15128 | __startTimestamp1451621998844__endTimestamp 20:19:58 INFO - PROCESS | 15128 | 20:19:58 INFO - PROCESS | 15128 | ------- Summary: start ------- 20:19:58 INFO - PROCESS | 15128 | Number of tests: 6 20:19:58 INFO - PROCESS | 15128 | 20:19:58 INFO - PROCESS | 15128 | [#0] dojo.html Cycles:165 Average:5483.86 Median:5665.92 stddev:616.51 (10.9%) stddev-sans-first:592.69 20:19:58 INFO - PROCESS | 15128 | Values: 3237.8 3261.9 3315.1 3317.9 3321.2 5384.4 5511.8 5514.2 5514.3 5535.3 5381.9 5402.9 5489.6 5563.1 5580.9 4968.7 5019.9 5068.3 5084.8 5187.9 4992.7 5012.3 5085.9 5102.0 5102.5 4919.6 4928.9 5022.7 5030.7 5060.2 4984.5 4986.3 4994.2 5010.3 5060.0 4932.8 4967.0 4968.5 4974.6 5061.9 5268.5 5312.7 5394.9 5402.7 5437.1 5905.8 5912.8 5957.8 5970.3 5986.2 5867.6 5981.1 5991.5 5998.3 6014.0 5492.4 5560.9 5629.9 5642.4 5682.6 6097.5 6107.7 6108.8 6116.0 6124.4 5586.1 5699.2 5873.4 5886.3 5903.8 5903.9 5942.3 5977.5 5980.3 5986.8 5848.1 5880.1 5907.6 5921.1 5923.1 5719.7 5814.4 5864.0 5908.5 5917.7 4533.0 4551.7 4567.7 4578.2 4583.2 4039.1 4048.3 4063.6 4080.0 4099.7 5384.9 5385.3 5416.4 5422.1 5556.4 5928.9 5943.4 5979.8 6015.5 6061.0 5412.5 5417.8 5458.3 5474.5 5535.3 4954.4 4993.4 5044.3 5079.3 5096.8 6101.7 6107.5 6135.4 6167.5 6170.4 5882.1 5937.0 5942.3 5942.7 5978.2 5970.9 6052.1 6084.8 6105.9 6159.2 5843.1 5862.2 5903.9 5909.0 5937.7 5964.8 5990.5 5998.6 6002.2 6008.4 5628.5 5689.4 5762.6 5780.1 5812.3 5727.9 5762.5 5768.4 5790.7 5795.1 5524.8 5665.9 5682.8 5687.1 5690.7 5716.3 5769.9 5776.0 5820.9 5849.6 5535.0 5590.6 5600.2 5614.1 5665.0 20:19:58 INFO - PROCESS | 15128 | 20:19:58 INFO - PROCESS | 15128 | [#1] ext.html Cycles:180 Average:45737.26 Median:3471.52 stddev:76138.86 (2193.2%) stddev-sans-first:76276.76 20:19:58 INFO - PROCESS | 15128 | Values: 522.9 582.8 594.4 598.2 605.5 36375.5 37115.3 37218.6 37243.8 37432.6 39724.8 39822.4 40147.2 40160.2 40347.0 8567.0 8688.1 8698.0 8738.8 8754.8 8470.9 8624.4 8634.1 8669.0 8773.0 8795.6 8896.2 8899.4 8900.9 8902.6 8636.9 8674.0 8740.4 8797.6 8801.8 8554.0 8702.7 8744.6 8745.1 8759.9 39531.2 39734.2 39819.6 40186.2 40214.4 3346.7 3374.4 3464.8 3478.2 3681.7 29927.7 29950.6 30137.0 30320.7 31312.0 2967.3 3032.7 3070.7 3098.1 3149.8 254295.0 254432.0 254732.0 254950.7 255450.0 53246.0 54323.2 65580.7 66813.3 66881.3 59346.4 59759.0 59768.7 59773.0 59885.4 14307.6 14538.4 14572.8 14579.6 14592.9 10685.8 10703.1 10752.1 10922.8 10977.7 19736.1 19859.6 20128.9 20137.5 20379.2 7712.3 7812.7 7963.7 8031.2 8040.5 918.4 990.9 1027.9 1043.7 1127.2 25485.6 26193.0 26822.6 26888.0 27114.6 1015.9 1021.9 1033.1 1066.0 1098.7 13981.2 14094.6 14143.4 14204.4 15433.2 319250.0 320162.0 320974.0 321522.0 321771.0 51794.2 51922.0 52241.7 52303.0 52454.5 1374.2 1380.6 1381.1 1394.7 1489.2 28723.3 29160.0 29649.3 29881.9 30216.7 46114.8 46378.3 46585.3 46636.8 46848.6 290520.0 292809.5 295043.0 295998.0 296536.0 30479.4 31282.2 31821.7 31930.5 32060.2 38131.2 38515.6 38758.6 39140.0 39359.2 34639.7 34794.4 35413.3 35458.9 35911.8 34928.5 35534.8 35975.5 36057.6 36121.3 32408.4 32795.2 32887.2 32970.3 35322.5 31222.5 31823.4 32611.5 32618.2 32745.5 24640.6 24903.3 25235.1 25397.2 25460.9 20:19:58 INFO - PROCESS | 15128 | 20:19:58 INFO - PROCESS | 15128 | [#2] jquery.html Cycles:180 Average:24003.37 Median:358.62 stddev:63405.76 (17680.6%) stddev-sans-first:63558.77 20:19:58 INFO - PROCESS | 15128 | Values: 357.5 359.7 360.4 361.4 362.0 16821.0 17037.8 17535.6 17918.4 18503.4 14020.8 14178.9 14230.1 14299.5 14310.7 4688.1 4881.5 4897.2 4898.1 4929.6 4802.2 4809.9 4831.8 4833.6 4865.6 4744.4 4840.5 5031.1 5185.1 5189.9 5084.3 5140.1 5153.3 5155.2 5159.9 5061.0 5062.0 5065.2 5068.3 5078.6 12408.4 12482.7 12675.5 12868.4 12882.2 2009.2 2014.2 2148.9 2180.6 2279.9 9555.6 9784.7 9823.2 9954.0 11308.8 1840.6 1842.6 1895.6 1897.3 1950.3 56375.4 61443.0 63417.7 63732.7 63775.7 10292.5 10415.2 10451.4 10485.9 10523.4 13544.9 13565.2 13612.7 13636.7 13686.6 7493.7 7511.7 7565.0 7581.7 7616.9 7142.0 7194.7 7206.9 7222.4 7228.2 4491.8 4548.6 4550.7 4564.1 4568.8 1804.6 1816.2 1847.5 1865.3 1894.8 441.9 447.1 460.2 818.7 944.4 10709.8 10936.7 16772.0 17536.9 18429.7 903.7 933.4 971.9 1000.2 1014.7 9579.3 9708.6 9862.6 9909.2 10042.5 374638.0 379588.0 388518.0 390134.0 391933.0 78023.0 79798.0 82587.8 82891.0 83279.0 1110.5 1117.3 1126.4 1131.3 1142.0 15450.2 15610.3 15715.6 15761.9 15772.8 18325.6 18471.0 31259.4 32095.5 33456.8 44724.6 44825.3 44971.3 45300.5 47958.3 9538.9 9540.1 9698.6 9778.6 9803.4 11763.6 11773.6 11806.4 17545.6 17690.9 14046.7 14348.4 14514.9 14524.5 14867.3 13518.9 14161.7 14458.1 14545.5 14624.8 14418.0 14461.3 14507.3 14640.6 14654.3 9717.8 9762.0 9887.9 9948.2 10061.6 14603.6 14826.4 14828.5 15002.2 15005.9 20:19:58 INFO - PROCESS | 15128 | 20:19:58 INFO - PROCESS | 15128 | [#3] mootools.html Cycles:180 Average:5341.09 Median:6494.71 stddev:2765.61 (42.6%) stddev-sans-first:2756.84 20:19:58 INFO - PROCESS | 15128 | Values: 1318.9 1353.6 1377.5 1538.9 1562.4 7260.9 7378.6 7383.6 7673.6 7756.3 7776.2 7848.0 7857.1 7872.5 7950.8 2248.9 2282.7 2282.8 2285.9 2287.0 2218.3 2225.6 2314.4 2314.8 2315.4 2097.7 2177.0 2184.4 2244.2 2265.6 2268.0 2272.8 2318.2 2326.3 2331.1 2285.3 2337.6 2338.1 2339.7 2341.9 7759.6 7769.2 7787.8 7809.6 7814.6 4458.1 4485.3 4490.3 4490.8 4509.4 3068.0 3086.7 3159.7 3202.1 3213.3 980.7 986.9 1011.3 1014.4 1026.0 9805.0 9888.5 9904.1 9917.3 9936.2 3937.4 4005.8 4027.6 4036.8 4045.2 8037.8 8107.1 8121.0 8122.8 8142.9 4288.2 4305.1 4323.6 4329.1 4346.8 3920.8 3971.0 3975.8 3977.8 3998.8 3307.7 3353.2 3359.7 3367.7 3401.4 1023.8 1032.7 1036.9 1046.4 1048.3 1034.8 1043.2 1095.4 1185.5 1325.0 6865.2 7115.5 7137.5 7142.6 7169.0 1102.6 1104.6 1105.8 1114.7 1139.3 5824.6 5857.8 5881.6 5888.1 5937.2 9259.3 9418.9 9553.4 9559.7 9712.1 9386.8 9394.9 9395.1 9414.0 9466.7 7153.5 7300.3 7343.9 7406.6 7473.3 7156.2 7157.4 7234.9 7248.0 7254.9 8070.5 8193.0 8333.5 8428.8 8442.6 8571.1 8584.5 8650.7 8701.1 8752.0 6672.3 6789.7 6851.3 6860.4 6863.1 7095.0 7118.7 7124.5 7146.3 7158.4 6416.7 6657.3 6829.7 6902.0 6960.1 6784.5 6858.5 6860.8 6914.1 6916.3 6755.8 6910.2 6912.1 6922.7 6927.4 6221.2 6459.9 6476.5 6487.3 6491.8 6452.3 6475.1 6497.6 6559.2 6593.3 20:19:58 INFO - PROCESS | 15128 | 20:19:58 INFO - PROCESS | 15128 | [#4] prototype.html Cycles:180 Average:5650.33 Median:6319.29 stddev:1728.95 (27.4%) stddev-sans-first:1687.34 20:19:58 INFO - PROCESS | 15128 | Values: 345.8 348.8 349.4 350.4 351.3 6286.5 6321.2 6358.7 6378.8 6453.2 6274.1 6287.2 6328.6 6355.1 6410.6 4841.5 4841.5 4847.8 4853.5 4878.9 4867.0 4884.3 4884.5 4886.5 4888.0 4629.9 4763.5 4771.9 4782.7 4813.7 4752.5 4756.8 4769.7 4790.0 4793.2 4137.4 4142.0 4150.1 4150.4 4159.1 6032.5 6056.8 6063.8 6110.8 6121.1 5474.6 5572.6 5574.2 5576.3 5600.2 6694.8 6720.1 6722.9 6724.4 6734.0 4573.4 4586.1 4586.3 4608.3 4608.7 6751.9 6955.3 6988.8 6998.1 7037.3 4696.3 4714.2 4715.8 4720.4 4723.6 4781.6 4790.0 4802.9 4806.4 4807.9 5592.2 5621.3 5625.0 5633.9 5645.9 6636.6 6779.6 6781.7 6783.0 6796.0 1659.0 1684.5 1703.4 1705.7 1708.1 1120.4 1128.1 1132.8 1138.0 1142.1 6260.2 6292.4 6307.4 6317.9 6322.6 6933.5 6945.7 6952.3 6958.0 6971.7 6214.9 6260.4 6284.7 6309.1 6320.7 3784.5 3804.6 3822.9 3836.4 3848.2 7323.8 7346.9 7360.2 7382.0 7388.1 7149.0 7269.6 7297.7 7316.0 7325.7 7249.7 7288.2 7313.4 7326.5 7341.3 6998.1 7031.5 7037.8 7043.5 7065.9 6750.2 6923.0 7010.2 7033.2 7033.8 7279.6 7335.1 7356.5 7364.2 7369.7 4749.8 4777.3 4779.3 4781.8 4785.7 6897.4 6916.1 7064.4 7078.3 7109.6 6808.2 6839.8 6873.1 6883.7 6895.1 6805.1 6807.8 6809.2 6817.0 6825.5 6529.3 6707.5 6718.5 6721.3 6738.4 6890.0 6896.0 6901.5 6907.7 6919.3 6673.4 6679.2 6707.8 6710.4 6710.9 20:19:58 INFO - PROCESS | 15128 | 20:19:58 INFO - PROCESS | 15128 | [#5] yui.html Cycles:180 Average:13446.30 Median:24391.05 stddev:15344.13 (62.9%) stddev-sans-first:15357.76 20:19:58 INFO - PROCESS | 15128 | Values: 794.8 838.9 841.6 843.7 845.2 11737.5 11820.2 11861.3 11893.6 12022.0 11508.8 11867.9 11875.8 11881.7 11908.4 683.9 694.8 817.0 826.2 838.3 826.9 839.4 843.9 845.3 851.1 874.2 881.3 884.7 884.8 887.7 872.1 873.5 878.4 880.7 881.0 644.4 647.0 647.2 651.5 652.6 11828.3 11963.1 11980.5 11987.3 12030.3 12459.9 12782.8 12914.3 13225.2 13242.1 10063.6 10328.6 10434.9 10972.7 11044.1 3730.0 3738.5 3753.7 3778.3 3897.6 46683.0 47824.5 48478.5 48972.8 48978.8 10716.9 10735.2 10766.8 10813.8 10977.3 18745.0 18796.8 18802.0 18822.6 18837.9 7153.9 7200.2 7229.5 7235.3 7259.9 4024.8 4043.6 4105.1 4116.9 4254.0 3127.9 3138.5 3170.7 3177.9 3185.4 579.4 590.5 593.7 594.9 603.5 558.0 559.1 584.4 589.7 664.8 7874.0 8167.1 8248.2 8298.2 8454.9 638.8 668.1 688.5 691.3 708.8 3886.0 4081.5 4230.3 4410.3 4436.5 51431.5 53514.7 53941.5 54175.2 54232.2 48896.0 49554.5 49701.0 50010.5 50409.5 43031.0 43968.8 44220.3 44405.8 47137.8 8554.5 8586.4 8602.3 8879.5 8969.6 33650.0 33957.5 34509.0 34577.8 34985.7 40328.8 41425.6 43854.0 44345.6 44893.0 10298.3 10356.3 10415.1 10510.2 10819.7 12175.7 12454.5 12490.1 12576.0 12715.2 11134.4 11247.1 11529.7 11639.3 11943.8 11197.7 11516.6 11551.8 11565.4 11854.6 11647.4 11648.8 11727.4 11978.8 12009.1 9047.8 9069.6 9459.1 9652.4 9717.0 8010.4 8507.3 8646.9 9260.9 9629.6 20:19:58 INFO - PROCESS | 15128 | -------- Summary: end -------- 20:19:58 INFO - PROCESS | 15128 | 20:19:59 INFO - TEST-INFO | 15128: exit 0 20:19:59 INFO - TEST-OK | dromaeo_css | took 1110787ms 20:19:59 INFO - TEST-START | kraken 20:19:59 INFO - operating with platform_type : linux_ 20:19:59 INFO - Initialising browser for kraken test... 20:19:59 INFO - TEST-INFO | started process 15381 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzJQKbM/profile http://localhost:38791/getInfo.html) 20:20:03 INFO - PROCESS | 15381 | __metrics Screen width/height:1600/1200 20:20:03 INFO - PROCESS | 15381 | colorDepth:24 20:20:03 INFO - PROCESS | 15381 | Browser inner width/height: 1024/697 20:20:03 INFO - PROCESS | 15381 | __metrics 20:20:03 INFO - PROCESS | 15381 | 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:20:04 INFO - TEST-INFO | 15381: exit 0 20:20:04 INFO - Browser initialized. 20:20:04 INFO - Running cycle 1/1 for kraken test... 20:20:04 INFO - TEST-INFO | started process 15505 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzJQKbM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:16 INFO - PROCESS | 15505 | RSS: Main: 150904832 20:20:16 INFO - PROCESS | 15505 | 20:20:19 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38791/tests/kraken/driver.html?testName=audio-beat-detection) 20:20:19 INFO - PROCESS | 15505 | RSS: Main: 151535616 20:20:19 INFO - PROCESS | 15505 | 20:20:22 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38791/tests/kraken/driver.html?testName=audio-dft) 20:20:22 INFO - PROCESS | 15505 | RSS: Main: 152383488 20:20:22 INFO - PROCESS | 15505 | 20:20:25 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38791/tests/kraken/driver.html?testName=audio-fft) 20:20:26 INFO - PROCESS | 15505 | RSS: Main: 146051072 20:20:26 INFO - PROCESS | 15505 | 20:20:28 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38791/tests/kraken/driver.html?testName=audio-oscillator) 20:20:29 INFO - PROCESS | 15505 | RSS: Main: 146591744 20:20:29 INFO - PROCESS | 15505 | 20:20:31 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38791/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:20:32 INFO - PROCESS | 15505 | RSS: Main: 146931712 20:20:32 INFO - PROCESS | 15505 | 20:20:35 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38791/tests/kraken/driver.html?testName=imaging-darkroom) 20:20:35 INFO - PROCESS | 15505 | RSS: Main: 147812352 20:20:35 INFO - PROCESS | 15505 | 20:20:39 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38791/tests/kraken/driver.html?testName=imaging-desaturate) 20:20:39 INFO - PROCESS | 15505 | RSS: Main: 148668416 20:20:39 INFO - PROCESS | 15505 | 20:20:42 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38791/tests/kraken/driver.html?testName=json-parse-financial) 20:20:43 INFO - PROCESS | 15505 | RSS: Main: 149745664 20:20:43 INFO - PROCESS | 15505 | 20:20:44 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38791/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:20:45 INFO - PROCESS | 15505 | RSS: Main: 148979712 20:20:45 INFO - PROCESS | 15505 | 20:20:47 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38791/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:20:47 INFO - PROCESS | 15505 | RSS: Main: 149487616 20:20:47 INFO - PROCESS | 15505 | 20:20:49 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38791/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:20:50 INFO - PROCESS | 15505 | RSS: Main: 149774336 20:20:50 INFO - PROCESS | 15505 | 20:20:52 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:20:53 INFO - PROCESS | 15505 | RSS: Main: 149528576 20:20:53 INFO - PROCESS | 15505 | 20:20:56 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:20:56 INFO - PROCESS | 15505 | RSS: Main: 149327872 20:20:56 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:38791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38791/tests/kraken/driver.html?testName=ai-astar) 20:20:58 INFO - PROCESS | 15505 | RSS: Main: 150253568 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | __start_tp_report 20:20:58 INFO - PROCESS | 15505 | _x_x_mozilla_page_load 20:20:58 INFO - PROCESS | 15505 | _x_x_mozilla_page_load_details 20:20:58 INFO - PROCESS | 15505 | |i|pagename|runs| 20:20:58 INFO - PROCESS | 15505 | |0;ai-astar;114;108;111;112;111;124;110;111;111;111 20:20:58 INFO - PROCESS | 15505 | |1;audio-beat-detection;153;124;151;173;140;153;153;127;168;129 20:20:58 INFO - PROCESS | 15505 | |2;audio-dft;163;166;163;163;163;162;168;166;169;162 20:20:58 INFO - PROCESS | 15505 | |3;audio-fft;75;75;73;74;75;75;76;148;75;71 20:20:58 INFO - PROCESS | 15505 | |4;audio-oscillator;96;97;138;95;96;97;143;97;96;134 20:20:58 INFO - PROCESS | 15505 | |5;imaging-gaussian-blur;109;110;109;110;111;110;110;110;109;110 20:20:58 INFO - PROCESS | 15505 | |6;imaging-darkroom;147;146;149;147;148;148;147;146;147;146 20:20:58 INFO - PROCESS | 15505 | |7;imaging-desaturate;96;96;96;98;97;97;97;96;97;97 20:20:58 INFO - PROCESS | 15505 | |8;json-parse-financial;61;61;60;61;60;58;59;61;57;57 20:20:58 INFO - PROCESS | 15505 | |9;json-stringify-tinderbox;68;69;70;69;70;71;70;69;70;69 20:20:58 INFO - PROCESS | 15505 | |10;stanford-crypto-aes;85;90;87;89;88;94;92;88;90;86 20:20:58 INFO - PROCESS | 15505 | |11;stanford-crypto-ccm;124;119;125;130;119;120;128;121;119;125 20:20:58 INFO - PROCESS | 15505 | |12;stanford-crypto-pbkdf2;150;152;151;158;155;143;145;152;160;141 20:20:58 INFO - PROCESS | 15505 | |13;stanford-crypto-sha256-iterative;71;70;67;67;68;70;67;69;69;70 20:20:58 INFO - PROCESS | 15505 | __end_tp_report 20:20:58 INFO - PROCESS | 15505 | __start_cc_report 20:20:58 INFO - PROCESS | 15505 | _x_x_mozilla_cycle_collect,763 20:20:58 INFO - PROCESS | 15505 | __end_cc_report 20:20:58 INFO - PROCESS | 15505 | __startTimestamp1451622058549__endTimestamp 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | ------- Summary: start ------- 20:20:58 INFO - PROCESS | 15505 | Number of tests: 14 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#0] ai-astar Cycles:10 Average:112.30 Median:111.00 stddev:4.37 (3.9%) stddev-sans-first:4.59 20:20:58 INFO - PROCESS | 15505 | Values: 114.0 108.0 111.0 112.0 111.0 124.0 110.0 111.0 111.0 111.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:153.00 stddev:16.81 (11.0%) stddev-sans-first:17.69 20:20:58 INFO - PROCESS | 15505 | Values: 153.0 124.0 151.0 173.0 140.0 153.0 153.0 127.0 168.0 129.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.55 (1.5%) stddev-sans-first:2.65 20:20:58 INFO - PROCESS | 15505 | Values: 163.0 166.0 163.0 163.0 163.0 162.0 168.0 166.0 169.0 162.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:23.34 (31.1%) stddev-sans-first:24.63 20:20:58 INFO - PROCESS | 15505 | Values: 75.0 75.0 73.0 74.0 75.0 75.0 76.0 148.0 75.0 71.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:96.00 stddev:20.43 (21.3%) stddev-sans-first:21.13 20:20:58 INFO - PROCESS | 15505 | Values: 96.0 97.0 138.0 95.0 96.0 97.0 143.0 97.0 96.0 134.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 20:20:58 INFO - PROCESS | 15505 | Values: 109.0 110.0 109.0 110.0 111.0 110.0 110.0 110.0 109.0 110.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 20:20:58 INFO - PROCESS | 15505 | Values: 147.0 146.0 149.0 147.0 148.0 148.0 147.0 146.0 147.0 146.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 20:20:58 INFO - PROCESS | 15505 | Values: 96.0 96.0 96.0 98.0 97.0 97.0 97.0 96.0 97.0 97.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:60.50 stddev:1.65 (2.7%) stddev-sans-first:1.66 20:20:58 INFO - PROCESS | 15505 | Values: 61.0 61.0 60.0 61.0 60.0 58.0 59.0 61.0 57.0 57.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:0.85 (1.2%) stddev-sans-first:0.71 20:20:58 INFO - PROCESS | 15505 | Values: 68.0 69.0 70.0 69.0 70.0 71.0 70.0 69.0 70.0 69.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:89.50 stddev:2.73 (3.0%) stddev-sans-first:2.50 20:20:58 INFO - PROCESS | 15505 | Values: 85.0 90.0 87.0 89.0 88.0 94.0 92.0 88.0 90.0 86.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:124.50 stddev:4.00 (3.2%) stddev-sans-first:4.23 20:20:58 INFO - PROCESS | 15505 | Values: 124.0 119.0 125.0 130.0 119.0 120.0 128.0 121.0 119.0 125.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:152.00 stddev:6.22 (4.1%) stddev-sans-first:6.59 20:20:58 INFO - PROCESS | 15505 | Values: 150.0 152.0 151.0 158.0 155.0 143.0 145.0 152.0 160.0 141.0 20:20:58 INFO - PROCESS | 15505 | 20:20:58 INFO - PROCESS | 15505 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.50 stddev:1.48 (2.1%) stddev-sans-first:1.33 20:20:58 INFO - PROCESS | 15505 | Values: 71.0 70.0 67.0 67.0 68.0 70.0 67.0 69.0 69.0 70.0 20:20:58 INFO - PROCESS | 15505 | -------- Summary: end -------- 20:20:58 INFO - PROCESS | 15505 | 20:20:59 INFO - TEST-INFO | 15505: exit 0 20:20:59 INFO - TEST-OK | kraken | took 59924ms 20:20:59 INFO - TEST-START | v8_7 20:20:59 INFO - operating with platform_type : linux_ 20:20:59 INFO - Initialising browser for v8_7 test... 20:20:59 INFO - TEST-INFO | started process 15791 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3tohYx/profile http://localhost:38791/getInfo.html) 20:21:03 INFO - PROCESS | 15791 | __metrics Screen width/height:1600/1200 20:21:03 INFO - PROCESS | 15791 | colorDepth:24 20:21:03 INFO - PROCESS | 15791 | Browser inner width/height: 1024/697 20:21:03 INFO - PROCESS | 15791 | __metrics 20:21:03 INFO - PROCESS | 15791 | 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:21:04 INFO - TEST-INFO | 15791: exit 0 20:21:04 INFO - Browser initialized. 20:21:04 INFO - Running cycle 1/1 for v8_7 test... 20:21:04 INFO - TEST-INFO | started process 15910 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3tohYx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:16 INFO - PROCESS | 15910 | RSS: Main: 150405120 20:21:16 INFO - PROCESS | 15910 | 20:21:37 INFO - PROCESS | 15910 | Cycle 1(1): loaded http://localhost:38791/tests/v8_7/run.html (next: http://localhost:38791/tests/v8_7/run.html) 20:21:38 INFO - PROCESS | 15910 | RSS: Main: 146214912 20:21:38 INFO - PROCESS | 15910 | 20:21:38 INFO - PROCESS | 15910 | __start_tp_report 20:21:38 INFO - PROCESS | 15910 | _x_x_mozilla_page_load 20:21:38 INFO - PROCESS | 15910 | _x_x_mozilla_page_load_details 20:21:38 INFO - PROCESS | 15910 | |i|pagename|runs| 20:21:38 INFO - PROCESS | 15910 | |0;Richards;166.86133822793258 20:21:38 INFO - PROCESS | 15910 | |1;DeltaBlue;188.82175226586102 20:21:38 INFO - PROCESS | 15910 | |2;Encrypt;279.01785714285717 20:21:38 INFO - PROCESS | 15910 | |3;Decrypt;5202.072538860104 20:21:38 INFO - PROCESS | 15910 | |4;RayTrace;1047.071129707113 20:21:38 INFO - PROCESS | 15910 | |5;Earley;713.9800285306704 20:21:38 INFO - PROCESS | 15910 | |6;Boyer;12525 20:21:38 INFO - PROCESS | 15910 | |7;RegExp;25500 20:21:38 INFO - PROCESS | 15910 | |8;Splay;674.7638326585695 20:21:38 INFO - PROCESS | 15910 | |9;NavierStokes;4840.579710144928 20:21:38 INFO - PROCESS | 15910 | __end_tp_report 20:21:38 INFO - PROCESS | 15910 | __startTimestamp1451622098153__endTimestamp 20:21:38 INFO - PROCESS | 15910 | 20:21:38 INFO - PROCESS | 15910 | ------- Summary: start ------- 20:21:38 INFO - PROCESS | 15910 | Number of tests: 10 20:21:38 INFO - PROCESS | 15910 | 20:21:38 INFO - PROCESS | 15910 | [#0] Richards Cycles:1 Average:166.86 Median:166.86 stddev:0.00 (0.0%) 20:21:38 INFO - PROCESS | 15910 | Values: 166.9 20:21:38 INFO - PROCESS | 15910 | 20:21:38 INFO - PROCESS | 15910 | [#1] DeltaBlue Cycles:1 Average:188.82 Median:188.82 stddev:0.00 (0.0%) 20:21:38 INFO - PROCESS | 15910 | Values: 188.8 20:21:38 INFO - PROCESS | 15910 | 20:21:38 INFO - PROCESS | 15910 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 20:21:38 INFO - PROCESS | 15910 | Values: 279.0 20:21:38 INFO - PROCESS | 15910 | 20:21:38 INFO - PROCESS | 15910 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 20:21:38 INFO - PROCESS | 15910 | Values: 5202.1 20:21:38 INFO - PROCESS | 15910 | 20:21:38 INFO - PROCESS | 15910 | [#4] RayTrace Cycles:1 Average:1047.07 Median:1047.07 stddev:0.00 (0.0%) 20:21:38 INFO - PROCESS | 15910 | Values: 1047.1 20:21:38 INFO - PROCESS | 15910 | 20:21:38 INFO - PROCESS | 15910 | [#5] Earley Cycles:1 Average:713.98 Median:713.98 stddev:0.00 (0.0%) 20:21:38 INFO - PROCESS | 15910 | Values: 714.0 20:21:38 INFO - PROCESS | 15910 | 20:21:38 INFO - PROCESS | 15910 | [#6] Boyer Cycles:1 Average:12525.00 Median:12525.00 stddev:0.00 (0.0%) 20:21:38 INFO - PROCESS | 15910 | Values: 12525.0 20:21:38 INFO - PROCESS | 15910 | 20:21:38 INFO - PROCESS | 15910 | [#7] RegExp Cycles:1 Average:25500.00 Median:25500.00 stddev:0.00 (0.0%) 20:21:38 INFO - PROCESS | 15910 | Values: 25500.0 20:21:38 INFO - PROCESS | 15910 | 20:21:38 INFO - PROCESS | 15910 | [#8] Splay Cycles:1 Average:674.76 Median:674.76 stddev:0.00 (0.0%) 20:21:38 INFO - PROCESS | 15910 | Values: 674.8 20:21:38 INFO - PROCESS | 15910 | 20:21:38 INFO - PROCESS | 15910 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:21:38 INFO - PROCESS | 15910 | Values: 4840.6 20:21:38 INFO - PROCESS | 15910 | -------- Summary: end -------- 20:21:38 INFO - PROCESS | 15910 | 20:21:39 INFO - TEST-INFO | 15910: exit 0 20:21:39 INFO - TEST-OK | v8_7 | took 39624ms 20:21:39 INFO - SUITE-END | took 1210s 20:21:39 INFO - Completed test suite (00:20:10) 20:21:39 INFO - Working with test: dromaeo_css 20:21:39 INFO - Generating results file: dromaeo_css 20:21:39 INFO - Working with test: kraken 20:21:39 INFO - Generating results file: kraken 20:21:39 INFO - javascript benchmark 20:21:39 INFO - Working with test: v8_7 20:21:39 INFO - Generating results file: v8_7 20:21:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:21:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:21:39 INFO - process_Request line: dromaeo_css 6982.71 graph.html#tests=[[72,64,43]] 20:21:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:21:39 INFO - process_Request line: kraken 1528.50 graph.html#tests=[[232,64,43]] 20:21:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:21:39 INFO - process_Request line: v8_7 21099.99 graph.html#tests=[[230,64,43]] 20:21:39 INFO - RETURN: dromaeo_css: 6982.71 20:21:39 INFO - RETURN: kraken: 1528.50 20:21:39 INFO - RETURN: v8_7: 21099.99 20:21:39 INFO - javascript benchmark 20:21:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3237.8381080945956, 3261.86952521899, 3315.1214928044055, 3317.8838740644073, 3321.15310595798, 5384.40771515134, 5511.751971161298, 5514.172874068887, 5514.310711161105, 5535.335759708831, 5381.865453363668, 5402.945970540293, 5489.64317319374, 5563.13771365438, 5580.944190558093, 4968.652194346406, 5019.874503137433, 5068.315777370063, 5084.847454576368, 5187.948120518784, 4992.725400102993, 5012.298278241031, 5085.949140508585, 5102.030614183312, 5102.540771330579, 4919.606431485473, 4928.852134435972, 5022.698638081709, 5030.723310217936, 5060.240963855451, 4984.526469985346, 4986.326845875833, 4994.175960966436, 5010.2735103409805, 5059.974700126476, 4932.753362331869, 4966.975165124188, 4968.453470118284, 4974.552290293855, 5061.924071138936, 5268.4994925482015, 5312.681239125664, 5394.946050539484, 5402.729863506809, 5437.13005919051, 5905.763769449217, 5912.822615321547, 5957.791477298274, 5970.313413957407, 5986.161937328778, 5867.618604790675, 5981.0729336952845, 5991.490723288525, 5998.25021872266, 6013.969930150365, 5492.368377636583, 5560.888782224333, 5629.915551266693, 5642.435756424325, 5682.573806964453, 6097.542684298695, 6107.725152368154, 6108.786192483241, 6115.969420152871, 6124.38756124384, 5586.050371436784, 5699.202111704365, 5873.383294754075, 5886.323072846678, 5903.793367232212, 5903.881922361528, 5942.346341902387, 5977.462028417376, 5980.252468441445, 5986.760529578768, 5848.093545500455, 5880.088586269135, 5907.645541267538, 5921.111833225051, 5923.08192230205, 5719.685417302005, 5814.418558144152, 5863.970680146572, 5908.497777688859, 5917.733701983421, 4533.0, 4551.749653769075, 4567.703099298535, 4578.244589642738, 4583.243764778841, 4039.071013666873, 4048.2713111640187, 4063.593640635913, 4079.9592004080173, 4099.733517321364, 5384.9461505385225, 5385.27298814655, 5416.431274716098, 5422.1053526168525, 5556.444355564411, 5928.911066334009, 5943.435373639497, 5979.820605381846, 6015.458608725148, 6060.969695151584, 5412.458754124635, 5417.83746487606, 5458.263134476874, 5474.534664553557, 5535.308086489189, 4954.380702412199, 4993.350864387607, 5044.344235249394, 5079.31429257053, 5096.770645320969, 6101.725422356005, 6107.531162142591, 6135.361474963699, 6167.475764559973, 6170.382961703884, 5882.088276317178, 5936.970315148396, 5942.346341902301, 5942.702864856654, 5978.222831031938, 5970.940290597038, 6052.122442245938, 6084.817455476343, 6105.877882442237, 6159.19930409044, 5843.094320380178, 5862.179294898632, 5903.881922361443, 5908.970455147697, 5937.703114844327, 5964.7912323068485, 5990.4908082813445, 5998.610090344114, 6002.219711437485, 6008.369121242382, 5628.465295796893, 5689.374168841507, 5762.625429347079, 5780.132980052857, 5812.273465816773, 5727.885442291047, 5762.4525670061275, 5768.394318596487, 5790.710464476843, 5795.130730390475, 5524.779008839601, 5665.915011274917, 5682.77268909239, 5687.0616348302065, 5690.743916523684, 5716.342620598518, 5769.8557536061935, 5776.046952252831, 5820.854478638068, 5849.590528663123, 5535.0, 5590.608657393944, 5600.187972744011, 5614.07367784311, 5665.0], "unit": "score", "name": "dojo.html", "value": 5443.527044415422}, {"lowerIsBetter": false, "replicates": [522.9163333866583, 582.8309790160854, 594.3759052994358, 598.2491972574419, 605.4581149870866, 36375.454368184466, 37115.257694846085, 37218.627813721854, 37243.813780931094, 37432.625673743256, 39724.80137599315, 39822.40266395999, 40147.19705605886, 40160.19679606406, 40347.0, 8566.999999999984, 8688.087750786171, 8698.043215246349, 8738.781530461725, 8754.824903501925, 8470.915290847104, 8624.35317351198, 8634.093420190884, 8668.956655216714, 8772.956135219314, 8795.648174073029, 8896.243819275369, 8899.37704360695, 8900.8664870027, 8902.554872256394, 8636.913630863673, 8674.0, 8740.431871928336, 8797.648094076229, 8801.823963520726, 8553.95723021381, 8702.651893924236, 8744.606492707844, 8745.081766414562, 8759.912400876037, 39531.209375812614, 39734.20531589381, 39819.60180398217, 40186.19627607461, 40214.396784048266, 3346.682065203802, 3374.3926093303194, 3464.8094354810473, 3478.234788346585, 3681.723870709681, 29927.700722992708, 29950.55074173889, 30137.0, 30320.696793032228, 31312.0, 2967.2730181105767, 3032.7270545650777, 3070.7082827131385, 3098.101550550338, 3149.826759528225, 254295.0, 254432.0, 254732.0, 254950.72524637444, 255450.0, 53246.0, 54323.18515222275, 65580.67209663922, 66813.33186668072, 66881.33118668849, 59346.406535934955, 59759.0, 59768.70115649481, 59773.0, 59885.40687558761, 14307.64230894236, 14538.41846326135, 14572.781408278885, 14579.635509112144, 14592.927035364968, 10685.83971240432, 10703.143748500257, 10752.139828813833, 10922.836157457645, 10977.725556861142, 19736.11187496566, 19859.60280794376, 20128.89935550342, 20137.49656258576, 20379.184832606825, 7712.251779692769, 7812.687492500237, 7963.673420453197, 8031.1567285434185, 8040.517568945882, 918.42598376015, 990.8612794208816, 1027.9434631095362, 1043.7286305560608, 1127.1827924754487, 25485.61771573428, 26193.0, 26822.5976610351, 26887.984069902126, 27114.5932811008, 1015.9441230732381, 1021.8927012663712, 1033.0857191385678, 1066.0458889294193, 1098.6594155811724, 13981.23103229332, 14094.577162685136, 14143.434262629586, 14204.431822726976, 15433.151176685391, 319250.0, 320162.0, 320974.0, 321522.0, 321771.0, 51794.22308665373, 51922.0, 52241.7387913058, 52303.0, 52454.47545524572, 1374.223563686514, 1380.6459985724316, 1381.1022835157028, 1394.6652803327129, 1489.1883923261848, 28723.28191795222, 29160.0, 29649.25876853096, 29881.850590746908, 30216.69783302139, 46114.769426152656, 46378.304325434474, 46585.301220481044, 46636.7668161657, 46848.59454216379, 290520.0, 292809.53595231887, 295043.0, 295998.0, 296536.0, 30479.390412192075, 31282.21794455157, 31821.681783182798, 31930.52104218485, 32060.19849503781, 38131.237375252895, 38515.6148438512, 38758.61241387663, 39140.0, 39359.212815742954, 34639.653603463645, 34794.43425045828, 35413.29173416569, 35458.93623191308, 35911.82044089763, 34928.476072859434, 35534.822325888206, 35975.460368095024, 36057.639423605426, 36121.27757444889, 32408.35183296368, 32795.18012049718, 32887.17782055372, 32970.340593188484, 35322.470162947066, 31222.531662025543, 31823.36353272968, 32611.510827338083, 32618.184545386554, 32745.50881736728, 24640.630390544517, 24903.252902412958, 25235.11677091293, 25397.238082857544, 25460.872695636404], "unit": "score", "name": "ext.html", "value": 18152.45754906035}, {"lowerIsBetter": false, "replicates": [357.52092196456744, 359.71582449864604, 360.35136753843074, 361.37482155870345, 361.98552057917675, 16820.990740555575, 17037.82962170378, 17535.561610959732, 17918.372856949976, 18503.444896653087, 14020.789688154686, 14178.929105354484, 14230.146191228534, 14299.49951751689, 14310.71378572428, 4688.062387522501, 4881.511848815107, 4897.216445368742, 4898.142825005628, 4929.630277729185, 4802.23164293713, 4809.903801923977, 4831.782569784351, 4833.564979151875, 4865.562099411052, 4744.4306683198065, 4840.540148685886, 5031.144705400073, 5185.066687996159, 5189.870253243661, 5084.288199652052, 5140.126178549637, 5153.304303918961, 5155.200943853709, 5159.948400516003, 5061.0, 5061.974690126563, 5065.189569668835, 5068.315777370081, 5078.568321692624, 12408.441620127116, 12482.687932801662, 12675.492980280778, 12868.420921058481, 12882.162659427107, 2009.2465325502938, 2014.1540552967788, 2148.881811500367, 2180.6292930201903, 2279.920202792894, 9555.569999350046, 9784.706458806248, 9823.214142868625, 9954.0, 11308.830367544493, 1840.6134711710556, 1842.5867617380516, 1895.5545446819986, 1897.297999740105, 1950.3271371376852, 56375.43624563743, 61443.0, 63417.68291158561, 63732.68133659349, 63775.681121594556, 10292.485375731183, 10415.16678665705, 10451.425171615634, 10485.9475702621, 10523.421211833269, 13544.864551354558, 13565.186088834702, 13612.659683507793, 13636.65908352299, 13686.589402317946, 7493.66278517468, 7511.737089201852, 7565.0, 7581.658825352873, 7616.9238307616215, 7141.9642901785155, 7194.712211511481, 7206.855862882818, 7222.422206223489, 7228.168760592494, 4491.820327186876, 4548.559689249899, 4550.681452298373, 4564.132814765184, 4568.794404251817, 1804.5578833185953, 1816.1827177770056, 1847.4919397165618, 1865.32848174657, 1894.8389386901993, 441.88510987143576, 447.14595123314314, 460.2429004287928, 818.6561644109488, 944.4427787605208, 10709.78580428387, 10936.726581835517, 16772.0, 17536.91231543834, 18429.72355414643, 903.6837107012625, 933.3699752666922, 971.9308760363543, 1000.1598657128047, 1014.6651604970342, 9579.329446938787, 9708.563114659857, 9862.556184971694, 9909.157721593745, 10042.548085336177, 374638.0, 379588.0, 388518.0, 390134.0, 391933.0, 78023.0, 79798.0, 82587.76118358229, 82891.0, 83279.0, 1110.539126262592, 1117.3184357541893, 1126.4367816091954, 1131.2703306367348, 1141.9885801142048, 15450.22748862575, 15610.297536611108, 15715.607109822346, 15761.921190393974, 15772.842271577138, 18325.633487330444, 18471.0, 31259.437028148957, 32095.518567221978, 33456.83271583724, 44724.55275447204, 44825.32762008638, 44971.32543011923, 45300.546994529635, 47958.28062579134, 9538.904610953801, 9540.141387275178, 9698.563564639468, 9778.55996480146, 9803.411795292306, 11763.588274410355, 11773.646790596296, 11806.35065071395, 17545.56136096608, 17690.91154544219, 14046.719065618834, 14348.426062957366, 14514.85485145135, 14524.49164279245, 14867.330970106588, 13518.864811352154, 14161.716765664834, 14458.132512049311, 14545.490907818175, 14624.780628290797, 14418.0, 14461.276936153361, 14507.274636267934, 14640.633984150056, 14654.267286635411, 9717.805643887225, 9762.0, 9887.901120988985, 9948.154406875206, 10061.647842325483, 14603.634909127357, 14826.40694372213, 14828.481003165269, 15002.174880381684, 15005.924970375077], "unit": "score", "name": "jquery.html", "value": 8414.66224865519}, {"lowerIsBetter": false, "replicates": [1318.9208647481153, 1353.593921823453, 1377.4765589076155, 1538.9153596552185, 1562.3594326326208, 7260.854782904339, 7378.631068446583, 7383.593902335363, 7673.577953212571, 7756.301932826044, 7776.222377762221, 7847.960760196205, 7857.1357150713375, 7872.5276483411035, 7950.840983180333, 2248.9437764055865, 2282.7374851891996, 2282.7945484906354, 2285.851419657717, 2287.005152758555, 2218.3455880515285, 2225.5771403433378, 2314.4098254944965, 2314.849534780234, 2315.351701523576, 2097.6538871086254, 2176.9564608707815, 2184.4102092435032, 2244.1584405847807, 2265.614845476273, 2267.954640907181, 2272.818174546049, 2318.211807985285, 2326.336993956723, 2331.1258278145697, 2285.268714011517, 2337.590921588715, 2338.088145623208, 2339.7075365579303, 2341.94145146371, 7759.612019399064, 7769.184235655288, 7787.8442431151625, 7809.609519524001, 7814.648340824677, 4458.1306645204195, 4485.2599321111975, 4490.3488994096, 4490.775461226958, 4509.413776209105, 3068.0, 3086.737627301682, 3159.7314228290625, 3202.087405089538, 3213.3091385352027, 980.7302991677275, 986.9309148359617, 1011.3476807459222, 1014.4015031131594, 1025.9897401026044, 9805.0, 9888.456134912576, 9904.108630223242, 9917.305788594802, 9936.155426788804, 3937.3503371943307, 4005.839766409369, 4027.5972402760076, 4036.798160091984, 4045.211183819127, 8037.799055023671, 8107.067687215927, 8120.959395202986, 8122.796930076795, 8142.877856832152, 4288.24955632763, 4305.138972205571, 4323.610875021263, 4329.134173165379, 4346.7609281489185, 3920.7843568604, 3970.9602903971168, 3975.8012099394914, 3977.8209980550946, 3998.8400463981698, 3307.7188438982957, 3353.245519758035, 3359.714424273964, 3367.6632336766615, 3401.3707464119216, 1023.8259495885717, 1032.7160030991388, 1036.8859425463193, 1046.4453839465095, 1048.2766890845292, 1034.7878684869584, 1043.1706793099504, 1095.4194277033184, 1185.5376403202758, 1324.973500529984, 6865.176178858569, 7115.501914865909, 7137.536060156073, 7142.607156606437, 7168.964155179295, 1102.5534658463334, 1104.6465131157952, 1105.8285965675334, 1114.7436089699415, 1139.2594813371375, 5824.621399609012, 5857.765689372377, 5881.588288819741, 5888.116782482576, 5937.198478205473, 9259.30555208362, 9418.858717119248, 9553.42679439222, 9559.713208603753, 9712.077352651488, 9386.812263754686, 9394.859077113848, 9395.060493950687, 9413.952930235306, 9466.668666596635, 7153.463490238253, 7300.342969132697, 7343.8898416522725, 7406.629668516553, 7473.252674732484, 7156.248593897566, 7157.355837974607, 7234.89147662796, 7248.0, 7254.927450725425, 8070.49814557489, 8193.0, 8333.499990000619, 8428.831423371375, 8442.620082096444, 8571.142885711628, 8584.527850968258, 8650.697225597074, 8701.086385929639, 8752.0, 6672.332766723289, 6789.728410863708, 6851.3491218334175, 6860.382565568923, 6863.07348507965, 7095.0421693070775, 7118.679659415235, 7124.536905101152, 7146.285371462812, 7158.391536719437, 6416.711247993758, 6657.3009833966735, 6829.692663830239, 6901.999210114405, 6960.060391847036, 6784.525083244323, 6858.451323894176, 6860.794176174722, 6914.0666010088, 6916.308369163044, 6755.831104222434, 6910.2398736137975, 6912.101426814683, 6922.653867306715, 6927.445804335742, 6221.160143380766, 6459.9031014533875, 6476.481881449567, 6487.286398496256, 6491.805245842632, 6452.322506136976, 6475.125858009108, 6497.610143391412, 6559.180102487189, 6593.307702691149], "unit": "score", "name": "mootools.html", "value": 4382.8010618199}, {"lowerIsBetter": false, "replicates": [345.81671713991585, 348.75412833952066, 349.40775385721196, 350.4462948541305, 351.3324683102106, 6286.465650419708, 6321.241451025878, 6358.713857876395, 6378.831197392886, 6453.193350831146, 6274.090256912745, 6287.245530536342, 6328.5760703841615, 6355.110284560154, 6410.615363078218, 4841.515848415148, 4841.540053694894, 4847.830325938593, 4853.490383509742, 4878.926816097762, 4866.975665121669, 4884.3406140171155, 4884.535969082932, 4886.486918873503, 4888.0, 4629.8842528936875, 4763.54746299101, 4771.928421073687, 4782.736949467778, 4813.735244561548, 4752.5485078917445, 4756.7859446324655, 4769.689970151963, 4789.976050119744, 4793.18515852306, 4137.358709400048, 4141.958580414218, 4150.107726838714, 4150.439690641755, 4159.064210552601, 6032.547558933097, 6056.757729690807, 6063.787242551507, 6110.847228819271, 6121.143039974407, 5474.562035037187, 5572.58205634579, 5574.163875418679, 5576.275084239023, 5600.159976003632, 6694.7656832011135, 6720.126383570154, 6722.93277067228, 6724.428423584001, 6733.966330168367, 4573.428321459817, 4586.105709386671, 4586.334981427708, 4608.28571571407, 4608.677392582521, 6751.932480675179, 6955.269696681826, 6988.825279368006, 6998.055262539543, 7037.331453511908, 4696.272077827942, 4714.245720684674, 4715.81136754526, 4720.409948756405, 4723.5984941279685, 4781.641376896747, 4790.041991601694, 4802.8799280018275, 4806.423229212517, 4807.903841923142, 5592.245046918695, 5621.325440947113, 5625.0, 5633.887322253532, 5645.858853528694, 6636.601803891782, 6779.559328643622, 6781.694823732944, 6782.966085169543, 6796.0, 1658.991705041467, 1684.5114916674272, 1703.3782669325856, 1705.718556438174, 1708.103245795967, 1120.4173829608558, 1128.0806142993433, 1132.841402203692, 1138.032672228599, 1142.0863309352485, 6260.186175797117, 6292.370762923762, 6307.432331090132, 6317.936820631827, 6322.589031712924, 6933.479989000845, 6945.7221711132, 6952.270011648805, 6958.0, 6971.6862741176765, 6214.906776398358, 6260.373962603794, 6284.748610055638, 6309.053641953652, 6320.652364119926, 3784.526934133233, 3804.630333080089, 3822.904427389282, 3836.4245363195746, 3848.1534062506203, 7323.816904577428, 7346.926530734731, 7360.153582337993, 7382.0, 7388.076490438695, 7149.0, 7269.563826170341, 7297.671604777798, 7316.0, 7325.743598974011, 7249.710011599583, 7288.161861386008, 7313.378362839112, 7326.487145899842, 7341.339279464767, 6998.055262539492, 7031.542949708252, 7037.824054398477, 7043.542169758949, 7065.940108983488, 6750.1562304711915, 6923.0, 7010.193827709879, 7033.191183014019, 7033.753818616324, 7279.563226206445, 7335.1197856257595, 7356.485046046725, 7364.189939106587, 7369.705211791468, 4749.762511874462, 4777.259524773665, 4779.283107533759, 4781.808727650855, 4785.712857228577, 6897.379235868595, 6916.066331045245, 7064.434845212473, 7078.327558881898, 7109.573425594481, 6808.183018037867, 6839.829004274933, 6873.140857392826, 6883.724651013903, 6895.103636527219, 6805.115335006615, 6807.829804254933, 6809.182898052265, 6817.0, 6825.522213445011, 6529.347065293433, 6707.463402927657, 6718.462522998051, 6721.260661327348, 6738.35985581369, 6890.0, 6896.0, 6901.516893817385, 6907.654617269016, 6919.273476284918, 6673.366030227121, 6679.165104361955, 6707.832304192434, 6710.396064354036, 6710.932890671226], "unit": "score", "name": "prototype.html", "value": 5084.953375127789}, {"lowerIsBetter": false, "replicates": [794.8012996750813, 838.9077201507829, 841.5960339037262, 843.6709683223544, 845.2435070611803, 11737.47181376838, 11820.172587918849, 11861.347625880573, 11893.643190704282, 12021.978131858792, 11508.769824603503, 11867.881321186807, 11875.81241875812, 11881.702957426069, 11908.404579770999, 683.9384455399013, 694.8297667071574, 816.9632366543505, 826.1862065865148, 838.2790799912101, 826.8718348655968, 839.4207996482438, 843.9029511606152, 845.2561745663808, 851.0638297872352, 874.204473928725, 881.2817553693719, 884.7080463447079, 884.7876509637705, 887.6759982606335, 872.1060912564609, 873.4890089297768, 878.4070752242211, 880.6917578847416, 880.9559522023937, 644.4264604501997, 646.993530064698, 647.184547470191, 651.495091304243, 652.5693042591867, 11828.34944078084, 11963.102767292401, 11980.460879260367, 11987.280763154238, 12030.27818330903, 12459.875401246052, 12782.808257876139, 12914.289714065722, 13225.206487610678, 13242.073054886161, 10063.597456101747, 10328.58685652573, 10434.89565104347, 10972.670819875417, 11044.116470682406, 3730.0488375464356, 3738.4579236010627, 3753.6997040236715, 3778.282126395976, 3897.590752970954, 46683.0, 47824.521754782356, 48478.51521484775, 48972.75513622409, 48978.7551062246, 10716.94641526803, 10735.248532602644, 10766.78466430667, 10813.783724325627, 10977.28647637901, 18745.0, 18796.81203187978, 18802.0, 18822.623547529245, 18837.905810471133, 7153.89269160963, 7200.243974382719, 7229.49393542447, 7235.312645298688, 7259.9274007259255, 4024.7585144890813, 4043.5956404359918, 4105.117399759066, 4116.91766164675, 4253.957460425418, 3127.8592463339205, 3138.5292206169256, 3170.651228364878, 3177.9046628601177, 3185.4266232077985, 579.4118969246218, 590.515777062813, 593.6705128653552, 594.8661551151043, 603.4508597176548, 557.9972100139554, 559.1221781802612, 584.386394285998, 589.7464090441066, 664.757363562306, 7874.0, 8167.101618821925, 8248.216419440143, 8298.21166989135, 8454.87317690235, 638.8434833465737, 668.1180841289548, 688.4526801193064, 691.339770519163, 708.7731925783803, 3885.9611403886165, 4081.4898137732785, 4230.323148296257, 4410.33844923264, 4436.534163912807, 51431.485685143416, 53514.7324263384, 53941.46058539443, 54175.18737218945, 54232.18651720227, 48896.0, 49554.50445495571, 49701.0, 50010.49989500131, 50409.49590504048, 43031.0, 43968.78015609901, 44220.336694949605, 44405.77797111058, 47137.76431117891, 8554.529500877512, 8586.441881277697, 8602.311815054656, 8879.511626860585, 8969.641214351353, 33650.0, 33957.49063763996, 34509.0, 34577.82711086429, 34985.65014349824, 40328.79835600803, 41425.585744142176, 43854.0, 44345.55654443414, 44893.0, 10298.330608510423, 10356.326838755456, 10415.114715248985, 10510.159187264848, 10819.675409737405, 12175.695607609881, 12454.501819927102, 12490.125691201529, 12576.0, 12715.173513721578, 11134.443277836237, 11247.100231981258, 11529.711757206136, 11639.301641901175, 11943.761124777282, 11197.66407007791, 11516.596919107791, 11551.76896462083, 11565.421728913689, 11854.644360669194, 11647.359395233343, 11648.825267620823, 11727.41362931833, 11978.76042479163, 12009.099317551043, 9047.773805654911, 9069.591868365807, 9459.148676619137, 9652.372595781251, 9716.951415242878, 8010.399220058635, 8507.319414446953, 8646.870296945677, 9260.861087083835, 9629.614815407305], "unit": "score", "name": "yui.html", "value": 6254.857658936161}], "name": "dromaeo_css", "value": 6982.711875710506}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 111.0, 112.0, 111.0, 124.0, 110.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 151.0, 173.0, 140.0, 153.0, 153.0, 127.0, 168.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [163.0, 166.0, 163.0, 163.0, 163.0, 162.0, 168.0, 166.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 73.0, 74.0, 75.0, 75.0, 76.0, 148.0, 75.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 138.0, 95.0, 96.0, 97.0, 143.0, 97.0, 96.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 149.0, 147.0, 148.0, 148.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 98.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 60.0, 61.0, 60.0, 58.0, 59.0, 61.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 69.0, 70.0, 71.0, 70.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 87.0, 89.0, 88.0, 94.0, 92.0, 88.0, 90.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [124.0, 119.0, 125.0, 130.0, 119.0, 120.0, 128.0, 121.0, 119.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [150.0, 152.0, 151.0, 158.0, 155.0, 143.0, 145.0, 152.0, 160.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 67.0, 67.0, 68.0, 70.0, 67.0, 69.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1528.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.86133822793258], "unit": "score", "name": "Richards", "value": 211.56488599999994}, {"lowerIsBetter": false, "replicates": [188.82175226586102], "unit": "score", "name": "DeltaBlue", "value": 350.16092799999996}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1047.071129707113], "unit": "score", "name": "RayTrace", "value": 706.7227612387616}, {"lowerIsBetter": false, "replicates": [713.9800285306704], "unit": "score", "name": "Earley", "value": 933.447678321678}, {"lowerIsBetter": false, "replicates": [12525.0], "unit": "score", "name": "Boyer", "value": 53.21061876247504}, {"lowerIsBetter": false, "replicates": [25500.0], "unit": "score", "name": "RegExp", "value": 35.72490196078431}, {"lowerIsBetter": false, "replicates": [674.7638326585695], "unit": "score", "name": "Splay", "value": 120.76966199999997}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21099.993126194488}]} 20:21:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21099.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1528.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6982.71"}}} 20:21:39 INFO - Return code: 0 20:21:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:21:39 INFO - # TBPL SUCCESS # 20:21:39 INFO - Running post-action listener: _resource_record_post_action 20:21:39 INFO - Running post-run listener: _resource_record_post_run 20:21:40 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 567701504; Read time: 0; Write time: 576140 20:21:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234754048; Read time: 0; Write time: 328824 20:21:40 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 321409024; Read time: 0; Write time: 244820 20:21:40 INFO - Running post-run listener: _upload_blobber_files 20:21:40 INFO - Blob upload gear active. 20:21:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:21:40 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:21:40 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:21:40 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:21:40 INFO - (blobuploader) - INFO - Open directory for files ... 20:21:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:21:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:41 INFO - (blobuploader) - INFO - Done attempting. 20:21:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:21:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:21:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:42 INFO - (blobuploader) - INFO - Done attempting. 20:21:42 INFO - (blobuploader) - INFO - Iteration through files over. 20:21:42 INFO - Return code: 0 20:21:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:21:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:21:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1870f1fd6a77e654786298f287da8a7a4f8aa7b72fd2fd2e5a1324ccdf72abd5494fbef7de4f136e831a639de2951b4ceda3dffb50dc5436d5221938dfe886e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4945ca057ad62bd7b6045ce2b62d20852e24091279e849f09e7da258b9037ba6499281e3a651171270d490afe85e8495ed95e36470ca163b47aab7228dfe90c7"} 20:21:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:21:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:21:42 INFO - Contents: 20:21:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1870f1fd6a77e654786298f287da8a7a4f8aa7b72fd2fd2e5a1324ccdf72abd5494fbef7de4f136e831a639de2951b4ceda3dffb50dc5436d5221938dfe886e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4945ca057ad62bd7b6045ce2b62d20852e24091279e849f09e7da258b9037ba6499281e3a651171270d490afe85e8495ed95e36470ca163b47aab7228dfe90c7"} 20:21:42 INFO - Copying logs to upload dir... 20:21:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.678304 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-31 20:21:41.190852) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 20:21:41.194896) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1870f1fd6a77e654786298f287da8a7a4f8aa7b72fd2fd2e5a1324ccdf72abd5494fbef7de4f136e831a639de2951b4ceda3dffb50dc5436d5221938dfe886e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4945ca057ad62bd7b6045ce2b62d20852e24091279e849f09e7da258b9037ba6499281e3a651171270d490afe85e8495ed95e36470ca163b47aab7228dfe90c7"} build_url:https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011453 build_url: 'https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1870f1fd6a77e654786298f287da8a7a4f8aa7b72fd2fd2e5a1324ccdf72abd5494fbef7de4f136e831a639de2951b4ceda3dffb50dc5436d5221938dfe886e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4945ca057ad62bd7b6045ce2b62d20852e24091279e849f09e7da258b9037ba6499281e3a651171270d490afe85e8495ed95e36470ca163b47aab7228dfe90c7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 20:21:41.219992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:21:41.220401) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1451612160.924917-244672223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:21:41.304972) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 20:21:41.305566) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 20:21:41.306120) ========= ========= Total master_lag: 0.31 =========