builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1451501604.85 results: success (0) buildid: 20151230083144 builduid: 627f3cd32a8e42d098d5604938d0abb2 revision: 9e210cee056b1a3d213198b4e38679612b0bb0bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.848427) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.848903) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.849199) ========= 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=256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006457 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.891751) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.892122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.957622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.957922) ========= 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=256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.018239) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.018571) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.018943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.019261) ========= 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=256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 10:53:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 221M=0s 2015-12-30 10:53:25 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168352 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.207154) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.207451) ========= 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=256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014440 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.256577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.256903) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9e210cee056b1a3d213198b4e38679612b0bb0bc --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 9e210cee056b1a3d213198b4e38679612b0bb0bc --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=256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 10:53:25,395 truncating revision to first 12 chars 2015-12-30 10:53:25,395 Setting DEBUG logging. 2015-12-30 10:53:25,395 attempt 1/10 2015-12-30 10:53:25,395 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9e210cee056b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 10:53:25,636 unpacking tar archive at: fx-team-9e210cee056b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.509148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.778994) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.779352) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.791525) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.791914) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.792434) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 4 secs) (at 2015-12-30 10:53:25.792771) ========= /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=256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:53:26 INFO - MultiFileLogger online at 20151230 10:53:26 in /builds/slave/test-pgo 10:53:26 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 10:53:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:53:26 INFO - {'append_to_log': False, 10:53:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:53:26 INFO - 'blob_upload_branch': 'Fx-Team', 10:53:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:53:26 INFO - 'branch': 'Fx-Team', 10:53:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:53:26 INFO - 'config_files': ('talos/linux_config.py',), 10:53:26 INFO - 'default_actions': ('clobber', 10:53:26 INFO - 'read-buildbot-config', 10:53:26 INFO - 'download-and-extract', 10:53:26 INFO - 'populate-webroot', 10:53:26 INFO - 'create-virtualenv', 10:53:26 INFO - 'install', 10:53:26 INFO - 'run-tests'), 10:53:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:53:26 INFO - 'download_minidump_stackwalk': True, 10:53:26 INFO - 'download_symbols': 'ondemand', 10:53:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:53:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:53:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:53:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:53:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:53:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:53:26 INFO - 'installer_path': 'installer.exe', 10:53:26 INFO - 'log_level': 'info', 10:53:26 INFO - 'log_name': 'talos', 10:53:26 INFO - 'log_to_console': True, 10:53:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:53:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:53:26 INFO - 'opt_config_files': (), 10:53:26 INFO - 'pip_index': False, 10:53:26 INFO - 'sps_profile': False, 10:53:26 INFO - 'sps_profile_interval': 0, 10:53:26 INFO - 'suite': 'dromaeojs-e10s', 10:53:26 INFO - 'system_bits': '32', 10:53:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:53:26 INFO - 'title': 'talos-linux64-ix-013', 10:53:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:53:26 INFO - 'use_talos_json': True, 10:53:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:53:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:53:26 INFO - 'work_dir': 'build'} 10:53:26 INFO - ##### 10:53:26 INFO - ##### Running clobber step. 10:53:26 INFO - ##### 10:53:26 INFO - Running pre-action listener: _resource_record_pre_action 10:53:26 INFO - Running main action method: clobber 10:53:26 INFO - rmtree: /builds/slave/test-pgo/build 10:53:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:53:26 INFO - Running post-action listener: _resource_record_post_action 10:53:26 INFO - ##### 10:53:26 INFO - ##### Running read-buildbot-config step. 10:53:26 INFO - ##### 10:53:26 INFO - Running pre-action listener: _resource_record_pre_action 10:53:26 INFO - Running main action method: read_buildbot_config 10:53:26 INFO - Using buildbot properties: 10:53:26 INFO - { 10:53:26 INFO - "project": "", 10:53:26 INFO - "product": "firefox", 10:53:26 INFO - "script_repo_revision": "production", 10:53:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:53:26 INFO - "repository": "", 10:53:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:53:26 INFO - "buildid": "20151230083144", 10:53:26 INFO - "pgo_build": "True", 10:53:26 INFO - "basedir": "/builds/slave/test-pgo", 10:53:26 INFO - "buildnumber": 416, 10:53:26 INFO - "slavename": "talos-linux64-ix-013", 10:53:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:53:26 INFO - "platform": "ubuntu64_hw", 10:53:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:53:26 INFO - "branch": "fx-team", 10:53:26 INFO - "repo_path": "integration/fx-team", 10:53:26 INFO - "revision": "9e210cee056b1a3d213198b4e38679612b0bb0bc", 10:53:26 INFO - "stage_platform": "linux64-pgo", 10:53:26 INFO - "builduid": "627f3cd32a8e42d098d5604938d0abb2", 10:53:26 INFO - "slavebuilddir": "test" 10:53:26 INFO - } 10:53:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:53:26 INFO - Running post-action listener: _resource_record_post_action 10:53:26 INFO - ##### 10:53:26 INFO - ##### Running download-and-extract step. 10:53:26 INFO - ##### 10:53:26 INFO - Running pre-action listener: _resource_record_pre_action 10:53:26 INFO - Running main action method: download_and_extract 10:53:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:53:26 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')]} 10:53:26 INFO - https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:53:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/test_packages.json 10:53:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/test_packages.json 10:53:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:53:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:53:37 INFO - Downloaded 1302 bytes. 10:53:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:53:37 INFO - Using the following test package requirements: 10:53:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:53:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:53:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:37 INFO - u'jsshell-linux-x86_64.zip'], 10:53:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:53:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:53:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:53:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:53:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:53:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:53:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:53:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:37 INFO - https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/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 10:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/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 10:53:43 INFO - Downloaded 23202480 bytes. 10:53:43 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 10:53:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:43 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 10:53:44 INFO - Return code: 0 10:53:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:44 INFO - https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:53:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/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 10:53:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/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 10:53:49 INFO - Downloaded 23202480 bytes. 10:53:49 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 10:53:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:49 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 10:53:50 INFO - Return code: 0 10:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:50 INFO - https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/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 10:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/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 10:53:51 INFO - Downloaded 11132285 bytes. 10:53:51 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 10:53:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:51 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 10:53:51 INFO - Return code: 0 10:53: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')]} 10:53:51 INFO - https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:53:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/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 10:53:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/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 10:53:52 INFO - Downloaded 54953841 bytes. 10:53:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:52 INFO - mkdir: /builds/slave/test-pgo/properties 10:53:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:53:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:53:52 INFO - Contents: 10:53:52 INFO - build_url:https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:52 INFO - Running post-action listener: _resource_record_post_action 10:53:52 INFO - Running post-action listener: set_extra_try_arguments 10:53:52 INFO - ##### 10:53:52 INFO - ##### Running populate-webroot step. 10:53:52 INFO - ##### 10:53:52 INFO - Running pre-action listener: _resource_record_pre_action 10:53:52 INFO - Running main action method: populate_webroot 10:53:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:52 INFO - '--tppagecycles', 10:53:52 INFO - '7'], 10:53:52 INFO - 'tests': ['tsvgm']}}, 10:53:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:53:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:53:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:53:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:53:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:53:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:52 INFO - 'talos_options': ['--e10s'], 10:53:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:52 INFO - 'tests': ['damp', 'tps']}, 10:53:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:52 INFO - 'talos_options': ['--e10s'], 10:53:52 INFO - 'tests': ['damp', 'tps']}, 10:53:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:53:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:52 INFO - 'other': {'tests': ['a11yr', 10:53:52 INFO - 'ts_paint', 10:53:52 INFO - 'tpaint', 10:53:52 INFO - 'sessionrestore', 10:53:52 INFO - 'sessionrestore_no_auto_restore']}, 10:53:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:53:52 INFO - 'tests': ['a11yr', 10:53:52 INFO - 'ts_paint', 10:53:52 INFO - 'tpaint', 10:53:52 INFO - 'sessionrestore', 10:53:52 INFO - 'sessionrestore_no_auto_restore']}, 10:53:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:53:52 INFO - 'tests': ['a11yr', 10:53:52 INFO - 'ts_paint', 10:53:52 INFO - 'tpaint', 10:53:52 INFO - 'sessionrestore', 10:53:52 INFO - 'sessionrestore_no_auto_restore']}, 10:53:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:53:52 INFO - 'tests': ['a11yr', 10:53:52 INFO - 'ts_paint', 10:53:52 INFO - 'tpaint', 10:53:52 INFO - 'sessionrestore', 10:53:52 INFO - 'sessionrestore_no_auto_restore']}, 10:53:52 INFO - 'other_l64': {'tests': ['a11yr', 10:53:52 INFO - 'ts_paint', 10:53:52 INFO - 'tpaint', 10:53:52 INFO - 'sessionrestore', 10:53:52 INFO - 'sessionrestore_no_auto_restore']}, 10:53:52 INFO - 'other_nol64': {'tests': ['a11yr', 10:53:52 INFO - 'ts_paint', 10:53:52 INFO - 'tpaint', 10:53:52 INFO - 'sessionrestore', 10:53:52 INFO - 'sessionrestore_no_auto_restore']}, 10:53:52 INFO - 'svgr': {'tests': ['tsvgx', 10:53:52 INFO - 'tsvgr_opacity', 10:53:52 INFO - 'tart', 10:53:52 INFO - 'tscrollx', 10:53:52 INFO - 'cart']}, 10:53:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:53:52 INFO - 'tests': ['tsvgx', 10:53:52 INFO - 'tsvgr_opacity', 10:53:52 INFO - 'tart', 10:53:52 INFO - 'tscrollx', 10:53:52 INFO - 'cart']}, 10:53:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:52 INFO - 'tests': ['tp5o']}, 10:53:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:52 INFO - 'talos_options': ['--e10s'], 10:53:52 INFO - 'tests': ['tp5o']}, 10:53:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:52 INFO - 'talos_options': ['--xperf_path', 10:53:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:52 INFO - 'tests': ['tp5n']}, 10:53:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:52 INFO - 'talos_options': ['--e10s', 10:53:52 INFO - '--xperf_path', 10:53:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:52 INFO - 'tests': ['tp5n']}}, 10:53:52 INFO - 'talos.zip': {'path': '', 10:53:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:52 INFO - Running post-action listener: _resource_record_post_action 10:53:52 INFO - ##### 10:53:52 INFO - ##### Running create-virtualenv step. 10:53:52 INFO - ##### 10:53:52 INFO - Running pre-action listener: _resource_record_pre_action 10:53:52 INFO - Running main action method: create_virtualenv 10:53:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:53:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:53:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:53:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:54 INFO - Using real prefix '/usr' 10:53:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:53:54 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:56 INFO - Installing pip.................done. 10:53:56 INFO - Return code: 0 10:53:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f654e5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', '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 10:53:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:53:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:53:56 INFO - Using env: {'DISPLAY': ':0', 10:53:56 INFO - 'HOME': '/home/cltbld', 10:53:56 INFO - 'LANG': 'en_US.UTF-8', 10:53:56 INFO - 'LANGUAGE': 'en_US:en', 10:53:56 INFO - 'LOGNAME': 'cltbld', 10:53:56 INFO - 'MAIL': '/var/mail/cltbld', 10:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:56 INFO - 'MOZ_NO_REMOTE': '1', 10:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:56 INFO - 'NO_EM_RESTART': '1', 10:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:56 INFO - 'SHELL': '/bin/bash', 10:53:56 INFO - 'SHLVL': '1', 10:53:56 INFO - 'TERM': 'linux', 10:53:56 INFO - 'TMOUT': '86400', 10:53:56 INFO - 'USER': 'cltbld', 10:53:56 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', 10:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:56 INFO - '_': '/tools/buildbot/bin/python'} 10:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:53:56 INFO - Cleaning up... 10:53:56 INFO - Return code: 0 10:53:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f654e5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', '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 10:53:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:53:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:53:56 INFO - Using env: {'DISPLAY': ':0', 10:53:56 INFO - 'HOME': '/home/cltbld', 10:53:56 INFO - 'LANG': 'en_US.UTF-8', 10:53:56 INFO - 'LANGUAGE': 'en_US:en', 10:53:56 INFO - 'LOGNAME': 'cltbld', 10:53:56 INFO - 'MAIL': '/var/mail/cltbld', 10:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:56 INFO - 'MOZ_NO_REMOTE': '1', 10:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:56 INFO - 'NO_EM_RESTART': '1', 10:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:56 INFO - 'SHELL': '/bin/bash', 10:53:56 INFO - 'SHLVL': '1', 10:53:56 INFO - 'TERM': 'linux', 10:53:56 INFO - 'TMOUT': '86400', 10:53:56 INFO - 'USER': 'cltbld', 10:53:56 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', 10:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:56 INFO - '_': '/tools/buildbot/bin/python'} 10:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:56 INFO - Downloading/unpacking psutil>=0.7.1 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:53:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:53:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:53:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:58 INFO - Installing collected packages: psutil 10:53:58 INFO - Running setup.py install for psutil 10:53:58 INFO - building 'psutil._psutil_linux' extension 10:53:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:53:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:53:58 INFO - building 'psutil._psutil_posix' extension 10:53:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:53:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:53:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:59 INFO - Successfully installed psutil 10:53:59 INFO - Cleaning up... 10:53:59 INFO - Return code: 0 10:53:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:53: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')]} 10:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f654e5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', '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 10:53:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:53:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:53:59 INFO - Using env: {'DISPLAY': ':0', 10:53:59 INFO - 'HOME': '/home/cltbld', 10:53:59 INFO - 'LANG': 'en_US.UTF-8', 10:53:59 INFO - 'LANGUAGE': 'en_US:en', 10:53:59 INFO - 'LOGNAME': 'cltbld', 10:53:59 INFO - 'MAIL': '/var/mail/cltbld', 10:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:59 INFO - 'MOZ_NO_REMOTE': '1', 10:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:59 INFO - 'NO_EM_RESTART': '1', 10:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:59 INFO - 'SHELL': '/bin/bash', 10:53:59 INFO - 'SHLVL': '1', 10:53:59 INFO - 'TERM': 'linux', 10:53:59 INFO - 'TMOUT': '86400', 10:53:59 INFO - 'USER': 'cltbld', 10:53:59 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', 10:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:59 INFO - '_': '/tools/buildbot/bin/python'} 10:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:54:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:54:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:54:01 INFO - Installing collected packages: mozsystemmonitor 10:54:01 INFO - Running setup.py install for mozsystemmonitor 10:54:01 INFO - Successfully installed mozsystemmonitor 10:54:01 INFO - Cleaning up... 10:54:01 INFO - Return code: 0 10:54:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f654e5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', '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 10:54:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:54:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:54:01 INFO - Using env: {'DISPLAY': ':0', 10:54:01 INFO - 'HOME': '/home/cltbld', 10:54:01 INFO - 'LANG': 'en_US.UTF-8', 10:54:01 INFO - 'LANGUAGE': 'en_US:en', 10:54:01 INFO - 'LOGNAME': 'cltbld', 10:54:01 INFO - 'MAIL': '/var/mail/cltbld', 10:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:01 INFO - 'MOZ_NO_REMOTE': '1', 10:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:01 INFO - 'NO_EM_RESTART': '1', 10:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:01 INFO - 'SHELL': '/bin/bash', 10:54:01 INFO - 'SHLVL': '1', 10:54:01 INFO - 'TERM': 'linux', 10:54:01 INFO - 'TMOUT': '86400', 10:54:01 INFO - 'USER': 'cltbld', 10:54:01 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', 10:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:01 INFO - '_': '/tools/buildbot/bin/python'} 10:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:01 INFO - Downloading/unpacking blobuploader==1.2.4 10:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:03 INFO - Downloading blobuploader-1.2.4.tar.gz 10:54:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:54:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:54:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:54:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:54:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:04 INFO - Downloading docopt-0.6.1.tar.gz 10:54:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:54:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:54:04 INFO - Installing collected packages: blobuploader, requests, docopt 10:54:04 INFO - Running setup.py install for blobuploader 10:54:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:54:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:54:04 INFO - Running setup.py install for requests 10:54:05 INFO - Running setup.py install for docopt 10:54:05 INFO - Successfully installed blobuploader requests docopt 10:54:05 INFO - Cleaning up... 10:54:05 INFO - Return code: 0 10:54:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f654e5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', '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 10:54:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:54:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:05 INFO - Using env: {'DISPLAY': ':0', 10:54:05 INFO - 'HOME': '/home/cltbld', 10:54:05 INFO - 'LANG': 'en_US.UTF-8', 10:54:05 INFO - 'LANGUAGE': 'en_US:en', 10:54:05 INFO - 'LOGNAME': 'cltbld', 10:54:05 INFO - 'MAIL': '/var/mail/cltbld', 10:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:05 INFO - 'MOZ_NO_REMOTE': '1', 10:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:05 INFO - 'NO_EM_RESTART': '1', 10:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:05 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:05 INFO - 'SHELL': '/bin/bash', 10:54:05 INFO - 'SHLVL': '1', 10:54:05 INFO - 'TERM': 'linux', 10:54:05 INFO - 'TMOUT': '86400', 10:54:05 INFO - 'USER': 'cltbld', 10:54:05 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', 10:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:05 INFO - '_': '/tools/buildbot/bin/python'} 10:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:54:05 INFO - Running setup.py (path:/tmp/pip-0yl4WR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:54:05 INFO - Running setup.py (path:/tmp/pip-DO9vLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:54:05 INFO - Running setup.py (path:/tmp/pip-ehUA2b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:54:06 INFO - Running setup.py (path:/tmp/pip-2L4oth-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:54:06 INFO - Running setup.py (path:/tmp/pip-GHoVqH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:54:06 INFO - Running setup.py (path:/tmp/pip-HHD_at-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:54:06 INFO - Running setup.py (path:/tmp/pip-qODD5h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:54:06 INFO - Running setup.py (path:/tmp/pip-EpYU3S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:54:06 INFO - Running setup.py (path:/tmp/pip-6qd8W5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:54:06 INFO - Running setup.py (path:/tmp/pip-8cP6kv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:54:06 INFO - Running setup.py (path:/tmp/pip-pxpZh9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:54:06 INFO - Running setup.py (path:/tmp/pip-EkkqtU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:54:06 INFO - Running setup.py (path:/tmp/pip-YthjyA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:54:06 INFO - Running setup.py (path:/tmp/pip-J3i7bP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:54:06 INFO - Running setup.py (path:/tmp/pip-QpUmV9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:54:06 INFO - Running setup.py (path:/tmp/pip-mr0NK4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:54:06 INFO - Running setup.py (path:/tmp/pip-bd0KWC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:54:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:54:07 INFO - Running setup.py install for manifestparser 10:54:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:54:07 INFO - Running setup.py install for mozcrash 10:54:07 INFO - Running setup.py install for mozdebug 10:54:07 INFO - Running setup.py install for mozdevice 10:54:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:54:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:54:07 INFO - Running setup.py install for mozfile 10:54:07 INFO - Running setup.py install for mozhttpd 10:54:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:54:07 INFO - Running setup.py install for mozinfo 10:54:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:54:07 INFO - Running setup.py install for mozInstall 10:54:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:54:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:54:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:54:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:54:07 INFO - Running setup.py install for mozleak 10:54:07 INFO - Running setup.py install for mozlog 10:54:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Running setup.py install for moznetwork 10:54:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Running setup.py install for mozprocess 10:54:08 INFO - Running setup.py install for mozprofile 10:54:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Running setup.py install for mozrunner 10:54:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Running setup.py install for mozscreenshot 10:54:08 INFO - Running setup.py install for moztest 10:54:08 INFO - Running setup.py install for mozversion 10:54:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:54:08 INFO - Cleaning up... 10:54:08 INFO - Return code: 0 10:54:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:54: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')]} 10:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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')]} 10:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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', '-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 0x7f654e5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', '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 10:54:08 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 10:54:08 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 10:54:08 INFO - Using env: {'DISPLAY': ':0', 10:54:08 INFO - 'HOME': '/home/cltbld', 10:54:08 INFO - 'LANG': 'en_US.UTF-8', 10:54:08 INFO - 'LANGUAGE': 'en_US:en', 10:54:08 INFO - 'LOGNAME': 'cltbld', 10:54:08 INFO - 'MAIL': '/var/mail/cltbld', 10:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:08 INFO - 'MOZ_NO_REMOTE': '1', 10:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:08 INFO - 'NO_EM_RESTART': '1', 10:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:08 INFO - 'SHELL': '/bin/bash', 10:54:08 INFO - 'SHLVL': '1', 10:54:08 INFO - 'TERM': 'linux', 10:54:08 INFO - 'TMOUT': '86400', 10:54:08 INFO - 'USER': 'cltbld', 10:54:08 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', 10:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:08 INFO - '_': '/tools/buildbot/bin/python'} 10:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:54:09 INFO - Running setup.py (path:/tmp/pip-28QcaF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:54:09 INFO - Running setup.py (path:/tmp/pip-aJkOHb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:54:09 INFO - Running setup.py (path:/tmp/pip-i6fLrK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:54:09 INFO - Running setup.py (path:/tmp/pip-gRRief-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:54:09 INFO - Running setup.py (path:/tmp/pip-XAvW4c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:54:09 INFO - Running setup.py (path:/tmp/pip-vJppam-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:54:09 INFO - Running setup.py (path:/tmp/pip-neEqMQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:54:09 INFO - Running setup.py (path:/tmp/pip-LzdE0L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:54:09 INFO - Running setup.py (path:/tmp/pip-BNsqQi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:54:09 INFO - Running setup.py (path:/tmp/pip-Ih4_5m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:54:09 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)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:54:09 INFO - Running setup.py (path:/tmp/pip-yFnv_p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:54:09 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)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:54:09 INFO - Running setup.py (path:/tmp/pip-8bz4F5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:54:09 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)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:54:09 INFO - Running setup.py (path:/tmp/pip-d46fLw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:54:09 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)) 10:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:54:09 INFO - Running setup.py (path:/tmp/pip-rwZnwF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:54:10 INFO - Running setup.py (path:/tmp/pip-KOaEjJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:54:10 INFO - Running setup.py (path:/tmp/pip-zRSX2W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:54:10 INFO - Running setup.py (path:/tmp/pip-NJpuFK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54:11 INFO - Downloading blessings-1.5.1.tar.gz 10:54:11 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 10:54:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:54:11 INFO - Installing collected packages: blessings 10:54:11 INFO - Running setup.py install for blessings 10:54:12 INFO - Successfully installed blessings 10:54:12 INFO - Cleaning up... 10:54:12 INFO - Return code: 0 10:54:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:54:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:54:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:54:12 INFO - Reading from file tmpfile_stdout 10:54:12 INFO - Current package versions: 10:54:12 INFO - argparse == 1.2.1 10:54:12 INFO - blessings == 1.5.1 10:54:12 INFO - blobuploader == 1.2.4 10:54:12 INFO - docopt == 0.6.1 10:54:12 INFO - manifestparser == 1.1 10:54:12 INFO - mozInstall == 1.12 10:54:12 INFO - mozcrash == 0.16 10:54:12 INFO - mozdebug == 0.1 10:54:12 INFO - mozdevice == 0.47 10:54:12 INFO - mozfile == 1.2 10:54:12 INFO - mozhttpd == 0.7 10:54:12 INFO - mozinfo == 0.9 10:54:12 INFO - mozleak == 0.1 10:54:12 INFO - mozlog == 3.1 10:54:12 INFO - moznetwork == 0.27 10:54:12 INFO - mozprocess == 0.22 10:54:12 INFO - mozprofile == 0.28 10:54:12 INFO - mozrunner == 6.11 10:54:12 INFO - mozscreenshot == 0.1 10:54:12 INFO - mozsystemmonitor == 0.0 10:54:12 INFO - moztest == 0.7 10:54:12 INFO - mozversion == 1.4 10:54:12 INFO - psutil == 3.1.1 10:54:12 INFO - requests == 1.2.3 10:54:12 INFO - wsgiref == 0.1.2 10:54:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f654e5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', '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 10:54:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 10:54:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:12 INFO - Using env: {'DISPLAY': ':0', 10:54:12 INFO - 'HOME': '/home/cltbld', 10:54:12 INFO - 'LANG': 'en_US.UTF-8', 10:54:12 INFO - 'LANGUAGE': 'en_US:en', 10:54:12 INFO - 'LOGNAME': 'cltbld', 10:54:12 INFO - 'MAIL': '/var/mail/cltbld', 10:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:12 INFO - 'MOZ_NO_REMOTE': '1', 10:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:12 INFO - 'NO_EM_RESTART': '1', 10:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:12 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:12 INFO - 'SHELL': '/bin/bash', 10:54:12 INFO - 'SHLVL': '1', 10:54:12 INFO - 'TERM': 'linux', 10:54:12 INFO - 'TMOUT': '86400', 10:54:12 INFO - 'USER': 'cltbld', 10:54:12 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', 10:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:12 INFO - '_': '/tools/buildbot/bin/python'} 10:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 10:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:54:12 INFO - Cleaning up... 10:54:12 INFO - Return code: 0 10:54:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f654e5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', '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 10:54:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:54:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:54:12 INFO - Using env: {'DISPLAY': ':0', 10:54:12 INFO - 'HOME': '/home/cltbld', 10:54:12 INFO - 'LANG': 'en_US.UTF-8', 10:54:12 INFO - 'LANGUAGE': 'en_US:en', 10:54:12 INFO - 'LOGNAME': 'cltbld', 10:54:12 INFO - 'MAIL': '/var/mail/cltbld', 10:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:12 INFO - 'MOZ_NO_REMOTE': '1', 10:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:12 INFO - 'NO_EM_RESTART': '1', 10:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:12 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:12 INFO - 'SHELL': '/bin/bash', 10:54:12 INFO - 'SHLVL': '1', 10:54:12 INFO - 'TERM': 'linux', 10:54:12 INFO - 'TMOUT': '86400', 10:54:12 INFO - 'USER': 'cltbld', 10:54:12 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', 10:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:12 INFO - '_': '/tools/buildbot/bin/python'} 10:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:12 INFO - Downloading/unpacking jsonschema 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:54:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 10:54:14 INFO - Downloading/unpacking functools32 (from jsonschema) 10:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:14 INFO - Downloading functools32-3.2.3-2.tar.gz 10:54:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:54:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:54:14 INFO - warning: no files found matching '*.txt' 10:54:14 INFO - no previously-included directories found matching 'build' 10:54:14 INFO - no previously-included directories found matching 'dist' 10:54:14 INFO - no previously-included directories found matching '.git*' 10:54:14 INFO - Installing collected packages: jsonschema, functools32 10:54:14 INFO - Running setup.py install for functools32 10:54:14 INFO - warning: no files found matching '*.txt' 10:54:14 INFO - no previously-included directories found matching 'build' 10:54:14 INFO - no previously-included directories found matching 'dist' 10:54:14 INFO - no previously-included directories found matching '.git*' 10:54:14 INFO - Successfully installed jsonschema functools32 10:54:14 INFO - Cleaning up... 10:54:14 INFO - Return code: 0 10:54:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f654e5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, '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': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', '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 10:54:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:54:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:54:14 INFO - Using env: {'DISPLAY': ':0', 10:54:14 INFO - 'HOME': '/home/cltbld', 10:54:14 INFO - 'LANG': 'en_US.UTF-8', 10:54:14 INFO - 'LANGUAGE': 'en_US:en', 10:54:14 INFO - 'LOGNAME': 'cltbld', 10:54:14 INFO - 'MAIL': '/var/mail/cltbld', 10:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:14 INFO - 'MOZ_NO_REMOTE': '1', 10:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:14 INFO - 'NO_EM_RESTART': '1', 10:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:14 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:14 INFO - 'SHELL': '/bin/bash', 10:54:14 INFO - 'SHLVL': '1', 10:54:14 INFO - 'TERM': 'linux', 10:54:14 INFO - 'TMOUT': '86400', 10:54:14 INFO - 'USER': 'cltbld', 10:54:14 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', 10:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:14 INFO - '_': '/tools/buildbot/bin/python'} 10:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:15 INFO - Downloading/unpacking flake8 10:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:54:16 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 10:54:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:54:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 10:54:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 10:54:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:54:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:54:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:54:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:54:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:54:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:54:17 INFO - no previously-included directories found matching 'docs/_build' 10:54:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:54:17 INFO - Running setup.py install for pep8 10:54:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:54:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:54:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:54:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:54:17 INFO - no previously-included directories found matching 'docs/_build' 10:54:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:54:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:54:17 INFO - Cleaning up... 10:54:17 INFO - Return code: 0 10:54:17 INFO - Running post-action listener: _resource_record_post_action 10:54:17 INFO - Running post-action listener: _start_resource_monitoring 10:54:17 INFO - Starting resource monitoring. 10:54:17 INFO - ##### 10:54:17 INFO - ##### Running install step. 10:54:17 INFO - ##### 10:54:17 INFO - Running pre-action listener: _resource_record_pre_action 10:54:17 INFO - Running main action method: install 10:54:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:54:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:54:17 INFO - Reading from file tmpfile_stdout 10:54:17 INFO - Detecting whether we're running mozinstall >=1.0... 10:54:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:54:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:54:18 INFO - Reading from file tmpfile_stdout 10:54:18 INFO - Output received: 10:54:18 INFO - Usage: mozinstall [options] installer 10:54:18 INFO - Options: 10:54:18 INFO - -h, --help show this help message and exit 10:54:18 INFO - -d DEST, --destination=DEST 10:54:18 INFO - Directory to install application into. [default: 10:54:18 INFO - "/builds/slave/test-pgo"] 10:54:18 INFO - --app=APP Application being installed. [default: firefox] 10:54:18 INFO - mkdir: /builds/slave/test-pgo/build/application 10:54:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:54:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:54:33 INFO - Reading from file tmpfile_stdout 10:54:33 INFO - Output received: 10:54:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:54:33 INFO - Running post-action listener: _resource_record_post_action 10:54:33 INFO - ##### 10:54:33 INFO - ##### Running run-tests step. 10:54:33 INFO - ##### 10:54:33 INFO - Running pre-action listener: _resource_record_pre_action 10:54:33 INFO - Running main action method: run_tests 10:54:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:54:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:54:33 INFO - Python 2.7.3 10:54:33 INFO - Return code: 0 10:54:33 INFO - grabbing minidump binary from tooltool 10:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0840>, '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 0xd4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:54:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:54:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:54:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:54:33 INFO - Return code: 0 10:54:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:54:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:54:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:54:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:54:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:54:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:54:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:54:34 INFO - Return code: 0 10:54:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 10:54:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 10:54:34 INFO - Using env: {'DISPLAY': ':0', 10:54:34 INFO - 'HOME': '/home/cltbld', 10:54:34 INFO - 'LANG': 'en_US.UTF-8', 10:54:34 INFO - 'LANGUAGE': 'en_US:en', 10:54:34 INFO - 'LOGNAME': 'cltbld', 10:54:34 INFO - 'MAIL': '/var/mail/cltbld', 10:54:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:54:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:34 INFO - 'MOZ_NO_REMOTE': '1', 10:54:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:34 INFO - 'NO_EM_RESTART': '1', 10:54:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:34 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:54:34 INFO - 'SHELL': '/bin/bash', 10:54:34 INFO - 'SHLVL': '1', 10:54:34 INFO - 'TERM': 'linux', 10:54:34 INFO - 'TMOUT': '86400', 10:54:34 INFO - 'USER': 'cltbld', 10:54:34 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981', 10:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:34 INFO - '_': '/tools/buildbot/bin/python'} 10:54:34 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 10:54:35 INFO - mozversion application_buildid: 20151230083144 10:54:35 INFO - mozversion application_changeset: 9e210cee056b1a3d213198b4e38679612b0bb0bc 10:54:35 INFO - mozversion application_display_name: Nightly 10:54:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:54:35 INFO - mozversion application_name: Firefox 10:54:35 INFO - mozversion application_remotingname: firefox 10:54:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:54:35 INFO - mozversion application_vendor: Mozilla 10:54:35 INFO - mozversion application_version: 46.0a1 10:54:35 INFO - mozversion platform_buildid: 20151230083144 10:54:35 INFO - mozversion platform_changeset: 9e210cee056b1a3d213198b4e38679612b0bb0bc 10:54:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:54:35 INFO - mozversion platform_version: 46.0a1 10:54:35 INFO - using testdate: 1451501675 10:54:35 INFO - actual date: 1451501675 10:54:35 INFO - starting webserver on 'localhost:35259' 10:54:35 INFO - SUITE-START | Running 3 tests 10:54:35 INFO - TEST-START | dromaeo_css 10:54:35 INFO - operating with platform_type : linux_ 10:54:35 INFO - Initialising browser for dromaeo_css test... 10:54:35 INFO - TEST-INFO | started process 22285 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkh0q6f/profile http://localhost:35259/getInfo.html) 10:55:46 INFO - PROCESS | 22285 | __metrics Screen width/height:1600/1200 10:55:46 INFO - PROCESS | 22285 | colorDepth:24 10:55:46 INFO - PROCESS | 22285 | Browser inner width/height: 1024/697 10:55:46 INFO - PROCESS | 22285 | __metrics 10:55:47 INFO - PROCESS | 22285 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:55:48 INFO - PROCESS | 22285 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 10:55:51 INFO - TEST-INFO | 22285: exit 0 10:55:51 INFO - Browser initialized. 10:55:51 INFO - Running cycle 1/1 for dromaeo_css test... 10:55:51 INFO - TEST-INFO | started process 22419 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkh0q6f/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:56:03 INFO - PROCESS | 22419 | RSS: Main: 149938176 10:56:03 INFO - PROCESS | 22419 | 10:56:52 INFO - PROCESS | 22419 | 1451501812601 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] 10:59:01 INFO - PROCESS | 22419 | Cycle 1(1): loaded http://localhost:35259/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35259/tests/dromaeo/cssquery-ext.html) 10:59:02 INFO - PROCESS | 22419 | RSS: Main: 157712384 10:59:02 INFO - PROCESS | 22419 | 11:02:04 INFO - PROCESS | 22419 | Cycle 1(1): loaded http://localhost:35259/tests/dromaeo/cssquery-ext.html (next: http://localhost:35259/tests/dromaeo/cssquery-jquery.html) 11:02:04 INFO - PROCESS | 22419 | RSS: Main: 152481792 11:02:04 INFO - PROCESS | 22419 | 11:05:06 INFO - PROCESS | 22419 | Cycle 1(1): loaded http://localhost:35259/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35259/tests/dromaeo/cssquery-mootools.html) 11:05:07 INFO - PROCESS | 22419 | RSS: Main: 153726976 11:05:07 INFO - PROCESS | 22419 | 11:08:08 INFO - PROCESS | 22419 | Cycle 1(1): loaded http://localhost:35259/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35259/tests/dromaeo/cssquery-prototype.html) 11:08:09 INFO - PROCESS | 22419 | RSS: Main: 150790144 11:08:09 INFO - PROCESS | 22419 | 11:11:11 INFO - PROCESS | 22419 | Cycle 1(1): loaded http://localhost:35259/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35259/tests/dromaeo/cssquery-yui.html) 11:11:12 INFO - PROCESS | 22419 | RSS: Main: 152637440 11:11:12 INFO - PROCESS | 22419 | 11:14:14 INFO - PROCESS | 22419 | Cycle 1(1): loaded http://localhost:35259/tests/dromaeo/cssquery-yui.html (next: http://localhost:35259/tests/dromaeo/cssquery-dojo.html) 11:14:15 INFO - PROCESS | 22419 | RSS: Main: 155435008 11:14:15 INFO - PROCESS | 22419 | 11:14:15 INFO - PROCESS | 22419 | __start_tp_report 11:14:15 INFO - PROCESS | 22419 | _x_x_mozilla_page_load 11:14:15 INFO - PROCESS | 22419 | _x_x_mozilla_page_load_details 11:14:15 INFO - PROCESS | 22419 | |i|pagename|runs| 11:14:15 INFO - PROCESS | 22419 | |0;dojo.html;3071.8941181174773;3102.16241614764;3123.968760312396;3135.043811637451;3152.1961899715575;5239.397469291032;5272.736363181844;5331.386890507588;5331.626786124973;5361.3030306060255;5303.65526240794;5344.251804747339;5404.297441332631;5425.674459532431;5473;4645.187092258858;4898.999999999991;5102.413222479426;5105.5149760772665;5129.3844738631415;4823.951760482403;5005.624578156653;5028.371453568304;5085.618578606601;5096.210087436453;4859.246816743411;4881.8291359802415;4913.041956818422;4943.406791185045;4969.527894849984;4892.143874821892;4893.363862697862;4902.068606964701;4950.6782059166035;4957.107720610289;4779.928301075487;4865.6594038417325;4898.289747986522;4899.755012249373;4960.70235785854;5170.896582068375;5224.111900976843;5255.02781985334;5279.6832190068335;5296.3379577552805;5700.173474846166;5702.657840529581;5712.400197979236;5729.1119876419225;5733.111367737965;5635.633683810539;5759.971200143972;5770.249867517238;5777.508911742507;5825.417458254141;5428.5385742211565;5438.428964958662;5444.292242008553;5450.073487507133;5458.235846981426;5941.970290148522;5979.790707325223;5997.70011499432;6003.939960600338;6007.068904319837;5611.410801865827;5634.352049514358;5699.2590963174525;5701.942980570141;5753.280839895013;5740.598158128974;5775.16260142277;5781.653100813965;5782.421757824184;5799.2750906136735;5725.370209276976;5764.538836893123;5764.769409223668;5764.798232061858;5773.16289138081;5667.489925906688;5706.058500347479;5755.3381361143165;5758.481736643722;5831.241938547962;4477.731336119843;4479.820807167742;4500.752458614742;4515.164694531522;4540.977295113504;3962.40563915415;3969.2656858481273;3982.522097348337;3989.7207195496617;4057.046594050396;5230.712310822942;5267.288915996368;5316.362036555638;5322.733863306819;5334.0665383557725;5784.305883294031;5800.419958004166;5836.037053886146;5839.416058394211;5839.532837373;5406.053940560386;5412.512873841373;5419.376771671229;5423.783048678088;5430.647007944471;4861.927071093936;4935.851924442272;5017.347744793226;5026.472220416877;5101.464346243665;6025.0359942409;6028.216331876915;6037.607555508878;6044.24446944132;6044.788432404845;5799.2750906136735;5845.444682755132;5847.356790753099;5848.824535263949;5867.149263356704;5784.305883293863;5905.52755779528;5909.409059094056;5976.521878249642;6100.206973093469;5756.65460072397;5759.04975679025;5765.164051212634;5768.509676677361;5784.2191304175085;5855.619384739978;5880.441358070976;5880.705964701662;5881.9705901470215;5896.174535564938;5577.163425486047;5639.859003524781;5666.34836993751;5701.629394089371;5747.511461525817;5643;5688.971555142363;5698.287714035746;5706.771729130788;5712.11462223356;5453.182022696627;5602.4957753802355;5627.859303517281;5633.0705433603;5637.098064309691;5633.492985631313;5667.886642267049;5693.28833895763;5725.656460612377;5777.24895763548;5529.557635389078;5565.38780734127;5565.499105080562;5579.832605021856;5588.86027849307 11:14:15 INFO - PROCESS | 22419 | |1;ext.html;511.85855542141024;546.148009105795;564.31999440674;596.6300893446064;605.1648724759831;33872.15319617011;34563.48154777677;34613.30773384537;34636.48045279316;34834;35159;35512.82243588785;35599.644003560024;35657.2868542629;35703.464448033235;8315.459495132796;8414.36892233082;8457.53483558404;8473.576321183948;8481.236688698016;8228.670853165866;8406.075331713506;8427.747167584983;8432.53621050842;8434.114417986115;8422.073571907085;8434.198751118634;8469.618867150963;8479.957600212021;8503.532305723184;8324.250817426431;8454.746357609281;8471.407001509928;8479.06730259671;8480.151984801532;8373.665053397857;8405.579721013924;8460.450070745383;8468.49189048659;8514.361422893246;35066.82466587676;35323.29353412943;35504.467432988524;35539.4669079964;35729;3031.696830316973;3046.2384403899027;3126.515390114536;3296.528082273701;3636.272745450894;28027.439451210863;28152;28245.576316355273;28644.427111457655;29065.564016539767;3733.21602463483;3766.510353654035;3824.694024478063;3830.253100645375;3900.7854567998747;257915;258545.9999999981;259342;259361;259423;49302.26046609304;49953.50046499488;50120.49879501158;50257.24614130791;56258;55145;55160.72419637876;55172.448275517534;55366.12437129362;55565.444345556025;15340;15384.615384615474;15398.384064637288;15517.068975861259;15522.844771552365;11657.76684466306;11791.29252244868;11815.586454474053;11820;11875.168738188244;18787.34244301443;18913;18931.716024259647;18975;19098.427047188605;7670.348020418327;8025.719099831595;8044.074931382966;8052.476589021695;8112.634931427981;948.9762755931018;973.2214228617078;983.5819776595062;989.4805227255748;1079.6760971708457;27382.589261161098;27572.185831098024;27627.723722762916;27872.721272787014;27899.721002790116;996.461910568285;1054.630879192292;1060.1201003167353;1134.1663877050362;1168.8013037783596;14724.411023558938;14944.551663450115;15181.392744290326;15225.467108651144;15316.310766015557;305612;309264;309483;310644;310720;48863.26705099426;49526.50473495219;49698;49922.50077499251;49982.75008624933;1356.7150898311268;1373.3270697358223;1389.0485017762865;1400.1599040575572;1400.7968844517488;27262.591061134495;28372.00697975561;28408.85795571009;28430.43139137247;28619.28451788722;43464.34803477887;43968.34047489226;44056;44092.118157636025;44205.55794442143;234777;235162;236081;293518;294365;29307.560386593792;29532.409351812414;30564.4850842156;30672.233194169432;30720.539191912587;35694.64305357017;36054;36149;36360.45459318059;36771;31016.68983310138;31483.370332593677;33835.83082084574;35119;35264.29471410609;31333.52999705052;31419.84290078535;31515.84242078775;31692.366152677278;31693.20766980844;31449;31792;31940;32058.67941320557;32082.83958580192;28860;28990.7100928988;29180.416391671624;29318;29334.70665293405;23551.646725299477;23854.761452385254;23856.16503422372;23867;24095.879520602284 11:14:15 INFO - PROCESS | 22419 | |2;jquery.html;342.3563700243543;343.8349592195747;345.9360018396597;346.15365431519933;347.70271417937664;16641.83358166418;16950.321987120515;17441.91279043606;17749.112544372794;18190.27238910442;11147.944260278708;12304;16186.595335116628;16208;16237.188140592953;4835.903281934359;5310.893782124355;5313.867153321159;5314.468553144693;5335.1197052486295;5313.946860531384;5316.362036555619;5327.174287985368;5342.973285133569;5345.572354211654;5048.772805223755;5175.456577059411;5265.289185959904;5272.261883336336;5372.355317361922;5156.639035267533;5162.406323272815;5170.276161337416;5174.172132458826;5184.71484068378;5192.1692529195525;5246.7638956247065;5249.580033597303;5303.23103150045;5313.628046036779;16269.023858568406;19467.415977520555;19524.219031238732;20326.695099573517;20395.286164984154;2065.917363305466;2089.7492300923836;2100.6638937769885;2117.417710129727;2157.8489505734606;6463.062855885917;6468.256150542701;9449.244060475145;9706.51467426633;10163.983601639851;1738.0353903583507;1741.0598276930443;1837.4120281509922;1851;1869.9813001869943;56576;56758.71620641871;57289.42710572883;60256;65795;10002.399616061395;10339.4313312767;10384.169266458664;10498.212634052477;10529.578816847394;13534.93232533831;13648.181109133484;13669.248191349572;13678.247696376795;13679.384427700777;7743.30310272067;7769.3784497240085;7774.378049756006;7810;7968.0438347398685;7441.069866266716;7823.882641760378;7888.48724832884;7891.565963871927;7953.920460795433;4450.933236001462;4464.620507256855;4561.566651168134;4574.222382195035;4580.267157254823;1821.5901422180168;1825.6805059114602;1835.8255965683238;1865.6325332774202;1868.495506213342;277.55591054312936;421.4626351401987;421.791213349394;424.85979626723105;442.33207856136823;10594;11077.279976801483;11223.438828058564;16217.189140542925;16701;921.3688623293066;949.7957939043139;963.0850691842777;972.1250874213265;1009.2380252909006;9385.202257808163;9658.517074146264;9677.467739274407;9756.902430975599;9777;553446;554626;559074;585498;589337;76774;78415.60792196002;78966;79070.60464697755;79602;1148.8047032004413;1162.9940101811872;1218.530865616744;1226.7239871028946;1229.1825935752624;15135;15432.151231682365;15539.766903496682;15546.689066218387;15707.371705131667;34591.827040864635;35032.47451288182;35513.467297990035;36143.45784813283;36191.638083618825;46370.768146159055;47742.52257477381;47802.521974779804;49745;50201;9670.613175472903;9730;9730.902690973282;9776.315657903879;9830.262730295113;15903.761443578123;17123;17574.648507030044;17898.194581243613;17928.938172109854;14321.785173222619;14482.927585362006;14528.636784080483;14956.476523321631;15014.849851501345;14065.507707230607;14235.928820356246;14258.287085645883;14716.632084197981;14944.92527537399;14410;14539.34572944199;14588.124712517283;14706.41174353014;14800.851991479947;12811.295378754257;13322;14093.929530352283;14628;14933.775993359892;9837.458939758095;10291.588336466457;10295.279330446796;15235.085894846345;15423.768643470581 11:14:15 INFO - PROCESS | 22419 | |3;mootools.html;1444.3283872999054;1461.9049761765484;1601.159391319557;1759.3578343904462;1780.9403404974037;6358.205224346957;6406.519511036679;7111.324424179707;7282.162551306601;7286.67209975551;6282.2147231596055;6334.968325158379;6383.106365108877;6392.7442902283965;6399.968000159993;2150.182930486421;2150.2474134053114;2167;2179.2917301876873;2182.159868450642;2136.5513242219076;2167.934961951144;2261.762514935933;2262.1403866530695;2262.7058482397347;2131.3073251193346;2132.786721327863;2174;2175.7824217578273;2213.0373287619855;2190.266260802633;2207.106122020576;2211.148707747521;2215.9556808863895;2217.556488702266;2174.4563859035243;2220.544788318407;2221.7556068832578;2224.1992882562263;2224.8442609017375;6957.478189135784;6984.371406573382;7025.964870175668;7028.472864535181;7036.859262814715;4304.461942257218;4382.868513944587;4390;4403.141387429452;4422.977885110586;2751.147144385247;2789.023841655425;2792.1623512946035;2805.4950108980374;2808.8033837631374;866.58403966096;913.5204017890594;916.0884919505135;1855.5917698106396;1948.133080779054;8824.470531768051;8890.688825891128;8930.419522731001;8985.966613839426;9000.414973026733;3732;3746.100935775394;3764.962350376516;3814.122751767109;3878.204967981613;7700.306972372513;7703.730369437043;7710.460267781314;7712.421568382281;7723.266289702469;4266.722663026893;4277.636400905958;4284.635805956466;4294.806733696929;4299.78501074945;3985.242803867256;3994.121293315524;4014.578469260744;4058.6753059755147;4064.6748260139116;3230.5154226866157;3242.3515296940705;3242.7567932405163;3259.5762550868235;3279.5900512435946;1011.8532812742111;1025.3386565665105;1032.7573020340214;1040;1041.1722680469045;847.8346722389075;853.0957185383513;1147.9196456248148;1155.2779512804498;1158.5597472960221;6768.255491895888;6875.724971001204;6876.656167191721;6884.0362349271145;6922.2731613180895;1063.7393838509615;1074.2265568790458;1074.8602681651334;1077.5474300793685;1081.9891801082047;5406.648567843077;5422.213779002022;5452;5463.480969307989;5464.726763661801;8113.18868113184;8127.512349259064;8240.13478584752;8301.2943899768;8343.749687509384;8258.710945117013;8313.12712165226;8348.707795227137;8357.122502137188;8397.244248017707;6643.1031810704935;6766.28953959837;6799.694013769392;6803.2856550062525;6804.081449004321;6817.488688348294;6872.484563657646;6879.036934829028;6890.276520965427;6897.620630865351;7637.732679356196;7690.077190737147;7713.344365728976;7756.92243077562;7790.376769858284;7572.507786993828;7864.21357864209;7878.172791857001;7959.323457506177;8030.919690803017;6282.905756413749;6416.32628573993;6467.094606755152;6578.901316480161;6581.3418658133805;6829.385355318045;6832.453403727789;6838.418734407631;6888.896666549906;6897.689439006573;6385.77649782274;6480.449161821298;6536.084948107174;6609.272979972296;6617.139771829631;6283.088952102011;6391.93608063932;6402;6558.573692709959;6566.244881838458;6185.195924529962;6262.718177682106;6298.307186209605;6316.305206427198;6370.490360771035;6035.094735789667;6104.694765261808;6114.938850611437;6117.541184411276;6168.013117901114;6142.907856382247;6160.784372546939;6162.722677479434;6182.1345011699295;6201.844953876189 11:14:15 INFO - PROCESS | 22419 | |4;prototype.html;321.06089687663587;323.55672728362134;328.1697305816286;329.85651241709866;331.0895038643731;6220.875582488359;6316.115743795872;6328.303886572479;6347.3969972852565;6385.840353991152;6129.969350153243;6315.210598675166;6350.587211831228;6356.427921487065;6357.71390287437;4742.976285118578;4757.714537127766;4760.476347601761;4772.475027746945;4808.807647694088;4784.401949756263;4799.832005879794;4805.567498925096;4811.59101476375;4817.566419022287;4681.648876334271;4748.19280722278;4758.857234282977;4783.928241076386;4789.736564488951;4742.976285118552;4746.454157771848;4756.500567440421;4757.00102978375;4759.809607615691;4151.481064866892;4160.646345060673;4162.83348666053;4182.728122672017;4183.4979802423595;5998.730057147439;6006.729697163594;6007.8197654070445;6055.939440605625;6057.485113765335;5453.23654688344;5565.749541270612;5574.247476590689;5577.135543990688;5598.888022239573;6674.799756007327;6679.599224046524;6684.565503242322;6686.531942764009;6703.664816759143;4629;4633.073385322915;4644.512326205733;4653.464851542082;4653.697509661861;6806.965965170142;6954.617496037716;6958.130233720785;7015.789526314168;7038.190608080085;4580.839670611579;4623.844038990253;4627.120847039052;4628.004978929546;4635.605973492224;4700.247960326331;4700.88247793801;4701.670883038223;4704.153252414599;4708.317293992352;5487.149491828773;5493.835184944458;5496.6701997880255;5499.670019798825;5500.312460942382;6627.237867645283;6768.560043597249;6780.72877084911;6782.287859774751;6792.966035169792;1611.7260065788844;1613.2014652746966;1660.825613310585;1664.2926756128597;1667.7831881855282;1046.8900765419673;1046.9790604187874;1054.862867827193;1060.7454210989306;1067.1836045425257;6210.627362358273;6256.812295631138;6294.370562943669;6295.96852015737;6298.811035668938;6791.796246112624;6791.830204244933;6798.490113241428;6822.044913711985;6827.453803695693;6126.938730612636;6270.216222972129;6271.717772700239;6287.654179020106;6287.9056814147825;3731.347014272546;3738.158914244273;3744.6817020553012;3751.3247615429486;3758.3986562149926;7074.045003924404;7105.111861017373;7116.71533138679;7117.3238542338395;7121.394681452135;6812.182538095461;6940.30596940312;6986.056882320821;6989.091418115612;6991.825204369931;6981.3716765490335;7058.541194822423;7070.434365250768;7090.07828982229;7115.71537138519;6777.08509351251;6814.727410903508;6823.010663453871;6829.590224586541;6835.043093966948;6652.368025037614;6709.194896612437;6722.529422940543;6751.45988320943;6899.275576064441;7278.563286202633;7330.706771729285;7331.973523706792;7335.816604584928;7335.963320183365;4522.118186953512;4567.109413664436;4568.132054909556;4591.380163677861;4596.655250856266;6826.11260536147;6981.965090174516;6989.266127056586;7010.123734533184;7015.894761578478;6771.796846094625;6803.659817009228;6837.794866154023;6846.691898864464;6854.6229957352825;6804.523683342119;6825.658717064226;6834.453243740588;6839.418649414855;6843.7604683835825;6506.869862602816;6683.832904177434;6684.364985326386;6691.665416729047;6695.698693558899;6826.044353790573;6833.829154271183;6835.521513494008;6853.623050732258;6873;6620;6657.966710166418;6670.232923213893;6678;6678.165229346332 11:14:15 INFO - PROCESS | 22419 | |5;yui.html;724.3625609463671;825.9215374539418;842.2461896602541;842.6629348260695;874.9256313213378;13555.864441355583;13654.863451365509;13689.315534223286;13741.862581374184;13787.58637240882;13009.219446833173;14529.782053269182;14704.411823527045;14704.779428308584;14714.852851471482;817.0685418622775;838.7357982235607;841.8232171244047;843.1863251961855;846.2764336492303;836.5273620404482;842.3387640702019;843.7595285343648;848.7114381110421;851.4040171879678;809.4212637963855;853.4409961475212;875.6672464463495;875.7854325690215;877.1360210192955;868.7741187291286;869.5043825019741;873.8776571280026;876.8334016536837;876.8597024476117;637.2575949019387;638.0970926139507;638.996805015972;640.8846407646622;643.2409756487343;13579.59261222165;13582.728345433035;13647.522336718266;13669.658258543615;13672.863271367258;11481.65555033342;11602.76794464106;11655.475503602274;11813.527458901634;12362.75274494505;9911;10291.79416411675;10399.79200415995;10545.947270263676;10587.629432969808;3622.2755448910325;3664.468652045465;3700.8704695335805;3712.795796231206;3770.7926064066464;45138;45276;45447;45463.54536454626;45819.54180458186;9619.326647134634;9807.705768826947;9881.209503239867;10121.797564048826;10161.949190254001;16973.66052678964;17000;17092.0599367036;17171.31314747421;17184.656306873792;7246.927530724731;7298.96350518244;7383.483156179016;7394.55632662042;7722.768316950501;4078.836846526165;4093.6111069448357;4121.216968775923;4137.668986481074;4140.213359461693;2946.8821247150304;2947.498925182724;2973.2566858285427;2978.5532170174215;2986.746126579265;514.3056873221196;528.6590149353722;540.2517513244106;540.5837505121035;543.2774410034644;504.3065784546249;527.6728428374432;530.8885134121878;544.0940833512237;565.2990292037844;8062.596870156469;8291.502509849308;8325;8362;8542.316614670812;623.566621198272;648.9843395086768;649.9805005849737;661.6790856434625;723.5405517496323;3939.7242193046213;4045.2516284487465;4145.647619952278;4225.302825033835;4416.6245869101485;52896.735516322944;53859.73070134624;58428;59660;60940.39059609436;47676.523234767206;47825.5217447828;48295.5170448298;48302.516974830505;48613.75693121582;43857.12285754267;43906.34140487895;44469.55530444719;44702.776486117364;44712;8421.789455263668;8503.957480212559;8509.191626795444;8743.300535957236;8883.067277935723;33280.50079248765;33357.83321083379;33418.997430077136;34203.82898085494;36506.81746591356;42284.15431691287;42759.358609620256;43512.56487435085;44202.77898610615;44316.33525497056;10744.51649675782;10779.245452818228;10855.077318428022;10933.945330273298;11217;12215.26708397499;12250.816237756262;12464.127511074137;12514.31171285588;12564.497420103093;10988.340699558052;11144.275622084539;11517.769644607228;11531.769364612828;11744.17790754639;11395.772084558097;11472.369019703663;11615.6515304541;11742.955121514971;11819.40902954866;11143.554257829921;11159.553617855196;11383.487743051417;11405.372704501333;11483.106669175906;9831.31180817336;10005.699829005142;10010.698380315154;10063.698089057047;10480.528376223241;8923.286137108886;9122.680706175252;9417.387869788441;9711.003321401342;10108.949455252676 11:14:15 INFO - PROCESS | 22419 | __end_tp_report 11:14:15 INFO - PROCESS | 22419 | __start_cc_report 11:14:15 INFO - PROCESS | 22419 | _x_x_mozilla_cycle_collect,327 11:14:15 INFO - PROCESS | 22419 | __end_cc_report 11:14:15 INFO - PROCESS | 22419 | __startTimestamp1451502855136__endTimestamp 11:14:15 INFO - PROCESS | 22419 | 11:14:15 INFO - PROCESS | 22419 | ------- Summary: start ------- 11:14:15 INFO - PROCESS | 22419 | Number of tests: 6 11:14:15 INFO - PROCESS | 22419 | 11:14:15 INFO - PROCESS | 22419 | [#0] dojo.html Cycles:165 Average:5372.79 Median:5602.50 stddev:608.19 (10.9%) stddev-sans-first:582.66 11:14:15 INFO - PROCESS | 22419 | Values: 3071.9 3102.2 3124.0 3135.0 3152.2 5239.4 5272.7 5331.4 5331.6 5361.3 5303.7 5344.3 5404.3 5425.7 5473.0 4645.2 4899.0 5102.4 5105.5 5129.4 4824.0 5005.6 5028.4 5085.6 5096.2 4859.2 4881.8 4913.0 4943.4 4969.5 4892.1 4893.4 4902.1 4950.7 4957.1 4779.9 4865.7 4898.3 4899.8 4960.7 5170.9 5224.1 5255.0 5279.7 5296.3 5700.2 5702.7 5712.4 5729.1 5733.1 5635.6 5760.0 5770.2 5777.5 5825.4 5428.5 5438.4 5444.3 5450.1 5458.2 5942.0 5979.8 5997.7 6003.9 6007.1 5611.4 5634.4 5699.3 5701.9 5753.3 5740.6 5775.2 5781.7 5782.4 5799.3 5725.4 5764.5 5764.8 5764.8 5773.2 5667.5 5706.1 5755.3 5758.5 5831.2 4477.7 4479.8 4500.8 4515.2 4541.0 3962.4 3969.3 3982.5 3989.7 4057.0 5230.7 5267.3 5316.4 5322.7 5334.1 5784.3 5800.4 5836.0 5839.4 5839.5 5406.1 5412.5 5419.4 5423.8 5430.6 4861.9 4935.9 5017.3 5026.5 5101.5 6025.0 6028.2 6037.6 6044.2 6044.8 5799.3 5845.4 5847.4 5848.8 5867.1 5784.3 5905.5 5909.4 5976.5 6100.2 5756.7 5759.0 5765.2 5768.5 5784.2 5855.6 5880.4 5880.7 5882.0 5896.2 5577.2 5639.9 5666.3 5701.6 5747.5 5643.0 5689.0 5698.3 5706.8 5712.1 5453.2 5602.5 5627.9 5633.1 5637.1 5633.5 5667.9 5693.3 5725.7 5777.2 5529.6 5565.4 5565.5 5579.8 5588.9 11:14:15 INFO - PROCESS | 22419 | 11:14:15 INFO - PROCESS | 22419 | [#1] ext.html Cycles:180 Average:43199.38 Median:18566.18 stddev:72379.74 (389.8%) stddev-sans-first:72511.82 11:14:15 INFO - PROCESS | 22419 | Values: 511.9 546.1 564.3 596.6 605.2 33872.2 34563.5 34613.3 34636.5 34834.0 35159.0 35512.8 35599.6 35657.3 35703.5 8315.5 8414.4 8457.5 8473.6 8481.2 8228.7 8406.1 8427.7 8432.5 8434.1 8422.1 8434.2 8469.6 8480.0 8503.5 8324.3 8454.7 8471.4 8479.1 8480.2 8373.7 8405.6 8460.5 8468.5 8514.4 35066.8 35323.3 35504.5 35539.5 35729.0 3031.7 3046.2 3126.5 3296.5 3636.3 28027.4 28152.0 28245.6 28644.4 29065.6 3733.2 3766.5 3824.7 3830.3 3900.8 257915.0 258546.0 259342.0 259361.0 259423.0 49302.3 49953.5 50120.5 50257.2 56258.0 55145.0 55160.7 55172.4 55366.1 55565.4 15340.0 15384.6 15398.4 15517.1 15522.8 11657.8 11791.3 11815.6 11820.0 11875.2 18787.3 18913.0 18931.7 18975.0 19098.4 7670.3 8025.7 8044.1 8052.5 8112.6 949.0 973.2 983.6 989.5 1079.7 27382.6 27572.2 27627.7 27872.7 27899.7 996.5 1054.6 1060.1 1134.2 1168.8 14724.4 14944.6 15181.4 15225.5 15316.3 305612.0 309264.0 309483.0 310644.0 310720.0 48863.3 49526.5 49698.0 49922.5 49982.8 1356.7 1373.3 1389.0 1400.2 1400.8 27262.6 28372.0 28408.9 28430.4 28619.3 43464.3 43968.3 44056.0 44092.1 44205.6 234777.0 235162.0 236081.0 293518.0 294365.0 29307.6 29532.4 30564.5 30672.2 30720.5 35694.6 36054.0 36149.0 36360.5 36771.0 31016.7 31483.4 33835.8 35119.0 35264.3 31333.5 31419.8 31515.8 31692.4 31693.2 31449.0 31792.0 31940.0 32058.7 32082.8 28860.0 28990.7 29180.4 29318.0 29334.7 23551.6 23854.8 23856.2 23867.0 24095.9 11:14:15 INFO - PROCESS | 22419 | 11:14:15 INFO - PROCESS | 22419 | [#2] jquery.html Cycles:180 Average:29550.86 Median:17468.99 stddev:92849.85 (531.5%) stddev-sans-first:93084.41 11:14:15 INFO - PROCESS | 22419 | Values: 342.4 343.8 345.9 346.2 347.7 16641.8 16950.3 17441.9 17749.1 18190.3 11147.9 12304.0 16186.6 16208.0 16237.2 4835.9 5310.9 5313.9 5314.5 5335.1 5313.9 5316.4 5327.2 5343.0 5345.6 5048.8 5175.5 5265.3 5272.3 5372.4 5156.6 5162.4 5170.3 5174.2 5184.7 5192.2 5246.8 5249.6 5303.2 5313.6 16269.0 19467.4 19524.2 20326.7 20395.3 2065.9 2089.7 2100.7 2117.4 2157.8 6463.1 6468.3 9449.2 9706.5 10164.0 1738.0 1741.1 1837.4 1851.0 1870.0 56576.0 56758.7 57289.4 60256.0 65795.0 10002.4 10339.4 10384.2 10498.2 10529.6 13534.9 13648.2 13669.2 13678.2 13679.4 7743.3 7769.4 7774.4 7810.0 7968.0 7441.1 7823.9 7888.5 7891.6 7953.9 4450.9 4464.6 4561.6 4574.2 4580.3 1821.6 1825.7 1835.8 1865.6 1868.5 277.6 421.5 421.8 424.9 442.3 10594.0 11077.3 11223.4 16217.2 16701.0 921.4 949.8 963.1 972.1 1009.2 9385.2 9658.5 9677.5 9756.9 9777.0 553446.0 554626.0 559074.0 585498.0 589337.0 76774.0 78415.6 78966.0 79070.6 79602.0 1148.8 1163.0 1218.5 1226.7 1229.2 15135.0 15432.2 15539.8 15546.7 15707.4 34591.8 35032.5 35513.5 36143.5 36191.6 46370.8 47742.5 47802.5 49745.0 50201.0 9670.6 9730.0 9730.9 9776.3 9830.3 15903.8 17123.0 17574.6 17898.2 17928.9 14321.8 14482.9 14528.6 14956.5 15014.8 14065.5 14235.9 14258.3 14716.6 14944.9 14410.0 14539.3 14588.1 14706.4 14800.9 12811.3 13322.0 14093.9 14628.0 14933.8 9837.5 10291.6 10295.3 15235.1 15423.8 11:14:15 INFO - PROCESS | 22419 | 11:14:15 INFO - PROCESS | 22419 | [#3] mootools.html Cycles:180 Average:4982.19 Median:6232.28 stddev:2462.64 (39.5%) stddev-sans-first:2455.19 11:14:15 INFO - PROCESS | 22419 | Values: 1444.3 1461.9 1601.2 1759.4 1780.9 6358.2 6406.5 7111.3 7282.2 7286.7 6282.2 6335.0 6383.1 6392.7 6400.0 2150.2 2150.2 2167.0 2179.3 2182.2 2136.6 2167.9 2261.8 2262.1 2262.7 2131.3 2132.8 2174.0 2175.8 2213.0 2190.3 2207.1 2211.1 2216.0 2217.6 2174.5 2220.5 2221.8 2224.2 2224.8 6957.5 6984.4 7026.0 7028.5 7036.9 4304.5 4382.9 4390.0 4403.1 4423.0 2751.1 2789.0 2792.2 2805.5 2808.8 866.6 913.5 916.1 1855.6 1948.1 8824.5 8890.7 8930.4 8986.0 9000.4 3732.0 3746.1 3765.0 3814.1 3878.2 7700.3 7703.7 7710.5 7712.4 7723.3 4266.7 4277.6 4284.6 4294.8 4299.8 3985.2 3994.1 4014.6 4058.7 4064.7 3230.5 3242.4 3242.8 3259.6 3279.6 1011.9 1025.3 1032.8 1040.0 1041.2 847.8 853.1 1147.9 1155.3 1158.6 6768.3 6875.7 6876.7 6884.0 6922.3 1063.7 1074.2 1074.9 1077.5 1082.0 5406.6 5422.2 5452.0 5463.5 5464.7 8113.2 8127.5 8240.1 8301.3 8343.7 8258.7 8313.1 8348.7 8357.1 8397.2 6643.1 6766.3 6799.7 6803.3 6804.1 6817.5 6872.5 6879.0 6890.3 6897.6 7637.7 7690.1 7713.3 7756.9 7790.4 7572.5 7864.2 7878.2 7959.3 8030.9 6282.9 6416.3 6467.1 6578.9 6581.3 6829.4 6832.5 6838.4 6888.9 6897.7 6385.8 6480.4 6536.1 6609.3 6617.1 6283.1 6391.9 6402.0 6558.6 6566.2 6185.2 6262.7 6298.3 6316.3 6370.5 6035.1 6104.7 6114.9 6117.5 6168.0 6142.9 6160.8 6162.7 6182.1 6201.8 11:14:15 INFO - PROCESS | 22419 | 11:14:15 INFO - PROCESS | 22419 | [#4] prototype.html Cycles:180 Average:5576.06 Median:6297.39 stddev:1709.77 (27.2%) stddev-sans-first:1668.45 11:14:15 INFO - PROCESS | 22419 | Values: 321.1 323.6 328.2 329.9 331.1 6220.9 6316.1 6328.3 6347.4 6385.8 6130.0 6315.2 6350.6 6356.4 6357.7 4743.0 4757.7 4760.5 4772.5 4808.8 4784.4 4799.8 4805.6 4811.6 4817.6 4681.6 4748.2 4758.9 4783.9 4789.7 4743.0 4746.5 4756.5 4757.0 4759.8 4151.5 4160.6 4162.8 4182.7 4183.5 5998.7 6006.7 6007.8 6055.9 6057.5 5453.2 5565.7 5574.2 5577.1 5598.9 6674.8 6679.6 6684.6 6686.5 6703.7 4629.0 4633.1 4644.5 4653.5 4653.7 6807.0 6954.6 6958.1 7015.8 7038.2 4580.8 4623.8 4627.1 4628.0 4635.6 4700.2 4700.9 4701.7 4704.2 4708.3 5487.1 5493.8 5496.7 5499.7 5500.3 6627.2 6768.6 6780.7 6782.3 6793.0 1611.7 1613.2 1660.8 1664.3 1667.8 1046.9 1047.0 1054.9 1060.7 1067.2 6210.6 6256.8 6294.4 6296.0 6298.8 6791.8 6791.8 6798.5 6822.0 6827.5 6126.9 6270.2 6271.7 6287.7 6287.9 3731.3 3738.2 3744.7 3751.3 3758.4 7074.0 7105.1 7116.7 7117.3 7121.4 6812.2 6940.3 6986.1 6989.1 6991.8 6981.4 7058.5 7070.4 7090.1 7115.7 6777.1 6814.7 6823.0 6829.6 6835.0 6652.4 6709.2 6722.5 6751.5 6899.3 7278.6 7330.7 7332.0 7335.8 7336.0 4522.1 4567.1 4568.1 4591.4 4596.7 6826.1 6982.0 6989.3 7010.1 7015.9 6771.8 6803.7 6837.8 6846.7 6854.6 6804.5 6825.7 6834.5 6839.4 6843.8 6506.9 6683.8 6684.4 6691.7 6695.7 6826.0 6833.8 6835.5 6853.6 6873.0 6620.0 6658.0 6670.2 6678.0 6678.2 11:14:15 INFO - PROCESS | 22419 | 11:14:15 INFO - PROCESS | 22419 | [#5] yui.html Cycles:180 Average:13512.05 Median:24309.70 stddev:15351.31 (63.1%) stddev-sans-first:15364.33 11:14:15 INFO - PROCESS | 22419 | Values: 724.4 825.9 842.2 842.7 874.9 13555.9 13654.9 13689.3 13741.9 13787.6 13009.2 14529.8 14704.4 14704.8 14714.9 817.1 838.7 841.8 843.2 846.3 836.5 842.3 843.8 848.7 851.4 809.4 853.4 875.7 875.8 877.1 868.8 869.5 873.9 876.8 876.9 637.3 638.1 639.0 640.9 643.2 13579.6 13582.7 13647.5 13669.7 13672.9 11481.7 11602.8 11655.5 11813.5 12362.8 9911.0 10291.8 10399.8 10545.9 10587.6 3622.3 3664.5 3700.9 3712.8 3770.8 45138.0 45276.0 45447.0 45463.5 45819.5 9619.3 9807.7 9881.2 10121.8 10161.9 16973.7 17000.0 17092.1 17171.3 17184.7 7246.9 7299.0 7383.5 7394.6 7722.8 4078.8 4093.6 4121.2 4137.7 4140.2 2946.9 2947.5 2973.3 2978.6 2986.7 514.3 528.7 540.3 540.6 543.3 504.3 527.7 530.9 544.1 565.3 8062.6 8291.5 8325.0 8362.0 8542.3 623.6 649.0 650.0 661.7 723.5 3939.7 4045.3 4145.6 4225.3 4416.6 52896.7 53859.7 58428.0 59660.0 60940.4 47676.5 47825.5 48295.5 48302.5 48613.8 43857.1 43906.3 44469.6 44702.8 44712.0 8421.8 8504.0 8509.2 8743.3 8883.1 33280.5 33357.8 33419.0 34203.8 36506.8 42284.2 42759.4 43512.6 44202.8 44316.3 10744.5 10779.2 10855.1 10933.9 11217.0 12215.3 12250.8 12464.1 12514.3 12564.5 10988.3 11144.3 11517.8 11531.8 11744.2 11395.8 11472.4 11615.7 11743.0 11819.4 11143.6 11159.6 11383.5 11405.4 11483.1 9831.3 10005.7 10010.7 10063.7 10480.5 8923.3 9122.7 9417.4 9711.0 10108.9 11:14:15 INFO - PROCESS | 22419 | -------- Summary: end -------- 11:14:15 INFO - PROCESS | 22419 | 11:14:16 INFO - TEST-INFO | 22419: exit 0 11:14:16 INFO - TEST-OK | dromaeo_css | took 1181389ms 11:14:16 INFO - TEST-START | kraken 11:14:16 INFO - operating with platform_type : linux_ 11:14:16 INFO - Initialising browser for kraken test... 11:14:16 INFO - TEST-INFO | started process 22663 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo7hCc5/profile http://localhost:35259/getInfo.html) 11:14:31 INFO - PROCESS | 22663 | __metrics Screen width/height:1600/1200 11:14:31 INFO - PROCESS | 22663 | colorDepth:24 11:14:31 INFO - PROCESS | 22663 | Browser inner width/height: 1024/697 11:14:31 INFO - PROCESS | 22663 | __metrics 11:14:32 INFO - PROCESS | 22663 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:14:33 INFO - PROCESS | 22663 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 11:14:36 INFO - TEST-INFO | 22663: exit 0 11:14:36 INFO - Browser initialized. 11:14:36 INFO - Running cycle 1/1 for kraken test... 11:14:36 INFO - TEST-INFO | started process 22783 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo7hCc5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:48 INFO - PROCESS | 22783 | RSS: Main: 150016000 11:14:48 INFO - PROCESS | 22783 | 11:14:50 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35259/tests/kraken/driver.html?testName=audio-beat-detection) 11:14:51 INFO - PROCESS | 22783 | RSS: Main: 152330240 11:14:51 INFO - PROCESS | 22783 | 11:14:53 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35259/tests/kraken/driver.html?testName=audio-dft) 11:14:54 INFO - PROCESS | 22783 | RSS: Main: 152481792 11:14:54 INFO - PROCESS | 22783 | 11:14:57 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35259/tests/kraken/driver.html?testName=audio-fft) 11:14:57 INFO - PROCESS | 22783 | RSS: Main: 146485248 11:14:57 INFO - PROCESS | 22783 | 11:15:00 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35259/tests/kraken/driver.html?testName=audio-oscillator) 11:15:00 INFO - PROCESS | 22783 | RSS: Main: 146305024 11:15:00 INFO - PROCESS | 22783 | 11:15:02 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35259/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:15:03 INFO - PROCESS | 22783 | RSS: Main: 146472960 11:15:03 INFO - PROCESS | 22783 | 11:15:06 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35259/tests/kraken/driver.html?testName=imaging-darkroom) 11:15:07 INFO - PROCESS | 22783 | RSS: Main: 147091456 11:15:07 INFO - PROCESS | 22783 | 11:15:10 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35259/tests/kraken/driver.html?testName=imaging-desaturate) 11:15:11 INFO - PROCESS | 22783 | RSS: Main: 148758528 11:15:11 INFO - PROCESS | 22783 | 11:15:13 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35259/tests/kraken/driver.html?testName=json-parse-financial) 11:15:14 INFO - PROCESS | 22783 | RSS: Main: 149180416 11:15:14 INFO - PROCESS | 22783 | 11:15:16 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35259/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:15:16 INFO - PROCESS | 22783 | RSS: Main: 148672512 11:15:16 INFO - PROCESS | 22783 | 11:15:18 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:15:19 INFO - PROCESS | 22783 | RSS: Main: 148635648 11:15:19 INFO - PROCESS | 22783 | 11:15:21 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:15:21 INFO - PROCESS | 22783 | RSS: Main: 148422656 11:15:21 INFO - PROCESS | 22783 | 11:15:24 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:15:24 INFO - PROCESS | 22783 | RSS: Main: 148799488 11:15:24 INFO - PROCESS | 22783 | 11:15:27 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:15:27 INFO - PROCESS | 22783 | RSS: Main: 148406272 11:15:27 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35259/tests/kraken/driver.html?testName=ai-astar) 11:15:29 INFO - PROCESS | 22783 | RSS: Main: 150061056 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | __start_tp_report 11:15:29 INFO - PROCESS | 22783 | _x_x_mozilla_page_load 11:15:29 INFO - PROCESS | 22783 | _x_x_mozilla_page_load_details 11:15:29 INFO - PROCESS | 22783 | |i|pagename|runs| 11:15:29 INFO - PROCESS | 22783 | |0;ai-astar;113;105;112;111;112;123;110;113;111;112 11:15:29 INFO - PROCESS | 22783 | |1;audio-beat-detection;161;125;151;163;135;156;152;128;169;131 11:15:29 INFO - PROCESS | 22783 | |2;audio-dft;162;161;162;165;161;162;161;163;169;162 11:15:29 INFO - PROCESS | 22783 | |3;audio-fft;72;74;75;71;75;74;135;74;73;75 11:15:29 INFO - PROCESS | 22783 | |4;audio-oscillator;96;96;137;95;97;97;151;96;97;134 11:15:29 INFO - PROCESS | 22783 | |5;imaging-gaussian-blur;109;110;110;110;109;109;110;109;109;110 11:15:29 INFO - PROCESS | 22783 | |6;imaging-darkroom;146;146;147;145;147;145;148;147;147;146 11:15:29 INFO - PROCESS | 22783 | |7;imaging-desaturate;97;97;96;96;97;96;97;96;97;97 11:15:29 INFO - PROCESS | 22783 | |8;json-parse-financial;58;58;60;63;58;58;59;57;55;55 11:15:29 INFO - PROCESS | 22783 | |9;json-stringify-tinderbox;68;68;72;68;69;67;68;68;69;68 11:15:29 INFO - PROCESS | 22783 | |10;stanford-crypto-aes;87;88;96;88;87;87;86;86;87;86 11:15:29 INFO - PROCESS | 22783 | |11;stanford-crypto-ccm;121;125;119;124;124;117;118;119;120;119 11:15:29 INFO - PROCESS | 22783 | |12;stanford-crypto-pbkdf2;143;144;151;154;145;151;153;152;151;145 11:15:29 INFO - PROCESS | 22783 | |13;stanford-crypto-sha256-iterative;69;68;67;70;71;67;75;69;67;68 11:15:29 INFO - PROCESS | 22783 | __end_tp_report 11:15:29 INFO - PROCESS | 22783 | __start_cc_report 11:15:29 INFO - PROCESS | 22783 | _x_x_mozilla_cycle_collect,747 11:15:29 INFO - PROCESS | 22783 | __end_cc_report 11:15:29 INFO - PROCESS | 22783 | __startTimestamp1451502929791__endTimestamp 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | ------- Summary: start ------- 11:15:29 INFO - PROCESS | 22783 | Number of tests: 14 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.44 (4.0%) stddev-sans-first:4.70 11:15:29 INFO - PROCESS | 22783 | Values: 113.0 105.0 112.0 111.0 112.0 123.0 110.0 113.0 111.0 112.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:154.00 stddev:16.00 (10.4%) stddev-sans-first:16.16 11:15:29 INFO - PROCESS | 22783 | Values: 161.0 125.0 151.0 163.0 135.0 156.0 152.0 128.0 169.0 131.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.00 stddev:2.49 (1.5%) stddev-sans-first:2.62 11:15:29 INFO - PROCESS | 22783 | Values: 162.0 161.0 162.0 165.0 161.0 162.0 161.0 163.0 169.0 162.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#3] audio-fft Cycles:10 Average:79.80 Median:74.00 stddev:19.44 (26.3%) stddev-sans-first:20.41 11:15:29 INFO - PROCESS | 22783 | Values: 72.0 74.0 75.0 71.0 75.0 74.0 135.0 74.0 73.0 75.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:96.00 stddev:21.87 (22.8%) stddev-sans-first:22.64 11:15:29 INFO - PROCESS | 22783 | Values: 96.0 96.0 137.0 95.0 97.0 97.0 151.0 96.0 97.0 134.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:15:29 INFO - PROCESS | 22783 | Values: 109.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 110.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 11:15:29 INFO - PROCESS | 22783 | Values: 146.0 146.0 147.0 145.0 147.0 145.0 148.0 147.0 147.0 146.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:15:29 INFO - PROCESS | 22783 | Values: 97.0 97.0 96.0 96.0 97.0 96.0 97.0 96.0 97.0 97.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:2.33 (4.0%) stddev-sans-first:2.47 11:15:29 INFO - PROCESS | 22783 | Values: 58.0 58.0 60.0 63.0 58.0 58.0 59.0 57.0 55.0 55.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 11:15:29 INFO - PROCESS | 22783 | Values: 68.0 68.0 72.0 68.0 69.0 67.0 68.0 68.0 69.0 68.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.00 stddev:2.97 (3.4%) stddev-sans-first:3.14 11:15:29 INFO - PROCESS | 22783 | Values: 87.0 88.0 96.0 88.0 87.0 87.0 86.0 86.0 87.0 86.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:120.50 stddev:2.80 (2.3%) stddev-sans-first:2.96 11:15:29 INFO - PROCESS | 22783 | Values: 121.0 125.0 119.0 124.0 124.0 117.0 118.0 119.0 120.0 119.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:151.00 stddev:4.15 (2.7%) stddev-sans-first:3.81 11:15:29 INFO - PROCESS | 22783 | Values: 143.0 144.0 151.0 154.0 145.0 151.0 153.0 152.0 151.0 145.0 11:15:29 INFO - PROCESS | 22783 | 11:15:29 INFO - PROCESS | 22783 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:2.47 (3.6%) stddev-sans-first:2.62 11:15:29 INFO - PROCESS | 22783 | Values: 69.0 68.0 67.0 70.0 71.0 67.0 75.0 69.0 67.0 68.0 11:15:29 INFO - PROCESS | 22783 | -------- Summary: end -------- 11:15:29 INFO - PROCESS | 22783 | 11:15:32 INFO - TEST-INFO | 22783: exit 0 11:15:32 INFO - TEST-OK | kraken | took 75822ms 11:15:32 INFO - TEST-START | v8_7 11:15:32 INFO - operating with platform_type : linux_ 11:15:32 INFO - Initialising browser for v8_7 test... 11:15:32 INFO - TEST-INFO | started process 23071 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgBODli/profile http://localhost:35259/getInfo.html) 11:15:48 INFO - PROCESS | 23071 | __metrics Screen width/height:1600/1200 11:15:48 INFO - PROCESS | 23071 | colorDepth:24 11:15:48 INFO - PROCESS | 23071 | Browser inner width/height: 1024/697 11:15:48 INFO - PROCESS | 23071 | __metrics 11:15:48 INFO - PROCESS | 23071 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:15:51 INFO - TEST-INFO | 23071: exit 0 11:15:51 INFO - Browser initialized. 11:15:51 INFO - Running cycle 1/1 for v8_7 test... 11:15:51 INFO - TEST-INFO | started process 23191 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgBODli/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:03 INFO - PROCESS | 23191 | RSS: Main: 149876736 11:16:03 INFO - PROCESS | 23191 | 11:16:24 INFO - PROCESS | 23191 | Cycle 1(1): loaded http://localhost:35259/tests/v8_7/run.html (next: http://localhost:35259/tests/v8_7/run.html) 11:16:25 INFO - PROCESS | 23191 | RSS: Main: 145838080 11:16:25 INFO - PROCESS | 23191 | 11:16:25 INFO - PROCESS | 23191 | __start_tp_report 11:16:25 INFO - PROCESS | 23191 | _x_x_mozilla_page_load 11:16:25 INFO - PROCESS | 23191 | _x_x_mozilla_page_load_details 11:16:25 INFO - PROCESS | 23191 | |i|pagename|runs| 11:16:25 INFO - PROCESS | 23191 | |0;Richards;166.03021749958492 11:16:25 INFO - PROCESS | 23191 | |1;DeltaBlue;190.07793195210036 11:16:25 INFO - PROCESS | 23191 | |2;Encrypt;279.56388034665923 11:16:25 INFO - PROCESS | 23191 | |3;Decrypt;5240.837696335078 11:16:25 INFO - PROCESS | 23191 | |4;RayTrace;1066.0980810234541 11:16:25 INFO - PROCESS | 23191 | |5;Earley;704.9295774647887 11:16:25 INFO - PROCESS | 23191 | |6;Boyer;12268.292682926829 11:16:25 INFO - PROCESS | 23191 | |7;RegExp;25450 11:16:25 INFO - PROCESS | 23191 | |8;Splay;566.6666666666666 11:16:25 INFO - PROCESS | 23191 | |9;NavierStokes;4835.748792270531 11:16:25 INFO - PROCESS | 23191 | __end_tp_report 11:16:25 INFO - PROCESS | 23191 | __startTimestamp1451502985062__endTimestamp 11:16:25 INFO - PROCESS | 23191 | 11:16:25 INFO - PROCESS | 23191 | ------- Summary: start ------- 11:16:25 INFO - PROCESS | 23191 | Number of tests: 10 11:16:25 INFO - PROCESS | 23191 | 11:16:25 INFO - PROCESS | 23191 | [#0] Richards Cycles:1 Average:166.03 Median:166.03 stddev:0.00 (0.0%) 11:16:25 INFO - PROCESS | 23191 | Values: 166.0 11:16:25 INFO - PROCESS | 23191 | 11:16:25 INFO - PROCESS | 23191 | [#1] DeltaBlue Cycles:1 Average:190.08 Median:190.08 stddev:0.00 (0.0%) 11:16:25 INFO - PROCESS | 23191 | Values: 190.1 11:16:25 INFO - PROCESS | 23191 | 11:16:25 INFO - PROCESS | 23191 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 11:16:25 INFO - PROCESS | 23191 | Values: 279.6 11:16:25 INFO - PROCESS | 23191 | 11:16:25 INFO - PROCESS | 23191 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 11:16:25 INFO - PROCESS | 23191 | Values: 5240.8 11:16:25 INFO - PROCESS | 23191 | 11:16:25 INFO - PROCESS | 23191 | [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 11:16:25 INFO - PROCESS | 23191 | Values: 1066.1 11:16:25 INFO - PROCESS | 23191 | 11:16:25 INFO - PROCESS | 23191 | [#5] Earley Cycles:1 Average:704.93 Median:704.93 stddev:0.00 (0.0%) 11:16:25 INFO - PROCESS | 23191 | Values: 704.9 11:16:25 INFO - PROCESS | 23191 | 11:16:25 INFO - PROCESS | 23191 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 11:16:25 INFO - PROCESS | 23191 | Values: 12268.3 11:16:25 INFO - PROCESS | 23191 | 11:16:25 INFO - PROCESS | 23191 | [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 11:16:25 INFO - PROCESS | 23191 | Values: 25450.0 11:16:25 INFO - PROCESS | 23191 | 11:16:25 INFO - PROCESS | 23191 | [#8] Splay Cycles:1 Average:566.67 Median:566.67 stddev:0.00 (0.0%) 11:16:25 INFO - PROCESS | 23191 | Values: 566.7 11:16:25 INFO - PROCESS | 23191 | 11:16:25 INFO - PROCESS | 23191 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:16:25 INFO - PROCESS | 23191 | Values: 4835.7 11:16:25 INFO - PROCESS | 23191 | -------- Summary: end -------- 11:16:25 INFO - PROCESS | 23191 | 11:16:26 INFO - TEST-INFO | 23191: exit 0 11:16:26 INFO - TEST-OK | v8_7 | took 54134ms 11:16:26 INFO - SUITE-END | took 1311s 11:16:26 INFO - Completed test suite (00:21:51) 11:16:26 INFO - Working with test: dromaeo_css 11:16:26 INFO - Generating results file: dromaeo_css 11:16:26 INFO - Working with test: kraken 11:16:26 INFO - Generating results file: kraken 11:16:26 INFO - javascript benchmark 11:16:26 INFO - Working with test: v8_7 11:16:26 INFO - Generating results file: v8_7 11:16:26 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:16:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:16:26 INFO - process_Request line: dromaeo_css 6874.53 graph.html#tests=[[72,64,43]] 11:16:26 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:16:26 INFO - process_Request line: kraken 1517.00 graph.html#tests=[[232,64,43]] 11:16:26 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:16:27 INFO - process_Request line: v8_7 21485.90 graph.html#tests=[[230,64,43]] 11:16:27 INFO - RETURN: dromaeo_css: 6874.53 11:16:27 INFO - RETURN: kraken: 1517.00 11:16:27 INFO - RETURN: v8_7: 21485.90 11:16:27 INFO - javascript benchmark 11:16:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3071.8941181174773, 3102.16241614764, 3123.968760312396, 3135.043811637451, 3152.1961899715575, 5239.397469291032, 5272.736363181844, 5331.386890507588, 5331.626786124973, 5361.3030306060255, 5303.65526240794, 5344.251804747339, 5404.297441332631, 5425.674459532431, 5473.0, 4645.187092258858, 4898.999999999991, 5102.413222479426, 5105.5149760772665, 5129.3844738631415, 4823.951760482403, 5005.624578156653, 5028.371453568304, 5085.618578606601, 5096.210087436453, 4859.246816743411, 4881.8291359802415, 4913.041956818422, 4943.406791185045, 4969.527894849984, 4892.143874821892, 4893.363862697862, 4902.068606964701, 4950.6782059166035, 4957.107720610289, 4779.928301075487, 4865.6594038417325, 4898.289747986522, 4899.755012249373, 4960.70235785854, 5170.896582068375, 5224.111900976843, 5255.02781985334, 5279.6832190068335, 5296.3379577552805, 5700.173474846166, 5702.657840529581, 5712.400197979236, 5729.1119876419225, 5733.111367737965, 5635.633683810539, 5759.971200143972, 5770.249867517238, 5777.508911742507, 5825.417458254141, 5428.5385742211565, 5438.428964958662, 5444.292242008553, 5450.073487507133, 5458.235846981426, 5941.970290148522, 5979.790707325223, 5997.70011499432, 6003.939960600338, 6007.068904319837, 5611.410801865827, 5634.352049514358, 5699.2590963174525, 5701.942980570141, 5753.280839895013, 5740.598158128974, 5775.16260142277, 5781.653100813965, 5782.421757824184, 5799.2750906136735, 5725.370209276976, 5764.538836893123, 5764.769409223668, 5764.798232061858, 5773.16289138081, 5667.489925906688, 5706.058500347479, 5755.3381361143165, 5758.481736643722, 5831.241938547962, 4477.731336119843, 4479.820807167742, 4500.752458614742, 4515.164694531522, 4540.977295113504, 3962.40563915415, 3969.2656858481273, 3982.522097348337, 3989.7207195496617, 4057.046594050396, 5230.712310822942, 5267.288915996368, 5316.362036555638, 5322.733863306819, 5334.0665383557725, 5784.305883294031, 5800.419958004166, 5836.037053886146, 5839.416058394211, 5839.532837373, 5406.053940560386, 5412.512873841373, 5419.376771671229, 5423.783048678088, 5430.647007944471, 4861.927071093936, 4935.851924442272, 5017.347744793226, 5026.472220416877, 5101.464346243665, 6025.0359942409, 6028.216331876915, 6037.607555508878, 6044.24446944132, 6044.788432404845, 5799.2750906136735, 5845.444682755132, 5847.356790753099, 5848.824535263949, 5867.149263356704, 5784.305883293863, 5905.52755779528, 5909.409059094056, 5976.521878249642, 6100.206973093469, 5756.65460072397, 5759.04975679025, 5765.164051212634, 5768.509676677361, 5784.2191304175085, 5855.619384739978, 5880.441358070976, 5880.705964701662, 5881.9705901470215, 5896.174535564938, 5577.163425486047, 5639.859003524781, 5666.34836993751, 5701.629394089371, 5747.511461525817, 5643.0, 5688.971555142363, 5698.287714035746, 5706.771729130788, 5712.11462223356, 5453.182022696627, 5602.4957753802355, 5627.859303517281, 5633.0705433603, 5637.098064309691, 5633.492985631313, 5667.886642267049, 5693.28833895763, 5725.656460612377, 5777.24895763548, 5529.557635389078, 5565.38780734127, 5565.499105080562, 5579.832605021856, 5588.86027849307], "unit": "score", "name": "dojo.html", "value": 5331.990043105444}, {"lowerIsBetter": false, "replicates": [511.85855542141024, 546.148009105795, 564.31999440674, 596.6300893446064, 605.1648724759831, 33872.15319617011, 34563.48154777677, 34613.30773384537, 34636.48045279316, 34834.0, 35159.0, 35512.82243588785, 35599.644003560024, 35657.2868542629, 35703.464448033235, 8315.459495132796, 8414.36892233082, 8457.53483558404, 8473.576321183948, 8481.236688698016, 8228.670853165866, 8406.075331713506, 8427.747167584983, 8432.53621050842, 8434.114417986115, 8422.073571907085, 8434.198751118634, 8469.618867150963, 8479.957600212021, 8503.532305723184, 8324.250817426431, 8454.746357609281, 8471.407001509928, 8479.06730259671, 8480.151984801532, 8373.665053397857, 8405.579721013924, 8460.450070745383, 8468.49189048659, 8514.361422893246, 35066.82466587676, 35323.29353412943, 35504.467432988524, 35539.4669079964, 35729.0, 3031.696830316973, 3046.2384403899027, 3126.515390114536, 3296.528082273701, 3636.272745450894, 28027.439451210863, 28152.0, 28245.576316355273, 28644.427111457655, 29065.564016539767, 3733.21602463483, 3766.510353654035, 3824.694024478063, 3830.253100645375, 3900.7854567998747, 257915.0, 258545.9999999981, 259342.0, 259361.0, 259423.0, 49302.26046609304, 49953.50046499488, 50120.49879501158, 50257.24614130791, 56258.0, 55145.0, 55160.72419637876, 55172.448275517534, 55366.12437129362, 55565.444345556025, 15340.0, 15384.615384615474, 15398.384064637288, 15517.068975861259, 15522.844771552365, 11657.76684466306, 11791.29252244868, 11815.586454474053, 11820.0, 11875.168738188244, 18787.34244301443, 18913.0, 18931.716024259647, 18975.0, 19098.427047188605, 7670.348020418327, 8025.719099831595, 8044.074931382966, 8052.476589021695, 8112.634931427981, 948.9762755931018, 973.2214228617078, 983.5819776595062, 989.4805227255748, 1079.6760971708457, 27382.589261161098, 27572.185831098024, 27627.723722762916, 27872.721272787014, 27899.721002790116, 996.461910568285, 1054.630879192292, 1060.1201003167353, 1134.1663877050362, 1168.8013037783596, 14724.411023558938, 14944.551663450115, 15181.392744290326, 15225.467108651144, 15316.310766015557, 305612.0, 309264.0, 309483.0, 310644.0, 310720.0, 48863.26705099426, 49526.50473495219, 49698.0, 49922.50077499251, 49982.75008624933, 1356.7150898311268, 1373.3270697358223, 1389.0485017762865, 1400.1599040575572, 1400.7968844517488, 27262.591061134495, 28372.00697975561, 28408.85795571009, 28430.43139137247, 28619.28451788722, 43464.34803477887, 43968.34047489226, 44056.0, 44092.118157636025, 44205.55794442143, 234777.0, 235162.0, 236081.0, 293518.0, 294365.0, 29307.560386593792, 29532.409351812414, 30564.4850842156, 30672.233194169432, 30720.539191912587, 35694.64305357017, 36054.0, 36149.0, 36360.45459318059, 36771.0, 31016.68983310138, 31483.370332593677, 33835.83082084574, 35119.0, 35264.29471410609, 31333.52999705052, 31419.84290078535, 31515.84242078775, 31692.366152677278, 31693.20766980844, 31449.0, 31792.0, 31940.0, 32058.67941320557, 32082.83958580192, 28860.0, 28990.7100928988, 29180.416391671624, 29318.0, 29334.70665293405, 23551.646725299477, 23854.761452385254, 23856.16503422372, 23867.0, 24095.879520602284], "unit": "score", "name": "ext.html", "value": 17512.496509229637}, {"lowerIsBetter": false, "replicates": [342.3563700243543, 343.8349592195747, 345.9360018396597, 346.15365431519933, 347.70271417937664, 16641.83358166418, 16950.321987120515, 17441.91279043606, 17749.112544372794, 18190.27238910442, 11147.944260278708, 12304.0, 16186.595335116628, 16208.0, 16237.188140592953, 4835.903281934359, 5310.893782124355, 5313.867153321159, 5314.468553144693, 5335.1197052486295, 5313.946860531384, 5316.362036555619, 5327.174287985368, 5342.973285133569, 5345.572354211654, 5048.772805223755, 5175.456577059411, 5265.289185959904, 5272.261883336336, 5372.355317361922, 5156.639035267533, 5162.406323272815, 5170.276161337416, 5174.172132458826, 5184.71484068378, 5192.1692529195525, 5246.7638956247065, 5249.580033597303, 5303.23103150045, 5313.628046036779, 16269.023858568406, 19467.415977520555, 19524.219031238732, 20326.695099573517, 20395.286164984154, 2065.917363305466, 2089.7492300923836, 2100.6638937769885, 2117.417710129727, 2157.8489505734606, 6463.062855885917, 6468.256150542701, 9449.244060475145, 9706.51467426633, 10163.983601639851, 1738.0353903583507, 1741.0598276930443, 1837.4120281509922, 1851.0, 1869.9813001869943, 56576.0, 56758.71620641871, 57289.42710572883, 60256.0, 65795.0, 10002.399616061395, 10339.4313312767, 10384.169266458664, 10498.212634052477, 10529.578816847394, 13534.93232533831, 13648.181109133484, 13669.248191349572, 13678.247696376795, 13679.384427700777, 7743.30310272067, 7769.3784497240085, 7774.378049756006, 7810.0, 7968.0438347398685, 7441.069866266716, 7823.882641760378, 7888.48724832884, 7891.565963871927, 7953.920460795433, 4450.933236001462, 4464.620507256855, 4561.566651168134, 4574.222382195035, 4580.267157254823, 1821.5901422180168, 1825.6805059114602, 1835.8255965683238, 1865.6325332774202, 1868.495506213342, 277.55591054312936, 421.4626351401987, 421.791213349394, 424.85979626723105, 442.33207856136823, 10594.0, 11077.279976801483, 11223.438828058564, 16217.189140542925, 16701.0, 921.3688623293066, 949.7957939043139, 963.0850691842777, 972.1250874213265, 1009.2380252909006, 9385.202257808163, 9658.517074146264, 9677.467739274407, 9756.902430975599, 9777.0, 553446.0, 554626.0, 559074.0, 585498.0, 589337.0, 76774.0, 78415.60792196002, 78966.0, 79070.60464697755, 79602.0, 1148.8047032004413, 1162.9940101811872, 1218.530865616744, 1226.7239871028946, 1229.1825935752624, 15135.0, 15432.151231682365, 15539.766903496682, 15546.689066218387, 15707.371705131667, 34591.827040864635, 35032.47451288182, 35513.467297990035, 36143.45784813283, 36191.638083618825, 46370.768146159055, 47742.52257477381, 47802.521974779804, 49745.0, 50201.0, 9670.613175472903, 9730.0, 9730.902690973282, 9776.315657903879, 9830.262730295113, 15903.761443578123, 17123.0, 17574.648507030044, 17898.194581243613, 17928.938172109854, 14321.785173222619, 14482.927585362006, 14528.636784080483, 14956.476523321631, 15014.849851501345, 14065.507707230607, 14235.928820356246, 14258.287085645883, 14716.632084197981, 14944.92527537399, 14410.0, 14539.34572944199, 14588.124712517283, 14706.41174353014, 14800.851991479947, 12811.295378754257, 13322.0, 14093.929530352283, 14628.0, 14933.775993359892, 9837.458939758095, 10291.588336466457, 10295.279330446796, 15235.085894846345, 15423.768643470581], "unit": "score", "name": "jquery.html", "value": 8657.559300909032}, {"lowerIsBetter": false, "replicates": [1444.3283872999054, 1461.9049761765484, 1601.159391319557, 1759.3578343904462, 1780.9403404974037, 6358.205224346957, 6406.519511036679, 7111.324424179707, 7282.162551306601, 7286.67209975551, 6282.2147231596055, 6334.968325158379, 6383.106365108877, 6392.7442902283965, 6399.968000159993, 2150.182930486421, 2150.2474134053114, 2167.0, 2179.2917301876873, 2182.159868450642, 2136.5513242219076, 2167.934961951144, 2261.762514935933, 2262.1403866530695, 2262.7058482397347, 2131.3073251193346, 2132.786721327863, 2174.0, 2175.7824217578273, 2213.0373287619855, 2190.266260802633, 2207.106122020576, 2211.148707747521, 2215.9556808863895, 2217.556488702266, 2174.4563859035243, 2220.544788318407, 2221.7556068832578, 2224.1992882562263, 2224.8442609017375, 6957.478189135784, 6984.371406573382, 7025.964870175668, 7028.472864535181, 7036.859262814715, 4304.461942257218, 4382.868513944587, 4390.0, 4403.141387429452, 4422.977885110586, 2751.147144385247, 2789.023841655425, 2792.1623512946035, 2805.4950108980374, 2808.8033837631374, 866.58403966096, 913.5204017890594, 916.0884919505135, 1855.5917698106396, 1948.133080779054, 8824.470531768051, 8890.688825891128, 8930.419522731001, 8985.966613839426, 9000.414973026733, 3732.0, 3746.100935775394, 3764.962350376516, 3814.122751767109, 3878.204967981613, 7700.306972372513, 7703.730369437043, 7710.460267781314, 7712.421568382281, 7723.266289702469, 4266.722663026893, 4277.636400905958, 4284.635805956466, 4294.806733696929, 4299.78501074945, 3985.242803867256, 3994.121293315524, 4014.578469260744, 4058.6753059755147, 4064.6748260139116, 3230.5154226866157, 3242.3515296940705, 3242.7567932405163, 3259.5762550868235, 3279.5900512435946, 1011.8532812742111, 1025.3386565665105, 1032.7573020340214, 1040.0, 1041.1722680469045, 847.8346722389075, 853.0957185383513, 1147.9196456248148, 1155.2779512804498, 1158.5597472960221, 6768.255491895888, 6875.724971001204, 6876.656167191721, 6884.0362349271145, 6922.2731613180895, 1063.7393838509615, 1074.2265568790458, 1074.8602681651334, 1077.5474300793685, 1081.9891801082047, 5406.648567843077, 5422.213779002022, 5452.0, 5463.480969307989, 5464.726763661801, 8113.18868113184, 8127.512349259064, 8240.13478584752, 8301.2943899768, 8343.749687509384, 8258.710945117013, 8313.12712165226, 8348.707795227137, 8357.122502137188, 8397.244248017707, 6643.1031810704935, 6766.28953959837, 6799.694013769392, 6803.2856550062525, 6804.081449004321, 6817.488688348294, 6872.484563657646, 6879.036934829028, 6890.276520965427, 6897.620630865351, 7637.732679356196, 7690.077190737147, 7713.344365728976, 7756.92243077562, 7790.376769858284, 7572.507786993828, 7864.21357864209, 7878.172791857001, 7959.323457506177, 8030.919690803017, 6282.905756413749, 6416.32628573993, 6467.094606755152, 6578.901316480161, 6581.3418658133805, 6829.385355318045, 6832.453403727789, 6838.418734407631, 6888.896666549906, 6897.689439006573, 6385.77649782274, 6480.449161821298, 6536.084948107174, 6609.272979972296, 6617.139771829631, 6283.088952102011, 6391.93608063932, 6402.0, 6558.573692709959, 6566.244881838458, 6185.195924529962, 6262.718177682106, 6298.307186209605, 6316.305206427198, 6370.490360771035, 6035.094735789667, 6104.694765261808, 6114.938850611437, 6117.541184411276, 6168.013117901114, 6142.907856382247, 6160.784372546939, 6162.722677479434, 6182.1345011699295, 6201.844953876189], "unit": "score", "name": "mootools.html", "value": 4170.865430109151}, {"lowerIsBetter": false, "replicates": [321.06089687663587, 323.55672728362134, 328.1697305816286, 329.85651241709866, 331.0895038643731, 6220.875582488359, 6316.115743795872, 6328.303886572479, 6347.3969972852565, 6385.840353991152, 6129.969350153243, 6315.210598675166, 6350.587211831228, 6356.427921487065, 6357.71390287437, 4742.976285118578, 4757.714537127766, 4760.476347601761, 4772.475027746945, 4808.807647694088, 4784.401949756263, 4799.832005879794, 4805.567498925096, 4811.59101476375, 4817.566419022287, 4681.648876334271, 4748.19280722278, 4758.857234282977, 4783.928241076386, 4789.736564488951, 4742.976285118552, 4746.454157771848, 4756.500567440421, 4757.00102978375, 4759.809607615691, 4151.481064866892, 4160.646345060673, 4162.83348666053, 4182.728122672017, 4183.4979802423595, 5998.730057147439, 6006.729697163594, 6007.8197654070445, 6055.939440605625, 6057.485113765335, 5453.23654688344, 5565.749541270612, 5574.247476590689, 5577.135543990688, 5598.888022239573, 6674.799756007327, 6679.599224046524, 6684.565503242322, 6686.531942764009, 6703.664816759143, 4629.0, 4633.073385322915, 4644.512326205733, 4653.464851542082, 4653.697509661861, 6806.965965170142, 6954.617496037716, 6958.130233720785, 7015.789526314168, 7038.190608080085, 4580.839670611579, 4623.844038990253, 4627.120847039052, 4628.004978929546, 4635.605973492224, 4700.247960326331, 4700.88247793801, 4701.670883038223, 4704.153252414599, 4708.317293992352, 5487.149491828773, 5493.835184944458, 5496.6701997880255, 5499.670019798825, 5500.312460942382, 6627.237867645283, 6768.560043597249, 6780.72877084911, 6782.287859774751, 6792.966035169792, 1611.7260065788844, 1613.2014652746966, 1660.825613310585, 1664.2926756128597, 1667.7831881855282, 1046.8900765419673, 1046.9790604187874, 1054.862867827193, 1060.7454210989306, 1067.1836045425257, 6210.627362358273, 6256.812295631138, 6294.370562943669, 6295.96852015737, 6298.811035668938, 6791.796246112624, 6791.830204244933, 6798.490113241428, 6822.044913711985, 6827.453803695693, 6126.938730612636, 6270.216222972129, 6271.717772700239, 6287.654179020106, 6287.9056814147825, 3731.347014272546, 3738.158914244273, 3744.6817020553012, 3751.3247615429486, 3758.3986562149926, 7074.045003924404, 7105.111861017373, 7116.71533138679, 7117.3238542338395, 7121.394681452135, 6812.182538095461, 6940.30596940312, 6986.056882320821, 6989.091418115612, 6991.825204369931, 6981.3716765490335, 7058.541194822423, 7070.434365250768, 7090.07828982229, 7115.71537138519, 6777.08509351251, 6814.727410903508, 6823.010663453871, 6829.590224586541, 6835.043093966948, 6652.368025037614, 6709.194896612437, 6722.529422940543, 6751.45988320943, 6899.275576064441, 7278.563286202633, 7330.706771729285, 7331.973523706792, 7335.816604584928, 7335.963320183365, 4522.118186953512, 4567.109413664436, 4568.132054909556, 4591.380163677861, 4596.655250856266, 6826.11260536147, 6981.965090174516, 6989.266127056586, 7010.123734533184, 7015.894761578478, 6771.796846094625, 6803.659817009228, 6837.794866154023, 6846.691898864464, 6854.6229957352825, 6804.523683342119, 6825.658717064226, 6834.453243740588, 6839.418649414855, 6843.7604683835825, 6506.869862602816, 6683.832904177434, 6684.364985326386, 6691.665416729047, 6695.698693558899, 6826.044353790573, 6833.829154271183, 6835.521513494008, 6853.623050732258, 6873.0, 6620.0, 6657.966710166418, 6670.232923213893, 6678.0, 6678.165229346332], "unit": "score", "name": "prototype.html", "value": 5004.110224595651}, {"lowerIsBetter": false, "replicates": [724.3625609463671, 825.9215374539418, 842.2461896602541, 842.6629348260695, 874.9256313213378, 13555.864441355583, 13654.863451365509, 13689.315534223286, 13741.862581374184, 13787.58637240882, 13009.219446833173, 14529.782053269182, 14704.411823527045, 14704.779428308584, 14714.852851471482, 817.0685418622775, 838.7357982235607, 841.8232171244047, 843.1863251961855, 846.2764336492303, 836.5273620404482, 842.3387640702019, 843.7595285343648, 848.7114381110421, 851.4040171879678, 809.4212637963855, 853.4409961475212, 875.6672464463495, 875.7854325690215, 877.1360210192955, 868.7741187291286, 869.5043825019741, 873.8776571280026, 876.8334016536837, 876.8597024476117, 637.2575949019387, 638.0970926139507, 638.996805015972, 640.8846407646622, 643.2409756487343, 13579.59261222165, 13582.728345433035, 13647.522336718266, 13669.658258543615, 13672.863271367258, 11481.65555033342, 11602.76794464106, 11655.475503602274, 11813.527458901634, 12362.75274494505, 9911.0, 10291.79416411675, 10399.79200415995, 10545.947270263676, 10587.629432969808, 3622.2755448910325, 3664.468652045465, 3700.8704695335805, 3712.795796231206, 3770.7926064066464, 45138.0, 45276.0, 45447.0, 45463.54536454626, 45819.54180458186, 9619.326647134634, 9807.705768826947, 9881.209503239867, 10121.797564048826, 10161.949190254001, 16973.66052678964, 17000.0, 17092.0599367036, 17171.31314747421, 17184.656306873792, 7246.927530724731, 7298.96350518244, 7383.483156179016, 7394.55632662042, 7722.768316950501, 4078.836846526165, 4093.6111069448357, 4121.216968775923, 4137.668986481074, 4140.213359461693, 2946.8821247150304, 2947.498925182724, 2973.2566858285427, 2978.5532170174215, 2986.746126579265, 514.3056873221196, 528.6590149353722, 540.2517513244106, 540.5837505121035, 543.2774410034644, 504.3065784546249, 527.6728428374432, 530.8885134121878, 544.0940833512237, 565.2990292037844, 8062.596870156469, 8291.502509849308, 8325.0, 8362.0, 8542.316614670812, 623.566621198272, 648.9843395086768, 649.9805005849737, 661.6790856434625, 723.5405517496323, 3939.7242193046213, 4045.2516284487465, 4145.647619952278, 4225.302825033835, 4416.6245869101485, 52896.735516322944, 53859.73070134624, 58428.0, 59660.0, 60940.39059609436, 47676.523234767206, 47825.5217447828, 48295.5170448298, 48302.516974830505, 48613.75693121582, 43857.12285754267, 43906.34140487895, 44469.55530444719, 44702.776486117364, 44712.0, 8421.789455263668, 8503.957480212559, 8509.191626795444, 8743.300535957236, 8883.067277935723, 33280.50079248765, 33357.83321083379, 33418.997430077136, 34203.82898085494, 36506.81746591356, 42284.15431691287, 42759.358609620256, 43512.56487435085, 44202.77898610615, 44316.33525497056, 10744.51649675782, 10779.245452818228, 10855.077318428022, 10933.945330273298, 11217.0, 12215.26708397499, 12250.816237756262, 12464.127511074137, 12514.31171285588, 12564.497420103093, 10988.340699558052, 11144.275622084539, 11517.769644607228, 11531.769364612828, 11744.17790754639, 11395.772084558097, 11472.369019703663, 11615.6515304541, 11742.955121514971, 11819.40902954866, 11143.554257829921, 11159.553617855196, 11383.487743051417, 11405.372704501333, 11483.106669175906, 9831.31180817336, 10005.699829005142, 10010.698380315154, 10063.698089057047, 10480.528376223241, 8923.286137108886, 9122.680706175252, 9417.387869788441, 9711.003321401342, 10108.949455252676], "unit": "score", "name": "yui.html", "value": 6255.08532930298}], "name": "dromaeo_css", "value": 6874.526784514594}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 112.0, 111.0, 112.0, 123.0, 110.0, 113.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [161.0, 125.0, 151.0, 163.0, 135.0, 156.0, 152.0, 128.0, 169.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 165.0, 161.0, 162.0, 161.0, 163.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 75.0, 71.0, 75.0, 74.0, 135.0, 74.0, 73.0, 75.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 137.0, 95.0, 97.0, 97.0, 151.0, 96.0, 97.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 145.0, 147.0, 145.0, 148.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 60.0, 63.0, 58.0, 58.0, 59.0, 57.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 72.0, 68.0, 69.0, 67.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 96.0, 88.0, 87.0, 87.0, 86.0, 86.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [121.0, 125.0, 119.0, 124.0, 124.0, 117.0, 118.0, 119.0, 120.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [143.0, 144.0, 151.0, 154.0, 145.0, 151.0, 153.0, 152.0, 151.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 70.0, 71.0, 67.0, 75.0, 69.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1516.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.03021749958492], "unit": "score", "name": "Richards", "value": 212.62394600000007}, {"lowerIsBetter": false, "replicates": [190.07793195210036], "unit": "score", "name": "DeltaBlue", "value": 347.84679800000015}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [704.9295774647887], "unit": "score", "name": "Earley", "value": 945.432027972028}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [25450.0], "unit": "score", "name": "RegExp", "value": 35.79508840864438}, {"lowerIsBetter": false, "replicates": [566.6666666666666], "unit": "score", "name": "Splay", "value": 143.80764705882356}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21485.89970056231}]} 11:16:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21485.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1517.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6874.53"}}} 11:16:27 INFO - Return code: 0 11:16:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:16:27 INFO - # TBPL SUCCESS # 11:16:27 INFO - Running post-action listener: _resource_record_post_action 11:16:27 INFO - Running post-run listener: _resource_record_post_run 11:16:28 INFO - Total resource usage - Wall time: 1329s; CPU: 14.0%; Read bytes: 4096; Write bytes: 556335104; Read time: 2384; Write time: 7481472 11:16:28 INFO - install - Wall time: 16s; CPU: 28.0%; Read bytes: 0; Write bytes: 128069632; Read time: 0; Write time: 1321048 11:16:28 INFO - run-tests - Wall time: 1313s; CPU: 14.0%; Read bytes: 4096; Write bytes: 428265472; Read time: 2384; Write time: 6160424 11:16:28 INFO - Running post-run listener: _upload_blobber_files 11:16:28 INFO - Blob upload gear active. 11:16:28 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:16:28 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 11:16:28 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'] 11:16:28 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 11:16:28 INFO - (blobuploader) - INFO - Open directory for files ... 11:16:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:16:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:16:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:29 INFO - (blobuploader) - INFO - Done attempting. 11:16:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:16:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:16:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:30 INFO - (blobuploader) - INFO - Done attempting. 11:16:30 INFO - (blobuploader) - INFO - Iteration through files over. 11:16:30 INFO - Return code: 0 11:16:30 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:16:30 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:16:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a9bb54d028fef29f465aa82c353fcebc8b2156dbe4023a72720b8206b88e40740ef567a4d4e3c94180c0851207cf1aa6a6ef3d61023b40261c4688e8dfca93c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9274c33b4f9c1294196771012d16a50516c5d88fa6105b19b957fde1588db8756726f6cc22e89c3b7fcbfb3f48258767d62d671306bffddc8b165cd613a45a4f"} 11:16:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:16:30 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:16:30 INFO - Contents: 11:16:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a9bb54d028fef29f465aa82c353fcebc8b2156dbe4023a72720b8206b88e40740ef567a4d4e3c94180c0851207cf1aa6a6ef3d61023b40261c4688e8dfca93c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9274c33b4f9c1294196771012d16a50516c5d88fa6105b19b957fde1588db8756726f6cc22e89c3b7fcbfb3f48258767d62d671306bffddc8b165cd613a45a4f"} 11:16:30 INFO - Copying logs to upload dir... 11:16:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1384.464019 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 4 secs) (at 2015-12-30 11:16:30.273359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 11:16:30.276490) ========= 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=256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981 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/a9bb54d028fef29f465aa82c353fcebc8b2156dbe4023a72720b8206b88e40740ef567a4d4e3c94180c0851207cf1aa6a6ef3d61023b40261c4688e8dfca93c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9274c33b4f9c1294196771012d16a50516c5d88fa6105b19b957fde1588db8756726f6cc22e89c3b7fcbfb3f48258767d62d671306bffddc8b165cd613a45a4f"} build_url:https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/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/a9bb54d028fef29f465aa82c353fcebc8b2156dbe4023a72720b8206b88e40740ef567a4d4e3c94180c0851207cf1aa6a6ef3d61023b40261c4688e8dfca93c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9274c33b4f9c1294196771012d16a50516c5d88fa6105b19b957fde1588db8756726f6cc22e89c3b7fcbfb3f48258767d62d671306bffddc8b165cd613a45a4f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 11:16:30.301002) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 11:16:30.301343) ========= 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=256b35f542ca8bede9e27f1f00000291-1451500770.977334-983281981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 11:16:30.385146) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 11:16:30.385463) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 11:16:30.385781) ========= ========= Total master_lag: 0.27 =========