builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1453273512.0 results: success (0) buildid: 20160119203042 builduid: cf52693c06224a6b93186ead5b74abde revision: f55593fee5fcba46d7bc3afea9fd75f5d03dde59 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.005268) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.009119) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.009416) ========= 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=52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006409 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.066079) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.066380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.213405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.213652) ========= 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=52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004730 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.288062) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.288330) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.288703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.288989) ========= 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=52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 23:05:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-01-19 23:05:12 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087733 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.444996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.445306) ========= 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=52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019126 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.514686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:12.515001) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f55593fee5fcba46d7bc3afea9fd75f5d03dde59 --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 f55593fee5fcba46d7bc3afea9fd75f5d03dde59 --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=52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 23:05:12,714 truncating revision to first 12 chars 2016-01-19 23:05:12,714 Setting DEBUG logging. 2016-01-19 23:05:12,714 attempt 1/10 2016-01-19 23:05:12,714 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f55593fee5fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 23:05:13,073 unpacking tar archive at: fx-team-f55593fee5fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655279 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:13.188001) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:13.188373) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004454 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:13.239716) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:13.240040) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:13.253263) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:13.253561) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 23:05:13.253972) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-19 23:05:13.254345) ========= /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=52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:05:13 INFO - MultiFileLogger online at 20160119 23:05:13 in /builds/slave/test-pgo 23:05:13 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 23:05:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:05:13 INFO - {'append_to_log': False, 23:05:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:05:13 INFO - 'blob_upload_branch': 'Fx-Team', 23:05:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:05:13 INFO - 'branch': 'Fx-Team', 23:05:13 INFO - 'buildbot_json_path': 'buildprops.json', 23:05:13 INFO - 'config_files': ('talos/linux_config.py',), 23:05:13 INFO - 'default_actions': ('clobber', 23:05:13 INFO - 'read-buildbot-config', 23:05:13 INFO - 'download-and-extract', 23:05:13 INFO - 'populate-webroot', 23:05:13 INFO - 'create-virtualenv', 23:05:13 INFO - 'install', 23:05:13 INFO - 'run-tests'), 23:05:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:05:13 INFO - 'download_minidump_stackwalk': True, 23:05:13 INFO - 'download_symbols': 'ondemand', 23:05:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:05:13 INFO - 'tooltool.py': '/tools/tooltool.py', 23:05:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:05:13 INFO - '/tools/misc-python/virtualenv.py')}, 23:05:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:05:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:05:13 INFO - 'installer_path': 'installer.exe', 23:05:13 INFO - 'log_level': 'info', 23:05:13 INFO - 'log_name': 'talos', 23:05:13 INFO - 'log_to_console': True, 23:05:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:05:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:05:13 INFO - 'opt_config_files': (), 23:05:13 INFO - 'pip_index': False, 23:05:13 INFO - 'sps_profile': False, 23:05:13 INFO - 'sps_profile_interval': 0, 23:05:13 INFO - 'suite': 'dromaeojs-e10s', 23:05:13 INFO - 'system_bits': '32', 23:05:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:05:13 INFO - 'title': 'talos-linux64-ix-056', 23:05:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:05:13 INFO - 'use_talos_json': True, 23:05:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:05:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:05:13 INFO - 'work_dir': 'build'} 23:05:13 INFO - ##### 23:05:13 INFO - ##### Running clobber step. 23:05:13 INFO - ##### 23:05:13 INFO - Running pre-action listener: _resource_record_pre_action 23:05:13 INFO - Running main action method: clobber 23:05:13 INFO - rmtree: /builds/slave/test-pgo/build 23:05:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:05:14 INFO - Running post-action listener: _resource_record_post_action 23:05:14 INFO - ##### 23:05:14 INFO - ##### Running read-buildbot-config step. 23:05:14 INFO - ##### 23:05:14 INFO - Running pre-action listener: _resource_record_pre_action 23:05:14 INFO - Running main action method: read_buildbot_config 23:05:14 INFO - Using buildbot properties: 23:05:14 INFO - { 23:05:14 INFO - "project": "", 23:05:14 INFO - "product": "firefox", 23:05:14 INFO - "script_repo_revision": "production", 23:05:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:05:14 INFO - "repository": "", 23:05:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:05:14 INFO - "buildid": "20160119203042", 23:05:14 INFO - "pgo_build": "True", 23:05:14 INFO - "basedir": "/builds/slave/test-pgo", 23:05:14 INFO - "buildnumber": 224, 23:05:14 INFO - "slavename": "talos-linux64-ix-056", 23:05:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:05:14 INFO - "platform": "ubuntu64_hw", 23:05:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:05:14 INFO - "branch": "fx-team", 23:05:14 INFO - "repo_path": "integration/fx-team", 23:05:14 INFO - "revision": "f55593fee5fcba46d7bc3afea9fd75f5d03dde59", 23:05:14 INFO - "stage_platform": "linux64-pgo", 23:05:14 INFO - "builduid": "cf52693c06224a6b93186ead5b74abde", 23:05:14 INFO - "slavebuilddir": "test" 23:05:14 INFO - } 23:05:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 23:05:14 INFO - Running post-action listener: _resource_record_post_action 23:05:14 INFO - ##### 23:05:14 INFO - ##### Running download-and-extract step. 23:05:14 INFO - ##### 23:05:14 INFO - Running pre-action listener: _resource_record_pre_action 23:05:14 INFO - Running main action method: download_and_extract 23:05:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:05: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')]} 23:05:14 INFO - https://queue.taskcluster.net/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:05:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/test_packages.json 23:05:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/test_packages.json 23:05:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:05:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:05:15 INFO - Downloaded 1448 bytes. 23:05:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:05:15 INFO - Using the following test package requirements: 23:05:15 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:05:15 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:05:15 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:05:15 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:15 INFO - u'jsshell-linux-x86_64.zip'], 23:05:15 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:05:15 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:05:15 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:05:15 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:05:15 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:05:15 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:05:15 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:05:15 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:05:15 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')]} 23:05:15 INFO - https://queue.taskcluster.net/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/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 23:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/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 23:05:16 INFO - Downloaded 22485746 bytes. 23:05:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:05:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:05:18 INFO - Return code: 0 23:05:18 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 23:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:18 INFO - https://queue.taskcluster.net/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:05:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:05:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:05:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/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 23:05:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/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 23:05:22 INFO - Downloaded 22485746 bytes. 23:05:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:05:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:05:23 INFO - Return code: 0 23:05:23 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')]} 23:05:23 INFO - https://queue.taskcluster.net/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:05:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:05:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:05:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/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 23:05:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/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 23:05:24 INFO - Downloaded 11132144 bytes. 23:05:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:05:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 23:05:24 INFO - Return code: 0 23:05:24 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')]} 23:05:24 INFO - https://queue.taskcluster.net/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:05:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:05:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:05:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/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 23:05:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3lbBFlQHCTWfaK3HBe4g/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 23:05:26 INFO - Downloaded 55945235 bytes. 23:05:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:05:26 INFO - mkdir: /builds/slave/test-pgo/properties 23:05:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:05:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:05:26 INFO - Contents: 23:05:26 INFO - build_url:https://queue.taskcluster.net/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:05:26 INFO - Running post-action listener: _resource_record_post_action 23:05:26 INFO - Running post-action listener: set_extra_try_arguments 23:05:26 INFO - ##### 23:05:26 INFO - ##### Running populate-webroot step. 23:05:26 INFO - ##### 23:05:26 INFO - Running pre-action listener: _resource_record_pre_action 23:05:26 INFO - Running main action method: populate_webroot 23:05:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:05:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:05:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:05:26 INFO - '--tppagecycles', 23:05:26 INFO - '7'], 23:05:26 INFO - 'tests': ['tsvgm']}}, 23:05:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:05:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:05:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:05:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:05:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:05:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:05:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:26 INFO - 'talos_options': ['--e10s'], 23:05:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:26 INFO - 'tests': ['damp', 'tps']}, 23:05:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:26 INFO - 'talos_options': ['--e10s'], 23:05:26 INFO - 'tests': ['damp', 'tps']}, 23:05:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:05:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:05:26 INFO - 'other': {'tests': ['a11yr', 23:05:26 INFO - 'ts_paint', 23:05:26 INFO - 'tpaint', 23:05:26 INFO - 'sessionrestore', 23:05:26 INFO - 'sessionrestore_no_auto_restore']}, 23:05:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:05:26 INFO - 'tests': ['a11yr', 23:05:26 INFO - 'ts_paint', 23:05:26 INFO - 'tpaint', 23:05:26 INFO - 'sessionrestore', 23:05:26 INFO - 'sessionrestore_no_auto_restore']}, 23:05:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:05:26 INFO - 'tests': ['a11yr', 23:05:26 INFO - 'ts_paint', 23:05:26 INFO - 'tpaint', 23:05:26 INFO - 'sessionrestore', 23:05:26 INFO - 'sessionrestore_no_auto_restore']}, 23:05:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:05:26 INFO - 'tests': ['a11yr', 23:05:26 INFO - 'ts_paint', 23:05:26 INFO - 'tpaint', 23:05:26 INFO - 'sessionrestore', 23:05:26 INFO - 'sessionrestore_no_auto_restore']}, 23:05:26 INFO - 'other_l64': {'tests': ['a11yr', 23:05:26 INFO - 'ts_paint', 23:05:26 INFO - 'tpaint', 23:05:26 INFO - 'sessionrestore', 23:05:26 INFO - 'sessionrestore_no_auto_restore']}, 23:05:26 INFO - 'other_nol64': {'tests': ['a11yr', 23:05:26 INFO - 'ts_paint', 23:05:26 INFO - 'tpaint', 23:05:26 INFO - 'sessionrestore', 23:05:26 INFO - 'sessionrestore_no_auto_restore']}, 23:05:26 INFO - 'svgr': {'tests': ['tsvgx', 23:05:26 INFO - 'tsvgr_opacity', 23:05:26 INFO - 'tart', 23:05:26 INFO - 'tscrollx', 23:05:26 INFO - 'cart']}, 23:05:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:05:26 INFO - 'tests': ['tsvgx', 23:05:26 INFO - 'tsvgr_opacity', 23:05:26 INFO - 'tart', 23:05:26 INFO - 'tscrollx', 23:05:26 INFO - 'cart']}, 23:05:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:26 INFO - 'tests': ['tp5o']}, 23:05:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:26 INFO - 'talos_options': ['--e10s'], 23:05:26 INFO - 'tests': ['tp5o']}, 23:05:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:26 INFO - 'talos_options': ['--xperf_path', 23:05:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:26 INFO - 'tests': ['tp5n']}, 23:05:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:26 INFO - 'talos_options': ['--e10s', 23:05:26 INFO - '--xperf_path', 23:05:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:26 INFO - 'tests': ['tp5n']}}, 23:05:26 INFO - 'talos.zip': {'path': '', 23:05:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:05:26 INFO - Running post-action listener: _resource_record_post_action 23:05:26 INFO - ##### 23:05:26 INFO - ##### Running create-virtualenv step. 23:05:26 INFO - ##### 23:05:26 INFO - Running pre-action listener: _resource_record_pre_action 23:05:26 INFO - Running main action method: create_virtualenv 23:05:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:05:26 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 23:05:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:05:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:05:26 INFO - Using real prefix '/usr' 23:05:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:05:26 INFO - Installing distribute.............................................................................................................................................................................................done. 23:05:28 INFO - Installing pip.................done. 23:05:28 INFO - Return code: 0 23:05:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:05:28 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')]} 23:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:28 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')]} 23:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:28 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 0x7fe76d2e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09840>, '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 0x1c766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76b60>, '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': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', '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 23:05:28 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 23:05:28 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 23:05:28 INFO - Using env: {'DISPLAY': ':0', 23:05:28 INFO - 'HOME': '/home/cltbld', 23:05:28 INFO - 'LANG': 'en_US.UTF-8', 23:05:28 INFO - 'LANGUAGE': 'en_US:en', 23:05:28 INFO - 'LOGNAME': 'cltbld', 23:05:28 INFO - 'MAIL': '/var/mail/cltbld', 23:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:28 INFO - 'MOZ_NO_REMOTE': '1', 23:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:28 INFO - 'NO_EM_RESTART': '1', 23:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:28 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:28 INFO - 'SHELL': '/bin/bash', 23:05:28 INFO - 'SHLVL': '1', 23:05:28 INFO - 'TERM': 'linux', 23:05:28 INFO - 'TMOUT': '86400', 23:05:28 INFO - 'USER': 'cltbld', 23:05:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', 23:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:28 INFO - '_': '/tools/buildbot/bin/python'} 23:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:28 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 23:05:28 INFO - Cleaning up... 23:05:28 INFO - Return code: 0 23:05:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:05:28 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')]} 23:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:28 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')]} 23:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:28 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 0x7fe76d2e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09840>, '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 0x1c766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76b60>, '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': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', '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 23:05:28 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 23:05:28 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 23:05:28 INFO - Using env: {'DISPLAY': ':0', 23:05:28 INFO - 'HOME': '/home/cltbld', 23:05:28 INFO - 'LANG': 'en_US.UTF-8', 23:05:28 INFO - 'LANGUAGE': 'en_US:en', 23:05:28 INFO - 'LOGNAME': 'cltbld', 23:05:28 INFO - 'MAIL': '/var/mail/cltbld', 23:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:28 INFO - 'MOZ_NO_REMOTE': '1', 23:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:28 INFO - 'NO_EM_RESTART': '1', 23:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:28 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:28 INFO - 'SHELL': '/bin/bash', 23:05:28 INFO - 'SHLVL': '1', 23:05:28 INFO - 'TERM': 'linux', 23:05:28 INFO - 'TMOUT': '86400', 23:05:28 INFO - 'USER': 'cltbld', 23:05:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', 23:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:28 INFO - '_': '/tools/buildbot/bin/python'} 23:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:29 INFO - Downloading/unpacking psutil>=0.7.1 23:05:29 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 23:05:29 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 23:05:29 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 23:05:29 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 23:05:29 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 23:05:29 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 23:05:30 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 23:05:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:05:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:05:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:05:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:05:30 INFO - Installing collected packages: psutil 23:05:30 INFO - Running setup.py install for psutil 23:05:31 INFO - building 'psutil._psutil_linux' extension 23:05:31 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 23:05:31 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 23:05:31 INFO - building 'psutil._psutil_posix' extension 23:05:31 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 23:05:31 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 23:05:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:05:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:05:31 INFO - Successfully installed psutil 23:05:31 INFO - Cleaning up... 23:05:31 INFO - Return code: 0 23:05:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:31 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 0x7fe76d2e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09840>, '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 0x1c766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76b60>, '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': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', '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 23:05:31 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 23:05:31 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 23:05:31 INFO - Using env: {'DISPLAY': ':0', 23:05:31 INFO - 'HOME': '/home/cltbld', 23:05:31 INFO - 'LANG': 'en_US.UTF-8', 23:05:31 INFO - 'LANGUAGE': 'en_US:en', 23:05:31 INFO - 'LOGNAME': 'cltbld', 23:05:31 INFO - 'MAIL': '/var/mail/cltbld', 23:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:31 INFO - 'MOZ_NO_REMOTE': '1', 23:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:31 INFO - 'NO_EM_RESTART': '1', 23:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:31 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:31 INFO - 'SHELL': '/bin/bash', 23:05:31 INFO - 'SHLVL': '1', 23:05:31 INFO - 'TERM': 'linux', 23:05:31 INFO - 'TMOUT': '86400', 23:05:31 INFO - 'USER': 'cltbld', 23:05:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', 23:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:31 INFO - '_': '/tools/buildbot/bin/python'} 23:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:05:31 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 23:05:31 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 23:05:31 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 23:05:31 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 23:05:31 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 23:05:31 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 23:05:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:05:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:05:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:05:33 INFO - Installing collected packages: mozsystemmonitor 23:05:33 INFO - Running setup.py install for mozsystemmonitor 23:05:33 INFO - Successfully installed mozsystemmonitor 23:05:33 INFO - Cleaning up... 23:05:33 INFO - Return code: 0 23:05:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:05: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')]} 23:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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')]} 23:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:33 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 0x7fe76d2e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09840>, '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 0x1c766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76b60>, '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': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', '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 23:05:33 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 23:05:33 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 23:05:33 INFO - Using env: {'DISPLAY': ':0', 23:05:33 INFO - 'HOME': '/home/cltbld', 23:05:33 INFO - 'LANG': 'en_US.UTF-8', 23:05:33 INFO - 'LANGUAGE': 'en_US:en', 23:05:33 INFO - 'LOGNAME': 'cltbld', 23:05:33 INFO - 'MAIL': '/var/mail/cltbld', 23:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:33 INFO - 'MOZ_NO_REMOTE': '1', 23:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:33 INFO - 'NO_EM_RESTART': '1', 23:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:33 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:33 INFO - 'SHELL': '/bin/bash', 23:05:33 INFO - 'SHLVL': '1', 23:05:33 INFO - 'TERM': 'linux', 23:05:33 INFO - 'TMOUT': '86400', 23:05:33 INFO - 'USER': 'cltbld', 23:05:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', 23:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:33 INFO - '_': '/tools/buildbot/bin/python'} 23:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:33 INFO - Downloading/unpacking blobuploader==1.2.4 23:05:33 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 23:05:33 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 23:05:33 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 23:05:33 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 23:05:33 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 23:05:33 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 23:05:35 INFO - Downloading blobuploader-1.2.4.tar.gz 23:05:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:05:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:05:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:05:35 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 23:05:35 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 23:05:35 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 23:05:35 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 23:05:35 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 23:05:35 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 23:05:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:05:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:05:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:05:36 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 23:05:36 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 23:05:36 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 23:05:36 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 23:05:36 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 23:05:36 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 23:05:36 INFO - Downloading docopt-0.6.1.tar.gz 23:05:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:05:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:05:36 INFO - Installing collected packages: blobuploader, requests, docopt 23:05:36 INFO - Running setup.py install for blobuploader 23:05:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:05:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:05:36 INFO - Running setup.py install for requests 23:05:36 INFO - Running setup.py install for docopt 23:05:36 INFO - Successfully installed blobuploader requests docopt 23:05:36 INFO - Cleaning up... 23:05:36 INFO - Return code: 0 23:05:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:36 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 0x7fe76d2e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09840>, '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 0x1c766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76b60>, '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': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', '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 23:05:36 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 23:05:36 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 23:05:36 INFO - Using env: {'DISPLAY': ':0', 23:05:36 INFO - 'HOME': '/home/cltbld', 23:05:36 INFO - 'LANG': 'en_US.UTF-8', 23:05:36 INFO - 'LANGUAGE': 'en_US:en', 23:05:36 INFO - 'LOGNAME': 'cltbld', 23:05:36 INFO - 'MAIL': '/var/mail/cltbld', 23:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:36 INFO - 'MOZ_NO_REMOTE': '1', 23:05:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:36 INFO - 'NO_EM_RESTART': '1', 23:05:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:36 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:36 INFO - 'SHELL': '/bin/bash', 23:05:36 INFO - 'SHLVL': '1', 23:05:36 INFO - 'TERM': 'linux', 23:05:36 INFO - 'TMOUT': '86400', 23:05:36 INFO - 'USER': 'cltbld', 23:05:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', 23:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:36 INFO - '_': '/tools/buildbot/bin/python'} 23:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:05:37 INFO - Running setup.py (path:/tmp/pip-iZu18p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:05:37 INFO - Running setup.py (path:/tmp/pip-gU2LyV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:05:37 INFO - Running setup.py (path:/tmp/pip-XFTlB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:05:37 INFO - Running setup.py (path:/tmp/pip-JwI0dx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:05:37 INFO - Running setup.py (path:/tmp/pip-JX3qEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:05:37 INFO - Running setup.py (path:/tmp/pip-RBs3TE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:05:37 INFO - Running setup.py (path:/tmp/pip-Ne4ITX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:05:37 INFO - Running setup.py (path:/tmp/pip-Dg58my-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:05:37 INFO - Running setup.py (path:/tmp/pip-qJib8K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:05:37 INFO - Running setup.py (path:/tmp/pip-kiI2WC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:05:37 INFO - Running setup.py (path:/tmp/pip-rJ_0Ub-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:05:37 INFO - Running setup.py (path:/tmp/pip-zwqCOl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:05:37 INFO - Running setup.py (path:/tmp/pip-JVgJH7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:05:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:05:38 INFO - Running setup.py (path:/tmp/pip-CBeHmE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:05:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:05:38 INFO - Running setup.py (path:/tmp/pip-vwM2Qs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:05:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:05:38 INFO - Running setup.py (path:/tmp/pip-7GiJ_O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:05:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:05:38 INFO - Running setup.py (path:/tmp/pip-aFv2GF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:05:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:05:38 INFO - Running setup.py install for manifestparser 23:05:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:05:38 INFO - Running setup.py install for mozcrash 23:05:38 INFO - Running setup.py install for mozdebug 23:05:38 INFO - Running setup.py install for mozdevice 23:05:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:05:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:05:38 INFO - Running setup.py install for mozfile 23:05:38 INFO - Running setup.py install for mozhttpd 23:05:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:05:38 INFO - Running setup.py install for mozinfo 23:05:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:05:39 INFO - Running setup.py install for mozInstall 23:05:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:05:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:05:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:05:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:05:39 INFO - Running setup.py install for mozleak 23:05:39 INFO - Running setup.py install for mozlog 23:05:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:05:39 INFO - Running setup.py install for moznetwork 23:05:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:05:39 INFO - Running setup.py install for mozprocess 23:05:39 INFO - Running setup.py install for mozprofile 23:05:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:05:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:05:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:05:39 INFO - Running setup.py install for mozrunner 23:05:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:05:39 INFO - Running setup.py install for mozscreenshot 23:05:39 INFO - Running setup.py install for moztest 23:05:39 INFO - Running setup.py install for mozversion 23:05:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:05:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:05:40 INFO - Cleaning up... 23:05:40 INFO - Return code: 0 23:05:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:05:40 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')]} 23:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:40 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')]} 23:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:40 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 0x7fe76d2e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09840>, '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 0x1c766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76b60>, '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': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', '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 23:05:40 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 23:05:40 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 23:05:40 INFO - Using env: {'DISPLAY': ':0', 23:05:40 INFO - 'HOME': '/home/cltbld', 23:05:40 INFO - 'LANG': 'en_US.UTF-8', 23:05:40 INFO - 'LANGUAGE': 'en_US:en', 23:05:40 INFO - 'LOGNAME': 'cltbld', 23:05:40 INFO - 'MAIL': '/var/mail/cltbld', 23:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:40 INFO - 'MOZ_NO_REMOTE': '1', 23:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:40 INFO - 'NO_EM_RESTART': '1', 23:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:40 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:40 INFO - 'SHELL': '/bin/bash', 23:05:40 INFO - 'SHLVL': '1', 23:05:40 INFO - 'TERM': 'linux', 23:05:40 INFO - 'TMOUT': '86400', 23:05:40 INFO - 'USER': 'cltbld', 23:05:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', 23:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:40 INFO - '_': '/tools/buildbot/bin/python'} 23:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:05:40 INFO - Running setup.py (path:/tmp/pip-ZCpZgi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:05:40 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)) 23:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:05:40 INFO - Running setup.py (path:/tmp/pip-Iw363S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:05:40 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)) 23:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:05:40 INFO - Running setup.py (path:/tmp/pip-IKWvbY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:05:40 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)) 23:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:05:40 INFO - Running setup.py (path:/tmp/pip-FULZZK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:05:40 INFO - Running setup.py (path:/tmp/pip-aThC4Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:05:40 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)) 23:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:05:40 INFO - Running setup.py (path:/tmp/pip-jS7VSO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:05:40 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)) 23:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:05:40 INFO - Running setup.py (path:/tmp/pip-QhxphY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:05:40 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)) 23:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:05:40 INFO - Running setup.py (path:/tmp/pip-NTkmgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:05:40 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)) 23:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:05:40 INFO - Running setup.py (path:/tmp/pip-1UvGHW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:05:40 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)) 23:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:05:40 INFO - Running setup.py (path:/tmp/pip-C5VgYm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:05:41 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)) 23:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:05:41 INFO - Running setup.py (path:/tmp/pip-aMsp3N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:05:41 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)) 23:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:05:41 INFO - Running setup.py (path:/tmp/pip-VjLz3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:05:41 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)) 23:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:05:41 INFO - Running setup.py (path:/tmp/pip-sVaJnP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:05:41 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)) 23:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:05:41 INFO - Running setup.py (path:/tmp/pip-p4hB9o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:05:41 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)) 23:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:05:41 INFO - Running setup.py (path:/tmp/pip-oK8Afb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:05:41 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)) 23:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:05:41 INFO - Running setup.py (path:/tmp/pip-wbl6Xq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:05:41 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)) 23:05:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:05:41 INFO - Running setup.py (path:/tmp/pip-Z6P0aG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:05:41 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)) 23:05:41 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)) 23:05:41 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)) 23:05:41 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)) 23:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:05:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:05:41 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 23:05:41 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 23:05:41 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 23:05:41 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 23:05:41 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 23:05:41 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 23:05:43 INFO - Downloading blessings-1.5.1.tar.gz 23:05:43 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 23:05:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:05:43 INFO - Installing collected packages: blessings 23:05:43 INFO - Running setup.py install for blessings 23:05:43 INFO - Successfully installed blessings 23:05:43 INFO - Cleaning up... 23:05:43 INFO - Return code: 0 23:05:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:05:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:05:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:05:43 INFO - Reading from file tmpfile_stdout 23:05:43 INFO - Current package versions: 23:05:43 INFO - argparse == 1.2.1 23:05:43 INFO - blessings == 1.5.1 23:05:43 INFO - blobuploader == 1.2.4 23:05:43 INFO - docopt == 0.6.1 23:05:43 INFO - manifestparser == 1.1 23:05:43 INFO - mozInstall == 1.12 23:05:43 INFO - mozcrash == 0.16 23:05:43 INFO - mozdebug == 0.1 23:05:43 INFO - mozdevice == 0.48 23:05:43 INFO - mozfile == 1.2 23:05:43 INFO - mozhttpd == 0.7 23:05:43 INFO - mozinfo == 0.9 23:05:43 INFO - mozleak == 0.1 23:05:43 INFO - mozlog == 3.1 23:05:43 INFO - moznetwork == 0.27 23:05:43 INFO - mozprocess == 0.22 23:05:43 INFO - mozprofile == 0.28 23:05:43 INFO - mozrunner == 6.11 23:05:43 INFO - mozscreenshot == 0.1 23:05:43 INFO - mozsystemmonitor == 0.0 23:05:43 INFO - moztest == 0.7 23:05:43 INFO - mozversion == 1.4 23:05:43 INFO - psutil == 3.1.1 23:05:43 INFO - requests == 1.2.3 23:05:43 INFO - wsgiref == 0.1.2 23:05:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:43 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 0x7fe76d2e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09840>, '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 0x1c766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76b60>, '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': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', '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 23:05:43 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 23:05:43 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 23:05:43 INFO - Using env: {'DISPLAY': ':0', 23:05:43 INFO - 'HOME': '/home/cltbld', 23:05:43 INFO - 'LANG': 'en_US.UTF-8', 23:05:43 INFO - 'LANGUAGE': 'en_US:en', 23:05:43 INFO - 'LOGNAME': 'cltbld', 23:05:43 INFO - 'MAIL': '/var/mail/cltbld', 23:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:43 INFO - 'MOZ_NO_REMOTE': '1', 23:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:43 INFO - 'NO_EM_RESTART': '1', 23:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:43 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:43 INFO - 'SHELL': '/bin/bash', 23:05:43 INFO - 'SHLVL': '1', 23:05:43 INFO - 'TERM': 'linux', 23:05:43 INFO - 'TMOUT': '86400', 23:05:43 INFO - 'USER': 'cltbld', 23:05:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', 23:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:43 INFO - '_': '/tools/buildbot/bin/python'} 23:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:43 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)) 23:05:43 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)) 23:05:43 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)) 23:05:43 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)) 23:05:43 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)) 23:05:43 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)) 23:05:43 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)) 23:05:43 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)) 23:05:43 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)) 23:05:43 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)) 23:05:43 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)) 23:05:43 INFO - Cleaning up... 23:05:43 INFO - Return code: 0 23:05:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:43 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 0x7fe76d2e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09840>, '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 0x1c766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76b60>, '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': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', '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 23:05:43 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 23:05:43 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 23:05:43 INFO - Using env: {'DISPLAY': ':0', 23:05:43 INFO - 'HOME': '/home/cltbld', 23:05:43 INFO - 'LANG': 'en_US.UTF-8', 23:05:43 INFO - 'LANGUAGE': 'en_US:en', 23:05:43 INFO - 'LOGNAME': 'cltbld', 23:05:43 INFO - 'MAIL': '/var/mail/cltbld', 23:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:43 INFO - 'MOZ_NO_REMOTE': '1', 23:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:43 INFO - 'NO_EM_RESTART': '1', 23:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:43 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:43 INFO - 'SHELL': '/bin/bash', 23:05:43 INFO - 'SHLVL': '1', 23:05:43 INFO - 'TERM': 'linux', 23:05:43 INFO - 'TMOUT': '86400', 23:05:43 INFO - 'USER': 'cltbld', 23:05:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', 23:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:43 INFO - '_': '/tools/buildbot/bin/python'} 23:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:44 INFO - Downloading/unpacking jsonschema 23:05:44 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 23:05:44 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 23:05:44 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 23:05:44 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 23:05:44 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 23:05:44 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 23:05:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:05:45 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 23:05:45 INFO - Downloading/unpacking functools32 (from jsonschema) 23:05:45 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 23:05:45 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 23:05:45 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 23:05:45 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 23:05:45 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 23:05:45 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 23:05:46 INFO - Downloading functools32-3.2.3-2.tar.gz 23:05:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 23:05:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:05:46 INFO - warning: no files found matching '*.txt' 23:05:46 INFO - no previously-included directories found matching 'build' 23:05:46 INFO - no previously-included directories found matching 'dist' 23:05:46 INFO - no previously-included directories found matching '.git*' 23:05:46 INFO - Installing collected packages: jsonschema, functools32 23:05:46 INFO - Running setup.py install for functools32 23:05:46 INFO - warning: no files found matching '*.txt' 23:05:46 INFO - no previously-included directories found matching 'build' 23:05:46 INFO - no previously-included directories found matching 'dist' 23:05:46 INFO - no previously-included directories found matching '.git*' 23:05:46 INFO - Successfully installed jsonschema functools32 23:05:46 INFO - Cleaning up... 23:05:46 INFO - Return code: 0 23:05:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:46 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 0x7fe76d2e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09840>, '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 0x1c766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76b60>, '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': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', '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 23:05:46 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 23:05:46 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 23:05:46 INFO - Using env: {'DISPLAY': ':0', 23:05:46 INFO - 'HOME': '/home/cltbld', 23:05:46 INFO - 'LANG': 'en_US.UTF-8', 23:05:46 INFO - 'LANGUAGE': 'en_US:en', 23:05:46 INFO - 'LOGNAME': 'cltbld', 23:05:46 INFO - 'MAIL': '/var/mail/cltbld', 23:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:46 INFO - 'MOZ_NO_REMOTE': '1', 23:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:46 INFO - 'NO_EM_RESTART': '1', 23:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:46 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:46 INFO - 'SHELL': '/bin/bash', 23:05:46 INFO - 'SHLVL': '1', 23:05:46 INFO - 'TERM': 'linux', 23:05:46 INFO - 'TMOUT': '86400', 23:05:46 INFO - 'USER': 'cltbld', 23:05:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', 23:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:46 INFO - '_': '/tools/buildbot/bin/python'} 23:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:46 INFO - Downloading/unpacking flake8 23:05:46 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 23:05:46 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 23:05:46 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 23:05:46 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 23:05:46 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 23:05:46 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 23:05:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:05:48 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 23:05:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:05:48 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 23:05:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 23:05:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:05:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:05:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:05:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:05:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:05:48 INFO - no previously-included directories found matching 'docs/_build' 23:05:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:05:49 INFO - Running setup.py install for pep8 23:05:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:05:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:05:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:05:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:05:49 INFO - no previously-included directories found matching 'docs/_build' 23:05:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:05:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:05:49 INFO - Cleaning up... 23:05:49 INFO - Return code: 0 23:05:49 INFO - Running post-action listener: _resource_record_post_action 23:05:49 INFO - Running post-action listener: _start_resource_monitoring 23:05:49 INFO - Starting resource monitoring. 23:05:49 INFO - ##### 23:05:49 INFO - ##### Running install step. 23:05:49 INFO - ##### 23:05:49 INFO - Running pre-action listener: _resource_record_pre_action 23:05:49 INFO - Running main action method: install 23:05:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:05:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:05:49 INFO - Reading from file tmpfile_stdout 23:05:49 INFO - Detecting whether we're running mozinstall >=1.0... 23:05:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:05:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:05:49 INFO - Reading from file tmpfile_stdout 23:05:49 INFO - Output received: 23:05:49 INFO - Usage: mozinstall [options] installer 23:05:49 INFO - Options: 23:05:49 INFO - -h, --help show this help message and exit 23:05:49 INFO - -d DEST, --destination=DEST 23:05:49 INFO - Directory to install application into. [default: 23:05:49 INFO - "/builds/slave/test-pgo"] 23:05:49 INFO - --app=APP Application being installed. [default: firefox] 23:05:49 INFO - mkdir: /builds/slave/test-pgo/build/application 23:05:49 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'] 23:05:49 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 23:06:05 INFO - Reading from file tmpfile_stdout 23:06:05 INFO - Output received: 23:06:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:06:05 INFO - Running post-action listener: _resource_record_post_action 23:06:05 INFO - ##### 23:06:05 INFO - ##### Running run-tests step. 23:06:05 INFO - ##### 23:06:05 INFO - Running pre-action listener: _resource_record_pre_action 23:06:05 INFO - Running main action method: run_tests 23:06:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:06:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:06:05 INFO - Python 2.7.3 23:06:05 INFO - Return code: 0 23:06:05 INFO - grabbing minidump binary from tooltool 23:06: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')]} 23:06:05 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 0x1d09840>, '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 0x1c766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:06:05 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 23:06:05 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 23:06:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:06:05 INFO - Return code: 0 23:06:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:06:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:06:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:06:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:06:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:06:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:06:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:06:06 INFO - Return code: 0 23:06:06 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/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 23:06:06 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/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 23:06:06 INFO - Using env: {'DISPLAY': ':0', 23:06:06 INFO - 'HOME': '/home/cltbld', 23:06:06 INFO - 'LANG': 'en_US.UTF-8', 23:06:06 INFO - 'LANGUAGE': 'en_US:en', 23:06:06 INFO - 'LOGNAME': 'cltbld', 23:06:06 INFO - 'MAIL': '/var/mail/cltbld', 23:06:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:06:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:06 INFO - 'MOZ_NO_REMOTE': '1', 23:06:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:06 INFO - 'NO_EM_RESTART': '1', 23:06:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:06:06 INFO - 'PWD': '/builds/slave/test-pgo', 23:06:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:06:06 INFO - 'SHELL': '/bin/bash', 23:06:06 INFO - 'SHLVL': '1', 23:06:06 INFO - 'TERM': 'linux', 23:06:06 INFO - 'TMOUT': '86400', 23:06:06 INFO - 'USER': 'cltbld', 23:06:06 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410', 23:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:06 INFO - '_': '/tools/buildbot/bin/python'} 23:06:06 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/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 23:06:06 INFO - mozversion application_buildid: 20160119203042 23:06:06 INFO - mozversion application_changeset: f55593fee5fcba46d7bc3afea9fd75f5d03dde59 23:06:06 INFO - mozversion application_display_name: Nightly 23:06:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:06:06 INFO - mozversion application_name: Firefox 23:06:06 INFO - mozversion application_remotingname: firefox 23:06:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:06:06 INFO - mozversion application_vendor: Mozilla 23:06:06 INFO - mozversion application_version: 46.0a1 23:06:06 INFO - mozversion platform_buildid: 20160119203042 23:06:06 INFO - mozversion platform_changeset: f55593fee5fcba46d7bc3afea9fd75f5d03dde59 23:06:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:06:06 INFO - mozversion platform_version: 46.0a1 23:06:06 INFO - using testdate: 1453273566 23:06:06 INFO - actual date: 1453273566 23:06:06 INFO - starting webserver on 'localhost:54048' 23:06:06 INFO - SUITE-START | Running 3 tests 23:06:06 INFO - TEST-START | dromaeo_css 23:06:06 INFO - operating with platform_type : linux_ 23:06:06 INFO - Initialising browser for dromaeo_css test... 23:06:06 INFO - TEST-INFO | started process 22707 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaOXfaI/profile http://localhost:54048/getInfo.html) 23:06:10 INFO - PROCESS | 22707 | -- checkerboarding starts below -- 23:06:10 INFO - PROCESS | 22707 | RENDERTRACE 0.033479 rect red 0 0 1024 768 // viewport 23:06:10 INFO - PROCESS | 22707 | RENDERTRACE 307.307 rect brown 0 0 1024 768 // page 23:06:10 INFO - PROCESS | 22707 | RENDERTRACE 307.34 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 23:06:10 INFO - PROCESS | 22707 | Checkerboarded for 1 frames (316.535 ms), 786432 peak, 9592 severity. 23:06:10 INFO - PROCESS | 22707 | 23:06:10 INFO - PROCESS | 22707 | (process:22789): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:06:11 INFO - PROCESS | 22707 | __metrics Screen width/height:1600/1200 23:06:11 INFO - PROCESS | 22707 | colorDepth:24 23:06:11 INFO - PROCESS | 22707 | Browser inner width/height: 1024/697 23:06:11 INFO - PROCESS | 22707 | __metrics 23:06:11 INFO - PROCESS | 22707 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:06:11 INFO - PROCESS | 22707 | 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. 23:06:12 INFO - TEST-INFO | 22707: exit 0 23:06:12 INFO - Browser initialized. 23:06:12 INFO - Running cycle 1/1 for dromaeo_css test... 23:06:12 INFO - TEST-INFO | started process 22838 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaOXfaI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:06:13 INFO - PROCESS | 22838 | -- checkerboarding starts below -- 23:06:13 INFO - PROCESS | 22838 | RENDERTRACE 0.037773 rect red 0 0 10 10 // viewport 23:06:13 INFO - PROCESS | 22838 | RENDERTRACE 17.0394 rect brown 0 0 10 10 // page 23:06:13 INFO - PROCESS | 22838 | RENDERTRACE 17.0621 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 23:06:13 INFO - PROCESS | 22838 | Checkerboarded for 1 frames (20.1238 ms), 100 peak, 1 severity. 23:06:14 INFO - PROCESS | 22838 | 23:06:14 INFO - PROCESS | 22838 | (process:22900): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:06:24 INFO - PROCESS | 22838 | RSS: Main: 150896640 23:06:24 INFO - PROCESS | 22838 | 23:07:14 INFO - PROCESS | 22838 | 1453273634208 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] 23:09:23 INFO - PROCESS | 22838 | Cycle 1(1): loaded http://localhost:54048/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54048/tests/dromaeo/cssquery-ext.html) 23:09:24 INFO - PROCESS | 22838 | RSS: Main: 155766784 23:09:24 INFO - PROCESS | 22838 | 23:12:26 INFO - PROCESS | 22838 | Cycle 1(1): loaded http://localhost:54048/tests/dromaeo/cssquery-ext.html (next: http://localhost:54048/tests/dromaeo/cssquery-jquery.html) 23:12:26 INFO - PROCESS | 22838 | RSS: Main: 151101440 23:12:26 INFO - PROCESS | 22838 | 23:15:28 INFO - PROCESS | 22838 | Cycle 1(1): loaded http://localhost:54048/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54048/tests/dromaeo/cssquery-mootools.html) 23:15:29 INFO - PROCESS | 22838 | RSS: Main: 151875584 23:15:29 INFO - PROCESS | 22838 | 23:18:31 INFO - PROCESS | 22838 | Cycle 1(1): loaded http://localhost:54048/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54048/tests/dromaeo/cssquery-prototype.html) 23:18:31 INFO - PROCESS | 22838 | RSS: Main: 149671936 23:18:31 INFO - PROCESS | 22838 | 23:21:34 INFO - PROCESS | 22838 | Cycle 1(1): loaded http://localhost:54048/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54048/tests/dromaeo/cssquery-yui.html) 23:21:34 INFO - PROCESS | 22838 | RSS: Main: 151150592 23:21:34 INFO - PROCESS | 22838 | 23:24:37 INFO - PROCESS | 22838 | Cycle 1(1): loaded http://localhost:54048/tests/dromaeo/cssquery-yui.html (next: http://localhost:54048/tests/dromaeo/cssquery-dojo.html) 23:24:37 INFO - PROCESS | 22838 | RSS: Main: 153178112 23:24:37 INFO - PROCESS | 22838 | 23:24:37 INFO - PROCESS | 22838 | __start_tp_report 23:24:37 INFO - PROCESS | 22838 | _x_x_mozilla_page_load 23:24:37 INFO - PROCESS | 22838 | _x_x_mozilla_page_load_details 23:24:37 INFO - PROCESS | 22838 | |i|pagename|runs| 23:24:37 INFO - PROCESS | 22838 | |0;dojo.html;3194.1695159258593;3237.7086062254393;3243.7242834359063;3264.2165880188763;3277.573915390999;5194.27280180775;5283.339582552177;5299.629025968184;5302.2311764794085;5319.388270348911;5177.870553236171;5214.817481388152;5294.047071527124;5348.0640887844565;5445.37378201506;4898.999999999991;4926.827561035365;4946.3817022872145;4973.104841128596;4978.6017118630425;4926.334944782462;4932.408111026664;4967;5003.074431230216;5005.199168133099;4740.431148262196;4806.158922188603;4828.975855120737;4860.6111511079025;4871.050145221683;4914.508549145093;4916.975415122902;4917.60659147271;4942.752862356868;4951;4890.266460031024;4913.975430122827;4918.778654960535;4930.728809915489;4939.74036620663;5006.799728010875;5086.084504789136;5094.847154585368;5240.9213861792105;5301.284326615896;5736.426357364272;5756.02147634903;5760.942390576082;5774.133879918004;5786.0742281235225;5824.737886795105;5827.941720582782;5838.41615838417;5838.7372568234105;5840.065589505659;5284.365876094893;5285.86785330366;5329.467053294678;5340.866478338073;5342.866428339284;5952.107183922446;5961.165436838846;5963.0459126539545;5964.7315870785915;6030.547708921761;5726.3128424588485;5729.369769325371;5738.741756620962;5739.569532285095;5753.626014309057;5625;5746.281714785652;5779.595428320062;5786.276715410574;5811.564132690065;5730.7421166047625;5744.253247077853;5748.31020277561;5756.222909907193;5777.335606405317;5702.372738998707;5714.085746280658;5726.484616384545;5733.71331433435;5740.6268592541355;4339.1972485090355;4407.162639098561;4419.9779001105435;4429.069895321954;4470.083632855257;3937.291287568265;3963.6829053675638;3986.6412022918075;4000.3399439092223;4003.8598649047144;5210.348706411699;5293.947060529423;5303.920441193385;5326.97336513315;5366.329208848894;5460.918086228709;5540.168974653834;5660.660360378391;5675.404082571271;5696.8860622787315;5415.53967912724;5428.809991650273;5442.2380866678695;5446.727663616883;5450.727463626803;4898.4121905371585;4917.483664215278;4918.729469879191;4925.556699897026;4969.105560999054;5733.655980641091;5745.712714364348;5985.371535988746;5997.730102145414;6111.358307377662;5738.254026976467;5739.397363276796;5753.654780713171;5760.222369979999;5768.1636162757;5922.881542369215;5930.584859059824;5977.073553599199;5980.282366116094;5994.820155395345;5545.889082218414;5622.971885140548;5653.123765816305;5664.886702266014;5706.543476521952;5789.652620842763;5800.50695690871;5804.361520232686;5813.854653633693;5825.970870145622;5437.32033495813;5656.151577263443;5657.886842263214;5670.744816483186;5692.743826527733;5497.285352904097;5602.411746766531;5605.215269862304;5725.08398656213;5790.334111577223;5479.287692599936;5512.834614961557;5518.117101263779;5525.557955363642;5550.916736249041;5590.776368945197;5611.298587676541;5611.747471363717;5625.128105143709;5627.352854421794;5485.945140548703;5508.3114610673665;5525.557955363481;5592.468715472024;5663.490285874291 23:24:37 INFO - PROCESS | 22838 | |1;ext.html;538.7171734839209;545.370097537344;575.1947273816659;575.8819442014386;589.599072630611;35697.82151089247;36553.634463655355;36655.450168247495;36705.265894682154;36756.26487470252;40531.18937621246;40659.18681626366;40914;40945.59054409462;41090;8409.83180336393;8556.144385561425;8568.742937711879;8594.183552562528;8612.612432440525;8492.447990880604;8667.046624871258;8703.30373570116;8711.259542938826;8735.1701588349;8736.956315218415;8749;8764.25503832175;8775.692850750225;8817.382783205177;8549.658013679446;8671.609777560025;8701.39090263685;8713.7821554461;8718.956405217965;8537.402381833273;8655.913440865574;8660.26387757035;8674.696385626472;8685.088065753069;38866;39317.21365572672;39331;39331.803340983395;39526.40710389318;2805.2005178524023;3088.7528997680133;3104.580881581003;3153.4639111351125;3180.77734558581;26887;26924;28141.718582814116;28227.71772282292;28661.85669071662;3067.432524982863;3067.8159310441447;3116.345567430842;3126.702963218491;3156.589643346373;224185;224821;225042;225892;226836;55960.16059759107;56028;56032.43967560272;56057.43942560604;56315.15527267094;65654;65793.34206657873;65991;66428.66785666137;66489;12849.100562960502;13131;13199.604011879659;13223.2727200003;13243;9742.659006934724;9807.656732014346;9823.557939892578;9841.655542056136;9896.752581185528;20105.39683809488;20384.49038774013;20459.38621841347;20494.18023279052;20936.895315523325;7959.84080318402;8180.386471014579;8279.812272275098;8286.46138001028;8322.292605128632;902.8645703144449;931.0735817861272;939.6711151097198;942.4533770413144;951.6145960885852;28580.71419285822;28780.856095719388;28888.42223155525;29043;29163.27091822679;1010.0505524806658;1023.8464230365505;1090.1387903556101;1115.297362661518;1169.0005045685987;15057;15077.773833392508;15117.773233401507;15312.770308445382;15365.846341536442;316270;317551;319987;320012;320640;50663;51308.48691513037;51336.74331628318;51686.48313516892;51764.74117629463;1235.2218102595307;1246.6010876519426;1278.8849003589535;1283.1210620724833;1289.0976316578244;27962;28894.71105289004;29050.762961894296;29083.56374654424;29134.7086529132;46241.76879115718;46423.76788116038;46469.76765116153;46545.8799532058;46552.7672361636;292512;293033;296219;297267;297322;28358.85820570884;28980;31100.533491997187;32121.51817722689;32737;37209.069773255884;38355.61644383632;39375.21249574935;39864.40203396893;41037;34159.65840341565;34365.65634343625;34444.82777586096;34737.82631086828;35237.295254094264;34791.65208347884;35148.82425587856;35400.82299588485;37925.81037094797;39596;33713.3257334847;38314.80842595769;39204;39234;39245;27798.583021254293;32510.67489325171;32783.67216327806;32812.67187328096;32948;25086.247412577653;25198.874005629856;25653.23040308794;25911.352216194748;27267.86366068157 23:24:37 INFO - PROCESS | 22838 | |2;jquery.html;356.9767965082269;370.48502581411833;371.5708356847841;371.9144596742749;375.75012616609956;15435.228238588068;17039;17260.568485787862;17732.37936672217;18200.271989120418;11003.61487347941;11532.481038353273;16567.088810115438;16591.83408165918;16620;4629.675922685405;4988.950110498885;5063.46833582474;5079.1365467870555;5079.466656001122;4471.597556219939;4976.576990955755;5040.319556859814;5043.344365232515;5062.392512898457;5132.563732082777;5357.330333708286;5373.113436283009;5471.835844924639;5487.6158668893195;5315.893682126355;5319.20211968206;5352.2239275305055;5645.887082258373;6051.727672254759;5392.110301800238;5405.297311349539;5407.459254074561;5410.404855465896;5428.158635411518;14155.85844141566;18709.50323974079;18732.812671873242;18758;20123.195072197093;2083.7603675577197;2101.674240492726;2123.3948324727535;2184.9781502184933;2218.5673793610254;8526.914730852674;8683.739487815375;9112.225460835836;9132.817343653156;9560.713178604654;1797.5416268851359;1804.7473353730488;1810.9909450452794;1851.5000949743628;1900.3633782682818;54754.341961574515;56975.145372819024;58195.76238138588;58851.41148588502;59245.11132333019;9844.655437059668;10195.592176312864;10302.639407620698;10312.381257124447;10439.321444106108;13566.321683915961;13646.795298070538;13662.385192666354;13675.111117777511;13685.931570342284;7083;7088.3974862136265;7145.6784444700115;7170.749023784247;7192.172900116449;6574.243961944438;6591.505637077143;6614.900776488356;6648.7340506379205;6679.031540426611;4384.4519435070615;4410.867673969786;4423.867283981485;4454.22051141049;4558.840440584564;1788.5439213000861;1837.384476200461;1879.8966056867005;2899.5215789394933;2970;901.8286525560122;952.3143336797494;964.3827950111934;981.3915372468972;987.5161171026145;14601;15043.398264069534;15358.078515289119;16560.337586496404;16939.915300423665;850.0776657326869;863.5509535041743;899.1772528136681;903.2412773270485;951.8619800129081;8264.256216940505;9666.661666841626;9797.363171393836;9798.755031124136;10019.148372388283;490416;492805;499507;507713;509684;71477.28522714706;74126.6293668539;74611;74912.25087749053;74963.62518187374;1094.6332978452149;1101.1466113761899;1103.933763974164;1121.4785124916953;1128.9379084150287;14498.637534061732;14788.260586970393;14823.33295001706;15203.543893683207;15342.30959606798;30792.38415231638;31157.221069473446;31552.211194720316;32820.671793282716;34712.479312810836;39578.406323904586;41948.79025604852;41972.79013604912;41999.58000420079;42058;7199.352058314567;7493.587852668155;7563.546187228784;7585.506942048749;7664.540127592362;10351.275410721177;10811.729706757395;10948.45257737126;11554.59558915434;11597.304161750322;9616.182624476998;9641.27690423235;9648.372855764354;9995;10221;9289.489078100769;9996.3002589818;10107.69676909694;10348.896511034793;10369.948150259503;10266.691999240034;10267.640632577824;10312.329698569569;10315.793684126425;10330.896691032993;7145.3211944867235;7201.747938822116;7214;7335.889961650686;7502.699892004259;7438.628068596657;10200.183985281012;10344.37933723979;10451.21615878797;10469.790604188025 23:24:37 INFO - PROCESS | 22838 | |3;mootools.html;1501.9474318398854;1504.668972825978;1681.4535276035283;1786.7766529183853;1845.4463660901727;7826.452148349618;7896.960515197423;8063.959680201606;8100.959495202523;8133.593320333982;8022.1576734442915;8024.558649274288;8098.838023239547;8116.513009219436;8141.063777665556;2347.7182738071415;2377.453185767266;2387.2002879035545;2388.7014123234594;2390.1992832401165;2379.773921477457;2387.7970372518357;2438.7073551173885;2439.060961529815;2439.6462512935614;2287.9771202288016;2346.483773569812;2362.090595120874;2368.928932132039;2385.5825230584664;2373.501564671421;2381.2856143157155;2398.7121545414575;2400.627902675088;2408.0969636386353;2387.176424133671;2409.8795060247094;2417.2627348658652;2417.5406672732124;2420.3707036170545;7995.120536740954;8023;8053.234942680436;8054.556999365032;8056.677732890677;4792.496787837262;4905.23968784839;4906.852794416138;4907.312976183337;4914.557689807899;3059.1587313488744;3088.6911308869157;3165.5409965554863;3176.2218256527067;3184.6178458584886;969.4038166527605;985.2708995343394;1021.8007488539738;1040.4693606260862;1805.8555315574722;10737.731556711067;10781.245312828105;10783.784324313548;10817.350958942488;10879.782404351949;4182.686298527623;4279.101388708344;4323.3947247385395;4367.213901497697;4392.143532011291;8849.955750221336;8852.734417967342;8858.689945851864;8875.28997680184;8890.110988901188;4843.927341089887;4852.441969173519;4855.684380515255;4869.440014398318;4888.413390393175;4358.389825424443;4445.133199026223;4453.309736990772;4468.932966005513;4486.1252055849445;3449.862005519751;3526.559180102487;3546.769459985093;3566.411542095525;3576.1774791798034;1066.594694016269;1104.1994553948323;1104.7017305327677;1120.0983208517223;1126.5550107707575;967.7870868408938;979.2215188924822;1090.5637744902103;1171.0924033873646;1254.8055051467038;7166.677499512534;7251.601161936039;7281.781546553612;7327.926720732831;7363.668634911442;1066.9413182274893;1072.9624463143753;1090.4002798460815;1102.818035024228;1119.1158984402232;5682.886342273131;5723.370429252779;5746.454086861741;5777.162311464814;5800.5939584229545;9389.154976052052;9930.50347482623;9973.451460169616;9978.251631127694;10036.749081272881;9604;9716.75708107303;9732.270079743907;9758.414495130315;9775.266854985763;7059.858802823915;7326.3406293433845;7347.889781653173;7420.5547667140145;7429.517081389692;6905.1713794345;7048.929510704827;7062.364387205176;7076.25699301566;7100.112485939258;8246.917530824616;8294.419390642597;8351;8426.199511046441;8438.367122465963;8446.07093219733;8556.058833528432;8581.35639827003;8595.44129631572;8682.34882383811;7056.435485161072;7143.499955003308;7146.142462904277;7148.606826624586;7157.964210178916;7514.511556748794;7615.124260710089;7646.273604007611;7653;7659.617019149132;7082.504224704221;7282.96358518204;7311.378532824557;7357.969884216107;7431.071116110486;6236.937630623817;6771.255161932282;6835.93164068353;6849.212340580897;6895.482838787011;6822.931770682429;6872.140982377203;6881.243063262937;6885.690143943434;6916.100906882073;6294.15028971083;6348.936510634834;6366.427021568081;6402;6410.871782564229;6318.210223722035;6367.299597044414;6415;6421.8715625688155;6430.453411460078 23:24:37 INFO - PROCESS | 22838 | |4;prototype.html;331.22162917144715;338.98474568644406;342.14975785173846;349.4757863205192;353.52450953467593;6222.813315600528;6282.717277722508;6298.614304852931;6324.114623952651;6415.935840641592;6131;6202.06968954657;6210.130581718552;6236.719347629368;6246.9062964055465;4822;4824.6381521385865;4826.662133650629;4827.61379089672;4865.48912364202;4842.3535997760755;4849.757512124397;4852.078105160026;4856.39295088114;4858.149823780842;4728.621710263188;4824.8552543423575;4825;4828.299896515021;4831.251156070797;4753.453352864431;4791.880202994918;4793.304970779235;4807.687500312469;4818.325434439182;4207.474065741782;4225.91548169038;4229.809658565372;4234.216669916075;4235;5951.018082016462;5961.701914904281;5966.731497082642;6001.879962400728;6004.489618382399;5508.614396992212;5615.691136987464;5637.577181711347;5648.293963254593;5653.745581448845;6675.731610993896;6678.43233325168;6690.096836927001;6691.933080669229;6700.698468568926;4700.801295669617;4709.929351059737;4712.5051869553545;4715.811367545329;4731.030138821533;6733.966330168318;6961.37347638715;6971.721131154748;7043.013978043129;7046.330598593126;4710.222813235846;4730.59789917854;4731.4795372509;4732.148213321566;4739.767660408319;4759.738214398172;4801.1117943180625;4805.9759701201965;4808.855734327975;4809.0862736080035;5565.30433695788;5567.3854582171525;5572.969000734877;5573;5579.6931168785295;6532.020196970398;6756.223034351015;6756.594604323756;6776.08522849409;6776.220734615484;1699.2523289752469;1724.1551639696459;1743.4246698589436;1747.764051853009;1755.4996825904557;1181.078758568318;1191.684203686024;1192.469351138735;1201.1831954271004;1205.1563905266173;6176.980798168342;6213.161223234805;6225.159603453566;6247.718852651551;6254.405831446005;6734.56225345351;6784.864302713918;6813.3527314905;6821.317868213238;6822;6079.817605471843;6180.351063138396;6227.19046523949;6229;6253.7185826637915;3692.1692619161013;3693.409054551259;3695.57500887396;3700.9814950925074;3716.9814150929615;7066.470014748915;7088.858222835514;7103.857922841515;7105.893411598727;7109.040279562297;6901.309869013058;7005.159380874327;7010.404115650227;7011.193712723102;7012.894806577905;7178.030965819547;7269.927300726925;7274.090738657668;7285.089363829521;7292.671829767673;6963.512554121366;6970.65146742671;6972.860542789217;6979.965100174467;6988.091548098715;6712.966435167793;6845.383915447634;6850;6896.069030680794;6906.136732908387;7208.639568021473;7209.783706488814;7237.601931893796;7245.166805817187;7261.273872612696;4525.456945166601;4536.11545748589;4547.886302842456;4558.316252562009;4570.748608826413;6804;6981.3367730065565;6999.1950925644205;7001.36987671112;7036.683349249399;6825.249222585412;6828.317168283132;6832.111825462658;6838.179418469816;6839.213490448463;6804.55770374924;6814.693338799667;6816.386525212754;6819.045333653194;6826.931730682828;6517.9348206517325;6673.766418175341;6675;6675.165604299463;6688.866222675422;6826.522143450109;6832.043513907957;6840.589564626139;6843.349881761224;6857.074294970115;6655.101561289164;6664.166979127609;6670.799876003728;6674.199096108498;6678.3989440950545 23:24:37 INFO - PROCESS | 22838 | |5;yui.html;643.9903401448979;677.6036018928926;694.6179601219328;777.3547955197186;810.4003037752063;11939.701507462318;11999;12008.09939254555;12074.698132546691;12092.637220883376;11211.439428028607;11421.42892855356;11426.828597571042;11431.485583148757;13094.607161785138;803.9397045221617;820.2453742556862;822.440740296598;823.81875987283;825.0882774534114;804.4811096842533;828.3704384667635;828.3745771942175;829.1211316005024;829.2868133405267;839.7984483723924;841.8905542279525;842.1914961636805;846.1327139681845;846.4117438380329;832.1553623072587;834.3700506117873;836.1680128272347;839.8278352937664;845.3152946113668;612.1002126873489;619.9225096862892;621.3848290192722;622.4180391334118;623.5385814497284;12836.16564923277;12890.355482225852;12892.935535322264;12964.611061668165;12983.480660773557;11790.35153066581;11878.346690931996;11926.224795388272;11971.64085077449;12186.455162900947;9768.120869121813;9842.704718858446;9909.306348555603;10014.54934527948;10067.748306292402;3433.296174284291;3469.444888817802;3469.7224222062173;3482.2687235680537;3482.4253998090285;47077.76461117707;47271.52728472705;47597.28604070942;47598.52401475976;47640.761796190796;8940.73177804667;9037.864432033524;9086.534884297673;9390.15488606015;9409.670661526814;17394.47816565505;17477.126143692763;17486.650266994842;17674.469765907044;17708.557286067695;6797.218319893275;6987.475939304572;7093.680784364716;7096.361327480448;7209.387202087776;3875.1668391296007;4144.896377590584;4145.751254924714;4151.833926642961;4159.563245859202;3155.4635711929027;3178.570892929425;3191.1543440988157;3194.425003499346;3194.552762613236;538.4373329870295;541.9945800542023;550.5072959701046;558.8379369982741;564.2326436046973;467.47876118128045;469.3030849188952;537.7848860455771;544.923710680505;579.2469789273927;7519.586422746802;7750.728724494616;7857.174996625272;7868.881966770503;8003.919960800434;577.5293136094153;584.5586582130464;589.9675517846559;603.1646170054419;608.5253502268149;3894.571597124314;3900.902477438087;4019.618136277049;4085.59144085595;4087.1212689271947;51480;52286.21570676443;52423.73788131111;52570.47429525656;52644.210336844975;47798;50982.49017509777;51011.7449412758;51687.22469162966;52504;41939.580604194176;42203.788981054895;42276;42410.57589424128;44095.11809763787;8062.113167551447;8135.755927321953;8407.15928407179;8443.197896199852;8888.777780555538;32771.18072048218;33164.50253246155;33567.16082097967;33672.83163584166;34244.48633270553;40002;41316.79341603273;41801.163976720905;42652.360214596185;42692.359614605186;10360.844587331045;10442.373457592568;10502.632407865687;10834.295770774874;10877.4017429039;11261.605843795427;11339.206255562362;11532.827007594726;11580.247283926517;11603.477843497232;10278;10414.73963150897;10609.734756630838;10692.411917344309;11025.83461248098;10687.82120234245;10709.946450267698;10763.515641796295;10792.460376980962;10911.399873006743;10363.274570779973;10405.427701476492;10808.729781755204;10840.349579025284;11060.834087488533;8673.609687563949;8778.956105219688;8905.51019693897;9175;9177.357584969255;8547.57262136903;9282.953585232031;9296.209822165192;9491.098345657152;9518.23854091685 23:24:37 INFO - PROCESS | 22838 | __end_tp_report 23:24:37 INFO - PROCESS | 22838 | __start_cc_report 23:24:37 INFO - PROCESS | 22838 | _x_x_mozilla_cycle_collect,317 23:24:37 INFO - PROCESS | 22838 | __end_cc_report 23:24:37 INFO - PROCESS | 22838 | __startTimestamp1453274677254__endTimestamp 23:24:37 INFO - PROCESS | 22838 | 23:24:37 INFO - PROCESS | 22838 | ------- Summary: start ------- 23:24:37 INFO - PROCESS | 22838 | Number of tests: 6 23:24:37 INFO - PROCESS | 22838 | 23:24:37 INFO - PROCESS | 22838 | [#0] dojo.html Cycles:165 Average:5335.84 Median:5518.12 stddev:589.58 (10.7%) stddev-sans-first:566.94 23:24:37 INFO - PROCESS | 22838 | Values: 3194.2 3237.7 3243.7 3264.2 3277.6 5194.3 5283.3 5299.6 5302.2 5319.4 5177.9 5214.8 5294.0 5348.1 5445.4 4899.0 4926.8 4946.4 4973.1 4978.6 4926.3 4932.4 4967.0 5003.1 5005.2 4740.4 4806.2 4829.0 4860.6 4871.1 4914.5 4917.0 4917.6 4942.8 4951.0 4890.3 4914.0 4918.8 4930.7 4939.7 5006.8 5086.1 5094.8 5240.9 5301.3 5736.4 5756.0 5760.9 5774.1 5786.1 5824.7 5827.9 5838.4 5838.7 5840.1 5284.4 5285.9 5329.5 5340.9 5342.9 5952.1 5961.2 5963.0 5964.7 6030.5 5726.3 5729.4 5738.7 5739.6 5753.6 5625.0 5746.3 5779.6 5786.3 5811.6 5730.7 5744.3 5748.3 5756.2 5777.3 5702.4 5714.1 5726.5 5733.7 5740.6 4339.2 4407.2 4420.0 4429.1 4470.1 3937.3 3963.7 3986.6 4000.3 4003.9 5210.3 5293.9 5303.9 5327.0 5366.3 5460.9 5540.2 5660.7 5675.4 5696.9 5415.5 5428.8 5442.2 5446.7 5450.7 4898.4 4917.5 4918.7 4925.6 4969.1 5733.7 5745.7 5985.4 5997.7 6111.4 5738.3 5739.4 5753.7 5760.2 5768.2 5922.9 5930.6 5977.1 5980.3 5994.8 5545.9 5623.0 5653.1 5664.9 5706.5 5789.7 5800.5 5804.4 5813.9 5826.0 5437.3 5656.2 5657.9 5670.7 5692.7 5497.3 5602.4 5605.2 5725.1 5790.3 5479.3 5512.8 5518.1 5525.6 5550.9 5590.8 5611.3 5611.7 5625.1 5627.4 5485.9 5508.3 5525.6 5592.5 5663.5 23:24:37 INFO - PROCESS | 22838 | 23:24:37 INFO - PROCESS | 22838 | [#1] ext.html Cycles:180 Average:44949.61 Median:36604.54 stddev:73943.37 (202.0%) stddev-sans-first:74075.61 23:24:37 INFO - PROCESS | 22838 | Values: 538.7 545.4 575.2 575.9 589.6 35697.8 36553.6 36655.5 36705.3 36756.3 40531.2 40659.2 40914.0 40945.6 41090.0 8409.8 8556.1 8568.7 8594.2 8612.6 8492.4 8667.0 8703.3 8711.3 8735.2 8737.0 8749.0 8764.3 8775.7 8817.4 8549.7 8671.6 8701.4 8713.8 8719.0 8537.4 8655.9 8660.3 8674.7 8685.1 38866.0 39317.2 39331.0 39331.8 39526.4 2805.2 3088.8 3104.6 3153.5 3180.8 26887.0 26924.0 28141.7 28227.7 28661.9 3067.4 3067.8 3116.3 3126.7 3156.6 224185.0 224821.0 225042.0 225892.0 226836.0 55960.2 56028.0 56032.4 56057.4 56315.2 65654.0 65793.3 65991.0 66428.7 66489.0 12849.1 13131.0 13199.6 13223.3 13243.0 9742.7 9807.7 9823.6 9841.7 9896.8 20105.4 20384.5 20459.4 20494.2 20936.9 7959.8 8180.4 8279.8 8286.5 8322.3 902.9 931.1 939.7 942.5 951.6 28580.7 28780.9 28888.4 29043.0 29163.3 1010.1 1023.8 1090.1 1115.3 1169.0 15057.0 15077.8 15117.8 15312.8 15365.8 316270.0 317551.0 319987.0 320012.0 320640.0 50663.0 51308.5 51336.7 51686.5 51764.7 1235.2 1246.6 1278.9 1283.1 1289.1 27962.0 28894.7 29050.8 29083.6 29134.7 46241.8 46423.8 46469.8 46545.9 46552.8 292512.0 293033.0 296219.0 297267.0 297322.0 28358.9 28980.0 31100.5 32121.5 32737.0 37209.1 38355.6 39375.2 39864.4 41037.0 34159.7 34365.7 34444.8 34737.8 35237.3 34791.7 35148.8 35400.8 37925.8 39596.0 33713.3 38314.8 39204.0 39234.0 39245.0 27798.6 32510.7 32783.7 32812.7 32948.0 25086.2 25198.9 25653.2 25911.4 27267.9 23:24:37 INFO - PROCESS | 22838 | 23:24:37 INFO - PROCESS | 22838 | [#2] jquery.html Cycles:180 Average:26328.10 Median:4439.04 stddev:81770.06 (1842.1%) stddev-sans-first:81976.19 23:24:37 INFO - PROCESS | 22838 | Values: 357.0 370.5 371.6 371.9 375.8 15435.2 17039.0 17260.6 17732.4 18200.3 11003.6 11532.5 16567.1 16591.8 16620.0 4629.7 4989.0 5063.5 5079.1 5079.5 4471.6 4976.6 5040.3 5043.3 5062.4 5132.6 5357.3 5373.1 5471.8 5487.6 5315.9 5319.2 5352.2 5645.9 6051.7 5392.1 5405.3 5407.5 5410.4 5428.2 14155.9 18709.5 18732.8 18758.0 20123.2 2083.8 2101.7 2123.4 2185.0 2218.6 8526.9 8683.7 9112.2 9132.8 9560.7 1797.5 1804.7 1811.0 1851.5 1900.4 54754.3 56975.1 58195.8 58851.4 59245.1 9844.7 10195.6 10302.6 10312.4 10439.3 13566.3 13646.8 13662.4 13675.1 13685.9 7083.0 7088.4 7145.7 7170.7 7192.2 6574.2 6591.5 6614.9 6648.7 6679.0 4384.5 4410.9 4423.9 4454.2 4558.8 1788.5 1837.4 1879.9 2899.5 2970.0 901.8 952.3 964.4 981.4 987.5 14601.0 15043.4 15358.1 16560.3 16939.9 850.1 863.6 899.2 903.2 951.9 8264.3 9666.7 9797.4 9798.8 10019.1 490416.0 492805.0 499507.0 507713.0 509684.0 71477.3 74126.6 74611.0 74912.3 74963.6 1094.6 1101.1 1103.9 1121.5 1128.9 14498.6 14788.3 14823.3 15203.5 15342.3 30792.4 31157.2 31552.2 32820.7 34712.5 39578.4 41948.8 41972.8 41999.6 42058.0 7199.4 7493.6 7563.5 7585.5 7664.5 10351.3 10811.7 10948.5 11554.6 11597.3 9616.2 9641.3 9648.4 9995.0 10221.0 9289.5 9996.3 10107.7 10348.9 10369.9 10266.7 10267.6 10312.3 10315.8 10330.9 7145.3 7201.7 7214.0 7335.9 7502.7 7438.6 10200.2 10344.4 10451.2 10469.8 23:24:37 INFO - PROCESS | 22838 | 23:24:37 INFO - PROCESS | 22838 | [#3] mootools.html Cycles:180 Average:5535.84 Median:6357.68 stddev:2848.57 (44.8%) stddev-sans-first:2840.42 23:24:37 INFO - PROCESS | 22838 | Values: 1501.9 1504.7 1681.5 1786.8 1845.4 7826.5 7897.0 8064.0 8101.0 8133.6 8022.2 8024.6 8098.8 8116.5 8141.1 2347.7 2377.5 2387.2 2388.7 2390.2 2379.8 2387.8 2438.7 2439.1 2439.6 2288.0 2346.5 2362.1 2368.9 2385.6 2373.5 2381.3 2398.7 2400.6 2408.1 2387.2 2409.9 2417.3 2417.5 2420.4 7995.1 8023.0 8053.2 8054.6 8056.7 4792.5 4905.2 4906.9 4907.3 4914.6 3059.2 3088.7 3165.5 3176.2 3184.6 969.4 985.3 1021.8 1040.5 1805.9 10737.7 10781.2 10783.8 10817.4 10879.8 4182.7 4279.1 4323.4 4367.2 4392.1 8850.0 8852.7 8858.7 8875.3 8890.1 4843.9 4852.4 4855.7 4869.4 4888.4 4358.4 4445.1 4453.3 4468.9 4486.1 3449.9 3526.6 3546.8 3566.4 3576.2 1066.6 1104.2 1104.7 1120.1 1126.6 967.8 979.2 1090.6 1171.1 1254.8 7166.7 7251.6 7281.8 7327.9 7363.7 1066.9 1073.0 1090.4 1102.8 1119.1 5682.9 5723.4 5746.5 5777.2 5800.6 9389.2 9930.5 9973.5 9978.3 10036.7 9604.0 9716.8 9732.3 9758.4 9775.3 7059.9 7326.3 7347.9 7420.6 7429.5 6905.2 7048.9 7062.4 7076.3 7100.1 8246.9 8294.4 8351.0 8426.2 8438.4 8446.1 8556.1 8581.4 8595.4 8682.3 7056.4 7143.5 7146.1 7148.6 7158.0 7514.5 7615.1 7646.3 7653.0 7659.6 7082.5 7283.0 7311.4 7358.0 7431.1 6236.9 6771.3 6835.9 6849.2 6895.5 6822.9 6872.1 6881.2 6885.7 6916.1 6294.2 6348.9 6366.4 6402.0 6410.9 6318.2 6367.3 6415.0 6421.9 6430.5 23:24:37 INFO - PROCESS | 22838 | 23:24:37 INFO - PROCESS | 22838 | [#4] prototype.html Cycles:180 Average:5602.17 Median:6232.86 stddev:1690.97 (27.1%) stddev-sans-first:1648.78 23:24:37 INFO - PROCESS | 22838 | Values: 331.2 339.0 342.1 349.5 353.5 6222.8 6282.7 6298.6 6324.1 6415.9 6131.0 6202.1 6210.1 6236.7 6246.9 4822.0 4824.6 4826.7 4827.6 4865.5 4842.4 4849.8 4852.1 4856.4 4858.1 4728.6 4824.9 4825.0 4828.3 4831.3 4753.5 4791.9 4793.3 4807.7 4818.3 4207.5 4225.9 4229.8 4234.2 4235.0 5951.0 5961.7 5966.7 6001.9 6004.5 5508.6 5615.7 5637.6 5648.3 5653.7 6675.7 6678.4 6690.1 6691.9 6700.7 4700.8 4709.9 4712.5 4715.8 4731.0 6734.0 6961.4 6971.7 7043.0 7046.3 4710.2 4730.6 4731.5 4732.1 4739.8 4759.7 4801.1 4806.0 4808.9 4809.1 5565.3 5567.4 5573.0 5573.0 5579.7 6532.0 6756.2 6756.6 6776.1 6776.2 1699.3 1724.2 1743.4 1747.8 1755.5 1181.1 1191.7 1192.5 1201.2 1205.2 6177.0 6213.2 6225.2 6247.7 6254.4 6734.6 6784.9 6813.4 6821.3 6822.0 6079.8 6180.4 6227.2 6229.0 6253.7 3692.2 3693.4 3695.6 3701.0 3717.0 7066.5 7088.9 7103.9 7105.9 7109.0 6901.3 7005.2 7010.4 7011.2 7012.9 7178.0 7269.9 7274.1 7285.1 7292.7 6963.5 6970.7 6972.9 6980.0 6988.1 6713.0 6845.4 6850.0 6896.1 6906.1 7208.6 7209.8 7237.6 7245.2 7261.3 4525.5 4536.1 4547.9 4558.3 4570.7 6804.0 6981.3 6999.2 7001.4 7036.7 6825.2 6828.3 6832.1 6838.2 6839.2 6804.6 6814.7 6816.4 6819.0 6826.9 6517.9 6673.8 6675.0 6675.2 6688.9 6826.5 6832.0 6840.6 6843.3 6857.1 6655.1 6664.2 6670.8 6674.2 6678.4 23:24:37 INFO - PROCESS | 22838 | 23:24:37 INFO - PROCESS | 22838 | [#5] yui.html Cycles:180 Average:13059.09 Median:47434.41 stddev:15113.26 (31.9%) stddev-sans-first:15126.90 23:24:37 INFO - PROCESS | 22838 | Values: 644.0 677.6 694.6 777.4 810.4 11939.7 11999.0 12008.1 12074.7 12092.6 11211.4 11421.4 11426.8 11431.5 13094.6 803.9 820.2 822.4 823.8 825.1 804.5 828.4 828.4 829.1 829.3 839.8 841.9 842.2 846.1 846.4 832.2 834.4 836.2 839.8 845.3 612.1 619.9 621.4 622.4 623.5 12836.2 12890.4 12892.9 12964.6 12983.5 11790.4 11878.3 11926.2 11971.6 12186.5 9768.1 9842.7 9909.3 10014.5 10067.7 3433.3 3469.4 3469.7 3482.3 3482.4 47077.8 47271.5 47597.3 47598.5 47640.8 8940.7 9037.9 9086.5 9390.2 9409.7 17394.5 17477.1 17486.7 17674.5 17708.6 6797.2 6987.5 7093.7 7096.4 7209.4 3875.2 4144.9 4145.8 4151.8 4159.6 3155.5 3178.6 3191.2 3194.4 3194.6 538.4 542.0 550.5 558.8 564.2 467.5 469.3 537.8 544.9 579.2 7519.6 7750.7 7857.2 7868.9 8003.9 577.5 584.6 590.0 603.2 608.5 3894.6 3900.9 4019.6 4085.6 4087.1 51480.0 52286.2 52423.7 52570.5 52644.2 47798.0 50982.5 51011.7 51687.2 52504.0 41939.6 42203.8 42276.0 42410.6 44095.1 8062.1 8135.8 8407.2 8443.2 8888.8 32771.2 33164.5 33567.2 33672.8 34244.5 40002.0 41316.8 41801.2 42652.4 42692.4 10360.8 10442.4 10502.6 10834.3 10877.4 11261.6 11339.2 11532.8 11580.2 11603.5 10278.0 10414.7 10609.7 10692.4 11025.8 10687.8 10709.9 10763.5 10792.5 10911.4 10363.3 10405.4 10808.7 10840.3 11060.8 8673.6 8779.0 8905.5 9175.0 9177.4 8547.6 9283.0 9296.2 9491.1 9518.2 23:24:37 INFO - PROCESS | 22838 | -------- Summary: end -------- 23:24:37 INFO - PROCESS | 22838 | 23:24:37 INFO - TEST-INFO | 22838: exit 0 23:24:37 INFO - TEST-OK | dromaeo_css | took 1111122ms 23:24:37 INFO - TEST-START | kraken 23:24:37 INFO - operating with platform_type : linux_ 23:24:37 INFO - Initialising browser for kraken test... 23:24:37 INFO - TEST-INFO | started process 23087 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHI61Uv/profile http://localhost:54048/getInfo.html) 23:24:41 INFO - PROCESS | 23087 | 23:24:41 INFO - PROCESS | 23087 | (process:23155): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:24:42 INFO - PROCESS | 23087 | __metrics Screen width/height:1600/1200 23:24:42 INFO - PROCESS | 23087 | colorDepth:24 23:24:42 INFO - PROCESS | 23087 | Browser inner width/height: 1024/697 23:24:42 INFO - PROCESS | 23087 | __metrics 23:24:42 INFO - PROCESS | 23087 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:24:42 INFO - PROCESS | 23087 | 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. 23:24:43 INFO - TEST-INFO | 23087: exit 0 23:24:43 INFO - Browser initialized. 23:24:43 INFO - Running cycle 1/1 for kraken test... 23:24:43 INFO - TEST-INFO | started process 23204 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHI61Uv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:24:44 INFO - PROCESS | 23204 | -- checkerboarding starts below -- 23:24:44 INFO - PROCESS | 23204 | RENDERTRACE 0.033301 rect red 0 0 10 10 // viewport 23:24:44 INFO - PROCESS | 23204 | RENDERTRACE 65.8397 rect brown 0 0 10 10 // page 23:24:44 INFO - PROCESS | 23204 | RENDERTRACE 65.859 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 23:24:44 INFO - PROCESS | 23204 | Checkerboarded for 1 frames (66.383 ms), 100 peak, 1 severity. 23:24:45 INFO - PROCESS | 23204 | 23:24:45 INFO - PROCESS | 23204 | (process:23260): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:24:55 INFO - PROCESS | 23204 | RSS: Main: 150265856 23:24:55 INFO - PROCESS | 23204 | 23:24:58 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54048/tests/kraken/driver.html?testName=audio-beat-detection) 23:24:58 INFO - PROCESS | 23204 | RSS: Main: 150806528 23:24:58 INFO - PROCESS | 23204 | 23:25:01 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54048/tests/kraken/driver.html?testName=audio-dft) 23:25:01 INFO - PROCESS | 23204 | RSS: Main: 154333184 23:25:01 INFO - PROCESS | 23204 | 23:25:04 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54048/tests/kraken/driver.html?testName=audio-fft) 23:25:05 INFO - PROCESS | 23204 | RSS: Main: 148762624 23:25:05 INFO - PROCESS | 23204 | 23:25:07 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54048/tests/kraken/driver.html?testName=audio-oscillator) 23:25:08 INFO - PROCESS | 23204 | RSS: Main: 148914176 23:25:08 INFO - PROCESS | 23204 | 23:25:10 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54048/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:25:11 INFO - PROCESS | 23204 | RSS: Main: 149299200 23:25:11 INFO - PROCESS | 23204 | 23:25:14 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54048/tests/kraken/driver.html?testName=imaging-darkroom) 23:25:14 INFO - PROCESS | 23204 | RSS: Main: 147980288 23:25:14 INFO - PROCESS | 23204 | 23:25:18 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54048/tests/kraken/driver.html?testName=imaging-desaturate) 23:25:18 INFO - PROCESS | 23204 | RSS: Main: 149262336 23:25:18 INFO - PROCESS | 23204 | 23:25:21 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54048/tests/kraken/driver.html?testName=json-parse-financial) 23:25:22 INFO - PROCESS | 23204 | RSS: Main: 148910080 23:25:22 INFO - PROCESS | 23204 | 23:25:23 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54048/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:25:24 INFO - PROCESS | 23204 | RSS: Main: 148307968 23:25:24 INFO - PROCESS | 23204 | 23:25:26 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54048/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:25:26 INFO - PROCESS | 23204 | RSS: Main: 150355968 23:25:26 INFO - PROCESS | 23204 | 23:25:28 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54048/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:25:29 INFO - PROCESS | 23204 | RSS: Main: 150679552 23:25:29 INFO - PROCESS | 23204 | 23:25:31 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54048/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:25:32 INFO - PROCESS | 23204 | RSS: Main: 148381696 23:25:32 INFO - PROCESS | 23204 | 23:25:34 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54048/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:25:35 INFO - PROCESS | 23204 | RSS: Main: 150298624 23:25:35 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | Cycle 1(1): loaded http://localhost:54048/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54048/tests/kraken/driver.html?testName=ai-astar) 23:25:37 INFO - PROCESS | 23204 | RSS: Main: 149405696 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | __start_tp_report 23:25:37 INFO - PROCESS | 23204 | _x_x_mozilla_page_load 23:25:37 INFO - PROCESS | 23204 | _x_x_mozilla_page_load_details 23:25:37 INFO - PROCESS | 23204 | |i|pagename|runs| 23:25:37 INFO - PROCESS | 23204 | |0;ai-astar;111;107;111;112;113;122;112;110;110;111 23:25:37 INFO - PROCESS | 23204 | |1;audio-beat-detection;153;132;151;164;133;152;153;130;163;132 23:25:37 INFO - PROCESS | 23204 | |2;audio-dft;164;164;163;164;164;164;165;174;163;165 23:25:37 INFO - PROCESS | 23204 | |3;audio-fft;73;76;75;74;74;75;144;75;73;75 23:25:37 INFO - PROCESS | 23204 | |4;audio-oscillator;96;98;139;96;98;97;153;97;99;138 23:25:37 INFO - PROCESS | 23204 | |5;imaging-gaussian-blur;110;110;110;111;110;110;109;110;109;109 23:25:37 INFO - PROCESS | 23204 | |6;imaging-darkroom;149;150;151;149;149;149;150;150;148;147 23:25:37 INFO - PROCESS | 23204 | |7;imaging-desaturate;97;96;98;99;97;97;97;96;97;96 23:25:37 INFO - PROCESS | 23204 | |8;json-parse-financial;58;65;59;60;58;61;59;59;67;57 23:25:37 INFO - PROCESS | 23204 | |9;json-stringify-tinderbox;69;70;70;70;68;70;70;70;72;69 23:25:37 INFO - PROCESS | 23204 | |10;stanford-crypto-aes;84;82;83;83;85;86;82;90;83;84 23:25:37 INFO - PROCESS | 23204 | |11;stanford-crypto-ccm;125;124;124;122;120;130;117;115;122;137 23:25:37 INFO - PROCESS | 23204 | |12;stanford-crypto-pbkdf2;139;140;145;133;141;130;141;147;136;130 23:25:37 INFO - PROCESS | 23204 | |13;stanford-crypto-sha256-iterative;67;71;67;69;69;76;66;68;68;67 23:25:37 INFO - PROCESS | 23204 | __end_tp_report 23:25:37 INFO - PROCESS | 23204 | __start_cc_report 23:25:37 INFO - PROCESS | 23204 | _x_x_mozilla_cycle_collect,747 23:25:37 INFO - PROCESS | 23204 | __end_cc_report 23:25:37 INFO - PROCESS | 23204 | __startTimestamp1453274737420__endTimestamp 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | ------- Summary: start ------- 23:25:37 INFO - PROCESS | 23204 | Number of tests: 14 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.50 stddev:3.90 (3.5%) stddev-sans-first:4.12 23:25:37 INFO - PROCESS | 23204 | Values: 111.0 107.0 111.0 112.0 113.0 122.0 112.0 110.0 110.0 111.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:152.50 stddev:13.28 (8.7%) stddev-sans-first:13.87 23:25:37 INFO - PROCESS | 23204 | Values: 153.0 132.0 151.0 164.0 133.0 152.0 153.0 130.0 163.0 132.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:3.23 (2.0%) stddev-sans-first:3.41 23:25:37 INFO - PROCESS | 23204 | Values: 164.0 164.0 163.0 164.0 164.0 164.0 165.0 174.0 163.0 165.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:22.02 (29.4%) stddev-sans-first:23.14 23:25:37 INFO - PROCESS | 23204 | Values: 73.0 76.0 75.0 74.0 74.0 75.0 144.0 75.0 73.0 75.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:97.00 stddev:22.61 (23.3%) stddev-sans-first:23.31 23:25:37 INFO - PROCESS | 23204 | Values: 96.0 98.0 139.0 96.0 98.0 97.0 153.0 97.0 99.0 138.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 23:25:37 INFO - PROCESS | 23204 | Values: 110.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 109.0 109.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.50 stddev:1.14 (0.8%) stddev-sans-first:1.20 23:25:37 INFO - PROCESS | 23204 | Values: 149.0 150.0 151.0 149.0 149.0 149.0 150.0 150.0 148.0 147.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 23:25:37 INFO - PROCESS | 23204 | Values: 97.0 96.0 98.0 99.0 97.0 97.0 97.0 96.0 97.0 96.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:59.50 stddev:3.23 (5.4%) stddev-sans-first:3.32 23:25:37 INFO - PROCESS | 23204 | Values: 58.0 65.0 59.0 60.0 58.0 61.0 59.0 59.0 67.0 57.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 23:25:37 INFO - PROCESS | 23204 | Values: 69.0 70.0 70.0 70.0 68.0 70.0 70.0 70.0 72.0 69.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:2.39 (2.9%) stddev-sans-first:2.54 23:25:37 INFO - PROCESS | 23204 | Values: 84.0 82.0 83.0 83.0 85.0 86.0 82.0 90.0 83.0 84.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:124.00 stddev:6.31 (5.1%) stddev-sans-first:6.67 23:25:37 INFO - PROCESS | 23204 | Values: 125.0 124.0 124.0 122.0 120.0 130.0 117.0 115.0 122.0 137.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.20 Median:140.50 stddev:5.87 (4.2%) stddev-sans-first:6.21 23:25:37 INFO - PROCESS | 23204 | Values: 139.0 140.0 145.0 133.0 141.0 130.0 141.0 147.0 136.0 130.0 23:25:37 INFO - PROCESS | 23204 | 23:25:37 INFO - PROCESS | 23204 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:2.90 (4.2%) stddev-sans-first:3.00 23:25:37 INFO - PROCESS | 23204 | Values: 67.0 71.0 67.0 69.0 69.0 76.0 66.0 68.0 68.0 67.0 23:25:37 INFO - PROCESS | 23204 | -------- Summary: end -------- 23:25:37 INFO - PROCESS | 23204 | 23:25:38 INFO - TEST-INFO | 23204: exit 0 23:25:38 INFO - TEST-OK | kraken | took 60475ms 23:25:38 INFO - TEST-START | v8_7 23:25:38 INFO - operating with platform_type : linux_ 23:25:38 INFO - Initialising browser for v8_7 test... 23:25:38 INFO - TEST-INFO | started process 23488 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpno1eew/profile http://localhost:54048/getInfo.html) 23:25:42 INFO - PROCESS | 23488 | 23:25:42 INFO - PROCESS | 23488 | (process:23560): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:25:43 INFO - PROCESS | 23488 | __metrics Screen width/height:1600/1200 23:25:43 INFO - PROCESS | 23488 | colorDepth:24 23:25:43 INFO - PROCESS | 23488 | Browser inner width/height: 1024/697 23:25:43 INFO - PROCESS | 23488 | __metrics 23:25:43 INFO - PROCESS | 23488 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:25:44 INFO - TEST-INFO | 23488: exit 0 23:25:44 INFO - Browser initialized. 23:25:44 INFO - Running cycle 1/1 for v8_7 test... 23:25:44 INFO - TEST-INFO | started process 23609 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpno1eew/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:44 INFO - PROCESS | 23609 | -- checkerboarding starts below -- 23:25:44 INFO - PROCESS | 23609 | RENDERTRACE 0.053554 rect red 0 0 10 10 // viewport 23:25:44 INFO - PROCESS | 23609 | RENDERTRACE 2.61393 rect red 0 0 10 10 // viewport 23:25:44 INFO - PROCESS | 23609 | RENDERTRACE 76.0384 rect brown 0 0 10 10 // page 23:25:44 INFO - PROCESS | 23609 | RENDERTRACE 76.0692 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 23:25:44 INFO - PROCESS | 23609 | Checkerboarded for 2 frames (78.5935 ms), 100 peak, 260 severity. 23:25:45 INFO - PROCESS | 23609 | 23:25:45 INFO - PROCESS | 23609 | (process:23666): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:25:55 INFO - PROCESS | 23609 | RSS: Main: 149995520 23:25:55 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | Cycle 1(1): loaded http://localhost:54048/tests/v8_7/run.html (next: http://localhost:54048/tests/v8_7/run.html) 23:26:18 INFO - PROCESS | 23609 | RSS: Main: 146604032 23:26:18 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | __start_tp_report 23:26:18 INFO - PROCESS | 23609 | _x_x_mozilla_page_load 23:26:18 INFO - PROCESS | 23609 | _x_x_mozilla_page_load_details 23:26:18 INFO - PROCESS | 23609 | |i|pagename|runs| 23:26:18 INFO - PROCESS | 23609 | |0;Richards;166.05778811026238 23:26:18 INFO - PROCESS | 23609 | |1;DeltaBlue;187.82870022539444 23:26:18 INFO - PROCESS | 23609 | |2;Encrypt;280.58361391694723 23:26:18 INFO - PROCESS | 23609 | |3;Decrypt;5223.958333333333 23:26:18 INFO - PROCESS | 23609 | |4;RayTrace;1106.1946902654868 23:26:18 INFO - PROCESS | 23609 | |5;Earley;724.112961622013 23:26:18 INFO - PROCESS | 23609 | |6;Boyer;12243.90243902439 23:26:18 INFO - PROCESS | 23609 | |7;RegExp;41285.71428571428 23:26:18 INFO - PROCESS | 23609 | |8;Splay;544.069640914037 23:26:18 INFO - PROCESS | 23609 | |9;NavierStokes;4835.748792270531 23:26:18 INFO - PROCESS | 23609 | __end_tp_report 23:26:18 INFO - PROCESS | 23609 | __startTimestamp1453274778627__endTimestamp 23:26:18 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | ------- Summary: start ------- 23:26:18 INFO - PROCESS | 23609 | Number of tests: 10 23:26:18 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 23:26:18 INFO - PROCESS | 23609 | Values: 166.1 23:26:18 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | [#1] DeltaBlue Cycles:1 Average:187.83 Median:187.83 stddev:0.00 (0.0%) 23:26:18 INFO - PROCESS | 23609 | Values: 187.8 23:26:18 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 23:26:18 INFO - PROCESS | 23609 | Values: 280.6 23:26:18 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 23:26:18 INFO - PROCESS | 23609 | Values: 5224.0 23:26:18 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | [#4] RayTrace Cycles:1 Average:1106.19 Median:1106.19 stddev:0.00 (0.0%) 23:26:18 INFO - PROCESS | 23609 | Values: 1106.2 23:26:18 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | [#5] Earley Cycles:1 Average:724.11 Median:724.11 stddev:0.00 (0.0%) 23:26:18 INFO - PROCESS | 23609 | Values: 724.1 23:26:18 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 23:26:18 INFO - PROCESS | 23609 | Values: 12243.9 23:26:18 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | [#7] RegExp Cycles:1 Average:41285.71 Median:41285.71 stddev:0.00 (0.0%) 23:26:18 INFO - PROCESS | 23609 | Values: 41285.7 23:26:18 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | [#8] Splay Cycles:1 Average:544.07 Median:544.07 stddev:0.00 (0.0%) 23:26:18 INFO - PROCESS | 23609 | Values: 544.1 23:26:18 INFO - PROCESS | 23609 | 23:26:18 INFO - PROCESS | 23609 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 23:26:18 INFO - PROCESS | 23609 | Values: 4835.7 23:26:18 INFO - PROCESS | 23609 | -------- Summary: end -------- 23:26:18 INFO - PROCESS | 23609 | 23:26:19 INFO - TEST-INFO | 23609: exit 0 23:26:19 INFO - TEST-OK | v8_7 | took 41144ms 23:26:19 INFO - SUITE-END | took 1212s 23:26:19 INFO - Completed test suite (00:20:12) 23:26:19 INFO - Working with test: dromaeo_css 23:26:19 INFO - Generating results file: dromaeo_css 23:26:19 INFO - Working with test: kraken 23:26:19 INFO - Generating results file: kraken 23:26:19 INFO - javascript benchmark 23:26:19 INFO - Working with test: v8_7 23:26:19 INFO - Generating results file: v8_7 23:26:19 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:26:19 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:26:19 INFO - process_Request line: dromaeo_css 6885.54 graph.html#tests=[[72,64,43]] 23:26:19 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:26:19 INFO - process_Request line: kraken 1516.60 graph.html#tests=[[232,64,43]] 23:26:19 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:26:19 INFO - process_Request line: v8_7 20480.19 graph.html#tests=[[230,64,43]] 23:26:19 INFO - RETURN: dromaeo_css: 6885.54 23:26:19 INFO - RETURN: kraken: 1516.60 23:26:19 INFO - RETURN: v8_7: 20480.19 23:26:19 INFO - javascript benchmark 23:26:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3194.1695159258593, 3237.7086062254393, 3243.7242834359063, 3264.2165880188763, 3277.573915390999, 5194.27280180775, 5283.339582552177, 5299.629025968184, 5302.2311764794085, 5319.388270348911, 5177.870553236171, 5214.817481388152, 5294.047071527124, 5348.0640887844565, 5445.37378201506, 4898.999999999991, 4926.827561035365, 4946.3817022872145, 4973.104841128596, 4978.6017118630425, 4926.334944782462, 4932.408111026664, 4967.0, 5003.074431230216, 5005.199168133099, 4740.431148262196, 4806.158922188603, 4828.975855120737, 4860.6111511079025, 4871.050145221683, 4914.508549145093, 4916.975415122902, 4917.60659147271, 4942.752862356868, 4951.0, 4890.266460031024, 4913.975430122827, 4918.778654960535, 4930.728809915489, 4939.74036620663, 5006.799728010875, 5086.084504789136, 5094.847154585368, 5240.9213861792105, 5301.284326615896, 5736.426357364272, 5756.02147634903, 5760.942390576082, 5774.133879918004, 5786.0742281235225, 5824.737886795105, 5827.941720582782, 5838.41615838417, 5838.7372568234105, 5840.065589505659, 5284.365876094893, 5285.86785330366, 5329.467053294678, 5340.866478338073, 5342.866428339284, 5952.107183922446, 5961.165436838846, 5963.0459126539545, 5964.7315870785915, 6030.547708921761, 5726.3128424588485, 5729.369769325371, 5738.741756620962, 5739.569532285095, 5753.626014309057, 5625.0, 5746.281714785652, 5779.595428320062, 5786.276715410574, 5811.564132690065, 5730.7421166047625, 5744.253247077853, 5748.31020277561, 5756.222909907193, 5777.335606405317, 5702.372738998707, 5714.085746280658, 5726.484616384545, 5733.71331433435, 5740.6268592541355, 4339.1972485090355, 4407.162639098561, 4419.9779001105435, 4429.069895321954, 4470.083632855257, 3937.291287568265, 3963.6829053675638, 3986.6412022918075, 4000.3399439092223, 4003.8598649047144, 5210.348706411699, 5293.947060529423, 5303.920441193385, 5326.97336513315, 5366.329208848894, 5460.918086228709, 5540.168974653834, 5660.660360378391, 5675.404082571271, 5696.8860622787315, 5415.53967912724, 5428.809991650273, 5442.2380866678695, 5446.727663616883, 5450.727463626803, 4898.4121905371585, 4917.483664215278, 4918.729469879191, 4925.556699897026, 4969.105560999054, 5733.655980641091, 5745.712714364348, 5985.371535988746, 5997.730102145414, 6111.358307377662, 5738.254026976467, 5739.397363276796, 5753.654780713171, 5760.222369979999, 5768.1636162757, 5922.881542369215, 5930.584859059824, 5977.073553599199, 5980.282366116094, 5994.820155395345, 5545.889082218414, 5622.971885140548, 5653.123765816305, 5664.886702266014, 5706.543476521952, 5789.652620842763, 5800.50695690871, 5804.361520232686, 5813.854653633693, 5825.970870145622, 5437.32033495813, 5656.151577263443, 5657.886842263214, 5670.744816483186, 5692.743826527733, 5497.285352904097, 5602.411746766531, 5605.215269862304, 5725.08398656213, 5790.334111577223, 5479.287692599936, 5512.834614961557, 5518.117101263779, 5525.557955363642, 5550.916736249041, 5590.776368945197, 5611.298587676541, 5611.747471363717, 5625.128105143709, 5627.352854421794, 5485.945140548703, 5508.3114610673665, 5525.557955363481, 5592.468715472024, 5663.490285874291], "unit": "score", "name": "dojo.html", "value": 5298.133492258554}, {"lowerIsBetter": false, "replicates": [538.7171734839209, 545.370097537344, 575.1947273816659, 575.8819442014386, 589.599072630611, 35697.82151089247, 36553.634463655355, 36655.450168247495, 36705.265894682154, 36756.26487470252, 40531.18937621246, 40659.18681626366, 40914.0, 40945.59054409462, 41090.0, 8409.83180336393, 8556.144385561425, 8568.742937711879, 8594.183552562528, 8612.612432440525, 8492.447990880604, 8667.046624871258, 8703.30373570116, 8711.259542938826, 8735.1701588349, 8736.956315218415, 8749.0, 8764.25503832175, 8775.692850750225, 8817.382783205177, 8549.658013679446, 8671.609777560025, 8701.39090263685, 8713.7821554461, 8718.956405217965, 8537.402381833273, 8655.913440865574, 8660.26387757035, 8674.696385626472, 8685.088065753069, 38866.0, 39317.21365572672, 39331.0, 39331.803340983395, 39526.40710389318, 2805.2005178524023, 3088.7528997680133, 3104.580881581003, 3153.4639111351125, 3180.77734558581, 26887.0, 26924.0, 28141.718582814116, 28227.71772282292, 28661.85669071662, 3067.432524982863, 3067.8159310441447, 3116.345567430842, 3126.702963218491, 3156.589643346373, 224185.0, 224821.0, 225042.0, 225892.0, 226836.0, 55960.16059759107, 56028.0, 56032.43967560272, 56057.43942560604, 56315.15527267094, 65654.0, 65793.34206657873, 65991.0, 66428.66785666137, 66489.0, 12849.100562960502, 13131.0, 13199.604011879659, 13223.2727200003, 13243.0, 9742.659006934724, 9807.656732014346, 9823.557939892578, 9841.655542056136, 9896.752581185528, 20105.39683809488, 20384.49038774013, 20459.38621841347, 20494.18023279052, 20936.895315523325, 7959.84080318402, 8180.386471014579, 8279.812272275098, 8286.46138001028, 8322.292605128632, 902.8645703144449, 931.0735817861272, 939.6711151097198, 942.4533770413144, 951.6145960885852, 28580.71419285822, 28780.856095719388, 28888.42223155525, 29043.0, 29163.27091822679, 1010.0505524806658, 1023.8464230365505, 1090.1387903556101, 1115.297362661518, 1169.0005045685987, 15057.0, 15077.773833392508, 15117.773233401507, 15312.770308445382, 15365.846341536442, 316270.0, 317551.0, 319987.0, 320012.0, 320640.0, 50663.0, 51308.48691513037, 51336.74331628318, 51686.48313516892, 51764.74117629463, 1235.2218102595307, 1246.6010876519426, 1278.8849003589535, 1283.1210620724833, 1289.0976316578244, 27962.0, 28894.71105289004, 29050.762961894296, 29083.56374654424, 29134.7086529132, 46241.76879115718, 46423.76788116038, 46469.76765116153, 46545.8799532058, 46552.7672361636, 292512.0, 293033.0, 296219.0, 297267.0, 297322.0, 28358.85820570884, 28980.0, 31100.533491997187, 32121.51817722689, 32737.0, 37209.069773255884, 38355.61644383632, 39375.21249574935, 39864.40203396893, 41037.0, 34159.65840341565, 34365.65634343625, 34444.82777586096, 34737.82631086828, 35237.295254094264, 34791.65208347884, 35148.82425587856, 35400.82299588485, 37925.81037094797, 39596.0, 33713.3257334847, 38314.80842595769, 39204.0, 39234.0, 39245.0, 27798.583021254293, 32510.67489325171, 32783.67216327806, 32812.67187328096, 32948.0, 25086.247412577653, 25198.874005629856, 25653.23040308794, 25911.352216194748, 27267.86366068157], "unit": "score", "name": "ext.html", "value": 17923.53764184294}, {"lowerIsBetter": false, "replicates": [356.9767965082269, 370.48502581411833, 371.5708356847841, 371.9144596742749, 375.75012616609956, 15435.228238588068, 17039.0, 17260.568485787862, 17732.37936672217, 18200.271989120418, 11003.61487347941, 11532.481038353273, 16567.088810115438, 16591.83408165918, 16620.0, 4629.675922685405, 4988.950110498885, 5063.46833582474, 5079.1365467870555, 5079.466656001122, 4471.597556219939, 4976.576990955755, 5040.319556859814, 5043.344365232515, 5062.392512898457, 5132.563732082777, 5357.330333708286, 5373.113436283009, 5471.835844924639, 5487.6158668893195, 5315.893682126355, 5319.20211968206, 5352.2239275305055, 5645.887082258373, 6051.727672254759, 5392.110301800238, 5405.297311349539, 5407.459254074561, 5410.404855465896, 5428.158635411518, 14155.85844141566, 18709.50323974079, 18732.812671873242, 18758.0, 20123.195072197093, 2083.7603675577197, 2101.674240492726, 2123.3948324727535, 2184.9781502184933, 2218.5673793610254, 8526.914730852674, 8683.739487815375, 9112.225460835836, 9132.817343653156, 9560.713178604654, 1797.5416268851359, 1804.7473353730488, 1810.9909450452794, 1851.5000949743628, 1900.3633782682818, 54754.341961574515, 56975.145372819024, 58195.76238138588, 58851.41148588502, 59245.11132333019, 9844.655437059668, 10195.592176312864, 10302.639407620698, 10312.381257124447, 10439.321444106108, 13566.321683915961, 13646.795298070538, 13662.385192666354, 13675.111117777511, 13685.931570342284, 7083.0, 7088.3974862136265, 7145.6784444700115, 7170.749023784247, 7192.172900116449, 6574.243961944438, 6591.505637077143, 6614.900776488356, 6648.7340506379205, 6679.031540426611, 4384.4519435070615, 4410.867673969786, 4423.867283981485, 4454.22051141049, 4558.840440584564, 1788.5439213000861, 1837.384476200461, 1879.8966056867005, 2899.5215789394933, 2970.0, 901.8286525560122, 952.3143336797494, 964.3827950111934, 981.3915372468972, 987.5161171026145, 14601.0, 15043.398264069534, 15358.078515289119, 16560.337586496404, 16939.915300423665, 850.0776657326869, 863.5509535041743, 899.1772528136681, 903.2412773270485, 951.8619800129081, 8264.256216940505, 9666.661666841626, 9797.363171393836, 9798.755031124136, 10019.148372388283, 490416.0, 492805.0, 499507.0, 507713.0, 509684.0, 71477.28522714706, 74126.6293668539, 74611.0, 74912.25087749053, 74963.62518187374, 1094.6332978452149, 1101.1466113761899, 1103.933763974164, 1121.4785124916953, 1128.9379084150287, 14498.637534061732, 14788.260586970393, 14823.33295001706, 15203.543893683207, 15342.30959606798, 30792.38415231638, 31157.221069473446, 31552.211194720316, 32820.671793282716, 34712.479312810836, 39578.406323904586, 41948.79025604852, 41972.79013604912, 41999.58000420079, 42058.0, 7199.352058314567, 7493.587852668155, 7563.546187228784, 7585.506942048749, 7664.540127592362, 10351.275410721177, 10811.729706757395, 10948.45257737126, 11554.59558915434, 11597.304161750322, 9616.182624476998, 9641.27690423235, 9648.372855764354, 9995.0, 10221.0, 9289.489078100769, 9996.3002589818, 10107.69676909694, 10348.896511034793, 10369.948150259503, 10266.691999240034, 10267.640632577824, 10312.329698569569, 10315.793684126425, 10330.896691032993, 7145.3211944867235, 7201.747938822116, 7214.0, 7335.889961650686, 7502.699892004259, 7438.628068596657, 10200.183985281012, 10344.37933723979, 10451.21615878797, 10469.790604188025], "unit": "score", "name": "jquery.html", "value": 8120.915664545064}, {"lowerIsBetter": false, "replicates": [1501.9474318398854, 1504.668972825978, 1681.4535276035283, 1786.7766529183853, 1845.4463660901727, 7826.452148349618, 7896.960515197423, 8063.959680201606, 8100.959495202523, 8133.593320333982, 8022.1576734442915, 8024.558649274288, 8098.838023239547, 8116.513009219436, 8141.063777665556, 2347.7182738071415, 2377.453185767266, 2387.2002879035545, 2388.7014123234594, 2390.1992832401165, 2379.773921477457, 2387.7970372518357, 2438.7073551173885, 2439.060961529815, 2439.6462512935614, 2287.9771202288016, 2346.483773569812, 2362.090595120874, 2368.928932132039, 2385.5825230584664, 2373.501564671421, 2381.2856143157155, 2398.7121545414575, 2400.627902675088, 2408.0969636386353, 2387.176424133671, 2409.8795060247094, 2417.2627348658652, 2417.5406672732124, 2420.3707036170545, 7995.120536740954, 8023.0, 8053.234942680436, 8054.556999365032, 8056.677732890677, 4792.496787837262, 4905.23968784839, 4906.852794416138, 4907.312976183337, 4914.557689807899, 3059.1587313488744, 3088.6911308869157, 3165.5409965554863, 3176.2218256527067, 3184.6178458584886, 969.4038166527605, 985.2708995343394, 1021.8007488539738, 1040.4693606260862, 1805.8555315574722, 10737.731556711067, 10781.245312828105, 10783.784324313548, 10817.350958942488, 10879.782404351949, 4182.686298527623, 4279.101388708344, 4323.3947247385395, 4367.213901497697, 4392.143532011291, 8849.955750221336, 8852.734417967342, 8858.689945851864, 8875.28997680184, 8890.110988901188, 4843.927341089887, 4852.441969173519, 4855.684380515255, 4869.440014398318, 4888.413390393175, 4358.389825424443, 4445.133199026223, 4453.309736990772, 4468.932966005513, 4486.1252055849445, 3449.862005519751, 3526.559180102487, 3546.769459985093, 3566.411542095525, 3576.1774791798034, 1066.594694016269, 1104.1994553948323, 1104.7017305327677, 1120.0983208517223, 1126.5550107707575, 967.7870868408938, 979.2215188924822, 1090.5637744902103, 1171.0924033873646, 1254.8055051467038, 7166.677499512534, 7251.601161936039, 7281.781546553612, 7327.926720732831, 7363.668634911442, 1066.9413182274893, 1072.9624463143753, 1090.4002798460815, 1102.818035024228, 1119.1158984402232, 5682.886342273131, 5723.370429252779, 5746.454086861741, 5777.162311464814, 5800.5939584229545, 9389.154976052052, 9930.50347482623, 9973.451460169616, 9978.251631127694, 10036.749081272881, 9604.0, 9716.75708107303, 9732.270079743907, 9758.414495130315, 9775.266854985763, 7059.858802823915, 7326.3406293433845, 7347.889781653173, 7420.5547667140145, 7429.517081389692, 6905.1713794345, 7048.929510704827, 7062.364387205176, 7076.25699301566, 7100.112485939258, 8246.917530824616, 8294.419390642597, 8351.0, 8426.199511046441, 8438.367122465963, 8446.07093219733, 8556.058833528432, 8581.35639827003, 8595.44129631572, 8682.34882383811, 7056.435485161072, 7143.499955003308, 7146.142462904277, 7148.606826624586, 7157.964210178916, 7514.511556748794, 7615.124260710089, 7646.273604007611, 7653.0, 7659.617019149132, 7082.504224704221, 7282.96358518204, 7311.378532824557, 7357.969884216107, 7431.071116110486, 6236.937630623817, 6771.255161932282, 6835.93164068353, 6849.212340580897, 6895.482838787011, 6822.931770682429, 6872.140982377203, 6881.243063262937, 6885.690143943434, 6916.100906882073, 6294.15028971083, 6348.936510634834, 6366.427021568081, 6402.0, 6410.871782564229, 6318.210223722035, 6367.299597044414, 6415.0, 6421.8715625688155, 6430.453411460078], "unit": "score", "name": "mootools.html", "value": 4564.900032467224}, {"lowerIsBetter": false, "replicates": [331.22162917144715, 338.98474568644406, 342.14975785173846, 349.4757863205192, 353.52450953467593, 6222.813315600528, 6282.717277722508, 6298.614304852931, 6324.114623952651, 6415.935840641592, 6131.0, 6202.06968954657, 6210.130581718552, 6236.719347629368, 6246.9062964055465, 4822.0, 4824.6381521385865, 4826.662133650629, 4827.61379089672, 4865.48912364202, 4842.3535997760755, 4849.757512124397, 4852.078105160026, 4856.39295088114, 4858.149823780842, 4728.621710263188, 4824.8552543423575, 4825.0, 4828.299896515021, 4831.251156070797, 4753.453352864431, 4791.880202994918, 4793.304970779235, 4807.687500312469, 4818.325434439182, 4207.474065741782, 4225.91548169038, 4229.809658565372, 4234.216669916075, 4235.0, 5951.018082016462, 5961.701914904281, 5966.731497082642, 6001.879962400728, 6004.489618382399, 5508.614396992212, 5615.691136987464, 5637.577181711347, 5648.293963254593, 5653.745581448845, 6675.731610993896, 6678.43233325168, 6690.096836927001, 6691.933080669229, 6700.698468568926, 4700.801295669617, 4709.929351059737, 4712.5051869553545, 4715.811367545329, 4731.030138821533, 6733.966330168318, 6961.37347638715, 6971.721131154748, 7043.013978043129, 7046.330598593126, 4710.222813235846, 4730.59789917854, 4731.4795372509, 4732.148213321566, 4739.767660408319, 4759.738214398172, 4801.1117943180625, 4805.9759701201965, 4808.855734327975, 4809.0862736080035, 5565.30433695788, 5567.3854582171525, 5572.969000734877, 5573.0, 5579.6931168785295, 6532.020196970398, 6756.223034351015, 6756.594604323756, 6776.08522849409, 6776.220734615484, 1699.2523289752469, 1724.1551639696459, 1743.4246698589436, 1747.764051853009, 1755.4996825904557, 1181.078758568318, 1191.684203686024, 1192.469351138735, 1201.1831954271004, 1205.1563905266173, 6176.980798168342, 6213.161223234805, 6225.159603453566, 6247.718852651551, 6254.405831446005, 6734.56225345351, 6784.864302713918, 6813.3527314905, 6821.317868213238, 6822.0, 6079.817605471843, 6180.351063138396, 6227.19046523949, 6229.0, 6253.7185826637915, 3692.1692619161013, 3693.409054551259, 3695.57500887396, 3700.9814950925074, 3716.9814150929615, 7066.470014748915, 7088.858222835514, 7103.857922841515, 7105.893411598727, 7109.040279562297, 6901.309869013058, 7005.159380874327, 7010.404115650227, 7011.193712723102, 7012.894806577905, 7178.030965819547, 7269.927300726925, 7274.090738657668, 7285.089363829521, 7292.671829767673, 6963.512554121366, 6970.65146742671, 6972.860542789217, 6979.965100174467, 6988.091548098715, 6712.966435167793, 6845.383915447634, 6850.0, 6896.069030680794, 6906.136732908387, 7208.639568021473, 7209.783706488814, 7237.601931893796, 7245.166805817187, 7261.273872612696, 4525.456945166601, 4536.11545748589, 4547.886302842456, 4558.316252562009, 4570.748608826413, 6804.0, 6981.3367730065565, 6999.1950925644205, 7001.36987671112, 7036.683349249399, 6825.249222585412, 6828.317168283132, 6832.111825462658, 6838.179418469816, 6839.213490448463, 6804.55770374924, 6814.693338799667, 6816.386525212754, 6819.045333653194, 6826.931730682828, 6517.9348206517325, 6673.766418175341, 6675.0, 6675.165604299463, 6688.866222675422, 6826.522143450109, 6832.043513907957, 6840.589564626139, 6843.349881761224, 6857.074294970115, 6655.101561289164, 6664.166979127609, 6670.799876003728, 6674.199096108498, 6678.3989440950545], "unit": "score", "name": "prototype.html", "value": 5053.952801302924}, {"lowerIsBetter": false, "replicates": [643.9903401448979, 677.6036018928926, 694.6179601219328, 777.3547955197186, 810.4003037752063, 11939.701507462318, 11999.0, 12008.09939254555, 12074.698132546691, 12092.637220883376, 11211.439428028607, 11421.42892855356, 11426.828597571042, 11431.485583148757, 13094.607161785138, 803.9397045221617, 820.2453742556862, 822.440740296598, 823.81875987283, 825.0882774534114, 804.4811096842533, 828.3704384667635, 828.3745771942175, 829.1211316005024, 829.2868133405267, 839.7984483723924, 841.8905542279525, 842.1914961636805, 846.1327139681845, 846.4117438380329, 832.1553623072587, 834.3700506117873, 836.1680128272347, 839.8278352937664, 845.3152946113668, 612.1002126873489, 619.9225096862892, 621.3848290192722, 622.4180391334118, 623.5385814497284, 12836.16564923277, 12890.355482225852, 12892.935535322264, 12964.611061668165, 12983.480660773557, 11790.35153066581, 11878.346690931996, 11926.224795388272, 11971.64085077449, 12186.455162900947, 9768.120869121813, 9842.704718858446, 9909.306348555603, 10014.54934527948, 10067.748306292402, 3433.296174284291, 3469.444888817802, 3469.7224222062173, 3482.2687235680537, 3482.4253998090285, 47077.76461117707, 47271.52728472705, 47597.28604070942, 47598.52401475976, 47640.761796190796, 8940.73177804667, 9037.864432033524, 9086.534884297673, 9390.15488606015, 9409.670661526814, 17394.47816565505, 17477.126143692763, 17486.650266994842, 17674.469765907044, 17708.557286067695, 6797.218319893275, 6987.475939304572, 7093.680784364716, 7096.361327480448, 7209.387202087776, 3875.1668391296007, 4144.896377590584, 4145.751254924714, 4151.833926642961, 4159.563245859202, 3155.4635711929027, 3178.570892929425, 3191.1543440988157, 3194.425003499346, 3194.552762613236, 538.4373329870295, 541.9945800542023, 550.5072959701046, 558.8379369982741, 564.2326436046973, 467.47876118128045, 469.3030849188952, 537.7848860455771, 544.923710680505, 579.2469789273927, 7519.586422746802, 7750.728724494616, 7857.174996625272, 7868.881966770503, 8003.919960800434, 577.5293136094153, 584.5586582130464, 589.9675517846559, 603.1646170054419, 608.5253502268149, 3894.571597124314, 3900.902477438087, 4019.618136277049, 4085.59144085595, 4087.1212689271947, 51480.0, 52286.21570676443, 52423.73788131111, 52570.47429525656, 52644.210336844975, 47798.0, 50982.49017509777, 51011.7449412758, 51687.22469162966, 52504.0, 41939.580604194176, 42203.788981054895, 42276.0, 42410.57589424128, 44095.11809763787, 8062.113167551447, 8135.755927321953, 8407.15928407179, 8443.197896199852, 8888.777780555538, 32771.18072048218, 33164.50253246155, 33567.16082097967, 33672.83163584166, 34244.48633270553, 40002.0, 41316.79341603273, 41801.163976720905, 42652.360214596185, 42692.359614605186, 10360.844587331045, 10442.373457592568, 10502.632407865687, 10834.295770774874, 10877.4017429039, 11261.605843795427, 11339.206255562362, 11532.827007594726, 11580.247283926517, 11603.477843497232, 10278.0, 10414.73963150897, 10609.734756630838, 10692.411917344309, 11025.83461248098, 10687.82120234245, 10709.946450267698, 10763.515641796295, 10792.460376980962, 10911.399873006743, 10363.274570779973, 10405.427701476492, 10808.729781755204, 10840.349579025284, 11060.834087488533, 8673.609687563949, 8778.956105219688, 8905.51019693897, 9175.0, 9177.357584969255, 8547.57262136903, 9282.953585232031, 9296.209822165192, 9491.098345657152, 9518.23854091685], "unit": "score", "name": "yui.html", "value": 5989.364189242831}], "name": "dromaeo_css", "value": 6885.544179153246}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 111.0, 112.0, 113.0, 122.0, 112.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 151.0, 164.0, 133.0, 152.0, 153.0, 130.0, 163.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 163.0, 164.0, 164.0, 164.0, 165.0, 174.0, 163.0, 165.0], "unit": "score", "name": "audio-dft", "value": 165.0}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 75.0, 74.0, 74.0, 75.0, 144.0, 75.0, 73.0, 75.0], "unit": "score", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 139.0, 96.0, 98.0, 97.0, 153.0, 97.0, 99.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 111.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [149.0, 150.0, 151.0, 149.0, 149.0, 149.0, 150.0, 150.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 149.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 98.0, 99.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [58.0, 65.0, 59.0, 60.0, 58.0, 61.0, 59.0, 59.0, 67.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 68.0, 70.0, 70.0, 70.0, 72.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 83.0, 83.0, 85.0, 86.0, 82.0, 90.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [125.0, 124.0, 124.0, 122.0, 120.0, 130.0, 117.0, 115.0, 122.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [139.0, 140.0, 145.0, 133.0, 141.0, 130.0, 141.0, 147.0, 136.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.2}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 67.0, 69.0, 69.0, 76.0, 66.0, 68.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1516.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [187.82870022539444], "unit": "score", "name": "DeltaBlue", "value": 352.01223200000004}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1106.1946902654868], "unit": "score", "name": "RayTrace", "value": 668.9500559999998}, {"lowerIsBetter": false, "replicates": [724.112961622013], "unit": "score", "name": "Earley", "value": 920.3854029999999}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [41285.71428571428], "unit": "score", "name": "RegExp", "value": 22.06538062283738}, {"lowerIsBetter": false, "replicates": [544.069640914037], "unit": "score", "name": "Splay", "value": 149.78045800000007}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20480.187098279766}]} 23:26:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20480.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1516.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6885.54"}}} 23:26:20 INFO - Return code: 0 23:26:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:26:20 INFO - # TBPL SUCCESS # 23:26:20 INFO - Running post-action listener: _resource_record_post_action 23:26:20 INFO - Running post-run listener: _resource_record_post_run 23:26:21 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 566878208; Read time: 0; Write time: 692580 23:26:21 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 254414848; Read time: 0; Write time: 463024 23:26:21 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 312463360; Read time: 0; Write time: 229556 23:26:21 INFO - Running post-run listener: _upload_blobber_files 23:26:21 INFO - Blob upload gear active. 23:26:21 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:26:21 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 23:26:21 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'] 23:26:21 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 23:26:21 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:26:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:26:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:22 INFO - (blobuploader) - INFO - Done attempting. 23:26:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:26:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:23 INFO - (blobuploader) - INFO - Done attempting. 23:26:23 INFO - (blobuploader) - INFO - Iteration through files over. 23:26:23 INFO - Return code: 0 23:26:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:26:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:26:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2254cd1df85d1ddab183875147cb54e7d7b93c8d47fa00335099974c813e4cf3b1e43ae09c0ffc7de502fba50a3484a6de56996db6047dec59c6483e52565180", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e340e9363395b5f0e6253b3a69db9b0788dfa15d09e3072a844a3af1262580eedbe04ae3264f86734b252e4babf218c547801761c7e6ad5b499e1e09f083bbe"} 23:26:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:26:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:26:23 INFO - Contents: 23:26:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2254cd1df85d1ddab183875147cb54e7d7b93c8d47fa00335099974c813e4cf3b1e43ae09c0ffc7de502fba50a3484a6de56996db6047dec59c6483e52565180", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e340e9363395b5f0e6253b3a69db9b0788dfa15d09e3072a844a3af1262580eedbe04ae3264f86734b252e4babf218c547801761c7e6ad5b499e1e09f083bbe"} 23:26:23 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:23 INFO - Copying logs to upload dir... 23:26:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:26:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.191040 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-19 23:26:23.441096) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 23:26:23.444473) ========= 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=52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410 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/2254cd1df85d1ddab183875147cb54e7d7b93c8d47fa00335099974c813e4cf3b1e43ae09c0ffc7de502fba50a3484a6de56996db6047dec59c6483e52565180", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e340e9363395b5f0e6253b3a69db9b0788dfa15d09e3072a844a3af1262580eedbe04ae3264f86734b252e4babf218c547801761c7e6ad5b499e1e09f083bbe"} build_url:https://queue.taskcluster.net/v1/task/BG3lbBFlQHCTWfaK3HBe4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/BG3lbBFlQHCTWfaK3HBe4g/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/2254cd1df85d1ddab183875147cb54e7d7b93c8d47fa00335099974c813e4cf3b1e43ae09c0ffc7de502fba50a3484a6de56996db6047dec59c6483e52565180", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e340e9363395b5f0e6253b3a69db9b0788dfa15d09e3072a844a3af1262580eedbe04ae3264f86734b252e4babf218c547801761c7e6ad5b499e1e09f083bbe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 23:26:23.469108) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 23:26:23.469430) ========= 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=52faae308a556c440401f8e5000001e8-1453272778.877077-1563003410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 23:26:23.554791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 23:26:23.555282) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 23:26:23.555600) ========= ========= Total master_lag: 0.39 =========