builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1452149244.52 results: success (0) buildid: 20160106203234 builduid: d86723d7a95f44afb1e1a5bf8de109ec revision: c91d6036456490a3bb20eb63e0dd02a5dd063561 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.522301) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.522748) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.523034) ========= 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=41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006300 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.554313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.554624) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.598119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.598444) ========= 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=41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.655829) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.656124) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.656503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.656819) ========= 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=41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 22:47:24-- 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.4M=0s 2016-01-06 22:47:24 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149674 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.834737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.835060) ========= 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=41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013890 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.886223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 22:47:24.886562) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c91d6036456490a3bb20eb63e0dd02a5dd063561 --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 c91d6036456490a3bb20eb63e0dd02a5dd063561 --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=41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 22:47:25,088 truncating revision to first 12 chars 2016-01-06 22:47:25,088 Setting DEBUG logging. 2016-01-06 22:47:25,088 attempt 1/10 2016-01-06 22:47:25,088 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c91d60364564?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 22:47:25,865 unpacking tar archive at: fx-team-c91d60364564/testing/mozharness/ program finished with exit code 0 elapsedTime=1.395381 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 22:47:26.302050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:26.302317) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:26.316562) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:26.316816) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:26.317179) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-06 22:47:26.317455) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:47:26 INFO - MultiFileLogger online at 20160106 22:47:26 in /builds/slave/test-pgo 22:47:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:47:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:47:26 INFO - {'append_to_log': False, 22:47:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:47:26 INFO - 'blob_upload_branch': 'Fx-Team', 22:47:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:47:26 INFO - 'branch': 'Fx-Team', 22:47:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:47:26 INFO - 'config_files': ('talos/linux_config.py',), 22:47:26 INFO - 'default_actions': ('clobber', 22:47:26 INFO - 'read-buildbot-config', 22:47:26 INFO - 'download-and-extract', 22:47:26 INFO - 'populate-webroot', 22:47:26 INFO - 'create-virtualenv', 22:47:26 INFO - 'install', 22:47:26 INFO - 'run-tests'), 22:47:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:47:26 INFO - 'download_minidump_stackwalk': True, 22:47:26 INFO - 'download_symbols': 'ondemand', 22:47:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:47:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:47:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:47:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:47:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:47:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:47:26 INFO - 'installer_path': 'installer.exe', 22:47:26 INFO - 'log_level': 'info', 22:47:26 INFO - 'log_name': 'talos', 22:47:26 INFO - 'log_to_console': True, 22:47:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:47:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:47:26 INFO - 'opt_config_files': (), 22:47:26 INFO - 'pip_index': False, 22:47:26 INFO - 'sps_profile': False, 22:47:26 INFO - 'sps_profile_interval': 0, 22:47:26 INFO - 'suite': 'dromaeojs', 22:47:26 INFO - 'system_bits': '32', 22:47:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:47:26 INFO - 'title': 'talos-linux64-ix-026', 22:47:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:47:26 INFO - 'use_talos_json': True, 22:47:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:47:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:47:26 INFO - 'work_dir': 'build'} 22:47:26 INFO - ##### 22:47:26 INFO - ##### Running clobber step. 22:47:26 INFO - ##### 22:47:26 INFO - Running pre-action listener: _resource_record_pre_action 22:47:26 INFO - Running main action method: clobber 22:47:26 INFO - rmtree: /builds/slave/test-pgo/build 22:47:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:47:27 INFO - Running post-action listener: _resource_record_post_action 22:47:27 INFO - ##### 22:47:27 INFO - ##### Running read-buildbot-config step. 22:47:27 INFO - ##### 22:47:27 INFO - Running pre-action listener: _resource_record_pre_action 22:47:27 INFO - Running main action method: read_buildbot_config 22:47:27 INFO - Using buildbot properties: 22:47:27 INFO - { 22:47:27 INFO - "project": "", 22:47:27 INFO - "product": "firefox", 22:47:27 INFO - "script_repo_revision": "production", 22:47:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:47:27 INFO - "repository": "", 22:47:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:47:27 INFO - "buildid": "20160106203234", 22:47:27 INFO - "pgo_build": "True", 22:47:27 INFO - "basedir": "/builds/slave/test-pgo", 22:47:27 INFO - "buildnumber": 880, 22:47:27 INFO - "slavename": "talos-linux64-ix-026", 22:47:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:47:27 INFO - "platform": "ubuntu64_hw", 22:47:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:47:27 INFO - "branch": "fx-team", 22:47:27 INFO - "repo_path": "integration/fx-team", 22:47:27 INFO - "revision": "c91d6036456490a3bb20eb63e0dd02a5dd063561", 22:47:27 INFO - "stage_platform": "linux64-pgo", 22:47:27 INFO - "builduid": "d86723d7a95f44afb1e1a5bf8de109ec", 22:47:27 INFO - "slavebuilddir": "test" 22:47:27 INFO - } 22:47:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:47:27 INFO - Running post-action listener: _resource_record_post_action 22:47:27 INFO - ##### 22:47:27 INFO - ##### Running download-and-extract step. 22:47:27 INFO - ##### 22:47:27 INFO - Running pre-action listener: _resource_record_pre_action 22:47:27 INFO - Running main action method: download_and_extract 22:47:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:27 INFO - https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:47:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/test_packages.json 22:47:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/test_packages.json 22:47:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:47:31 INFO - Downloaded 1302 bytes. 22:47:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:47:31 INFO - Using the following test package requirements: 22:47:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:47:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:31 INFO - u'jsshell-linux-x86_64.zip'], 22:47:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:47:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:47:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:47:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:47:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:47:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:47: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')]} 22:47:31 INFO - https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:47:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:32 INFO - Downloaded 24101983 bytes. 22:47:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:47:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:47:34 INFO - Return code: 0 22:47:34 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 22:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:34 INFO - https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:47:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:41 INFO - Downloaded 24101983 bytes. 22:47:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:47:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:47:42 INFO - Return code: 0 22:47:42 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')]} 22:47:42 INFO - https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:47:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:47:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:47:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:43 INFO - Downloaded 11132285 bytes. 22:47:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 22:47:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:47:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:47:43 INFO - Return code: 0 22:47: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')]} 22:47:43 INFO - https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:47:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:47:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:47:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:45 INFO - Downloaded 55066784 bytes. 22:47:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:47:45 INFO - mkdir: /builds/slave/test-pgo/properties 22:47:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:47:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:47:45 INFO - Contents: 22:47:45 INFO - build_url:https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:47:45 INFO - Running post-action listener: _resource_record_post_action 22:47:45 INFO - Running post-action listener: set_extra_try_arguments 22:47:45 INFO - ##### 22:47:45 INFO - ##### Running populate-webroot step. 22:47:45 INFO - ##### 22:47:45 INFO - Running pre-action listener: _resource_record_pre_action 22:47:45 INFO - Running main action method: populate_webroot 22:47:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:47:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:47:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:47:45 INFO - '--tppagecycles', 22:47:45 INFO - '7'], 22:47:45 INFO - 'tests': ['tsvgm']}}, 22:47:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:47:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:47:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:47:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:47:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:47:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:47:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:47:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:45 INFO - 'talos_options': ['--e10s'], 22:47:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:47:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:45 INFO - 'tests': ['damp', 'tps']}, 22:47:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:45 INFO - 'talos_options': ['--e10s'], 22:47:45 INFO - 'tests': ['damp', 'tps']}, 22:47:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:47:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:47:45 INFO - 'other': {'tests': ['a11yr', 22:47:45 INFO - 'ts_paint', 22:47:45 INFO - 'tpaint', 22:47:45 INFO - 'sessionrestore', 22:47:45 INFO - 'sessionrestore_no_auto_restore']}, 22:47:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:47:45 INFO - 'tests': ['a11yr', 22:47:45 INFO - 'ts_paint', 22:47:45 INFO - 'tpaint', 22:47:45 INFO - 'sessionrestore', 22:47:45 INFO - 'sessionrestore_no_auto_restore']}, 22:47:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:47:45 INFO - 'tests': ['a11yr', 22:47:45 INFO - 'ts_paint', 22:47:45 INFO - 'tpaint', 22:47:45 INFO - 'sessionrestore', 22:47:45 INFO - 'sessionrestore_no_auto_restore']}, 22:47:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:47:45 INFO - 'tests': ['a11yr', 22:47:45 INFO - 'ts_paint', 22:47:45 INFO - 'tpaint', 22:47:45 INFO - 'sessionrestore', 22:47:45 INFO - 'sessionrestore_no_auto_restore']}, 22:47:45 INFO - 'other_l64': {'tests': ['a11yr', 22:47:45 INFO - 'ts_paint', 22:47:45 INFO - 'tpaint', 22:47:45 INFO - 'sessionrestore', 22:47:45 INFO - 'sessionrestore_no_auto_restore']}, 22:47:45 INFO - 'other_nol64': {'tests': ['a11yr', 22:47:45 INFO - 'ts_paint', 22:47:45 INFO - 'tpaint', 22:47:45 INFO - 'sessionrestore', 22:47:45 INFO - 'sessionrestore_no_auto_restore']}, 22:47:45 INFO - 'svgr': {'tests': ['tsvgx', 22:47:45 INFO - 'tsvgr_opacity', 22:47:45 INFO - 'tart', 22:47:45 INFO - 'tscrollx', 22:47:45 INFO - 'cart']}, 22:47:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:47:45 INFO - 'tests': ['tsvgx', 22:47:45 INFO - 'tsvgr_opacity', 22:47:45 INFO - 'tart', 22:47:45 INFO - 'tscrollx', 22:47:45 INFO - 'cart']}, 22:47:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:45 INFO - 'tests': ['tp5o']}, 22:47:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:45 INFO - 'talos_options': ['--e10s'], 22:47:45 INFO - 'tests': ['tp5o']}, 22:47:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:45 INFO - 'talos_options': ['--xperf_path', 22:47:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:47:45 INFO - 'tests': ['tp5n']}, 22:47:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:45 INFO - 'talos_options': ['--e10s', 22:47:45 INFO - '--xperf_path', 22:47:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:47:45 INFO - 'tests': ['tp5n']}}, 22:47:45 INFO - 'talos.zip': {'path': '', 22:47:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:47:45 INFO - Running post-action listener: _resource_record_post_action 22:47:45 INFO - ##### 22:47:45 INFO - ##### Running create-virtualenv step. 22:47:45 INFO - ##### 22:47:45 INFO - Running pre-action listener: _resource_record_pre_action 22:47:45 INFO - Running main action method: create_virtualenv 22:47:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:47:45 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 22:47:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:47:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:47:45 INFO - Using real prefix '/usr' 22:47:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:47:45 INFO - Installing distribute.............................................................................................................................................................................................done. 22:47:47 INFO - Installing pip.................done. 22:47:47 INFO - Return code: 0 22:47:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:47 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 0x7fad419daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2438630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c9840>, '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 0x24366b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436b60>, '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': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', '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 22:47:47 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 22:47:47 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 22:47:47 INFO - Using env: {'DISPLAY': ':0', 22:47:47 INFO - 'HOME': '/home/cltbld', 22:47:47 INFO - 'LANG': 'en_US.UTF-8', 22:47:47 INFO - 'LANGUAGE': 'en_US:en', 22:47:47 INFO - 'LOGNAME': 'cltbld', 22:47:47 INFO - 'MAIL': '/var/mail/cltbld', 22:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:47 INFO - 'MOZ_NO_REMOTE': '1', 22:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:47 INFO - 'NO_EM_RESTART': '1', 22:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:47 INFO - 'SHELL': '/bin/bash', 22:47:47 INFO - 'SHLVL': '1', 22:47:47 INFO - 'TERM': 'linux', 22:47:47 INFO - 'TMOUT': '86400', 22:47:47 INFO - 'USER': 'cltbld', 22:47:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', 22:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:47 INFO - '_': '/tools/buildbot/bin/python'} 22:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:48 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 22:47:48 INFO - Cleaning up... 22:47:48 INFO - Return code: 0 22:47:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:47:48 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')]} 22:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:48 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')]} 22:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:48 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 0x7fad419daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2438630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c9840>, '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 0x24366b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436b60>, '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': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', '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 22:47:48 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 22:47:48 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 22:47:48 INFO - Using env: {'DISPLAY': ':0', 22:47:48 INFO - 'HOME': '/home/cltbld', 22:47:48 INFO - 'LANG': 'en_US.UTF-8', 22:47:48 INFO - 'LANGUAGE': 'en_US:en', 22:47:48 INFO - 'LOGNAME': 'cltbld', 22:47:48 INFO - 'MAIL': '/var/mail/cltbld', 22:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:48 INFO - 'MOZ_NO_REMOTE': '1', 22:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:48 INFO - 'NO_EM_RESTART': '1', 22:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:48 INFO - 'SHELL': '/bin/bash', 22:47:48 INFO - 'SHLVL': '1', 22:47:48 INFO - 'TERM': 'linux', 22:47:48 INFO - 'TMOUT': '86400', 22:47:48 INFO - 'USER': 'cltbld', 22:47:48 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', 22:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:48 INFO - '_': '/tools/buildbot/bin/python'} 22:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:48 INFO - Downloading/unpacking psutil>=0.7.1 22:47: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 22:47: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 22:47: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 22:47: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 22:47: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 22:47: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 22:47:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:47:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:47:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:47:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:47:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:47:50 INFO - Installing collected packages: psutil 22:47:50 INFO - Running setup.py install for psutil 22:47:50 INFO - building 'psutil._psutil_linux' extension 22:47:50 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 22:47:50 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 22:47:50 INFO - building 'psutil._psutil_posix' extension 22:47:50 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 22:47:50 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 22:47:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:47:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:47:50 INFO - Successfully installed psutil 22:47:50 INFO - Cleaning up... 22:47:50 INFO - Return code: 0 22:47:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:50 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 0x7fad419daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2438630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c9840>, '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 0x24366b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436b60>, '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': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', '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 22:47:50 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 22:47:50 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 22:47:50 INFO - Using env: {'DISPLAY': ':0', 22:47:50 INFO - 'HOME': '/home/cltbld', 22:47:50 INFO - 'LANG': 'en_US.UTF-8', 22:47:50 INFO - 'LANGUAGE': 'en_US:en', 22:47:50 INFO - 'LOGNAME': 'cltbld', 22:47:50 INFO - 'MAIL': '/var/mail/cltbld', 22:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:50 INFO - 'MOZ_NO_REMOTE': '1', 22:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:50 INFO - 'NO_EM_RESTART': '1', 22:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:50 INFO - 'SHELL': '/bin/bash', 22:47:50 INFO - 'SHLVL': '1', 22:47:50 INFO - 'TERM': 'linux', 22:47:50 INFO - 'TMOUT': '86400', 22:47:50 INFO - 'USER': 'cltbld', 22:47:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', 22:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:50 INFO - '_': '/tools/buildbot/bin/python'} 22:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:47:50 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 22:47:50 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 22:47:50 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 22:47:50 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 22:47:50 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 22:47:50 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 22:47:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:47:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:47:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:47:52 INFO - Installing collected packages: mozsystemmonitor 22:47:52 INFO - Running setup.py install for mozsystemmonitor 22:47:52 INFO - Successfully installed mozsystemmonitor 22:47:52 INFO - Cleaning up... 22:47:52 INFO - Return code: 0 22:47:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:47:52 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')]} 22:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:52 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')]} 22:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:52 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 0x7fad419daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2438630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c9840>, '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 0x24366b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436b60>, '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': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', '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 22:47:52 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 22:47:52 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 22:47:52 INFO - Using env: {'DISPLAY': ':0', 22:47:52 INFO - 'HOME': '/home/cltbld', 22:47:52 INFO - 'LANG': 'en_US.UTF-8', 22:47:52 INFO - 'LANGUAGE': 'en_US:en', 22:47:52 INFO - 'LOGNAME': 'cltbld', 22:47:52 INFO - 'MAIL': '/var/mail/cltbld', 22:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:52 INFO - 'MOZ_NO_REMOTE': '1', 22:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:52 INFO - 'NO_EM_RESTART': '1', 22:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:52 INFO - 'SHELL': '/bin/bash', 22:47:52 INFO - 'SHLVL': '1', 22:47:52 INFO - 'TERM': 'linux', 22:47:52 INFO - 'TMOUT': '86400', 22:47:52 INFO - 'USER': 'cltbld', 22:47:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', 22:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:52 INFO - '_': '/tools/buildbot/bin/python'} 22:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:52 INFO - Downloading/unpacking blobuploader==1.2.4 22:47:52 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 22:47:52 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 22:47:52 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 22:47:52 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 22:47:52 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 22:47:52 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 22:47:54 INFO - Downloading blobuploader-1.2.4.tar.gz 22:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:47:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:47:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:55 INFO - Downloading docopt-0.6.1.tar.gz 22:47:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:47:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:47:55 INFO - Installing collected packages: blobuploader, requests, docopt 22:47:55 INFO - Running setup.py install for blobuploader 22:47:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:47:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:47:55 INFO - Running setup.py install for requests 22:47:55 INFO - Running setup.py install for docopt 22:47:55 INFO - Successfully installed blobuploader requests docopt 22:47:55 INFO - Cleaning up... 22:47:55 INFO - Return code: 0 22:47:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:55 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 0x7fad419daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2438630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c9840>, '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 0x24366b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436b60>, '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': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', '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 22:47:55 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 22:47:55 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 22:47:55 INFO - Using env: {'DISPLAY': ':0', 22:47:55 INFO - 'HOME': '/home/cltbld', 22:47:55 INFO - 'LANG': 'en_US.UTF-8', 22:47:55 INFO - 'LANGUAGE': 'en_US:en', 22:47:55 INFO - 'LOGNAME': 'cltbld', 22:47:55 INFO - 'MAIL': '/var/mail/cltbld', 22:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:55 INFO - 'MOZ_NO_REMOTE': '1', 22:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:55 INFO - 'NO_EM_RESTART': '1', 22:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:55 INFO - 'SHELL': '/bin/bash', 22:47:55 INFO - 'SHLVL': '1', 22:47:55 INFO - 'TERM': 'linux', 22:47:55 INFO - 'TMOUT': '86400', 22:47:55 INFO - 'USER': 'cltbld', 22:47:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', 22:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:55 INFO - '_': '/tools/buildbot/bin/python'} 22:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:47:56 INFO - Running setup.py (path:/tmp/pip-EwmMvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:47:56 INFO - Running setup.py (path:/tmp/pip-0HRWvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:47:56 INFO - Running setup.py (path:/tmp/pip-xGB79h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:47:56 INFO - Running setup.py (path:/tmp/pip-98Rm1E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:47:56 INFO - Running setup.py (path:/tmp/pip-XhKjkQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:47:56 INFO - Running setup.py (path:/tmp/pip-cWvpKC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:47:56 INFO - Running setup.py (path:/tmp/pip-LUUf79-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:47:56 INFO - Running setup.py (path:/tmp/pip-kgsz3s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:47:56 INFO - Running setup.py (path:/tmp/pip-iGs8B7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:47:56 INFO - Running setup.py (path:/tmp/pip-gtbDQ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:47:56 INFO - Running setup.py (path:/tmp/pip-lx6xcF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:47:56 INFO - Running setup.py (path:/tmp/pip-VpfoGO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:47:57 INFO - Running setup.py (path:/tmp/pip-BXwErP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:47:57 INFO - Running setup.py (path:/tmp/pip-NYv6OT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:47:57 INFO - Running setup.py (path:/tmp/pip-cId0rO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:47:57 INFO - Running setup.py (path:/tmp/pip-JE3J4f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:47:57 INFO - Running setup.py (path:/tmp/pip-d9itIj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:47:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:47:57 INFO - Running setup.py install for manifestparser 22:47:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Running setup.py install for mozcrash 22:47:57 INFO - Running setup.py install for mozdebug 22:47:57 INFO - Running setup.py install for mozdevice 22:47:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Running setup.py install for mozfile 22:47:57 INFO - Running setup.py install for mozhttpd 22:47:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Running setup.py install for mozinfo 22:47:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Running setup.py install for mozInstall 22:47:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Running setup.py install for mozleak 22:47:58 INFO - Running setup.py install for mozlog 22:47:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Running setup.py install for moznetwork 22:47:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Running setup.py install for mozprocess 22:47:58 INFO - Running setup.py install for mozprofile 22:47:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Running setup.py install for mozrunner 22:47:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Running setup.py install for mozscreenshot 22:47:58 INFO - Running setup.py install for moztest 22:47:59 INFO - Running setup.py install for mozversion 22:47:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:47:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:47:59 INFO - Cleaning up... 22:47:59 INFO - Return code: 0 22:47:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fad419daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2438630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c9840>, '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 0x24366b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436b60>, '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': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', '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 22:47:59 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 22:47:59 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 22:47:59 INFO - Using env: {'DISPLAY': ':0', 22:47:59 INFO - 'HOME': '/home/cltbld', 22:47:59 INFO - 'LANG': 'en_US.UTF-8', 22:47:59 INFO - 'LANGUAGE': 'en_US:en', 22:47:59 INFO - 'LOGNAME': 'cltbld', 22:47:59 INFO - 'MAIL': '/var/mail/cltbld', 22:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:59 INFO - 'MOZ_NO_REMOTE': '1', 22:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:59 INFO - 'NO_EM_RESTART': '1', 22:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:59 INFO - 'SHELL': '/bin/bash', 22:47:59 INFO - 'SHLVL': '1', 22:47:59 INFO - 'TERM': 'linux', 22:47:59 INFO - 'TMOUT': '86400', 22:47:59 INFO - 'USER': 'cltbld', 22:47:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', 22:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:59 INFO - '_': '/tools/buildbot/bin/python'} 22:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:47:59 INFO - Running setup.py (path:/tmp/pip-Z7SXKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:47:59 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)) 22:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:47:59 INFO - Running setup.py (path:/tmp/pip-PEmHjN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:47:59 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)) 22:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:47:59 INFO - Running setup.py (path:/tmp/pip-sMog8w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:47:59 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)) 22:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:47:59 INFO - Running setup.py (path:/tmp/pip-Lbi34b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:47:59 INFO - Running setup.py (path:/tmp/pip-uYuLb0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:47:59 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)) 22:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:47:59 INFO - Running setup.py (path:/tmp/pip-W0UB5S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:47:59 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)) 22:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:47:59 INFO - Running setup.py (path:/tmp/pip-SXBup2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:47:59 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)) 22:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:47:59 INFO - Running setup.py (path:/tmp/pip-a3vbm9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:47:59 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)) 22:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:47:59 INFO - Running setup.py (path:/tmp/pip-LZ5VhT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:48:00 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)) 22:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:48:00 INFO - Running setup.py (path:/tmp/pip-eI7cxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:48:00 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)) 22:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:48:00 INFO - Running setup.py (path:/tmp/pip-3xySGd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:48:00 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)) 22:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:48:00 INFO - Running setup.py (path:/tmp/pip-mzHCTR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:48:00 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)) 22:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:48:00 INFO - Running setup.py (path:/tmp/pip-8QeoBf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:48:00 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)) 22:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:48:00 INFO - Running setup.py (path:/tmp/pip-Q3yF1L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:48:00 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)) 22:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:48:00 INFO - Running setup.py (path:/tmp/pip-mlnWJB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:48:00 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)) 22:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:48:00 INFO - Running setup.py (path:/tmp/pip-WiwIjF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:48:00 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)) 22:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:48:00 INFO - Running setup.py (path:/tmp/pip-Na0TA8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:48:00 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)) 22:48:00 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)) 22:48:00 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)) 22:48:00 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)) 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:48:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:02 INFO - Downloading blessings-1.5.1.tar.gz 22:48:02 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 22:48:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:48:02 INFO - Installing collected packages: blessings 22:48:02 INFO - Running setup.py install for blessings 22:48:02 INFO - Successfully installed blessings 22:48:02 INFO - Cleaning up... 22:48:02 INFO - Return code: 0 22:48:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:48:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:48:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:48:02 INFO - Reading from file tmpfile_stdout 22:48:02 INFO - Current package versions: 22:48:02 INFO - argparse == 1.2.1 22:48:02 INFO - blessings == 1.5.1 22:48:02 INFO - blobuploader == 1.2.4 22:48:02 INFO - docopt == 0.6.1 22:48:02 INFO - manifestparser == 1.1 22:48:02 INFO - mozInstall == 1.12 22:48:02 INFO - mozcrash == 0.16 22:48:02 INFO - mozdebug == 0.1 22:48:02 INFO - mozdevice == 0.47 22:48:02 INFO - mozfile == 1.2 22:48:02 INFO - mozhttpd == 0.7 22:48:02 INFO - mozinfo == 0.9 22:48:02 INFO - mozleak == 0.1 22:48:02 INFO - mozlog == 3.1 22:48:02 INFO - moznetwork == 0.27 22:48:02 INFO - mozprocess == 0.22 22:48:02 INFO - mozprofile == 0.28 22:48:02 INFO - mozrunner == 6.11 22:48:02 INFO - mozscreenshot == 0.1 22:48:02 INFO - mozsystemmonitor == 0.0 22:48:02 INFO - moztest == 0.7 22:48:02 INFO - mozversion == 1.4 22:48:02 INFO - psutil == 3.1.1 22:48:02 INFO - requests == 1.2.3 22:48:02 INFO - wsgiref == 0.1.2 22:48:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fad419daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2438630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c9840>, '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 0x24366b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436b60>, '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': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', '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 22:48:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 22:48:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 22:48:02 INFO - Using env: {'DISPLAY': ':0', 22:48:02 INFO - 'HOME': '/home/cltbld', 22:48:02 INFO - 'LANG': 'en_US.UTF-8', 22:48:02 INFO - 'LANGUAGE': 'en_US:en', 22:48:02 INFO - 'LOGNAME': 'cltbld', 22:48:02 INFO - 'MAIL': '/var/mail/cltbld', 22:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:02 INFO - 'MOZ_NO_REMOTE': '1', 22:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:02 INFO - 'NO_EM_RESTART': '1', 22:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:02 INFO - 'SHELL': '/bin/bash', 22:48:02 INFO - 'SHLVL': '1', 22:48:02 INFO - 'TERM': 'linux', 22:48:02 INFO - 'TMOUT': '86400', 22:48:02 INFO - 'USER': 'cltbld', 22:48:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', 22:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:02 INFO - '_': '/tools/buildbot/bin/python'} 22:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 INFO - Cleaning up... 22:48:03 INFO - Return code: 0 22:48:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:03 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 0x7fad419daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2438630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c9840>, '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 0x24366b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436b60>, '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': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', '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 22:48:03 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 22:48:03 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 22:48:03 INFO - Using env: {'DISPLAY': ':0', 22:48:03 INFO - 'HOME': '/home/cltbld', 22:48:03 INFO - 'LANG': 'en_US.UTF-8', 22:48:03 INFO - 'LANGUAGE': 'en_US:en', 22:48:03 INFO - 'LOGNAME': 'cltbld', 22:48:03 INFO - 'MAIL': '/var/mail/cltbld', 22:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:03 INFO - 'MOZ_NO_REMOTE': '1', 22:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:03 INFO - 'NO_EM_RESTART': '1', 22:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:03 INFO - 'SHELL': '/bin/bash', 22:48:03 INFO - 'SHLVL': '1', 22:48:03 INFO - 'TERM': 'linux', 22:48:03 INFO - 'TMOUT': '86400', 22:48:03 INFO - 'USER': 'cltbld', 22:48:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', 22:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:03 INFO - '_': '/tools/buildbot/bin/python'} 22:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:03 INFO - Downloading/unpacking jsonschema 22:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:48:04 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 22:48:04 INFO - Downloading/unpacking functools32 (from jsonschema) 22:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:05 INFO - Downloading functools32-3.2.3-2.tar.gz 22:48:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:48:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:48:05 INFO - warning: no files found matching '*.txt' 22:48:05 INFO - no previously-included directories found matching 'build' 22:48:05 INFO - no previously-included directories found matching 'dist' 22:48:05 INFO - no previously-included directories found matching '.git*' 22:48:05 INFO - Installing collected packages: jsonschema, functools32 22:48:05 INFO - Running setup.py install for functools32 22:48:05 INFO - warning: no files found matching '*.txt' 22:48:05 INFO - no previously-included directories found matching 'build' 22:48:05 INFO - no previously-included directories found matching 'dist' 22:48:05 INFO - no previously-included directories found matching '.git*' 22:48:05 INFO - Successfully installed jsonschema functools32 22:48:05 INFO - Cleaning up... 22:48:05 INFO - Return code: 0 22:48:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:48: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')]} 22:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48: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')]} 22:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:05 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 0x7fad419daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2438630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c9840>, '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 0x24366b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436b60>, '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': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', '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 22:48:05 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 22:48:05 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 22:48:05 INFO - Using env: {'DISPLAY': ':0', 22:48:05 INFO - 'HOME': '/home/cltbld', 22:48:05 INFO - 'LANG': 'en_US.UTF-8', 22:48:05 INFO - 'LANGUAGE': 'en_US:en', 22:48:05 INFO - 'LOGNAME': 'cltbld', 22:48:05 INFO - 'MAIL': '/var/mail/cltbld', 22:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:05 INFO - 'MOZ_NO_REMOTE': '1', 22:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:05 INFO - 'NO_EM_RESTART': '1', 22:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:05 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:05 INFO - 'SHELL': '/bin/bash', 22:48:05 INFO - 'SHLVL': '1', 22:48:05 INFO - 'TERM': 'linux', 22:48:05 INFO - 'TMOUT': '86400', 22:48:05 INFO - 'USER': 'cltbld', 22:48:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', 22:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:05 INFO - '_': '/tools/buildbot/bin/python'} 22:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:05 INFO - Downloading/unpacking flake8 22:48:05 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 22:48:05 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 22:48:05 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 22:48:05 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 22:48:05 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 22:48:05 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 22:48:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:48:07 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 22:48:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:48:07 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 22:48:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:07 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 22:48:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:48:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:48:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:48:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:48:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:48:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:48:07 INFO - no previously-included directories found matching 'docs/_build' 22:48:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:48:08 INFO - Running setup.py install for pep8 22:48:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:48:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:48:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:48:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:48:08 INFO - no previously-included directories found matching 'docs/_build' 22:48:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:48:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:48:08 INFO - Cleaning up... 22:48:08 INFO - Return code: 0 22:48:08 INFO - Running post-action listener: _resource_record_post_action 22:48:08 INFO - Running post-action listener: _start_resource_monitoring 22:48:08 INFO - Starting resource monitoring. 22:48:08 INFO - ##### 22:48:08 INFO - ##### Running install step. 22:48:08 INFO - ##### 22:48:08 INFO - Running pre-action listener: _resource_record_pre_action 22:48:08 INFO - Running main action method: install 22:48:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:48:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:48:08 INFO - Reading from file tmpfile_stdout 22:48:08 INFO - Detecting whether we're running mozinstall >=1.0... 22:48:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:48:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:48:08 INFO - Reading from file tmpfile_stdout 22:48:08 INFO - Output received: 22:48:08 INFO - Usage: mozinstall [options] installer 22:48:08 INFO - Options: 22:48:08 INFO - -h, --help show this help message and exit 22:48:08 INFO - -d DEST, --destination=DEST 22:48:08 INFO - Directory to install application into. [default: 22:48:08 INFO - "/builds/slave/test-pgo"] 22:48:08 INFO - --app=APP Application being installed. [default: firefox] 22:48:08 INFO - mkdir: /builds/slave/test-pgo/build/application 22:48:08 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'] 22:48:08 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 22:48:24 INFO - Reading from file tmpfile_stdout 22:48:24 INFO - Output received: 22:48:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:48:24 INFO - Running post-action listener: _resource_record_post_action 22:48:24 INFO - ##### 22:48:24 INFO - ##### Running run-tests step. 22:48:24 INFO - ##### 22:48:24 INFO - Running pre-action listener: _resource_record_pre_action 22:48:24 INFO - Running main action method: run_tests 22:48:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:48:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:48:24 INFO - Python 2.7.3 22:48:24 INFO - Return code: 0 22:48:24 INFO - grabbing minidump binary from tooltool 22:48: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')]} 22:48:24 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 0x24c9840>, '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 0x24366b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2436b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:48:24 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 22:48:24 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 22:48:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:48:24 INFO - Return code: 0 22:48:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:48:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:48:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:48:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:48:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:48:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:48:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:48:25 INFO - Return code: 0 22:48:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:48:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:48:25 INFO - Using env: {'DISPLAY': ':0', 22:48:25 INFO - 'HOME': '/home/cltbld', 22:48:25 INFO - 'LANG': 'en_US.UTF-8', 22:48:25 INFO - 'LANGUAGE': 'en_US:en', 22:48:25 INFO - 'LOGNAME': 'cltbld', 22:48:25 INFO - 'MAIL': '/var/mail/cltbld', 22:48:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:48:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:25 INFO - 'MOZ_NO_REMOTE': '1', 22:48:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:48:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:25 INFO - 'NO_EM_RESTART': '1', 22:48:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:48:25 INFO - 'SHELL': '/bin/bash', 22:48:25 INFO - 'SHLVL': '1', 22:48:25 INFO - 'TERM': 'linux', 22:48:25 INFO - 'TMOUT': '86400', 22:48:25 INFO - 'USER': 'cltbld', 22:48:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169', 22:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:25 INFO - '_': '/tools/buildbot/bin/python'} 22:48:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:48:25 INFO - mozversion application_buildid: 20160106203234 22:48:25 INFO - mozversion application_changeset: c91d6036456490a3bb20eb63e0dd02a5dd063561 22:48:25 INFO - mozversion application_display_name: Nightly 22:48:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:48:25 INFO - mozversion application_name: Firefox 22:48:25 INFO - mozversion application_remotingname: firefox 22:48:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:48:25 INFO - mozversion application_vendor: Mozilla 22:48:25 INFO - mozversion application_version: 46.0a1 22:48:25 INFO - mozversion platform_buildid: 20160106203234 22:48:25 INFO - mozversion platform_changeset: c91d6036456490a3bb20eb63e0dd02a5dd063561 22:48:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:48:25 INFO - mozversion platform_version: 46.0a1 22:48:25 INFO - using testdate: 1452149305 22:48:25 INFO - actual date: 1452149305 22:48:25 INFO - starting webserver on 'localhost:40478' 22:48:25 INFO - SUITE-START | Running 3 tests 22:48:25 INFO - TEST-START | dromaeo_css 22:48:25 INFO - operating with platform_type : linux_ 22:48:25 INFO - Initialising browser for dromaeo_css test... 22:48:25 INFO - TEST-INFO | started process 26651 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTjOaL5/profile http://localhost:40478/getInfo.html) 22:48:29 INFO - PROCESS | 26651 | __metrics Screen width/height:1600/1200 22:48:29 INFO - PROCESS | 26651 | colorDepth:24 22:48:29 INFO - PROCESS | 26651 | Browser inner width/height: 1024/697 22:48:29 INFO - PROCESS | 26651 | __metrics 22:48:29 INFO - PROCESS | 26651 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:48:29 INFO - PROCESS | 26651 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:48:30 INFO - TEST-INFO | 26651: exit 0 22:48:30 INFO - Browser initialized. 22:48:30 INFO - Running cycle 1/1 for dromaeo_css test... 22:48:30 INFO - TEST-INFO | started process 26745 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTjOaL5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:48:42 INFO - PROCESS | 26745 | RSS: Main: 150413312 22:48:42 INFO - PROCESS | 26745 | 22:49:33 INFO - PROCESS | 26745 | 1452149373636 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] 22:51:42 INFO - PROCESS | 26745 | Cycle 1(1): loaded http://localhost:40478/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40478/tests/dromaeo/cssquery-ext.html) 22:51:43 INFO - PROCESS | 26745 | RSS: Main: 230174720 22:51:43 INFO - PROCESS | 26745 | 22:54:45 INFO - PROCESS | 26745 | Cycle 1(1): loaded http://localhost:40478/tests/dromaeo/cssquery-ext.html (next: http://localhost:40478/tests/dromaeo/cssquery-jquery.html) 22:54:46 INFO - PROCESS | 26745 | RSS: Main: 234504192 22:54:46 INFO - PROCESS | 26745 | 22:57:48 INFO - PROCESS | 26745 | Cycle 1(1): loaded http://localhost:40478/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40478/tests/dromaeo/cssquery-mootools.html) 22:57:48 INFO - PROCESS | 26745 | RSS: Main: 231022592 22:57:48 INFO - PROCESS | 26745 | 23:00:50 INFO - PROCESS | 26745 | Cycle 1(1): loaded http://localhost:40478/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40478/tests/dromaeo/cssquery-prototype.html) 23:00:51 INFO - PROCESS | 26745 | RSS: Main: 216145920 23:00:51 INFO - PROCESS | 26745 | 23:03:53 INFO - PROCESS | 26745 | Cycle 1(1): loaded http://localhost:40478/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40478/tests/dromaeo/cssquery-yui.html) 23:03:54 INFO - PROCESS | 26745 | RSS: Main: 220524544 23:03:54 INFO - PROCESS | 26745 | 23:06:57 INFO - PROCESS | 26745 | Cycle 1(1): loaded http://localhost:40478/tests/dromaeo/cssquery-yui.html (next: http://localhost:40478/tests/dromaeo/cssquery-dojo.html) 23:06:57 INFO - PROCESS | 26745 | RSS: Main: 272691200 23:06:57 INFO - PROCESS | 26745 | 23:06:57 INFO - PROCESS | 26745 | __start_tp_report 23:06:57 INFO - PROCESS | 26745 | _x_x_mozilla_page_load 23:06:57 INFO - PROCESS | 26745 | _x_x_mozilla_page_load_details 23:06:57 INFO - PROCESS | 26745 | |i|pagename|runs| 23:06:57 INFO - PROCESS | 26745 | |0;dojo.html;3120.4851199552077;3145.512445570936;3214.9678503214977;3216.4532029554975;3256.120847371209;5067.518585734359;5153.716545589991;5173.586113110951;5195.766190521431;5218.29553010344;5006.674566153198;5027.3967123945085;5086.821961231358;5092.057969275686;5101.999999999991;4499.75251361175;4658.650601204906;4682.906341873169;4751.9762401187945;4825.010872771091;4546.61353784927;4645.163870503308;4740.786664600084;4742.1227072991605;4765.90468190636;4635.814567417299;4710.458297295786;4714.127886341003;4746.335513028196;4759;4650.86047418578;4691.554302341272;4691.7654117294;4730.455997560256;4735.384400027974;4559.99680070384;4662.347271382009;4697.365855609517;4699.859004229845;4710.74090924999;4846.224604063333;4868.269759536062;4872.074305881871;4872.3422337984275;4875.975620121877;5278.656887302352;5303.337082864642;5306.442823503554;5317.41508434072;5341.092014357569;5380.838574842761;5392.622516423852;5421.620486565942;5494.478024587658;5497.175423686439;5189.117849965477;5213.478652134794;5217;5218.112920803473;5219.791208351699;5578.44215578447;5613.578981576316;5663.178839068312;5664.49019588239;5670.666300795753;5144.819931302386;5182.533571978464;5222.686638801684;5230.320058392461;5317.1492561190025;5454;5464.480874316933;5480.150576660624;5480.808171713971;5491.039068163055;5337.946620533823;5402.783888644411;5409.432009638931;5410.458954104637;5456.672599644034;5316.893662126736;5379.058664733656;5390.137577987503;5390.757415916293;5458.017556839727;4320.783960801948;4327.437433133736;4329.805158767863;4332.891677708019;4361.193179261847;3842.5773164951834;3846.8461261549783;3857.0550215197454;3885.572587015426;3897.415387691869;4974.651774375831;5067;5071.721055341992;5073.16292811682;5199.2201169824075;5424.1321388577635;5492;5504.339479262514;5504.752286147133;5505.862353441196;5142.97428512855;5148.4851514848215;5150.0472412603785;5154.639175257771;5198;4602.56275653819;4626.467956185014;4655.976720116446;4674.392328997209;4710.175719249118;5756.856078597984;5780.826575202751;5782.7686892523825;5783.508401785895;5784.2769653793275;5502.642328248651;5544.473275038865;5548;5550.4727050931715;5553.305836770403;5482.862928426821;5548.916766248591;5591.217229587943;5609.831705048855;5651.067573850269;5404.108322126805;5422.349318081855;5430.321209848769;5430.40265570779;5432.293801805898;5413.83758487246;5496.890062198654;5499.780008799763;5501.229827824028;5555.00009998188;5269.78920843162;5323.6273460857365;5406;5406.135018397038;5463.07127788269;5270.947290527199;5271.736413179402;5272.578193744568;5281.339832520935;5294.205869119663;5127.077126117335;5130.2817605536;5180.533751962191;5204.0892843752945;5220.21696745476;5123.5388815005335;5355.143177091647;5399.055165346127;5404.2163886235485;5467.781288748405;5177.585793136615;5178.663386879992;5179.326687530597;5187.792488300426;5199.272101905661 23:06:57 INFO - PROCESS | 26745 | |1;ext.html;529.1639210048124;535.1785010009635;558.8602849287678;573.5497634357031;575.3326141675657;27691.723082769193;28367.574486382695;35573;35821;35872.64127358726;38537;38600.80699596498;38892;39001.21997560047;39103.60896391035;7407.14817795955;7481.401487880984;8296.419250652456;8466.44968077076;8469.407141500098;9893.604255829794;10052.346597471178;10061.597536098547;10063;10063.748406289864;9956.352837065604;9976.351537150062;10051.296409251356;10059.24555658325;10059.899401005969;7650.464467487278;7810.687572497093;7844.294013538809;7849.372050235967;9916.652917147901;9897.35667181631;10021.24840636948;10044.447555384451;10057.09486146243;10057.195424366033;35784;35835.462468063;36261.27477450463;36263.27473450516;36272;3075.9077227683206;3082.475979083561;3131.1232854800464;3333.233356328034;3592.7305452091196;27519.44961100787;27522.587161192598;28217;29667.258318541994;29696.70303296961;3328.5506456628286;3341.3818443588016;3411.812350320731;3420;3450.9482357764655;250776;253644;253677;254055.99999999814;254584;48521.51478485241;49601.25598116031;49659.50340496621;55797.72101139549;56377.43622563804;35506.82246588802;60372.69813650991;61078;61140.38859611347;61170;15759.921200394154;15850.128242946748;15876.44432444882;16051.518454446385;16057.678846423007;12177.208481448677;12331.568395106127;12350.3824808761;12389.93805030969;12391.380430978596;18216.453506394828;18444.723329150074;18570.81429185718;18645.347412840485;18713.438596842116;7392.408607311402;7475.551466911894;7607.16321204667;7649.541027538366;7675.731349402744;886.3131073418024;950.4154944708954;1033.1373303291684;1073.822819234833;1089.9891001089889;24259;24695.5060898781;24893.377665558506;25240.621390679156;26469.735302647114;1045.163868904873;1109.7669489407153;1115.6597237842536;1143.845580846575;1162.412981444382;13635.795463068062;13812.86187138136;13928.58214253574;13973.161610303414;14003.649908752159;299190;305091;306018;306471;307184;50247.748761255956;50369.49630503648;50382.49617503851;50441.74779126081;50472.242916356285;1294.3204817470714;1316.2892038299403;1330.8336457942758;1338.290705925861;1339.1094921877038;25328.620070698587;26225.475490490466;26234.475310494065;26258.606120908586;26270.605940911282;42379.7881010593;42729.572704272556;42783.7860810694;42790;42839;292689;295655;295816;296179;296949;25895;27257.182284531496;27510.312242194104;30601.387972240875;31497.8425107873;35788.642113579575;36107.81946090253;36512.81743591265;36704.81647591745;38600.613993859704;32974.34051318912;33893.661063390035;34081.65918340884;34437.48343774895;34530.482042768876;27808.44383112367;30403.54394684037;30602;31068.223294416915;31537.21156971094;24773.380665482786;24825.87587062053;28572.57141142926;29048.419031619673;29377.412451751272;25912.352191195372;25930;26630.20109396721;26976.289025248832;27164.864175678995;22953.426164346023;23698.526029479657;24022.15922442706;24080.39799004969;24089.879550602134 23:06:57 INFO - PROCESS | 26745 | |2;jquery.html;358.3442300589919;358.369270084651;361.5029334664835;364.28963521133795;364.49153430963804;13275.33623318835;13649.65875853104;15834.12912289825;15836.208189590518;16241.35034598616;15256.084634921912;15352.385904563804;15662.373505059784;15675.216239188052;15687.921560392182;5020.121478741224;5148.8712782180555;5184.559312458446;5186.8703282417955;5189.040027594888;3526.2242306692488;3565.5008298838184;5124.410692770323;6409.679516024204;6605.900911486331;6429.967850160766;6487.643179625119;6521.967390163042;6584.078229047937;6584.078229047937;6505.121808555832;6540.215174179129;6555.24614669312;6557.508186885955;6562;6137.018077107641;6227.470664993436;6275.560710750249;6292.465140463066;6309.652969086698;21840.890795546078;21862.562748744935;22054.779452205432;22488.88755556228;22496.100155993903;2172.92394766184;2205.878676672782;2219.9001044953015;2252.268012895799;2286.919957801469;13570.525031623845;13688.931555342258;13970.580882573538;14078.2960851957;14279.428822847074;1861.7300491428803;1946.1728765274702;1955.559999000228;1987.1157334985937;1990.9900450497655;65698.3430165697;68780.3121968784;70291;70576.29423705749;70873;14808.481703140555;14880.28876679174;14917.850821491864;14920.776188357184;14942.252887355806;23487.238457115785;23754.406139846298;23755.643665345033;23792;23825.52348953011;8915.955420222987;8986.101389860962;8986.68546600866;8999.595018224196;9093.681721139861;7759.107702614272;7767.1067827200595;7840.6863725451485;7841.294283514511;7849.48978316419;6631.336866313427;7344;7464.925350746532;7479.513831600929;7484.663190156456;2631.1974847671263;2978.3149875528748;3052.2674558106337;3125.7030582094662;3163.1775738307747;889.3463304471209;891.4606662968811;913.6847787513298;977.7897751983357;978.3493976505687;14848.183349915858;15527.146006969499;16137.112458814643;16150;16253.918730406273;887.8224355129;915.3683958068912;917.9862302065475;921.3044151665449;948.9478078705599;8915;9285.814283714288;9328.347015708836;9736;9782.706518804447;476814;481269;482076;530739;564809;72557;75064;75428.24571754212;76924;77242;1105.9723506912392;1126.448040460185;1174.9353785541878;1190.743990042145;1192.4812706472712;14535.127892326494;14614.780778288121;14817.740097178603;14950.327235274657;15162.848371516586;35558.46662300119;35577;36207.63792362042;36499.452508212926;36617.633823661425;47491.812704682656;47601.761991191204;47678.52321476741;49120.508794913025;49648.751756240985;8911.351399991023;9540.809183816424;9611.663591774255;9617.374870633386;9620.567074481805;11798.181899869694;13201.141925774795;13706.52027179044;14947.775783363475;16591.41930032443;12613.36933153357;12710.173838700455;13311.46754129824;13578.728425431633;13581.79627305611;9487.478188699411;9619.086186812241;9782.021797820162;12838.42227099764;13626.318684065558;7104.680289387094;8333.374996875138;8589.226969572768;9717.562709678223;9722.465264410524;13828.654283642989;14067.366968486647;14341.498047568284;14342.211178385289;14423.35094920752;9559.283053770856;9784.951075244579;9972.700818975442;10010.699679009642;10040.246981476565 23:06:57 INFO - PROCESS | 26745 | |3;mootools.html;1337.0707358385926;1454.578172330024;1463.6414078550756;1595.2821230446295;1797.910104494775;6343.587666801654;7110.43116550676;7202.603856787875;7212.386947109502;7213.458990575701;6937.271586483423;7125.073740413752;7127.714891404337;7136.643167841613;7145.428365730742;1915.2721965653031;1949.7855235924037;1952.1508143957353;2219.678146668736;2259.5254996450767;1984.1765667248076;2243.4839986803045;2246.595612789697;2265.5695417870634;2265.796078352948;2160.8487405881597;2198.857074290174;2203.151786562177;2207.293666026872;2219.3341997400794;2176.4123686604607;2190.518086021073;2190.59473997311;2198.7471440784357;2206.8013878750908;2202.405350555341;2248.87631180285;2250.0999600160067;2251.189571754167;2263.2644390572964;7143.214246432888;7217.855642887165;7238.746643867492;7239.38465230456;7249.420046396275;4385.166818304512;4466.59800617946;4502;4512.075024619945;4514.119746649405;2860;2886.696896825824;2906.244376462114;2914.373409716921;2915.416916616664;877.6313948141795;914.3599480363705;928.1600151862575;957.9808403831954;959.8416261316875;10005.64980225696;10070.597176112946;10083.59665613382;10087.546060427225;10100.545475453622;4037.9394309085387;4098.938515922264;4123.0516981093915;4126.504819421629;4161.459010328698;7920.366370690331;7944.721934732373;7982.760517184493;7985.720499782596;7994.880076798852;4537.38745269391;4542.659300552472;4574.45106587205;4575.885602859955;4577.725336479822;4135.97932010338;4137.40007698882;4143.4199212110325;4151.584841515824;4164.541900390955;3207.2302647364463;3396.626371099177;3412.590489141319;3442.4147894857933;3448.0000799768286;997.4962643864802;1076.445630500293;1087.8041952448634;1095.3592148593002;1098.4562641492512;958.1855422890627;959.3428501476511;1006.6325791086201;1050;1291.8708129187194;6927.792166235021;6939.132608423947;6944.513884028171;6957.512974091765;6966.233714291424;576.9192313076172;584.3163498706524;593.4214141212369;630.3948209718629;740.333699670301;5177.404598471224;5220.504052115043;5223.973880130575;5228.9477105229225;5243.10867152585;8321.209485098905;8445.873311900326;8624.870626940601;8639;8952;8336.583170841433;8390.706325278587;8496.937882764654;8565.486070835645;8580.785480363042;6817.352351526597;6883.724651013903;6985.126859142607;7004.124484439445;7042.542234754725;6842.828929276808;6844.589324640538;6878;6878.484113691393;6899.965500172668;7602.315791578784;7826.726064587712;7878.645460954156;7941.12647608751;8039.356851451987;7873.409494287836;8002.319802816825;8027.759167224759;8028.4781489203015;8169.305609023299;6404.9039264412;6424.421802037839;6479.481641468766;6503.642299673564;6604.801855944329;6410.647414392253;6531.804045878631;7228.277172282729;7242.7465038725495;7304.196538380667;6524.347565243627;6566.573172743756;6602.306757790363;6631.668416579055;6732.124823772878;6452.612843229421;6461.57999730016;6524.902126468011;6533.640649764308;6616.239132499824;6503.44720698727;6618.2719900811835;6630.900536492053;6642.368974947372;6648.1357423536565;6009.519238460825;6046.455818976313;6053.243344581927;6054.424829641177;6066.3630318815885;5883.882322353615;5937.465628093492;6081.057436097412;6081.300650425081;6083.695815209133 23:06:57 INFO - PROCESS | 26745 | |4;prototype.html;328.2859779978547;332.6208122740077;337.88680791934706;341.3838022369625;342.5427054881733;5849.883002339956;5881.147233651129;5884.058550631899;5909.172715819784;5923.726398824252;5546.140348246018;5583.441655834415;5695.003374409483;5767.769289228437;5786.276715410574;4436.068425630605;4453.665975051884;4466.8883277917985;4468.888277793057;4481.282994720846;4287.292596721537;4414.404055452521;4451.5993560579545;4464.799084041209;4468.776561171945;4321.027768752037;4372.868813935587;4428.468583769936;4441.911161776762;4447.177272204653;4421.46942366918;4422.955770442302;4423.248047831877;4425.35832304314;4427.756473393962;3942.211557688474;3951.170254246612;3965.722399432041;3971.860984865516;3978.5822488638564;5448.564114870801;5556.749946252428;5556.86107847303;5565.916511252334;5570.805021824217;5188.533032027098;5192.558632516203;5195.636305458619;5200.349956255468;5202.739863006835;6107.63354198745;6148.84627884302;6149.631022138686;6149.84625384369;6153.569250152491;4368.803403846803;4371.934420983688;4377.299632058855;4378.299472084451;4380.145871555048;6264.874702505925;6380.074889141095;6392.840178995562;6405.48756099511;6414.583052101645;4489.551044895549;4495.617872480811;4496.482904465963;4497.437820272466;4504.099180163915;4504.887377815581;4529.909401812011;4548;4555.293929440942;4555.544445555418;5172.508611681884;5172.793088276502;5183.092958732207;5186.066508028515;5189.117849965515;6026.457618814327;6197.5351848610635;6199.473044791243;6204.7828326008375;6206.534509911684;1558.9220538973234;1566.2716836671002;1566.2873392606564;1567.2085596773557;1567.4200545798128;1056.2870062707796;1067.4342598422693;1070.2454769387564;1082.3289560472558;1085.2891356161726;5909.025010873243;5927.703614819242;5930.318013428425;5930.614510056833;5941.168236446901;6332.208473940757;6332.52506062038;6333.841653958596;6343.270523889812;6356.618602883842;5747.885042299131;5805.303363596396;5851.6781577012825;5910.497607703307;5911.940880591139;3402.1324562236473;3414.214730611973;3414.8463319150696;3435.2957643682985;3444.8976327575438;6484.773032943825;6584.078229047937;6643.534952553275;6665.566738162004;6667.733290668319;6380.0748891410485;6503.6097834130105;6547.214334279917;6553.639549824806;6564.606123632598;6646.6676666166495;6658.766943157063;6674.733010679615;6689.063531105649;6714.060031595581;6410.45511131559;6422.229332480132;6429.164208652845;6430.7749228776765;6431.678416079084;6191.226096737908;6361.77733779334;6369.745210191726;6380.330065343258;6385;6690.665466726741;6692.163479565054;6693.631850248283;6709.698063587052;6728.629925353956;4402.9559704402545;4408.052268762103;4424.469063712375;4426.313921342197;4431.556844315543;6235.75056997715;6438.484921206198;6473.579217350857;6475.967620161869;6479;6306.842328941813;6310.873782524415;6318.304986451579;6320.399562041599;6323.304436511888;6298.905516417349;6299.181106456132;6299.244090709144;6300.527460440394;6302.779402720883;6073.271207455134;6163.876722465615;6166.784162554289;6173.506119510518;6183.443490085734;6315.715792789244;6317.589356691984;6321.8735625288155;6323.336049714714;6327.683615819283;6141.570090093651;6168.568200225941;6177.81466556004;6181;6182.505399567934 23:06:57 INFO - PROCESS | 26745 | |5;yui.html;718.9820254493637;745.735263981287;828.8590939540278;848.0883050720477;853.9188777066179;11880.76238475231;11894.52421903125;11949.223300485462;11949.940250298747;12013.819792703094;11846.466908989094;11867.52529898803;11918.523259069649;11997.34014629195;12064.215825971305;684.6782012454139;690.5442408010714;771.5640663025387;804.2359758229676;816.0941355095839;797;812.9878301514623;815.7838172884191;816.3428440105743;816.6651672814147;836.7447928381841;843.3674743942044;846.0777752250046;848.3891598049426;848.6053984897021;698.4761428928279;699.3775539769609;836.4437648963432;849.864021756519;855.7133360324299;625.7184267079787;625.8623102917351;626.1922120464641;626.6334194496225;627.419636835925;11552.422378881023;11648.126390520745;11695.181337306392;11703;11707.297562146214;10234.283600147992;10918.945405273002;11096.500657470353;11364.147688923364;11951;10063.748406289902;10109;10174.949125254401;10179.287449878511;10263;3432.1591210153674;3548.8399549573955;3577.7853328800356;3614.981925090384;3622.0039489140695;47301.29048064282;48746.7562662188;48804.023919521765;48903.755481222724;48968.755156224346;9526.095020972996;9528.666496672722;9533.237341012702;9567.13895749372;9741.318107732392;16794.328226870788;16835.915820421065;16893.577660558338;16928.322867085426;16954.321827127023;7126.964365178244;7205.207427183006;7266.672999715025;7291.708331666674;7432.888506672404;3739.3269211542183;3805.372113601225;3809.2571948470336;3846.442265871433;4002.839886404511;2858.0711268837713;2889.335452845857;2904.1142451552478;2904.361040571071;2908.6218791557385;497.562145312123;502.5778346189219;520.1106108554415;525.5480286953217;527.4540850220004;544.5262621519224;601.560860571785;609.938706650425;616.4939520847739;628.5254632752243;8515.531645759418;8948;9108.681196158102;9311.115444032806;9338.37053238549;492.74623568862063;532.5954357463753;637.9856028914049;639.2073828452685;653.6568301641677;3530.541029666127;3661.6521430464063;3795.6014618465215;3817.4273858921383;3832;51931.22103168455;53455.73272133692;55150;57496.71251643798;57576;46167.30749038767;47261.29108063382;47378.76310618425;47421.762891185324;48015;43511.782441088224;45603.77198113988;45836.3124553132;46179.30731039037;46581.5341846584;8177;8279.379046571652;8468.788280293042;8531.445456045338;8815.03034666199;33618;33694.3261134771;33927.830360848035;34493.65506344904;35429;41127;41281.793591031856;43089.56910430981;44378;44807.77596111999;9697.709068727949;10646.414447205478;11125.944370278097;11159.665210043711;11198.04816590599;11659.650210493699;11836.289822610672;11840.70398240051;12121.75756484883;13006.674833128869;11099.667009989713;11332.830007549728;11769.764604707687;11822.940885295518;12100.515979360727;11254.606088786853;11506.654800356002;11599.6520104397;11819.940900295443;11929.463174157358;10606.893931060591;11120.277181983145;11258.09935205198;11310.60412885545;11384.69076056231;9409.435433873989;9473.621055157717;9604.231661467205;9634.614615415305;9779.706608801747;8220.498097612788;8648.740537783877;8794.692185773723;9123.726288211365;9396.483193424427 23:06:57 INFO - PROCESS | 26745 | __end_tp_report 23:06:57 INFO - PROCESS | 26745 | __start_cc_report 23:06:57 INFO - PROCESS | 26745 | _x_x_mozilla_cycle_collect,974 23:06:57 INFO - PROCESS | 26745 | __end_cc_report 23:06:57 INFO - PROCESS | 26745 | __startTimestamp1452150417503__endTimestamp 23:06:57 INFO - PROCESS | 26745 | 23:06:57 INFO - PROCESS | 26745 | ------- Summary: start ------- 23:06:57 INFO - PROCESS | 26745 | Number of tests: 6 23:06:57 INFO - PROCESS | 26745 | 23:06:57 INFO - PROCESS | 26745 | [#0] dojo.html Cycles:165 Average:5077.59 Median:5213.48 stddev:528.95 (10.1%) stddev-sans-first:507.80 23:06:57 INFO - PROCESS | 26745 | Values: 3120.5 3145.5 3215.0 3216.5 3256.1 5067.5 5153.7 5173.6 5195.8 5218.3 5006.7 5027.4 5086.8 5092.1 5102.0 4499.8 4658.7 4682.9 4752.0 4825.0 4546.6 4645.2 4740.8 4742.1 4765.9 4635.8 4710.5 4714.1 4746.3 4759.0 4650.9 4691.6 4691.8 4730.5 4735.4 4560.0 4662.3 4697.4 4699.9 4710.7 4846.2 4868.3 4872.1 4872.3 4876.0 5278.7 5303.3 5306.4 5317.4 5341.1 5380.8 5392.6 5421.6 5494.5 5497.2 5189.1 5213.5 5217.0 5218.1 5219.8 5578.4 5613.6 5663.2 5664.5 5670.7 5144.8 5182.5 5222.7 5230.3 5317.1 5454.0 5464.5 5480.2 5480.8 5491.0 5337.9 5402.8 5409.4 5410.5 5456.7 5316.9 5379.1 5390.1 5390.8 5458.0 4320.8 4327.4 4329.8 4332.9 4361.2 3842.6 3846.8 3857.1 3885.6 3897.4 4974.7 5067.0 5071.7 5073.2 5199.2 5424.1 5492.0 5504.3 5504.8 5505.9 5143.0 5148.5 5150.0 5154.6 5198.0 4602.6 4626.5 4656.0 4674.4 4710.2 5756.9 5780.8 5782.8 5783.5 5784.3 5502.6 5544.5 5548.0 5550.5 5553.3 5482.9 5548.9 5591.2 5609.8 5651.1 5404.1 5422.3 5430.3 5430.4 5432.3 5413.8 5496.9 5499.8 5501.2 5555.0 5269.8 5323.6 5406.0 5406.1 5463.1 5270.9 5271.7 5272.6 5281.3 5294.2 5127.1 5130.3 5180.5 5204.1 5220.2 5123.5 5355.1 5399.1 5404.2 5467.8 5177.6 5178.7 5179.3 5187.8 5199.3 23:06:57 INFO - PROCESS | 26745 | 23:06:57 INFO - PROCESS | 26745 | [#1] ext.html Cycles:180 Average:43725.24 Median:164796.77 stddev:74668.77 (45.3%) stddev-sans-first:74807.80 23:06:57 INFO - PROCESS | 26745 | Values: 529.2 535.2 558.9 573.5 575.3 27691.7 28367.6 35573.0 35821.0 35872.6 38537.0 38600.8 38892.0 39001.2 39103.6 7407.1 7481.4 8296.4 8466.4 8469.4 9893.6 10052.3 10061.6 10063.0 10063.7 9956.4 9976.4 10051.3 10059.2 10059.9 7650.5 7810.7 7844.3 7849.4 9916.7 9897.4 10021.2 10044.4 10057.1 10057.2 35784.0 35835.5 36261.3 36263.3 36272.0 3075.9 3082.5 3131.1 3333.2 3592.7 27519.4 27522.6 28217.0 29667.3 29696.7 3328.6 3341.4 3411.8 3420.0 3450.9 250776.0 253644.0 253677.0 254056.0 254584.0 48521.5 49601.3 49659.5 55797.7 56377.4 35506.8 60372.7 61078.0 61140.4 61170.0 15759.9 15850.1 15876.4 16051.5 16057.7 12177.2 12331.6 12350.4 12389.9 12391.4 18216.5 18444.7 18570.8 18645.3 18713.4 7392.4 7475.6 7607.2 7649.5 7675.7 886.3 950.4 1033.1 1073.8 1090.0 24259.0 24695.5 24893.4 25240.6 26469.7 1045.2 1109.8 1115.7 1143.8 1162.4 13635.8 13812.9 13928.6 13973.2 14003.6 299190.0 305091.0 306018.0 306471.0 307184.0 50247.7 50369.5 50382.5 50441.7 50472.2 1294.3 1316.3 1330.8 1338.3 1339.1 25328.6 26225.5 26234.5 26258.6 26270.6 42379.8 42729.6 42783.8 42790.0 42839.0 292689.0 295655.0 295816.0 296179.0 296949.0 25895.0 27257.2 27510.3 30601.4 31497.8 35788.6 36107.8 36512.8 36704.8 38600.6 32974.3 33893.7 34081.7 34437.5 34530.5 27808.4 30403.5 30602.0 31068.2 31537.2 24773.4 24825.9 28572.6 29048.4 29377.4 25912.4 25930.0 26630.2 26976.3 27164.9 22953.4 23698.5 24022.2 24080.4 24089.9 23:06:57 INFO - PROCESS | 26745 | 23:06:57 INFO - PROCESS | 26745 | [#2] jquery.html Cycles:180 Average:28501.41 Median:42054.72 stddev:83088.17 (197.6%) stddev-sans-first:83294.39 23:06:57 INFO - PROCESS | 26745 | Values: 358.3 358.4 361.5 364.3 364.5 13275.3 13649.7 15834.1 15836.2 16241.4 15256.1 15352.4 15662.4 15675.2 15687.9 5020.1 5148.9 5184.6 5186.9 5189.0 3526.2 3565.5 5124.4 6409.7 6605.9 6430.0 6487.6 6522.0 6584.1 6584.1 6505.1 6540.2 6555.2 6557.5 6562.0 6137.0 6227.5 6275.6 6292.5 6309.7 21840.9 21862.6 22054.8 22488.9 22496.1 2172.9 2205.9 2219.9 2252.3 2286.9 13570.5 13688.9 13970.6 14078.3 14279.4 1861.7 1946.2 1955.6 1987.1 1991.0 65698.3 68780.3 70291.0 70576.3 70873.0 14808.5 14880.3 14917.9 14920.8 14942.3 23487.2 23754.4 23755.6 23792.0 23825.5 8916.0 8986.1 8986.7 8999.6 9093.7 7759.1 7767.1 7840.7 7841.3 7849.5 6631.3 7344.0 7464.9 7479.5 7484.7 2631.2 2978.3 3052.3 3125.7 3163.2 889.3 891.5 913.7 977.8 978.3 14848.2 15527.1 16137.1 16150.0 16253.9 887.8 915.4 918.0 921.3 948.9 8915.0 9285.8 9328.3 9736.0 9782.7 476814.0 481269.0 482076.0 530739.0 564809.0 72557.0 75064.0 75428.2 76924.0 77242.0 1106.0 1126.4 1174.9 1190.7 1192.5 14535.1 14614.8 14817.7 14950.3 15162.8 35558.5 35577.0 36207.6 36499.5 36617.6 47491.8 47601.8 47678.5 49120.5 49648.8 8911.4 9540.8 9611.7 9617.4 9620.6 11798.2 13201.1 13706.5 14947.8 16591.4 12613.4 12710.2 13311.5 13578.7 13581.8 9487.5 9619.1 9782.0 12838.4 13626.3 7104.7 8333.4 8589.2 9717.6 9722.5 13828.7 14067.4 14341.5 14342.2 14423.4 9559.3 9785.0 9972.7 10010.7 10040.2 23:06:57 INFO - PROCESS | 26745 | 23:06:57 INFO - PROCESS | 26745 | [#3] mootools.html Cycles:180 Average:5088.62 Median:3486.99 stddev:2614.41 (75.0%) stddev-sans-first:2606.54 23:06:57 INFO - PROCESS | 26745 | Values: 1337.1 1454.6 1463.6 1595.3 1797.9 6343.6 7110.4 7202.6 7212.4 7213.5 6937.3 7125.1 7127.7 7136.6 7145.4 1915.3 1949.8 1952.2 2219.7 2259.5 1984.2 2243.5 2246.6 2265.6 2265.8 2160.8 2198.9 2203.2 2207.3 2219.3 2176.4 2190.5 2190.6 2198.7 2206.8 2202.4 2248.9 2250.1 2251.2 2263.3 7143.2 7217.9 7238.7 7239.4 7249.4 4385.2 4466.6 4502.0 4512.1 4514.1 2860.0 2886.7 2906.2 2914.4 2915.4 877.6 914.4 928.2 958.0 959.8 10005.6 10070.6 10083.6 10087.5 10100.5 4037.9 4098.9 4123.1 4126.5 4161.5 7920.4 7944.7 7982.8 7985.7 7994.9 4537.4 4542.7 4574.5 4575.9 4577.7 4136.0 4137.4 4143.4 4151.6 4164.5 3207.2 3396.6 3412.6 3442.4 3448.0 997.5 1076.4 1087.8 1095.4 1098.5 958.2 959.3 1006.6 1050.0 1291.9 6927.8 6939.1 6944.5 6957.5 6966.2 576.9 584.3 593.4 630.4 740.3 5177.4 5220.5 5224.0 5228.9 5243.1 8321.2 8445.9 8624.9 8639.0 8952.0 8336.6 8390.7 8496.9 8565.5 8580.8 6817.4 6883.7 6985.1 7004.1 7042.5 6842.8 6844.6 6878.0 6878.5 6900.0 7602.3 7826.7 7878.6 7941.1 8039.4 7873.4 8002.3 8027.8 8028.5 8169.3 6404.9 6424.4 6479.5 6503.6 6604.8 6410.6 6531.8 7228.3 7242.7 7304.2 6524.3 6566.6 6602.3 6631.7 6732.1 6452.6 6461.6 6524.9 6533.6 6616.2 6503.4 6618.3 6630.9 6642.4 6648.1 6009.5 6046.5 6053.2 6054.4 6066.4 5883.9 5937.5 6081.1 6081.3 6083.7 23:06:57 INFO - PROCESS | 26745 | 23:06:57 INFO - PROCESS | 26745 | [#4] prototype.html Cycles:180 Average:5197.48 Median:5896.54 stddev:1563.53 (26.5%) stddev-sans-first:1524.60 23:06:57 INFO - PROCESS | 26745 | Values: 328.3 332.6 337.9 341.4 342.5 5849.9 5881.1 5884.1 5909.2 5923.7 5546.1 5583.4 5695.0 5767.8 5786.3 4436.1 4453.7 4466.9 4468.9 4481.3 4287.3 4414.4 4451.6 4464.8 4468.8 4321.0 4372.9 4428.5 4441.9 4447.2 4421.5 4423.0 4423.2 4425.4 4427.8 3942.2 3951.2 3965.7 3971.9 3978.6 5448.6 5556.7 5556.9 5565.9 5570.8 5188.5 5192.6 5195.6 5200.3 5202.7 6107.6 6148.8 6149.6 6149.8 6153.6 4368.8 4371.9 4377.3 4378.3 4380.1 6264.9 6380.1 6392.8 6405.5 6414.6 4489.6 4495.6 4496.5 4497.4 4504.1 4504.9 4529.9 4548.0 4555.3 4555.5 5172.5 5172.8 5183.1 5186.1 5189.1 6026.5 6197.5 6199.5 6204.8 6206.5 1558.9 1566.3 1566.3 1567.2 1567.4 1056.3 1067.4 1070.2 1082.3 1085.3 5909.0 5927.7 5930.3 5930.6 5941.2 6332.2 6332.5 6333.8 6343.3 6356.6 5747.9 5805.3 5851.7 5910.5 5911.9 3402.1 3414.2 3414.8 3435.3 3444.9 6484.8 6584.1 6643.5 6665.6 6667.7 6380.1 6503.6 6547.2 6553.6 6564.6 6646.7 6658.8 6674.7 6689.1 6714.1 6410.5 6422.2 6429.2 6430.8 6431.7 6191.2 6361.8 6369.7 6380.3 6385.0 6690.7 6692.2 6693.6 6709.7 6728.6 4403.0 4408.1 4424.5 4426.3 4431.6 6235.8 6438.5 6473.6 6476.0 6479.0 6306.8 6310.9 6318.3 6320.4 6323.3 6298.9 6299.2 6299.2 6300.5 6302.8 6073.3 6163.9 6166.8 6173.5 6183.4 6315.7 6317.6 6321.9 6323.3 6327.7 6141.6 6168.6 6177.8 6181.0 6182.5 23:06:57 INFO - PROCESS | 26745 | 23:06:57 INFO - PROCESS | 26745 | [#5] yui.html Cycles:180 Average:13268.58 Median:47281.29 stddev:15409.84 (32.6%) stddev-sans-first:15424.25 23:06:57 INFO - PROCESS | 26745 | Values: 719.0 745.7 828.9 848.1 853.9 11880.8 11894.5 11949.2 11949.9 12013.8 11846.5 11867.5 11918.5 11997.3 12064.2 684.7 690.5 771.6 804.2 816.1 797.0 813.0 815.8 816.3 816.7 836.7 843.4 846.1 848.4 848.6 698.5 699.4 836.4 849.9 855.7 625.7 625.9 626.2 626.6 627.4 11552.4 11648.1 11695.2 11703.0 11707.3 10234.3 10918.9 11096.5 11364.1 11951.0 10063.7 10109.0 10174.9 10179.3 10263.0 3432.2 3548.8 3577.8 3615.0 3622.0 47301.3 48746.8 48804.0 48903.8 48968.8 9526.1 9528.7 9533.2 9567.1 9741.3 16794.3 16835.9 16893.6 16928.3 16954.3 7127.0 7205.2 7266.7 7291.7 7432.9 3739.3 3805.4 3809.3 3846.4 4002.8 2858.1 2889.3 2904.1 2904.4 2908.6 497.6 502.6 520.1 525.5 527.5 544.5 601.6 609.9 616.5 628.5 8515.5 8948.0 9108.7 9311.1 9338.4 492.7 532.6 638.0 639.2 653.7 3530.5 3661.7 3795.6 3817.4 3832.0 51931.2 53455.7 55150.0 57496.7 57576.0 46167.3 47261.3 47378.8 47421.8 48015.0 43511.8 45603.8 45836.3 46179.3 46581.5 8177.0 8279.4 8468.8 8531.4 8815.0 33618.0 33694.3 33927.8 34493.7 35429.0 41127.0 41281.8 43089.6 44378.0 44807.8 9697.7 10646.4 11125.9 11159.7 11198.0 11659.7 11836.3 11840.7 12121.8 13006.7 11099.7 11332.8 11769.8 11822.9 12100.5 11254.6 11506.7 11599.7 11819.9 11929.5 10606.9 11120.3 11258.1 11310.6 11384.7 9409.4 9473.6 9604.2 9634.6 9779.7 8220.5 8648.7 8794.7 9123.7 9396.5 23:06:57 INFO - PROCESS | 26745 | -------- Summary: end -------- 23:06:57 INFO - PROCESS | 26745 | 23:06:58 INFO - TEST-INFO | 26745: exit 0 23:06:58 INFO - TEST-OK | dromaeo_css | took 1112552ms 23:06:58 INFO - TEST-START | kraken 23:06:58 INFO - operating with platform_type : linux_ 23:06:58 INFO - Initialising browser for kraken test... 23:06:58 INFO - TEST-INFO | started process 26938 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv30uBe/profile http://localhost:40478/getInfo.html) 23:07:02 INFO - PROCESS | 26938 | __metrics Screen width/height:1600/1200 23:07:02 INFO - PROCESS | 26938 | colorDepth:24 23:07:02 INFO - PROCESS | 26938 | Browser inner width/height: 1024/697 23:07:02 INFO - PROCESS | 26938 | __metrics 23:07:02 INFO - PROCESS | 26938 | 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:07:02 INFO - PROCESS | 26938 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:07:03 INFO - TEST-INFO | 26938: exit 0 23:07:03 INFO - Browser initialized. 23:07:03 INFO - Running cycle 1/1 for kraken test... 23:07:03 INFO - TEST-INFO | started process 27023 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv30uBe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:15 INFO - PROCESS | 27023 | RSS: Main: 150208512 23:07:15 INFO - PROCESS | 27023 | 23:07:17 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40478/tests/kraken/driver.html?testName=audio-beat-detection) 23:07:18 INFO - PROCESS | 27023 | RSS: Main: 185909248 23:07:18 INFO - PROCESS | 27023 | 23:07:20 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40478/tests/kraken/driver.html?testName=audio-dft) 23:07:21 INFO - PROCESS | 27023 | RSS: Main: 173936640 23:07:21 INFO - PROCESS | 27023 | 23:07:24 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40478/tests/kraken/driver.html?testName=audio-fft) 23:07:24 INFO - PROCESS | 27023 | RSS: Main: 159649792 23:07:24 INFO - PROCESS | 27023 | 23:07:26 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40478/tests/kraken/driver.html?testName=audio-oscillator) 23:07:27 INFO - PROCESS | 27023 | RSS: Main: 163278848 23:07:27 INFO - PROCESS | 27023 | 23:07:29 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40478/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:07:30 INFO - PROCESS | 27023 | RSS: Main: 163749888 23:07:30 INFO - PROCESS | 27023 | 23:07:33 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40478/tests/kraken/driver.html?testName=imaging-darkroom) 23:07:33 INFO - PROCESS | 27023 | RSS: Main: 164823040 23:07:33 INFO - PROCESS | 27023 | 23:07:36 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40478/tests/kraken/driver.html?testName=imaging-desaturate) 23:07:37 INFO - PROCESS | 27023 | RSS: Main: 164683776 23:07:37 INFO - PROCESS | 27023 | 23:07:40 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40478/tests/kraken/driver.html?testName=json-parse-financial) 23:07:40 INFO - PROCESS | 27023 | RSS: Main: 164646912 23:07:40 INFO - PROCESS | 27023 | 23:07:42 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40478/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:07:43 INFO - PROCESS | 27023 | RSS: Main: 179707904 23:07:43 INFO - PROCESS | 27023 | 23:07:44 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:07:45 INFO - PROCESS | 27023 | RSS: Main: 176472064 23:07:45 INFO - PROCESS | 27023 | 23:07:47 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:07:48 INFO - PROCESS | 27023 | RSS: Main: 188878848 23:07:48 INFO - PROCESS | 27023 | 23:07:50 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:07:51 INFO - PROCESS | 27023 | RSS: Main: 192614400 23:07:51 INFO - PROCESS | 27023 | 23:07:53 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:07:54 INFO - PROCESS | 27023 | RSS: Main: 191832064 23:07:54 INFO - PROCESS | 27023 | 23:07:55 INFO - PROCESS | 27023 | Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40478/tests/kraken/driver.html?testName=ai-astar) 23:07:56 INFO - PROCESS | 27023 | RSS: Main: 249409536 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | __start_tp_report 23:07:56 INFO - PROCESS | 27023 | _x_x_mozilla_page_load 23:07:56 INFO - PROCESS | 27023 | _x_x_mozilla_page_load_details 23:07:56 INFO - PROCESS | 27023 | |i|pagename|runs| 23:07:56 INFO - PROCESS | 27023 | |0;ai-astar;108;110;106;111;112;111;102;111;112;111 23:07:56 INFO - PROCESS | 27023 | |1;audio-beat-detection;158;126;156;175;130;153;155;127;168;134 23:07:56 INFO - PROCESS | 27023 | |2;audio-dft;162;160;160;160;160;160;161;163;162;162 23:07:56 INFO - PROCESS | 27023 | |3;audio-fft;71;74;86;98;72;71;72;95;94;74 23:07:56 INFO - PROCESS | 27023 | |4;audio-oscillator;96;97;141;95;96;96;143;96;96;141 23:07:56 INFO - PROCESS | 27023 | |5;imaging-gaussian-blur;109;109;109;109;109;109;108;109;110;109 23:07:56 INFO - PROCESS | 27023 | |6;imaging-darkroom;146;145;145;145;145;145;146;145;145;145 23:07:56 INFO - PROCESS | 27023 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;96 23:07:56 INFO - PROCESS | 27023 | |8;json-parse-financial;58;58;56;57;57;58;57;58;60;56 23:07:56 INFO - PROCESS | 27023 | |9;json-stringify-tinderbox;68;68;67;68;68;67;68;70;68;71 23:07:56 INFO - PROCESS | 27023 | |10;stanford-crypto-aes;86;90;86;86;87;86;85;93;86;87 23:07:56 INFO - PROCESS | 27023 | |11;stanford-crypto-ccm;117;115;120;117;118;118;128;117;115;123 23:07:56 INFO - PROCESS | 27023 | |12;stanford-crypto-pbkdf2;155;155;155;152;157;145;156;152;154;143 23:07:56 INFO - PROCESS | 27023 | |13;stanford-crypto-sha256-iterative;68;68;70;67;70;69;70;68;66;69 23:07:56 INFO - PROCESS | 27023 | __end_tp_report 23:07:56 INFO - PROCESS | 27023 | __start_cc_report 23:07:56 INFO - PROCESS | 27023 | _x_x_mozilla_cycle_collect,933 23:07:56 INFO - PROCESS | 27023 | __end_cc_report 23:07:56 INFO - PROCESS | 27023 | __startTimestamp1452150476201__endTimestamp 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | ------- Summary: start ------- 23:07:56 INFO - PROCESS | 27023 | Number of tests: 14 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.20 (2.9%) stddev-sans-first:3.36 23:07:56 INFO - PROCESS | 27023 | Values: 108.0 110.0 106.0 111.0 112.0 111.0 102.0 111.0 112.0 111.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:155.50 stddev:17.67 (11.4%) stddev-sans-first:18.39 23:07:56 INFO - PROCESS | 27023 | Values: 158.0 126.0 156.0 175.0 130.0 153.0 155.0 127.0 168.0 134.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.15 (0.7%) stddev-sans-first:1.17 23:07:56 INFO - PROCESS | 27023 | Values: 162.0 160.0 160.0 160.0 160.0 160.0 161.0 163.0 162.0 162.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#3] audio-fft Cycles:10 Average:80.70 Median:80.00 stddev:11.25 (14.1%) stddev-sans-first:11.37 23:07:56 INFO - PROCESS | 27023 | Values: 71.0 74.0 86.0 98.0 72.0 71.0 72.0 95.0 94.0 74.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:96.00 stddev:22.07 (23.0%) stddev-sans-first:22.85 23:07:56 INFO - PROCESS | 27023 | Values: 96.0 97.0 141.0 95.0 96.0 96.0 143.0 96.0 96.0 141.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 23:07:56 INFO - PROCESS | 27023 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 108.0 109.0 110.0 109.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 23:07:56 INFO - PROCESS | 27023 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 23:07:56 INFO - PROCESS | 27023 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.00 stddev:1.18 (2.0%) stddev-sans-first:1.24 23:07:56 INFO - PROCESS | 27023 | Values: 58.0 58.0 56.0 57.0 57.0 58.0 57.0 58.0 60.0 56.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.32 23:07:56 INFO - PROCESS | 27023 | Values: 68.0 68.0 67.0 68.0 68.0 67.0 68.0 70.0 68.0 71.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:86.50 stddev:2.44 (2.8%) stddev-sans-first:2.55 23:07:56 INFO - PROCESS | 27023 | Values: 86.0 90.0 86.0 86.0 87.0 86.0 85.0 93.0 86.0 87.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:118.00 stddev:3.99 (3.4%) stddev-sans-first:4.18 23:07:56 INFO - PROCESS | 27023 | Values: 117.0 115.0 120.0 117.0 118.0 118.0 128.0 117.0 115.0 123.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:155.00 stddev:4.72 (3.0%) stddev-sans-first:4.91 23:07:56 INFO - PROCESS | 27023 | Values: 155.0 155.0 155.0 152.0 157.0 145.0 156.0 152.0 154.0 143.0 23:07:56 INFO - PROCESS | 27023 | 23:07:56 INFO - PROCESS | 27023 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 23:07:56 INFO - PROCESS | 27023 | Values: 68.0 68.0 70.0 67.0 70.0 69.0 70.0 68.0 66.0 69.0 23:07:56 INFO - PROCESS | 27023 | -------- Summary: end -------- 23:07:56 INFO - PROCESS | 27023 | 23:07:57 INFO - TEST-INFO | 27023: exit 0 23:07:57 INFO - TEST-OK | kraken | took 58949ms 23:07:57 INFO - TEST-START | v8_7 23:07:57 INFO - operating with platform_type : linux_ 23:07:57 INFO - Initialising browser for v8_7 test... 23:07:57 INFO - TEST-INFO | started process 27272 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJvioOa/profile http://localhost:40478/getInfo.html) 23:08:00 INFO - PROCESS | 27272 | __metrics Screen width/height:1600/1200 23:08:00 INFO - PROCESS | 27272 | colorDepth:24 23:08:00 INFO - PROCESS | 27272 | Browser inner width/height: 1024/697 23:08:00 INFO - PROCESS | 27272 | __metrics 23:08:01 INFO - PROCESS | 27272 | 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:08:01 INFO - PROCESS | 27272 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:08:02 INFO - TEST-INFO | 27272: exit 0 23:08:02 INFO - Browser initialized. 23:08:02 INFO - Running cycle 1/1 for v8_7 test... 23:08:02 INFO - TEST-INFO | started process 27353 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJvioOa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:08:13 INFO - PROCESS | 27353 | RSS: Main: 149762048 23:08:13 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:40478/tests/v8_7/run.html (next: http://localhost:40478/tests/v8_7/run.html) 23:08:35 INFO - PROCESS | 27353 | RSS: Main: 623906816 23:08:35 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | __start_tp_report 23:08:35 INFO - PROCESS | 27353 | _x_x_mozilla_page_load 23:08:35 INFO - PROCESS | 27353 | _x_x_mozilla_page_load_details 23:08:35 INFO - PROCESS | 27353 | |i|pagename|runs| 23:08:35 INFO - PROCESS | 27353 | |0;Richards;168.15200941651253 23:08:35 INFO - PROCESS | 27353 | |1;DeltaBlue;190.8761213972132 23:08:35 INFO - PROCESS | 27353 | |2;Encrypt;280.19052956010086 23:08:35 INFO - PROCESS | 27353 | |3;Decrypt;5186.5284974093265 23:08:35 INFO - PROCESS | 27353 | |4;RayTrace;1113.5857461024498 23:08:35 INFO - PROCESS | 27353 | |5;Earley;789.8894154818325 23:08:35 INFO - PROCESS | 27353 | |6;Boyer;12280.487804878048 23:08:35 INFO - PROCESS | 27353 | |7;RegExp;25425 23:08:35 INFO - PROCESS | 27353 | |8;Splay;636.9426751592357 23:08:35 INFO - PROCESS | 27353 | |9;NavierStokes;4840.579710144928 23:08:35 INFO - PROCESS | 27353 | __end_tp_report 23:08:35 INFO - PROCESS | 27353 | __startTimestamp1452150515563__endTimestamp 23:08:35 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | ------- Summary: start ------- 23:08:35 INFO - PROCESS | 27353 | Number of tests: 10 23:08:35 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | [#0] Richards Cycles:1 Average:168.15 Median:168.15 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 27353 | Values: 168.2 23:08:35 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | [#1] DeltaBlue Cycles:1 Average:190.88 Median:190.88 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 27353 | Values: 190.9 23:08:35 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 27353 | Values: 280.2 23:08:35 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 27353 | Values: 5186.5 23:08:35 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | [#4] RayTrace Cycles:1 Average:1113.59 Median:1113.59 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 27353 | Values: 1113.6 23:08:35 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 27353 | Values: 789.9 23:08:35 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 27353 | Values: 12280.5 23:08:35 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | [#7] RegExp Cycles:1 Average:25425.00 Median:25425.00 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 27353 | Values: 25425.0 23:08:35 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | [#8] Splay Cycles:1 Average:636.94 Median:636.94 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 27353 | Values: 636.9 23:08:35 INFO - PROCESS | 27353 | 23:08:35 INFO - PROCESS | 27353 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 27353 | Values: 4840.6 23:08:35 INFO - PROCESS | 27353 | -------- Summary: end -------- 23:08:35 INFO - PROCESS | 27353 | 23:08:36 INFO - TEST-INFO | 27353: exit 0 23:08:36 INFO - TEST-OK | v8_7 | took 39276ms 23:08:36 INFO - SUITE-END | took 1210s 23:08:36 INFO - Completed test suite (00:20:10) 23:08:36 INFO - Working with test: dromaeo_css 23:08:36 INFO - Generating results file: dromaeo_css 23:08:36 INFO - Working with test: kraken 23:08:36 INFO - Generating results file: kraken 23:08:36 INFO - javascript benchmark 23:08:36 INFO - Working with test: v8_7 23:08:36 INFO - Generating results file: v8_7 23:08:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:08:36 INFO - process_Request line: dromaeo_css 6781.47 graph.html#tests=[[72,64,35]] 23:08:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:36 INFO - process_Request line: kraken 1511.80 graph.html#tests=[[232,64,35]] 23:08:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:36 INFO - process_Request line: v8_7 20883.40 graph.html#tests=[[230,64,35]] 23:08:36 INFO - RETURN: dromaeo_css: 6781.47 23:08:36 INFO - RETURN: kraken: 1511.80 23:08:36 INFO - RETURN: v8_7: 20883.40 23:08:36 INFO - javascript benchmark 23:08:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3120.4851199552077, 3145.512445570936, 3214.9678503214977, 3216.4532029554975, 3256.120847371209, 5067.518585734359, 5153.716545589991, 5173.586113110951, 5195.766190521431, 5218.29553010344, 5006.674566153198, 5027.3967123945085, 5086.821961231358, 5092.057969275686, 5101.999999999991, 4499.75251361175, 4658.650601204906, 4682.906341873169, 4751.9762401187945, 4825.010872771091, 4546.61353784927, 4645.163870503308, 4740.786664600084, 4742.1227072991605, 4765.90468190636, 4635.814567417299, 4710.458297295786, 4714.127886341003, 4746.335513028196, 4759.0, 4650.86047418578, 4691.554302341272, 4691.7654117294, 4730.455997560256, 4735.384400027974, 4559.99680070384, 4662.347271382009, 4697.365855609517, 4699.859004229845, 4710.74090924999, 4846.224604063333, 4868.269759536062, 4872.074305881871, 4872.3422337984275, 4875.975620121877, 5278.656887302352, 5303.337082864642, 5306.442823503554, 5317.41508434072, 5341.092014357569, 5380.838574842761, 5392.622516423852, 5421.620486565942, 5494.478024587658, 5497.175423686439, 5189.117849965477, 5213.478652134794, 5217.0, 5218.112920803473, 5219.791208351699, 5578.44215578447, 5613.578981576316, 5663.178839068312, 5664.49019588239, 5670.666300795753, 5144.819931302386, 5182.533571978464, 5222.686638801684, 5230.320058392461, 5317.1492561190025, 5454.0, 5464.480874316933, 5480.150576660624, 5480.808171713971, 5491.039068163055, 5337.946620533823, 5402.783888644411, 5409.432009638931, 5410.458954104637, 5456.672599644034, 5316.893662126736, 5379.058664733656, 5390.137577987503, 5390.757415916293, 5458.017556839727, 4320.783960801948, 4327.437433133736, 4329.805158767863, 4332.891677708019, 4361.193179261847, 3842.5773164951834, 3846.8461261549783, 3857.0550215197454, 3885.572587015426, 3897.415387691869, 4974.651774375831, 5067.0, 5071.721055341992, 5073.16292811682, 5199.2201169824075, 5424.1321388577635, 5492.0, 5504.339479262514, 5504.752286147133, 5505.862353441196, 5142.97428512855, 5148.4851514848215, 5150.0472412603785, 5154.639175257771, 5198.0, 4602.56275653819, 4626.467956185014, 4655.976720116446, 4674.392328997209, 4710.175719249118, 5756.856078597984, 5780.826575202751, 5782.7686892523825, 5783.508401785895, 5784.2769653793275, 5502.642328248651, 5544.473275038865, 5548.0, 5550.4727050931715, 5553.305836770403, 5482.862928426821, 5548.916766248591, 5591.217229587943, 5609.831705048855, 5651.067573850269, 5404.108322126805, 5422.349318081855, 5430.321209848769, 5430.40265570779, 5432.293801805898, 5413.83758487246, 5496.890062198654, 5499.780008799763, 5501.229827824028, 5555.00009998188, 5269.78920843162, 5323.6273460857365, 5406.0, 5406.135018397038, 5463.07127788269, 5270.947290527199, 5271.736413179402, 5272.578193744568, 5281.339832520935, 5294.205869119663, 5127.077126117335, 5130.2817605536, 5180.533751962191, 5204.0892843752945, 5220.21696745476, 5123.5388815005335, 5355.143177091647, 5399.055165346127, 5404.2163886235485, 5467.781288748405, 5177.585793136615, 5178.663386879992, 5179.326687530597, 5187.792488300426, 5199.272101905661], "unit": "score", "name": "dojo.html", "value": 5046.095896909349}, {"lowerIsBetter": false, "replicates": [529.1639210048124, 535.1785010009635, 558.8602849287678, 573.5497634357031, 575.3326141675657, 27691.723082769193, 28367.574486382695, 35573.0, 35821.0, 35872.64127358726, 38537.0, 38600.80699596498, 38892.0, 39001.21997560047, 39103.60896391035, 7407.14817795955, 7481.401487880984, 8296.419250652456, 8466.44968077076, 8469.407141500098, 9893.604255829794, 10052.346597471178, 10061.597536098547, 10063.0, 10063.748406289864, 9956.352837065604, 9976.351537150062, 10051.296409251356, 10059.24555658325, 10059.899401005969, 7650.464467487278, 7810.687572497093, 7844.294013538809, 7849.372050235967, 9916.652917147901, 9897.35667181631, 10021.24840636948, 10044.447555384451, 10057.09486146243, 10057.195424366033, 35784.0, 35835.462468063, 36261.27477450463, 36263.27473450516, 36272.0, 3075.9077227683206, 3082.475979083561, 3131.1232854800464, 3333.233356328034, 3592.7305452091196, 27519.44961100787, 27522.587161192598, 28217.0, 29667.258318541994, 29696.70303296961, 3328.5506456628286, 3341.3818443588016, 3411.812350320731, 3420.0, 3450.9482357764655, 250776.0, 253644.0, 253677.0, 254055.99999999814, 254584.0, 48521.51478485241, 49601.25598116031, 49659.50340496621, 55797.72101139549, 56377.43622563804, 35506.82246588802, 60372.69813650991, 61078.0, 61140.38859611347, 61170.0, 15759.921200394154, 15850.128242946748, 15876.44432444882, 16051.518454446385, 16057.678846423007, 12177.208481448677, 12331.568395106127, 12350.3824808761, 12389.93805030969, 12391.380430978596, 18216.453506394828, 18444.723329150074, 18570.81429185718, 18645.347412840485, 18713.438596842116, 7392.408607311402, 7475.551466911894, 7607.16321204667, 7649.541027538366, 7675.731349402744, 886.3131073418024, 950.4154944708954, 1033.1373303291684, 1073.822819234833, 1089.9891001089889, 24259.0, 24695.5060898781, 24893.377665558506, 25240.621390679156, 26469.735302647114, 1045.163868904873, 1109.7669489407153, 1115.6597237842536, 1143.845580846575, 1162.412981444382, 13635.795463068062, 13812.86187138136, 13928.58214253574, 13973.161610303414, 14003.649908752159, 299190.0, 305091.0, 306018.0, 306471.0, 307184.0, 50247.748761255956, 50369.49630503648, 50382.49617503851, 50441.74779126081, 50472.242916356285, 1294.3204817470714, 1316.2892038299403, 1330.8336457942758, 1338.290705925861, 1339.1094921877038, 25328.620070698587, 26225.475490490466, 26234.475310494065, 26258.606120908586, 26270.605940911282, 42379.7881010593, 42729.572704272556, 42783.7860810694, 42790.0, 42839.0, 292689.0, 295655.0, 295816.0, 296179.0, 296949.0, 25895.0, 27257.182284531496, 27510.312242194104, 30601.387972240875, 31497.8425107873, 35788.642113579575, 36107.81946090253, 36512.81743591265, 36704.81647591745, 38600.613993859704, 32974.34051318912, 33893.661063390035, 34081.65918340884, 34437.48343774895, 34530.482042768876, 27808.44383112367, 30403.54394684037, 30602.0, 31068.223294416915, 31537.21156971094, 24773.380665482786, 24825.87587062053, 28572.57141142926, 29048.419031619673, 29377.412451751272, 25912.352191195372, 25930.0, 26630.20109396721, 26976.289025248832, 27164.864175678995, 22953.426164346023, 23698.526029479657, 24022.15922442706, 24080.39799004969, 24089.879550602134], "unit": "score", "name": "ext.html", "value": 17463.685568758057}, {"lowerIsBetter": false, "replicates": [358.3442300589919, 358.369270084651, 361.5029334664835, 364.28963521133795, 364.49153430963804, 13275.33623318835, 13649.65875853104, 15834.12912289825, 15836.208189590518, 16241.35034598616, 15256.084634921912, 15352.385904563804, 15662.373505059784, 15675.216239188052, 15687.921560392182, 5020.121478741224, 5148.8712782180555, 5184.559312458446, 5186.8703282417955, 5189.040027594888, 3526.2242306692488, 3565.5008298838184, 5124.410692770323, 6409.679516024204, 6605.900911486331, 6429.967850160766, 6487.643179625119, 6521.967390163042, 6584.078229047937, 6584.078229047937, 6505.121808555832, 6540.215174179129, 6555.24614669312, 6557.508186885955, 6562.0, 6137.018077107641, 6227.470664993436, 6275.560710750249, 6292.465140463066, 6309.652969086698, 21840.890795546078, 21862.562748744935, 22054.779452205432, 22488.88755556228, 22496.100155993903, 2172.92394766184, 2205.878676672782, 2219.9001044953015, 2252.268012895799, 2286.919957801469, 13570.525031623845, 13688.931555342258, 13970.580882573538, 14078.2960851957, 14279.428822847074, 1861.7300491428803, 1946.1728765274702, 1955.559999000228, 1987.1157334985937, 1990.9900450497655, 65698.3430165697, 68780.3121968784, 70291.0, 70576.29423705749, 70873.0, 14808.481703140555, 14880.28876679174, 14917.850821491864, 14920.776188357184, 14942.252887355806, 23487.238457115785, 23754.406139846298, 23755.643665345033, 23792.0, 23825.52348953011, 8915.955420222987, 8986.101389860962, 8986.68546600866, 8999.595018224196, 9093.681721139861, 7759.107702614272, 7767.1067827200595, 7840.6863725451485, 7841.294283514511, 7849.48978316419, 6631.336866313427, 7344.0, 7464.925350746532, 7479.513831600929, 7484.663190156456, 2631.1974847671263, 2978.3149875528748, 3052.2674558106337, 3125.7030582094662, 3163.1775738307747, 889.3463304471209, 891.4606662968811, 913.6847787513298, 977.7897751983357, 978.3493976505687, 14848.183349915858, 15527.146006969499, 16137.112458814643, 16150.0, 16253.918730406273, 887.8224355129, 915.3683958068912, 917.9862302065475, 921.3044151665449, 948.9478078705599, 8915.0, 9285.814283714288, 9328.347015708836, 9736.0, 9782.706518804447, 476814.0, 481269.0, 482076.0, 530739.0, 564809.0, 72557.0, 75064.0, 75428.24571754212, 76924.0, 77242.0, 1105.9723506912392, 1126.448040460185, 1174.9353785541878, 1190.743990042145, 1192.4812706472712, 14535.127892326494, 14614.780778288121, 14817.740097178603, 14950.327235274657, 15162.848371516586, 35558.46662300119, 35577.0, 36207.63792362042, 36499.452508212926, 36617.633823661425, 47491.812704682656, 47601.761991191204, 47678.52321476741, 49120.508794913025, 49648.751756240985, 8911.351399991023, 9540.809183816424, 9611.663591774255, 9617.374870633386, 9620.567074481805, 11798.181899869694, 13201.141925774795, 13706.52027179044, 14947.775783363475, 16591.41930032443, 12613.36933153357, 12710.173838700455, 13311.46754129824, 13578.728425431633, 13581.79627305611, 9487.478188699411, 9619.086186812241, 9782.021797820162, 12838.42227099764, 13626.318684065558, 7104.680289387094, 8333.374996875138, 8589.226969572768, 9717.562709678223, 9722.465264410524, 13828.654283642989, 14067.366968486647, 14341.498047568284, 14342.211178385289, 14423.35094920752, 9559.283053770856, 9784.951075244579, 9972.700818975442, 10010.699679009642, 10040.246981476565], "unit": "score", "name": "jquery.html", "value": 9381.411780247374}, {"lowerIsBetter": false, "replicates": [1337.0707358385926, 1454.578172330024, 1463.6414078550756, 1595.2821230446295, 1797.910104494775, 6343.587666801654, 7110.43116550676, 7202.603856787875, 7212.386947109502, 7213.458990575701, 6937.271586483423, 7125.073740413752, 7127.714891404337, 7136.643167841613, 7145.428365730742, 1915.2721965653031, 1949.7855235924037, 1952.1508143957353, 2219.678146668736, 2259.5254996450767, 1984.1765667248076, 2243.4839986803045, 2246.595612789697, 2265.5695417870634, 2265.796078352948, 2160.8487405881597, 2198.857074290174, 2203.151786562177, 2207.293666026872, 2219.3341997400794, 2176.4123686604607, 2190.518086021073, 2190.59473997311, 2198.7471440784357, 2206.8013878750908, 2202.405350555341, 2248.87631180285, 2250.0999600160067, 2251.189571754167, 2263.2644390572964, 7143.214246432888, 7217.855642887165, 7238.746643867492, 7239.38465230456, 7249.420046396275, 4385.166818304512, 4466.59800617946, 4502.0, 4512.075024619945, 4514.119746649405, 2860.0, 2886.696896825824, 2906.244376462114, 2914.373409716921, 2915.416916616664, 877.6313948141795, 914.3599480363705, 928.1600151862575, 957.9808403831954, 959.8416261316875, 10005.64980225696, 10070.597176112946, 10083.59665613382, 10087.546060427225, 10100.545475453622, 4037.9394309085387, 4098.938515922264, 4123.0516981093915, 4126.504819421629, 4161.459010328698, 7920.366370690331, 7944.721934732373, 7982.760517184493, 7985.720499782596, 7994.880076798852, 4537.38745269391, 4542.659300552472, 4574.45106587205, 4575.885602859955, 4577.725336479822, 4135.97932010338, 4137.40007698882, 4143.4199212110325, 4151.584841515824, 4164.541900390955, 3207.2302647364463, 3396.626371099177, 3412.590489141319, 3442.4147894857933, 3448.0000799768286, 997.4962643864802, 1076.445630500293, 1087.8041952448634, 1095.3592148593002, 1098.4562641492512, 958.1855422890627, 959.3428501476511, 1006.6325791086201, 1050.0, 1291.8708129187194, 6927.792166235021, 6939.132608423947, 6944.513884028171, 6957.512974091765, 6966.233714291424, 576.9192313076172, 584.3163498706524, 593.4214141212369, 630.3948209718629, 740.333699670301, 5177.404598471224, 5220.504052115043, 5223.973880130575, 5228.9477105229225, 5243.10867152585, 8321.209485098905, 8445.873311900326, 8624.870626940601, 8639.0, 8952.0, 8336.583170841433, 8390.706325278587, 8496.937882764654, 8565.486070835645, 8580.785480363042, 6817.352351526597, 6883.724651013903, 6985.126859142607, 7004.124484439445, 7042.542234754725, 6842.828929276808, 6844.589324640538, 6878.0, 6878.484113691393, 6899.965500172668, 7602.315791578784, 7826.726064587712, 7878.645460954156, 7941.12647608751, 8039.356851451987, 7873.409494287836, 8002.319802816825, 8027.759167224759, 8028.4781489203015, 8169.305609023299, 6404.9039264412, 6424.421802037839, 6479.481641468766, 6503.642299673564, 6604.801855944329, 6410.647414392253, 6531.804045878631, 7228.277172282729, 7242.7465038725495, 7304.196538380667, 6524.347565243627, 6566.573172743756, 6602.306757790363, 6631.668416579055, 6732.124823772878, 6452.612843229421, 6461.57999730016, 6524.902126468011, 6533.640649764308, 6616.239132499824, 6503.44720698727, 6618.2719900811835, 6630.900536492053, 6642.368974947372, 6648.1357423536565, 6009.519238460825, 6046.455818976313, 6053.243344581927, 6054.424829641177, 6066.3630318815885, 5883.882322353615, 5937.465628093492, 6081.057436097412, 6081.300650425081, 6083.695815209133], "unit": "score", "name": "mootools.html", "value": 4150.70729879734}, {"lowerIsBetter": false, "replicates": [328.2859779978547, 332.6208122740077, 337.88680791934706, 341.3838022369625, 342.5427054881733, 5849.883002339956, 5881.147233651129, 5884.058550631899, 5909.172715819784, 5923.726398824252, 5546.140348246018, 5583.441655834415, 5695.003374409483, 5767.769289228437, 5786.276715410574, 4436.068425630605, 4453.665975051884, 4466.8883277917985, 4468.888277793057, 4481.282994720846, 4287.292596721537, 4414.404055452521, 4451.5993560579545, 4464.799084041209, 4468.776561171945, 4321.027768752037, 4372.868813935587, 4428.468583769936, 4441.911161776762, 4447.177272204653, 4421.46942366918, 4422.955770442302, 4423.248047831877, 4425.35832304314, 4427.756473393962, 3942.211557688474, 3951.170254246612, 3965.722399432041, 3971.860984865516, 3978.5822488638564, 5448.564114870801, 5556.749946252428, 5556.86107847303, 5565.916511252334, 5570.805021824217, 5188.533032027098, 5192.558632516203, 5195.636305458619, 5200.349956255468, 5202.739863006835, 6107.63354198745, 6148.84627884302, 6149.631022138686, 6149.84625384369, 6153.569250152491, 4368.803403846803, 4371.934420983688, 4377.299632058855, 4378.299472084451, 4380.145871555048, 6264.874702505925, 6380.074889141095, 6392.840178995562, 6405.48756099511, 6414.583052101645, 4489.551044895549, 4495.617872480811, 4496.482904465963, 4497.437820272466, 4504.099180163915, 4504.887377815581, 4529.909401812011, 4548.0, 4555.293929440942, 4555.544445555418, 5172.508611681884, 5172.793088276502, 5183.092958732207, 5186.066508028515, 5189.117849965515, 6026.457618814327, 6197.5351848610635, 6199.473044791243, 6204.7828326008375, 6206.534509911684, 1558.9220538973234, 1566.2716836671002, 1566.2873392606564, 1567.2085596773557, 1567.4200545798128, 1056.2870062707796, 1067.4342598422693, 1070.2454769387564, 1082.3289560472558, 1085.2891356161726, 5909.025010873243, 5927.703614819242, 5930.318013428425, 5930.614510056833, 5941.168236446901, 6332.208473940757, 6332.52506062038, 6333.841653958596, 6343.270523889812, 6356.618602883842, 5747.885042299131, 5805.303363596396, 5851.6781577012825, 5910.497607703307, 5911.940880591139, 3402.1324562236473, 3414.214730611973, 3414.8463319150696, 3435.2957643682985, 3444.8976327575438, 6484.773032943825, 6584.078229047937, 6643.534952553275, 6665.566738162004, 6667.733290668319, 6380.0748891410485, 6503.6097834130105, 6547.214334279917, 6553.639549824806, 6564.606123632598, 6646.6676666166495, 6658.766943157063, 6674.733010679615, 6689.063531105649, 6714.060031595581, 6410.45511131559, 6422.229332480132, 6429.164208652845, 6430.7749228776765, 6431.678416079084, 6191.226096737908, 6361.77733779334, 6369.745210191726, 6380.330065343258, 6385.0, 6690.665466726741, 6692.163479565054, 6693.631850248283, 6709.698063587052, 6728.629925353956, 4402.9559704402545, 4408.052268762103, 4424.469063712375, 4426.313921342197, 4431.556844315543, 6235.75056997715, 6438.484921206198, 6473.579217350857, 6475.967620161869, 6479.0, 6306.842328941813, 6310.873782524415, 6318.304986451579, 6320.399562041599, 6323.304436511888, 6298.905516417349, 6299.181106456132, 6299.244090709144, 6300.527460440394, 6302.779402720883, 6073.271207455134, 6163.876722465615, 6166.784162554289, 6173.506119510518, 6183.443490085734, 6315.715792789244, 6317.589356691984, 6321.8735625288155, 6323.336049714714, 6327.683615819283, 6141.570090093651, 6168.568200225941, 6177.81466556004, 6181.0, 6182.505399567934], "unit": "score", "name": "prototype.html", "value": 4692.2122981169305}, {"lowerIsBetter": false, "replicates": [718.9820254493637, 745.735263981287, 828.8590939540278, 848.0883050720477, 853.9188777066179, 11880.76238475231, 11894.52421903125, 11949.223300485462, 11949.940250298747, 12013.819792703094, 11846.466908989094, 11867.52529898803, 11918.523259069649, 11997.34014629195, 12064.215825971305, 684.6782012454139, 690.5442408010714, 771.5640663025387, 804.2359758229676, 816.0941355095839, 797.0, 812.9878301514623, 815.7838172884191, 816.3428440105743, 816.6651672814147, 836.7447928381841, 843.3674743942044, 846.0777752250046, 848.3891598049426, 848.6053984897021, 698.4761428928279, 699.3775539769609, 836.4437648963432, 849.864021756519, 855.7133360324299, 625.7184267079787, 625.8623102917351, 626.1922120464641, 626.6334194496225, 627.419636835925, 11552.422378881023, 11648.126390520745, 11695.181337306392, 11703.0, 11707.297562146214, 10234.283600147992, 10918.945405273002, 11096.500657470353, 11364.147688923364, 11951.0, 10063.748406289902, 10109.0, 10174.949125254401, 10179.287449878511, 10263.0, 3432.1591210153674, 3548.8399549573955, 3577.7853328800356, 3614.981925090384, 3622.0039489140695, 47301.29048064282, 48746.7562662188, 48804.023919521765, 48903.755481222724, 48968.755156224346, 9526.095020972996, 9528.666496672722, 9533.237341012702, 9567.13895749372, 9741.318107732392, 16794.328226870788, 16835.915820421065, 16893.577660558338, 16928.322867085426, 16954.321827127023, 7126.964365178244, 7205.207427183006, 7266.672999715025, 7291.708331666674, 7432.888506672404, 3739.3269211542183, 3805.372113601225, 3809.2571948470336, 3846.442265871433, 4002.839886404511, 2858.0711268837713, 2889.335452845857, 2904.1142451552478, 2904.361040571071, 2908.6218791557385, 497.562145312123, 502.5778346189219, 520.1106108554415, 525.5480286953217, 527.4540850220004, 544.5262621519224, 601.560860571785, 609.938706650425, 616.4939520847739, 628.5254632752243, 8515.531645759418, 8948.0, 9108.681196158102, 9311.115444032806, 9338.37053238549, 492.74623568862063, 532.5954357463753, 637.9856028914049, 639.2073828452685, 653.6568301641677, 3530.541029666127, 3661.6521430464063, 3795.6014618465215, 3817.4273858921383, 3832.0, 51931.22103168455, 53455.73272133692, 55150.0, 57496.71251643798, 57576.0, 46167.30749038767, 47261.29108063382, 47378.76310618425, 47421.762891185324, 48015.0, 43511.782441088224, 45603.77198113988, 45836.3124553132, 46179.30731039037, 46581.5341846584, 8177.0, 8279.379046571652, 8468.788280293042, 8531.445456045338, 8815.03034666199, 33618.0, 33694.3261134771, 33927.830360848035, 34493.65506344904, 35429.0, 41127.0, 41281.793591031856, 43089.56910430981, 44378.0, 44807.77596111999, 9697.709068727949, 10646.414447205478, 11125.944370278097, 11159.665210043711, 11198.04816590599, 11659.650210493699, 11836.289822610672, 11840.70398240051, 12121.75756484883, 13006.674833128869, 11099.667009989713, 11332.830007549728, 11769.764604707687, 11822.940885295518, 12100.515979360727, 11254.606088786853, 11506.654800356002, 11599.6520104397, 11819.940900295443, 11929.463174157358, 10606.893931060591, 11120.277181983145, 11258.09935205198, 11310.60412885545, 11384.69076056231, 9409.435433873989, 9473.621055157717, 9604.231661467205, 9634.614615415305, 9779.706608801747, 8220.498097612788, 8648.740537783877, 8794.692185773723, 9123.726288211365, 9396.483193424427], "unit": "score", "name": "yui.html", "value": 6040.038946415718}], "name": "dromaeo_css", "value": 6781.465032576109}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 106.0, 111.0, 112.0, 111.0, 102.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [158.0, 126.0, 156.0, 175.0, 130.0, 153.0, 155.0, 127.0, 168.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 163.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 86.0, 98.0, 72.0, 71.0, 72.0, 95.0, 94.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 141.0, 95.0, 96.0, 96.0, 143.0, 96.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 56.0, 57.0, 57.0, 58.0, 57.0, 58.0, 60.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0, 70.0, 68.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [86.0, 90.0, 86.0, 86.0, 87.0, 86.0, 85.0, 93.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [117.0, 115.0, 120.0, 117.0, 118.0, 118.0, 128.0, 117.0, 115.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [155.0, 155.0, 155.0, 152.0, 157.0, 145.0, 156.0, 152.0, 154.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 67.0, 70.0, 69.0, 70.0, 68.0, 66.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1511.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.15200941651253], "unit": "score", "name": "Richards", "value": 209.94099399999996}, {"lowerIsBetter": false, "replicates": [190.8761213972132], "unit": "score", "name": "DeltaBlue", "value": 346.39220200000005}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1113.5857461024498], "unit": "score", "name": "RayTrace", "value": 664.510122}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [25425.0], "unit": "score", "name": "RegExp", "value": 35.83028515240902}, {"lowerIsBetter": false, "replicates": [636.9426751592357], "unit": "score", "name": "Splay", "value": 127.94086999999998}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20883.39744664014}]} 23:08:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20883.40"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1511.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6781.47"}}} 23:08:36 INFO - Return code: 0 23:08:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:08:36 INFO - # TBPL SUCCESS # 23:08:36 INFO - Running post-action listener: _resource_record_post_action 23:08:36 INFO - Running post-run listener: _resource_record_post_run 23:08:37 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547569664; Read time: 16; Write time: 480284 23:08:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238608384; Read time: 0; Write time: 243584 23:08:37 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308666368; Read time: 16; Write time: 236676 23:08:37 INFO - Running post-run listener: _upload_blobber_files 23:08:37 INFO - Blob upload gear active. 23:08:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:08:37 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:08:37 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:08:37 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:08:38 INFO - (blobuploader) - INFO - Open directory for files ... 23:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:39 INFO - (blobuploader) - INFO - Done attempting. 23:08:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:08:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:39 INFO - (blobuploader) - INFO - Done attempting. 23:08:39 INFO - (blobuploader) - INFO - Iteration through files over. 23:08:39 INFO - Return code: 0 23:08:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:08:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:08:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b406cd42d971d25684ab2493fb400927b223fc7843c50b59d7d77ff8484e10e09ef13ae65d67a80c711ffffe7aebbdccdc20cdef5066fe48627180a2b16d44b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f02cb57a686415de7cc8cf3db6c3d21c701dfe3b3b7f7dc1a5ce07c332d3039ca658fa80b8ec180ccceb1663b4e636c32e50b33bfe6e2192ae32fcfe7eb5d99"} 23:08:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:08:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:08:39 INFO - Contents: 23:08:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b406cd42d971d25684ab2493fb400927b223fc7843c50b59d7d77ff8484e10e09ef13ae65d67a80c711ffffe7aebbdccdc20cdef5066fe48627180a2b16d44b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f02cb57a686415de7cc8cf3db6c3d21c701dfe3b3b7f7dc1a5ce07c332d3039ca658fa80b8ec180ccceb1663b4e636c32e50b33bfe6e2192ae32fcfe7eb5d99"} 23:08:39 INFO - Copying logs to upload dir... 23:08:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.404422 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-06 23:08:39.742526) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 23:08:39.746175) ========= 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=41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b406cd42d971d25684ab2493fb400927b223fc7843c50b59d7d77ff8484e10e09ef13ae65d67a80c711ffffe7aebbdccdc20cdef5066fe48627180a2b16d44b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f02cb57a686415de7cc8cf3db6c3d21c701dfe3b3b7f7dc1a5ce07c332d3039ca658fa80b8ec180ccceb1663b4e636c32e50b33bfe6e2192ae32fcfe7eb5d99"} build_url:https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b406cd42d971d25684ab2493fb400927b223fc7843c50b59d7d77ff8484e10e09ef13ae65d67a80c711ffffe7aebbdccdc20cdef5066fe48627180a2b16d44b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f02cb57a686415de7cc8cf3db6c3d21c701dfe3b3b7f7dc1a5ce07c332d3039ca658fa80b8ec180ccceb1663b4e636c32e50b33bfe6e2192ae32fcfe7eb5d99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 23:08:39.770792) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 23:08:39.771139) ========= 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=41bf3e9aed84707956354da8000001c5-1452148316.331550-1636937169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 23:08:39.857908) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 23:08:39.858481) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 23:08:39.859023) ========= ========= Total master_lag: 0.28 =========