builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1450903110.27 results: success (0) buildid: 20151223083144 builduid: cd5cab4a8e594f22acb6c831c2869617 revision: 30b9e8aa695d29d815baa2b1f8c05ff2fa10df6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.271694) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.272181) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.272474) ========= 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=edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006190 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.294861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.295163) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.308326) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.308710) ========= 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=edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004747 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.357343) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.357657) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.358041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.358345) ========= 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=edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-23 12:38:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2015-12-23 12:38:31 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173922 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.544333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.544659) ========= 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=edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014275 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.594219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:30.594574) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 30b9e8aa695d29d815baa2b1f8c05ff2fa10df6a --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 30b9e8aa695d29d815baa2b1f8c05ff2fa10df6a --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=edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-23 12:38:31,570 truncating revision to first 12 chars 2015-12-23 12:38:31,570 Setting DEBUG logging. 2015-12-23 12:38:31,570 attempt 1/10 2015-12-23 12:38:31,570 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/30b9e8aa695d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 12:38:31,799 unpacking tar archive at: fx-team-30b9e8aa695d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.494285 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:31.101648) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:31.101963) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:31.110464) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:31.110765) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:31.111215) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-12-23 12:38:31.111505) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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=edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:38:32 INFO - MultiFileLogger online at 20151223 12:38:32 in /builds/slave/test-pgo 12:38:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:38:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:38:32 INFO - {'append_to_log': False, 12:38:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:38:32 INFO - 'blob_upload_branch': 'Fx-Team', 12:38:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:38:32 INFO - 'branch': 'Fx-Team', 12:38:32 INFO - 'buildbot_json_path': 'buildprops.json', 12:38:32 INFO - 'config_files': ('talos/linux_config.py',), 12:38:32 INFO - 'default_actions': ('clobber', 12:38:32 INFO - 'read-buildbot-config', 12:38:32 INFO - 'download-and-extract', 12:38:32 INFO - 'populate-webroot', 12:38:32 INFO - 'create-virtualenv', 12:38:32 INFO - 'install', 12:38:32 INFO - 'run-tests'), 12:38:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:38:32 INFO - 'download_minidump_stackwalk': True, 12:38:32 INFO - 'download_symbols': 'ondemand', 12:38:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:38:32 INFO - 'tooltool.py': '/tools/tooltool.py', 12:38:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:38:32 INFO - '/tools/misc-python/virtualenv.py')}, 12:38:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:38:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:38:32 INFO - 'installer_path': 'installer.exe', 12:38:32 INFO - 'log_level': 'info', 12:38:32 INFO - 'log_name': 'talos', 12:38:32 INFO - 'log_to_console': True, 12:38:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:38:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:38:32 INFO - 'opt_config_files': (), 12:38:32 INFO - 'pip_index': False, 12:38:32 INFO - 'sps_profile': False, 12:38:32 INFO - 'sps_profile_interval': 0, 12:38:32 INFO - 'suite': 'dromaeojs', 12:38:32 INFO - 'system_bits': '64', 12:38:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:38:32 INFO - 'title': 'talos-linux64-ix-063', 12:38:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:38:32 INFO - 'use_talos_json': True, 12:38:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:38:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:38:32 INFO - 'work_dir': 'build'} 12:38:32 INFO - ##### 12:38:32 INFO - ##### Running clobber step. 12:38:32 INFO - ##### 12:38:32 INFO - Running pre-action listener: _resource_record_pre_action 12:38:32 INFO - Running main action method: clobber 12:38:32 INFO - rmtree: /builds/slave/test-pgo/build 12:38:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:38:33 INFO - Running post-action listener: _resource_record_post_action 12:38:33 INFO - ##### 12:38:33 INFO - ##### Running read-buildbot-config step. 12:38:33 INFO - ##### 12:38:33 INFO - Running pre-action listener: _resource_record_pre_action 12:38:33 INFO - Running main action method: read_buildbot_config 12:38:33 INFO - Using buildbot properties: 12:38:33 INFO - { 12:38:33 INFO - "project": "", 12:38:33 INFO - "product": "firefox", 12:38:33 INFO - "script_repo_revision": "production", 12:38:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:38:33 INFO - "repository": "", 12:38:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:38:33 INFO - "buildid": "20151223083144", 12:38:33 INFO - "pgo_build": "True", 12:38:33 INFO - "basedir": "/builds/slave/test-pgo", 12:38:33 INFO - "buildnumber": 558, 12:38:33 INFO - "slavename": "talos-linux64-ix-063", 12:38:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:38:33 INFO - "platform": "ubuntu64_hw", 12:38:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:38:33 INFO - "branch": "fx-team", 12:38:33 INFO - "repo_path": "integration/fx-team", 12:38:33 INFO - "revision": "30b9e8aa695d29d815baa2b1f8c05ff2fa10df6a", 12:38:33 INFO - "stage_platform": "linux64-pgo", 12:38:33 INFO - "builduid": "cd5cab4a8e594f22acb6c831c2869617", 12:38:33 INFO - "slavebuilddir": "test" 12:38:33 INFO - } 12:38:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:38:33 INFO - Running post-action listener: _resource_record_post_action 12:38:33 INFO - ##### 12:38:33 INFO - ##### Running download-and-extract step. 12:38:33 INFO - ##### 12:38:33 INFO - Running pre-action listener: _resource_record_pre_action 12:38:33 INFO - Running main action method: download_and_extract 12:38:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:33 INFO - https://queue.taskcluster.net/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:38:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/test_packages.json 12:38:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/test_packages.json 12:38:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:38:33 INFO - Downloaded 1302 bytes. 12:38:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:38:33 INFO - Using the following test package requirements: 12:38:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:38:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:38:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:33 INFO - u'jsshell-linux-x86_64.zip'], 12:38:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:38:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:38:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:38:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:38:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:38:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:38:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:38:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:33 INFO - https://queue.taskcluster.net/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:38:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:38:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:38:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/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 12:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/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 12:38:34 INFO - Downloaded 23182110 bytes. 12:38:34 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 12:38:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:38:34 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 12:38:35 INFO - Return code: 0 12:38:35 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 12:38:35 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')]} 12:38:35 INFO - https://queue.taskcluster.net/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:38:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:38:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:38:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/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 12:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/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 12:38:36 INFO - Downloaded 23182110 bytes. 12:38:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:38:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:38:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:38:38 INFO - Return code: 0 12:38:38 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')]} 12:38:38 INFO - https://queue.taskcluster.net/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:38:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:38:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:38:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/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 12:38:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/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 12:38:39 INFO - Downloaded 11132277 bytes. 12:38:39 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 12:38:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:38:39 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 12:38:39 INFO - Return code: 0 12:38:39 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')]} 12:38:39 INFO - https://queue.taskcluster.net/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:38:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:38:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:38:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/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 12:38:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AYNW0dZET4imfbnoe-YXpQ/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 12:38:40 INFO - Downloaded 54842630 bytes. 12:38:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:38:40 INFO - mkdir: /builds/slave/test-pgo/properties 12:38:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:38:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:38:40 INFO - Contents: 12:38:40 INFO - build_url:https://queue.taskcluster.net/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:38:40 INFO - Running post-action listener: _resource_record_post_action 12:38:40 INFO - Running post-action listener: set_extra_try_arguments 12:38:40 INFO - ##### 12:38:40 INFO - ##### Running populate-webroot step. 12:38:40 INFO - ##### 12:38:40 INFO - Running pre-action listener: _resource_record_pre_action 12:38:40 INFO - Running main action method: populate_webroot 12:38:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:38:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:38:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:38:40 INFO - '--tppagecycles', 12:38:40 INFO - '7'], 12:38:40 INFO - 'tests': ['tsvgm']}}, 12:38:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:38:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:38:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:38:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:38:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:38:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:38:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:38:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:40 INFO - 'talos_options': ['--e10s'], 12:38:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:38:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:40 INFO - 'tests': ['damp', 'tps']}, 12:38:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:40 INFO - 'talos_options': ['--e10s'], 12:38:40 INFO - 'tests': ['damp', 'tps']}, 12:38:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:38:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:38:40 INFO - 'other': {'tests': ['a11yr', 12:38:40 INFO - 'ts_paint', 12:38:40 INFO - 'tpaint', 12:38:40 INFO - 'sessionrestore', 12:38:40 INFO - 'sessionrestore_no_auto_restore']}, 12:38:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:38:40 INFO - 'tests': ['a11yr', 12:38:40 INFO - 'ts_paint', 12:38:40 INFO - 'tpaint', 12:38:40 INFO - 'sessionrestore', 12:38:40 INFO - 'sessionrestore_no_auto_restore']}, 12:38:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:38:40 INFO - 'tests': ['a11yr', 12:38:40 INFO - 'ts_paint', 12:38:40 INFO - 'tpaint', 12:38:40 INFO - 'sessionrestore', 12:38:40 INFO - 'sessionrestore_no_auto_restore']}, 12:38:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:38:40 INFO - 'tests': ['a11yr', 12:38:40 INFO - 'ts_paint', 12:38:40 INFO - 'tpaint', 12:38:40 INFO - 'sessionrestore', 12:38:40 INFO - 'sessionrestore_no_auto_restore']}, 12:38:40 INFO - 'other_l64': {'tests': ['a11yr', 12:38:40 INFO - 'ts_paint', 12:38:40 INFO - 'tpaint', 12:38:40 INFO - 'sessionrestore', 12:38:40 INFO - 'sessionrestore_no_auto_restore']}, 12:38:40 INFO - 'other_nol64': {'tests': ['a11yr', 12:38:40 INFO - 'ts_paint', 12:38:40 INFO - 'tpaint', 12:38:40 INFO - 'sessionrestore', 12:38:40 INFO - 'sessionrestore_no_auto_restore']}, 12:38:40 INFO - 'svgr': {'tests': ['tsvgx', 12:38:40 INFO - 'tsvgr_opacity', 12:38:40 INFO - 'tart', 12:38:40 INFO - 'tscrollx', 12:38:40 INFO - 'cart']}, 12:38:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:38:40 INFO - 'tests': ['tsvgx', 12:38:40 INFO - 'tsvgr_opacity', 12:38:40 INFO - 'tart', 12:38:40 INFO - 'tscrollx', 12:38:40 INFO - 'cart']}, 12:38:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:40 INFO - 'tests': ['tp5o']}, 12:38:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:40 INFO - 'talos_options': ['--e10s'], 12:38:40 INFO - 'tests': ['tp5o']}, 12:38:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:40 INFO - 'talos_options': ['--xperf_path', 12:38:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:38:40 INFO - 'tests': ['tp5n']}, 12:38:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:40 INFO - 'talos_options': ['--e10s', 12:38:40 INFO - '--xperf_path', 12:38:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:38:40 INFO - 'tests': ['tp5n']}}, 12:38:40 INFO - 'talos.zip': {'path': '', 12:38:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:38:40 INFO - Running post-action listener: _resource_record_post_action 12:38:40 INFO - ##### 12:38:40 INFO - ##### Running create-virtualenv step. 12:38:40 INFO - ##### 12:38:40 INFO - Running pre-action listener: _resource_record_pre_action 12:38:40 INFO - Running main action method: create_virtualenv 12:38:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:38:40 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 12:38:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:38:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:38:40 INFO - Using real prefix '/usr' 12:38:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:38:41 INFO - Installing distribute.............................................................................................................................................................................................done. 12:38:43 INFO - Installing pip.................done. 12:38:43 INFO - Return code: 0 12:38:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:38: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')]} 12:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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')]} 12:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a99361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c5360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a54540>, '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 0x1a55440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a558f0>, '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': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', '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 12:38:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 12:38:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:38:43 INFO - Using env: {'DISPLAY': ':0', 12:38:43 INFO - 'HOME': '/home/cltbld', 12:38:43 INFO - 'LANG': 'en_US.UTF-8', 12:38:43 INFO - 'LANGUAGE': 'en_US:en', 12:38:43 INFO - 'LOGNAME': 'cltbld', 12:38:43 INFO - 'MAIL': '/var/mail/cltbld', 12:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:43 INFO - 'MOZ_NO_REMOTE': '1', 12:38:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:43 INFO - 'NO_EM_RESTART': '1', 12:38:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:43 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:43 INFO - 'SHELL': '/bin/bash', 12:38:43 INFO - 'SHLVL': '1', 12:38:43 INFO - 'TERM': 'linux', 12:38:43 INFO - 'TMOUT': '86400', 12:38:43 INFO - 'USER': 'cltbld', 12:38:43 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', 12:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:43 INFO - '_': '/tools/buildbot/bin/python'} 12:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:43 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 12:38:43 INFO - Cleaning up... 12:38:43 INFO - Return code: 0 12:38:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:38: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')]} 12:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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')]} 12:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0a99361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c5360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a54540>, '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 0x1a55440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a558f0>, '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': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', '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 12:38:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 12:38:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:38:43 INFO - Using env: {'DISPLAY': ':0', 12:38:43 INFO - 'HOME': '/home/cltbld', 12:38:43 INFO - 'LANG': 'en_US.UTF-8', 12:38:43 INFO - 'LANGUAGE': 'en_US:en', 12:38:43 INFO - 'LOGNAME': 'cltbld', 12:38:43 INFO - 'MAIL': '/var/mail/cltbld', 12:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:43 INFO - 'MOZ_NO_REMOTE': '1', 12:38:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:43 INFO - 'NO_EM_RESTART': '1', 12:38:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:43 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:43 INFO - 'SHELL': '/bin/bash', 12:38:43 INFO - 'SHLVL': '1', 12:38:43 INFO - 'TERM': 'linux', 12:38:43 INFO - 'TMOUT': '86400', 12:38:43 INFO - 'USER': 'cltbld', 12:38:43 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', 12:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:43 INFO - '_': '/tools/buildbot/bin/python'} 12:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:43 INFO - Downloading/unpacking psutil>=0.7.1 12:38:43 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 12:38:43 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 12:38:43 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 12:38:43 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 12:38:43 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 12:38:43 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 12:38:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:38:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:38:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:38:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:38:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:38:45 INFO - Installing collected packages: psutil 12:38:45 INFO - Running setup.py install for psutil 12:38:45 INFO - building 'psutil._psutil_linux' extension 12:38:45 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 12:38:45 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 12:38:45 INFO - building 'psutil._psutil_posix' extension 12:38:45 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 12:38:46 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 12:38:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:38:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:38:46 INFO - Successfully installed psutil 12:38:46 INFO - Cleaning up... 12:38:46 INFO - Return code: 0 12:38:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0a99361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c5360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a54540>, '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 0x1a55440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a558f0>, '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': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', '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 12:38:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 12:38:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:38:46 INFO - Using env: {'DISPLAY': ':0', 12:38:46 INFO - 'HOME': '/home/cltbld', 12:38:46 INFO - 'LANG': 'en_US.UTF-8', 12:38:46 INFO - 'LANGUAGE': 'en_US:en', 12:38:46 INFO - 'LOGNAME': 'cltbld', 12:38:46 INFO - 'MAIL': '/var/mail/cltbld', 12:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:46 INFO - 'MOZ_NO_REMOTE': '1', 12:38:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:46 INFO - 'NO_EM_RESTART': '1', 12:38:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:46 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:46 INFO - 'SHELL': '/bin/bash', 12:38:46 INFO - 'SHLVL': '1', 12:38:46 INFO - 'TERM': 'linux', 12:38:46 INFO - 'TMOUT': '86400', 12:38:46 INFO - 'USER': 'cltbld', 12:38:46 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', 12:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:46 INFO - '_': '/tools/buildbot/bin/python'} 12:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:38:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:38:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:38:48 INFO - Installing collected packages: mozsystemmonitor 12:38:48 INFO - Running setup.py install for mozsystemmonitor 12:38:48 INFO - Successfully installed mozsystemmonitor 12:38:48 INFO - Cleaning up... 12:38:48 INFO - Return code: 0 12:38:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:38: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')]} 12:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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')]} 12:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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', '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 0x7f0a99361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c5360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a54540>, '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 0x1a55440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a558f0>, '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': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', '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 12:38: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 12:38: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 blobuploader==1.2.4 12:38:48 INFO - Using env: {'DISPLAY': ':0', 12:38:48 INFO - 'HOME': '/home/cltbld', 12:38:48 INFO - 'LANG': 'en_US.UTF-8', 12:38:48 INFO - 'LANGUAGE': 'en_US:en', 12:38:48 INFO - 'LOGNAME': 'cltbld', 12:38:48 INFO - 'MAIL': '/var/mail/cltbld', 12:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:48 INFO - 'MOZ_NO_REMOTE': '1', 12:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:48 INFO - 'NO_EM_RESTART': '1', 12:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:48 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:48 INFO - 'SHELL': '/bin/bash', 12:38:48 INFO - 'SHLVL': '1', 12:38:48 INFO - 'TERM': 'linux', 12:38:48 INFO - 'TMOUT': '86400', 12:38:48 INFO - 'USER': 'cltbld', 12:38:48 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', 12:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:48 INFO - '_': '/tools/buildbot/bin/python'} 12:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:48 INFO - Downloading/unpacking blobuploader==1.2.4 12:38: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 12:38: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 12:38: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 12:38: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 12:38: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 12:38: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 12:38:50 INFO - Downloading blobuploader-1.2.4.tar.gz 12:38:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:38:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:38:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:38: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 12:38: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 12:38: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 12:38: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 12:38: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 12:38: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 12:38:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:38:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:38:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:38: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 12:38: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 12:38: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 12:38: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 12:38: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 12:38: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 12:38:50 INFO - Downloading docopt-0.6.1.tar.gz 12:38:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:38:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:38:51 INFO - Installing collected packages: blobuploader, requests, docopt 12:38:51 INFO - Running setup.py install for blobuploader 12:38:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:38:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:38:51 INFO - Running setup.py install for requests 12:38:51 INFO - Running setup.py install for docopt 12:38:51 INFO - Successfully installed blobuploader requests docopt 12:38:51 INFO - Cleaning up... 12:38:51 INFO - Return code: 0 12:38:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:51 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 0x7f0a99361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c5360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a54540>, '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 0x1a55440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a558f0>, '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': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', '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 12:38:51 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 12:38:51 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 12:38:51 INFO - Using env: {'DISPLAY': ':0', 12:38:51 INFO - 'HOME': '/home/cltbld', 12:38:51 INFO - 'LANG': 'en_US.UTF-8', 12:38:51 INFO - 'LANGUAGE': 'en_US:en', 12:38:51 INFO - 'LOGNAME': 'cltbld', 12:38:51 INFO - 'MAIL': '/var/mail/cltbld', 12:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:51 INFO - 'MOZ_NO_REMOTE': '1', 12:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:51 INFO - 'NO_EM_RESTART': '1', 12:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:51 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:51 INFO - 'SHELL': '/bin/bash', 12:38:51 INFO - 'SHLVL': '1', 12:38:51 INFO - 'TERM': 'linux', 12:38:51 INFO - 'TMOUT': '86400', 12:38:51 INFO - 'USER': 'cltbld', 12:38:51 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', 12:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:51 INFO - '_': '/tools/buildbot/bin/python'} 12:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:38:51 INFO - Running setup.py (path:/tmp/pip-YwGV8j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:38:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:38:51 INFO - Running setup.py (path:/tmp/pip-E38kpC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:38:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:38:51 INFO - Running setup.py (path:/tmp/pip-wZNgMN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:38:52 INFO - Running setup.py (path:/tmp/pip-dUX2jU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:38:52 INFO - Running setup.py (path:/tmp/pip-56Ku0l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:38:52 INFO - Running setup.py (path:/tmp/pip-tVybFQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:38:52 INFO - Running setup.py (path:/tmp/pip-ao2Z_n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:38:52 INFO - Running setup.py (path:/tmp/pip-2BLCkM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:38:52 INFO - Running setup.py (path:/tmp/pip-hQqiXF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:38:52 INFO - Running setup.py (path:/tmp/pip-K6EwdU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:38:52 INFO - Running setup.py (path:/tmp/pip-NeGjUb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:38:52 INFO - Running setup.py (path:/tmp/pip-MuIebp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:38:52 INFO - Running setup.py (path:/tmp/pip-RpGyOQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:38:52 INFO - Running setup.py (path:/tmp/pip-Rr1wkK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:38:52 INFO - Running setup.py (path:/tmp/pip-0LYMYp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:38:52 INFO - Running setup.py (path:/tmp/pip-FkQWYW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:38:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:38:52 INFO - Running setup.py (path:/tmp/pip-kk4qQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:38:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:38:53 INFO - Running setup.py install for manifestparser 12:38:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:38:53 INFO - Running setup.py install for mozcrash 12:38:53 INFO - Running setup.py install for mozdebug 12:38:53 INFO - Running setup.py install for mozdevice 12:38:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:38:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:38:53 INFO - Running setup.py install for mozfile 12:38:53 INFO - Running setup.py install for mozhttpd 12:38:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:38:53 INFO - Running setup.py install for mozinfo 12:38:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:38:53 INFO - Running setup.py install for mozInstall 12:38:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:38:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:38:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:38:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:38:53 INFO - Running setup.py install for mozleak 12:38:53 INFO - Running setup.py install for mozlog 12:38:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:38:54 INFO - Running setup.py install for moznetwork 12:38:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:38:54 INFO - Running setup.py install for mozprocess 12:38:54 INFO - Running setup.py install for mozprofile 12:38:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:38:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:38:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:38:54 INFO - Running setup.py install for mozrunner 12:38:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:38:54 INFO - Running setup.py install for mozscreenshot 12:38:54 INFO - Running setup.py install for moztest 12:38:54 INFO - Running setup.py install for mozversion 12:38:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:38:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:38:54 INFO - Cleaning up... 12:38:54 INFO - Return code: 0 12:38:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:38:54 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')]} 12:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:54 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')]} 12:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:54 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 0x7f0a99361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c5360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a54540>, '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 0x1a55440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a558f0>, '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': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', '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 12:38:54 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 12:38:54 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 12:38:54 INFO - Using env: {'DISPLAY': ':0', 12:38:54 INFO - 'HOME': '/home/cltbld', 12:38:54 INFO - 'LANG': 'en_US.UTF-8', 12:38:54 INFO - 'LANGUAGE': 'en_US:en', 12:38:54 INFO - 'LOGNAME': 'cltbld', 12:38:54 INFO - 'MAIL': '/var/mail/cltbld', 12:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:54 INFO - 'MOZ_NO_REMOTE': '1', 12:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:54 INFO - 'NO_EM_RESTART': '1', 12:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:54 INFO - 'SHELL': '/bin/bash', 12:38:54 INFO - 'SHLVL': '1', 12:38:54 INFO - 'TERM': 'linux', 12:38:54 INFO - 'TMOUT': '86400', 12:38:54 INFO - 'USER': 'cltbld', 12:38:54 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', 12:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:54 INFO - '_': '/tools/buildbot/bin/python'} 12:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:38:55 INFO - Running setup.py (path:/tmp/pip-I9SVe_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:38:55 INFO - Running setup.py (path:/tmp/pip-vhHKZj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:38:55 INFO - Running setup.py (path:/tmp/pip-Fd8yK3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:38:55 INFO - Running setup.py (path:/tmp/pip-pmsU6v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:38:55 INFO - Running setup.py (path:/tmp/pip-0d2gR4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:38:55 INFO - Running setup.py (path:/tmp/pip-VPJEEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:38:55 INFO - Running setup.py (path:/tmp/pip-Hk1PnW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:38:55 INFO - Running setup.py (path:/tmp/pip-HH8fcG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:38:55 INFO - Running setup.py (path:/tmp/pip-hwlPlk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:38:55 INFO - Running setup.py (path:/tmp/pip-5Gt0ye-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:38:55 INFO - Running setup.py (path:/tmp/pip-3E8joY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:38:55 INFO - Running setup.py (path:/tmp/pip-xYHAU7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:38:55 INFO - Running setup.py (path:/tmp/pip-f69H23-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:38:55 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)) 12:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:38:55 INFO - Running setup.py (path:/tmp/pip-BtLW8g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:38:56 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)) 12:38:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:38:56 INFO - Running setup.py (path:/tmp/pip-_AQzJK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:38:56 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)) 12:38:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:38:56 INFO - Running setup.py (path:/tmp/pip-qdiMOw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:38:56 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)) 12:38:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:38:56 INFO - Running setup.py (path:/tmp/pip-m4N55u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:38:56 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)) 12:38:56 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)) 12:38:56 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)) 12:38:56 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)) 12:38:56 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)) 12:38:56 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)) 12:38:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:57 INFO - Downloading blessings-1.5.1.tar.gz 12:38:58 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 12:38:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:38:58 INFO - Installing collected packages: blessings 12:38:58 INFO - Running setup.py install for blessings 12:38:58 INFO - Successfully installed blessings 12:38:58 INFO - Cleaning up... 12:38:58 INFO - Return code: 0 12:38:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:38:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:38:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:38:58 INFO - Reading from file tmpfile_stdout 12:38:58 INFO - Current package versions: 12:38:58 INFO - argparse == 1.2.1 12:38:58 INFO - blessings == 1.5.1 12:38:58 INFO - blobuploader == 1.2.4 12:38:58 INFO - docopt == 0.6.1 12:38:58 INFO - manifestparser == 1.1 12:38:58 INFO - mozInstall == 1.12 12:38:58 INFO - mozcrash == 0.16 12:38:58 INFO - mozdebug == 0.1 12:38:58 INFO - mozdevice == 0.47 12:38:58 INFO - mozfile == 1.2 12:38:58 INFO - mozhttpd == 0.7 12:38:58 INFO - mozinfo == 0.9 12:38:58 INFO - mozleak == 0.1 12:38:58 INFO - mozlog == 3.1 12:38:58 INFO - moznetwork == 0.27 12:38:58 INFO - mozprocess == 0.22 12:38:58 INFO - mozprofile == 0.28 12:38:58 INFO - mozrunner == 6.11 12:38:58 INFO - mozscreenshot == 0.1 12:38:58 INFO - mozsystemmonitor == 0.0 12:38:58 INFO - moztest == 0.7 12:38:58 INFO - mozversion == 1.4 12:38:58 INFO - psutil == 3.1.1 12:38:58 INFO - requests == 1.2.3 12:38:58 INFO - wsgiref == 0.1.2 12:38:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:38:58 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')]} 12:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:58 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')]} 12:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:58 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 0x7f0a99361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c5360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a54540>, '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 0x1a55440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a558f0>, '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': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', '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 12:38:58 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 12:38:58 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 12:38:58 INFO - Using env: {'DISPLAY': ':0', 12:38:58 INFO - 'HOME': '/home/cltbld', 12:38:58 INFO - 'LANG': 'en_US.UTF-8', 12:38:58 INFO - 'LANGUAGE': 'en_US:en', 12:38:58 INFO - 'LOGNAME': 'cltbld', 12:38:58 INFO - 'MAIL': '/var/mail/cltbld', 12:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:58 INFO - 'MOZ_NO_REMOTE': '1', 12:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:58 INFO - 'NO_EM_RESTART': '1', 12:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:58 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:58 INFO - 'SHELL': '/bin/bash', 12:38:58 INFO - 'SHLVL': '1', 12:38:58 INFO - 'TERM': 'linux', 12:38:58 INFO - 'TMOUT': '86400', 12:38:58 INFO - 'USER': 'cltbld', 12:38:58 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', 12:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:58 INFO - '_': '/tools/buildbot/bin/python'} 12:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:58 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)) 12:38:58 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)) 12:38:58 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)) 12:38:58 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)) 12:38:58 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)) 12:38:58 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)) 12:38:58 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)) 12:38:58 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)) 12:38:58 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)) 12:38:58 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)) 12:38:58 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)) 12:38:58 INFO - Cleaning up... 12:38:58 INFO - Return code: 0 12:38:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:38:58 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')]} 12:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:58 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')]} 12:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:58 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 0x7f0a99361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c5360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a54540>, '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 0x1a55440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a558f0>, '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': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', '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 12:38:58 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 12:38:58 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 12:38:58 INFO - Using env: {'DISPLAY': ':0', 12:38:58 INFO - 'HOME': '/home/cltbld', 12:38:58 INFO - 'LANG': 'en_US.UTF-8', 12:38:58 INFO - 'LANGUAGE': 'en_US:en', 12:38:58 INFO - 'LOGNAME': 'cltbld', 12:38:58 INFO - 'MAIL': '/var/mail/cltbld', 12:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:58 INFO - 'MOZ_NO_REMOTE': '1', 12:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:58 INFO - 'NO_EM_RESTART': '1', 12:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:58 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:58 INFO - 'SHELL': '/bin/bash', 12:38:58 INFO - 'SHLVL': '1', 12:38:58 INFO - 'TERM': 'linux', 12:38:58 INFO - 'TMOUT': '86400', 12:38:58 INFO - 'USER': 'cltbld', 12:38:58 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', 12:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:58 INFO - '_': '/tools/buildbot/bin/python'} 12:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:59 INFO - Downloading/unpacking jsonschema 12:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:39:00 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 12:39:00 INFO - Downloading/unpacking functools32 (from jsonschema) 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39:00 INFO - Downloading functools32-3.2.3-2.tar.gz 12:39:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:39:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:39:00 INFO - warning: no files found matching '*.txt' 12:39:00 INFO - no previously-included directories found matching 'build' 12:39:00 INFO - no previously-included directories found matching 'dist' 12:39:00 INFO - no previously-included directories found matching '.git*' 12:39:00 INFO - Installing collected packages: jsonschema, functools32 12:39:01 INFO - Running setup.py install for functools32 12:39:01 INFO - warning: no files found matching '*.txt' 12:39:01 INFO - no previously-included directories found matching 'build' 12:39:01 INFO - no previously-included directories found matching 'dist' 12:39:01 INFO - no previously-included directories found matching '.git*' 12:39:01 INFO - Successfully installed jsonschema functools32 12:39:01 INFO - Cleaning up... 12:39:01 INFO - Return code: 0 12:39:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a99361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c5360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a54540>, '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 0x1a55440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a558f0>, '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': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', '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 12:39:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 12:39:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:39:01 INFO - Using env: {'DISPLAY': ':0', 12:39:01 INFO - 'HOME': '/home/cltbld', 12:39:01 INFO - 'LANG': 'en_US.UTF-8', 12:39:01 INFO - 'LANGUAGE': 'en_US:en', 12:39:01 INFO - 'LOGNAME': 'cltbld', 12:39:01 INFO - 'MAIL': '/var/mail/cltbld', 12:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:01 INFO - 'MOZ_NO_REMOTE': '1', 12:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:01 INFO - 'NO_EM_RESTART': '1', 12:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:01 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:01 INFO - 'SHELL': '/bin/bash', 12:39:01 INFO - 'SHLVL': '1', 12:39:01 INFO - 'TERM': 'linux', 12:39:01 INFO - 'TMOUT': '86400', 12:39:01 INFO - 'USER': 'cltbld', 12:39:01 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', 12:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:01 INFO - '_': '/tools/buildbot/bin/python'} 12:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:01 INFO - Downloading/unpacking flake8 12:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:39:03 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 12:39:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:39:03 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 12:39:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39:03 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 12:39:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:39:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:39:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:39:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:39:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:39:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:39:03 INFO - no previously-included directories found matching 'docs/_build' 12:39:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:39:03 INFO - Running setup.py install for pep8 12:39:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:39:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:39:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:39:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:39:03 INFO - no previously-included directories found matching 'docs/_build' 12:39:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:39:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:39:03 INFO - Cleaning up... 12:39:03 INFO - Return code: 0 12:39:03 INFO - Running post-action listener: _resource_record_post_action 12:39:03 INFO - Running post-action listener: _start_resource_monitoring 12:39:04 INFO - Starting resource monitoring. 12:39:04 INFO - ##### 12:39:04 INFO - ##### Running install step. 12:39:04 INFO - ##### 12:39:04 INFO - Running pre-action listener: _resource_record_pre_action 12:39:04 INFO - Running main action method: install 12:39:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:39:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:39:04 INFO - Reading from file tmpfile_stdout 12:39:04 INFO - Detecting whether we're running mozinstall >=1.0... 12:39:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:39:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:39:04 INFO - Reading from file tmpfile_stdout 12:39:04 INFO - Output received: 12:39:04 INFO - Usage: mozinstall [options] installer 12:39:04 INFO - Options: 12:39:04 INFO - -h, --help show this help message and exit 12:39:04 INFO - -d DEST, --destination=DEST 12:39:04 INFO - Directory to install application into. [default: 12:39:04 INFO - "/builds/slave/test-pgo"] 12:39:04 INFO - --app=APP Application being installed. [default: firefox] 12:39:04 INFO - mkdir: /builds/slave/test-pgo/build/application 12:39:04 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'] 12:39:04 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 12:39:20 INFO - Reading from file tmpfile_stdout 12:39:20 INFO - Output received: 12:39:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:39:20 INFO - Running post-action listener: _resource_record_post_action 12:39:20 INFO - ##### 12:39:20 INFO - ##### Running run-tests step. 12:39:20 INFO - ##### 12:39:20 INFO - Running pre-action listener: _resource_record_pre_action 12:39:20 INFO - Running main action method: run_tests 12:39:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:39:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:39:20 INFO - Python 2.7.3 12:39:20 INFO - Return code: 0 12:39:20 INFO - grabbing minidump binary from tooltool 12:39:20 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')]} 12:39:20 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 0x1a54540>, '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 0x1a55440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a558f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:39:20 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 12:39:20 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 12:39:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:39:20 INFO - Return code: 0 12:39:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:39:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:39:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:39:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:39:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:39:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:39:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:39:21 INFO - Return code: 0 12:39:21 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/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 12:39:21 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/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 12:39:21 INFO - Using env: {'DISPLAY': ':0', 12:39:21 INFO - 'HOME': '/home/cltbld', 12:39:21 INFO - 'LANG': 'en_US.UTF-8', 12:39:21 INFO - 'LANGUAGE': 'en_US:en', 12:39:21 INFO - 'LOGNAME': 'cltbld', 12:39:21 INFO - 'MAIL': '/var/mail/cltbld', 12:39:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:39:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:21 INFO - 'MOZ_NO_REMOTE': '1', 12:39:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:21 INFO - 'NO_EM_RESTART': '1', 12:39:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:21 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:39:21 INFO - 'SHELL': '/bin/bash', 12:39:21 INFO - 'SHLVL': '1', 12:39:21 INFO - 'TERM': 'linux', 12:39:21 INFO - 'TMOUT': '86400', 12:39:21 INFO - 'USER': 'cltbld', 12:39:21 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761', 12:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:21 INFO - '_': '/tools/buildbot/bin/python'} 12:39:21 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/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 12:39:21 INFO - mozversion application_buildid: 20151223083144 12:39:21 INFO - mozversion application_changeset: 30b9e8aa695d29d815baa2b1f8c05ff2fa10df6a 12:39:21 INFO - mozversion application_display_name: Nightly 12:39:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:39:21 INFO - mozversion application_name: Firefox 12:39:21 INFO - mozversion application_remotingname: firefox 12:39:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:39:21 INFO - mozversion application_vendor: Mozilla 12:39:21 INFO - mozversion application_version: 46.0a1 12:39:21 INFO - mozversion platform_buildid: 20151223083144 12:39:21 INFO - mozversion platform_changeset: 30b9e8aa695d29d815baa2b1f8c05ff2fa10df6a 12:39:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:39:21 INFO - mozversion platform_version: 46.0a1 12:39:21 INFO - using testdate: 1450903161 12:39:21 INFO - actual date: 1450903161 12:39:21 INFO - starting webserver on 'localhost:35682' 12:39:21 INFO - SUITE-START | Running 3 tests 12:39:21 INFO - TEST-START | dromaeo_css 12:39:21 INFO - operating with platform_type : linux_ 12:39:21 INFO - Initialising browser for dromaeo_css test... 12:39:21 INFO - TEST-INFO | started process 32324 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM9O0Mv/profile http://localhost:35682/getInfo.html) 12:39:25 INFO - PROCESS | 32324 | __metrics Screen width/height:1600/1200 12:39:25 INFO - PROCESS | 32324 | colorDepth:24 12:39:25 INFO - PROCESS | 32324 | Browser inner width/height: 1024/697 12:39:25 INFO - PROCESS | 32324 | __metrics 12:39:26 INFO - PROCESS | 32324 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:39:26 INFO - PROCESS | 32324 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:39:26 INFO - TEST-INFO | 32324: exit 0 12:39:26 INFO - Browser initialized. 12:39:26 INFO - Running cycle 1/1 for dromaeo_css test... 12:39:26 INFO - TEST-INFO | started process 32422 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM9O0Mv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:38 INFO - PROCESS | 32422 | RSS: Main: 150302720 12:39:38 INFO - PROCESS | 32422 | 12:40:30 INFO - PROCESS | 32422 | 1450903230157 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] 12:42:38 INFO - PROCESS | 32422 | Cycle 1(1): loaded http://localhost:35682/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35682/tests/dromaeo/cssquery-ext.html) 12:42:39 INFO - PROCESS | 32422 | RSS: Main: 286220288 12:42:39 INFO - PROCESS | 32422 | 12:45:42 INFO - PROCESS | 32422 | Cycle 1(1): loaded http://localhost:35682/tests/dromaeo/cssquery-ext.html (next: http://localhost:35682/tests/dromaeo/cssquery-jquery.html) 12:45:42 INFO - PROCESS | 32422 | RSS: Main: 228478976 12:45:42 INFO - PROCESS | 32422 | 12:48:44 INFO - PROCESS | 32422 | Cycle 1(1): loaded http://localhost:35682/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35682/tests/dromaeo/cssquery-mootools.html) 12:48:45 INFO - PROCESS | 32422 | RSS: Main: 221442048 12:48:45 INFO - PROCESS | 32422 | 12:51:47 INFO - PROCESS | 32422 | Cycle 1(1): loaded http://localhost:35682/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35682/tests/dromaeo/cssquery-prototype.html) 12:51:47 INFO - PROCESS | 32422 | RSS: Main: 211099648 12:51:47 INFO - PROCESS | 32422 | 12:54:50 INFO - PROCESS | 32422 | Cycle 1(1): loaded http://localhost:35682/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35682/tests/dromaeo/cssquery-yui.html) 12:54:50 INFO - PROCESS | 32422 | RSS: Main: 214405120 12:54:50 INFO - PROCESS | 32422 | 12:57:53 INFO - PROCESS | 32422 | Cycle 1(1): loaded http://localhost:35682/tests/dromaeo/cssquery-yui.html (next: http://localhost:35682/tests/dromaeo/cssquery-dojo.html) 12:57:53 INFO - PROCESS | 32422 | RSS: Main: 260104192 12:57:53 INFO - PROCESS | 32422 | 12:57:53 INFO - PROCESS | 32422 | __start_tp_report 12:57:53 INFO - PROCESS | 32422 | _x_x_mozilla_page_load 12:57:53 INFO - PROCESS | 32422 | _x_x_mozilla_page_load_details 12:57:53 INFO - PROCESS | 32422 | |i|pagename|runs| 12:57:53 INFO - PROCESS | 32422 | |0;dojo.html;3091.1035799618107;3141.905742827716;3180.348028654126;3182.013575791505;3196.680331966803;5051.419086805018;5246.1606143017125;5278.630495865286;5323.414424413311;5382.946170538294;5180.766865491052;5210.062188806013;5240.554552863002;5339.813106541272;5362.973185134078;4811.78346974387;4858.538438848322;4866.31871537985;4869.756512174377;4883.9511604883855;4888.853334399973;4912.656114072016;4922.3354847095725;4967.875803104916;5002.524760147799;4670.859874203779;4723;4784.5933095686905;4827.324174615556;4843.830465933675;4802.279658051285;4809.446913604946;4815.831445899376;4828.517148285178;4865.854024379274;4617.215073437524;4780.11567859947;4787.593054590364;4810.06203790261;4854;5023.346964894577;5055.646104772667;5073.974630126862;5092.541671249568;5093.949060509384;5637.633553818989;5644.435556444364;5645.8588535286535;5657.066584013633;5658.321001479849;5504.752286147133;5662.801801936913;5682.119271512881;5688.459596338341;5695.715214239312;5204.115300398941;5269.525742683177;5275.103232450454;5304.363476382859;5353.973230133864;5773.884522309614;5825.79609713658;5830.067189249699;5835.2414186156375;5884.176215329857;5350.224217488442;5444.428335024765;5646.181303711021;5647.322321321468;5657.038303488417;5493.450654934554;5595.8601034973635;5607.495325420732;5612;5628.802991895264;5646.661200327993;5648.435156484319;5657.377688454267;5662.631928924607;5676.631018983753;5462.235287059815;5571.749271282802;5574.777008919679;5615.6630602164005;5664.8867022659315;4385.473743150778;4414.845480408235;4416.823327066945;4438.1567502174485;4471.754053527022;3904.570497245301;3916.1971795781797;3920.4315374270573;3951.644352008333;3971.72197946141;5061.392632884003;5143.099957507496;5257.973710131425;5279.023380674587;5316.946830531722;5585.58108141891;5631.7747290108755;5726.141078838207;5739.16782066598;5750.539956803445;5241.475852414805;5248.081585722483;5249.763760630781;5255.13290307095;5275.63070585063;4745.976270118627;4839.249916262985;4929.260610908393;4933.383327084114;4966.553010229097;5762.337331206881;5804.216430781875;5807.5644326675665;5818.156367326798;5874.060150375919;5658.773649053992;5672.829815105553;5691.345495268097;5698.344690360662;5700.087985922232;5566.554675626021;5621.887562248814;5684.346300175367;5769.769209231584;5792.304923409218;5447.863803404788;5513.09034009384;5514.503694667499;5555.444455554412;5558.749856256397;5716.199732037435;5718.628289161191;5736.766595182056;5751.97124014394;5754.827355179351;5398.433164517669;5496.367917689517;5498.532624726943;5637.351704554028;5650.773969041193;5458.044842152528;5508.20131080999;5509.338879334506;5509.559235261249;5545.694986775766;5495.725213739377;5528.944710552843;5532.834014979557;5534.7509362078;5534.889302213853;5382.515573598395;5422.132458806572;5442.700651464049;5617.971910140586;5663.886722265449;5436.266104076058;5455.563554915518;5456.727163641882;5457.672539647475;5457.972710136424 12:57:53 INFO - PROCESS | 32422 | |1;ext.html;547.0969726980343;586.2525280267658;591.964482131072;604.6613896218118;612.7947137708867;38732.41901371482;39228.21543569127;39402.408963865564;39414.40878386823;39440.60559394405;41819;42495.36256956148;42497.36253956193;42510.57489425105;42520;7408.814779630526;7535.773926782205;7549.980752598384;8646.870296945535;8736.956315218447;10329.58681652733;10550.261481696285;10560.26078174528;10562.78874422511;10578;10211.336263142872;10397.792044159112;10408.895911040869;10409.73975650611;10412.895871041268;7715.189905059972;7910.841783164305;7916.208379162095;10309.793804123912;10439.269251152422;10080.94959525205;10309.32989355697;10310.07209351162;10311.742206444898;10312.742181445448;39576.60423395758;39604.40593391102;40029.39955900664;40030;40090.599094008976;3184.7452203823636;3219.4848824188252;3252.7235185009304;3276.655951125121;3350.4974253861874;30196;30326.241843953856;30572.08283751491;30809.845950770326;31460.528092078635;3591.497190393321;3625.274945011008;3635.5092062571744;3918.2163567286657;4080.775557344345;276027;276427;277707;279035.6048219766;279411;56507.43492565104;57754.13368799471;59648.701756491806;60054.399456005754;60063.59745610127;70595.2940470599;71493.642531787;71827.6408617964;71927;71946.64026679938;15801.525954221392;16004;16069.035857848332;16072.437464688679;16098.195090245441;10608.469576521144;10616.044555989998;10632.521536530874;10643.25497215203;10674.146068314516;19793.40619781409;20242.392728218176;20275.797242027686;20303.4924126898;20364.963503649516;7989.400794940403;8021;8087.959560202161;8135.877961830577;8246.917530824734;953.2802733935835;1039.880413752413;1058.0583280880023;1072.3137192197;1082.1883587309517;27162;27720;27907.72092279092;28201;28362.858185709352;1046.842973553973;1050.3750268590177;1068.7862427514528;1144.6337172105013;1157.6989982604584;14655.853441465662;16084.356625735074;16829.410970616216;16947.491575252763;16962.06708631037;390637;396160;396851;397106;397921;54033.1895021575;54585.72707136439;54629;54722.72638636861;54745.1788223169;1368.473137841938;1382.861713828609;1396.322783450026;1413.886889048894;1415.2499175437035;25878;28740.137795866158;28971.275718107216;29764.85117574398;30687;47369.52630473789;48046.27930581114;48059;48140.27789583089;48151;299495;301721;303202;303975;304582;26762.197134086007;27032.459350813268;30220.697793021787;30629.846850765603;31427;35759.46360804642;36147.819260903525;36453.81773091118;36546.8172659135;36837.81581092077;30801.537976929914;31183.220419489695;31370.372592548476;31601.5259771099;31723.20691982719;31719.841400792848;32046.83976580102;32358.83820580882;32661.836690816395;32750.181245469055;32953.83523082369;33152.66847331496;33306;33373.499397508574;33418;29216;30156.24609384783;30640;30674;30687;23622.173223937767;23936.52126957486;27377.589336159574;27727.44545109046;27914 12:57:53 INFO - PROCESS | 32422 | |2;jquery.html;344.9620541740408;346.95663042119736;350.1858179732122;353.46097201767304;353.8973697627688;13756;14175.149491030545;16220;16932.746008809863;18497.815021849776;16129.274182661778;16130.758038629401;16145.838541614581;16146.757798633;16219.51341459758;5242.135047717122;5525.723713814314;5550.77796888124;5551.750171242304;5553.694546799924;3996.3605823068315;4129.339305711087;5511.614187006911;5937.88124237515;6075.63546187228;6032.758689652409;6037.818865434044;6059.484943779784;6076.179715738385;6081.908771368433;4950.381202349707;5025.84922452327;5073.543381095682;5079.288899554065;5083.135866902617;4886.486918873538;4888.169011268057;5015.423226328946;5217.3217481727515;5232.6598771080135;19345.4196374109;19580;19948.90025549863;19979.400617981482;20078.09648565818;2050.3541384463997;2056.92800751973;2070.358188961427;2099.254764558575;2179.5096103376773;8973.416727912665;9143.451392916446;9146.131117543822;9192.448453092837;9212.447253164832;1792.345793785259;1843.557546188905;1847.3718935561974;1869.8317151456433;1873.4473330367575;58470.41529584692;60158.09762853517;60724.69637651827;61721;61730.382696173365;10035.849462258071;10152.086312231935;10238.18094552434;10255.7436064099;10307.072363487172;13252.469901204036;13267.270300133392;13269.867301326864;13279.004074694436;13285.13646612967;7612.8477430451085;7720.652570634335;7744.41916856238;7759.262870027451;7785.065792104983;7575.962120189474;7598.112717167441;7639.847203055908;7653.693852245848;7656.349210317074;4293.763842988666;4336.783160842008;4376.496702879146;4393.362962370502;4500.774961251925;1623.6427985843095;1673.8493535581613;1780.5459607800187;1828.1133650179652;1850.5928695686928;837.5644664774284;916.0518862976787;995.7311525887969;1026.5380578739598;1051.952662130206;14004.439822407194;16495.505134845975;16513.174341282887;17070.48788536321;17122.898058979044;902.2331018634239;962.6390103711109;1002.3484734922358;1008.505832142245;1022.6676330192718;8242.381821363422;9623.615055397706;9800.55897484615;9850.950745246228;9868.802623947624;539676.6032339705;541525;549991;551921;551963;77217.61391193008;77584;78910;79048;81019.59490202629;1090.7654854206385;1091.8525998990194;1121.3944469986116;1134.1493879590307;1134.1663877050526;14460.710785784437;15535.611609709396;15580.454684086002;15582;15757.133357665438;32551.51172732458;34818.82590587031;35189.824050880605;36104.819475902455;36338;42441;43826.34260486159;44494.777526112164;45190.548094518635;45819;9050.244148678225;9499.762505937408;9637.036296370587;9656.179224765974;9664.275179361435;11285.661430157108;11333.206675532634;16520;17875.19561619756;17955.730664039787;14277.357518911465;14440.133591984515;14806.703865922405;15086.698266034398;15130.092194468367;14334.569962901129;14373.496927607484;14651.706965860836;14906.850931490546;14974.176420296988;14998.925005374904;15025.624359391102;15253.923730381277;15285.465008724641;15357.3089210988;9366.578503967201;9420.576074076545;9437.197838183556;9488.193503552275;9497.572609232739;11513.251638643462;11680.94159529231;12744.61766147017;14126;14244.21656808844 12:57:53 INFO - PROCESS | 32422 | |3;mootools.html;1362.9591112266635;1498.512983280434;1553.7436323006705;1688.130612734442;1808.7700363752651;6572;7208.171060328057;7348.779536613897;7368.189499155089;7403.185649578542;7454.515456495324;7529.811754706121;7599.810004749884;7604.543727376347;7616.61916904154;2146.37755051035;2194.703714998471;2199.076387917071;2201.966970495436;2203.493196564791;2163.167180635459;2189.9343019709436;2272.7727227277305;2280.1107568048474;2280.2133264023887;2156.8598041127275;2171.207509259125;2191.4521369657587;2194.2539536557565;2194.572058448603;2164.8051675349216;2182.5962196993605;2185.3880913344287;2185.4536365908525;2186.169255682846;2188.6060509108356;2221.9000144993515;2224.799768020886;2232.5758105959817;2235.3964429603916;7323.963380183119;7333.706651733924;7401.70393184272;7412.4811263211595;7414.851702965964;4448.377227188196;4449.866504004853;4463.33050042493;4539.6368290536675;4540.682152249344;2926.4732348177317;2979.925501862449;3009.8043627164166;3024.259056531164;3034.8179109253515;968.8692026576463;987.5950860147377;1004.5278719002057;1015.2385710716962;1030.7629245273554;10140.695779126638;10144.644937427154;10146.34048786834;10151.492425378701;10175.643852465202;4036.65688416482;4046.0491784430637;4046.47395838545;4131.132462182975;4134.710570260053;8636.740897773077;8651.91348086511;8659.48043117415;8679.17547832955;8679.869801952977;4498.572635599613;4505.324201369755;4549.09018196362;4551.635869130461;4577.176108300538;3630.945535816965;3730.2725968435893;4078.347464405681;4132.91734165315;4133.21468920904;3504.491848681927;3521.735869809723;3551.5027896094566;3557.3241084194437;3584.8386822593047;1142.8628564572305;1149.2759561476216;1152.4698638626326;1155.1278784517635;1165.4813607944384;968.2592816495387;969.1519920069939;995.66147509847;1009.4548943570389;1017.064300843226;6851.554648947803;6889.552179108342;6892.483063770137;6899.827504312432;6908.827279317957;458.9105124500757;461.42091674947727;1170.309517384747;1179.988200118005;1225.8957988570894;5523.530499907552;5562.360328562268;5563.193336966198;5565.471280228372;5597.720113994284;8556.572171391406;8579.14208579137;8851.114888511098;8855.38012339143;8935.374523783403;8781.604827782765;8788.42875213109;8788.956055219684;8854.86717699235;8868.15752503511;7022.227554968949;7042.964785176144;7125.82185445368;7128.358447739728;7192.065031545865;6776.424003959719;6844.247132815287;6845.178578570603;6871.793846184622;6908.378245957687;7755.418343624138;7932.246436588515;8074.798130046795;8141.877871831809;8147.511149331059;8135.674573017013;8327.541985190872;8501.489910605136;8503.022152452548;8513.106123856905;5636.9718151410625;5710;6417.807465776034;6442.259140198749;6470.773522926675;7228.674709638184;7264.418846492163;7277.8908316376355;7303.817404564928;7310.853782924418;6726.764563240459;6783.966080169765;6792.796216113525;6849.452043836581;6954.3393377629045;6716.932830671631;6773.458123350219;6795.93204067953;6901.654917254017;6929.549579277331;6691.43122834545;6764.053032575345;6792.694328755119;6843.965780171067;6845.691943862438;5989.64062156272;6016;6020.307664618625;6032.215811944419;6054;6233.314335423191;6252.9374706254175;6256.155419018374;6260.874782504416;6299.149614801943 12:57:53 INFO - PROCESS | 32422 | |4;prototype.html;326.9280758233188;327.4302713278894;332.8585351225729;336.4767786092628;341.9213580876398;5976.282846058468;5996.400359964002;6025.638461692296;6067.575269731121;6114.1745864308305;5797.826065218051;5899.174115623816;5961.374055724152;5961.672108034057;5961.910571341434;4619.676622636417;4628.907421851561;4633.1891918914225;4634.37435946148;4637.582617564419;4441.422615060038;4529.433820772403;4540.432445944257;4615.93076103857;4640.814367425299;4561.087782443508;4575.970406658492;4599.678022538424;4604.930926036112;4605.263157894738;4592.288195329713;4601.608863246628;4610.746408947506;4624.838130665411;4628.83799067031;4069.6540794032544;4070.3894415837567;4076.5515793262716;4080.0207950091763;4088.2232375848494;5613.2422123013275;5693.316801983747;5708.828735137952;5711.685857277848;5738.799142030009;5368.543673787733;5368.899375627987;5370.785168593252;5374.408815030343;5379.515843574097;6049.395060493959;6350.237971443456;6362.491000719931;6364.459020983222;6368;4360.4331436913;4377.839872433808;4434.955650443487;4442.444694413199;4450.954025803933;6495.447886929616;6540.3132671069325;6587.044878492592;6591.143151390336;6613.239477460057;4593.402857628487;4595.862124136282;4598.770061496912;4603.102395032936;4604.953950460453;4399.64802815774;4499.785058034312;4501.572350626685;4671.15919134559;4671.48613652498;5246.213068039825;5278;5281.815136470205;5282.596418629514;5289.920651190235;6431.485481161496;6444.194475690539;6449.355064493513;6453.354664533509;6460.353964603502;1587.3888003676277;1612.040835702755;1613.0805440898575;1613.693398254328;1614.7497137943403;1058.5077938758513;1062.6652604429735;1064;1072.9034386905216;1096.1723898456614;6001.609895356788;6009.699515024318;6041.909371359433;6050.6974651267265;6055;6603.70283337251;6620.933790662128;6621.437177839841;6625.271220165778;6633.436157926534;5915.349311575723;6030.7889223876955;6035.39646035393;6035.517158627299;6036.728347224298;3553.466979953028;3582.982085089558;3584.175639602906;3584.6773790358993;3588.748787584896;6766.898496522556;6770.390664840188;6771.864562708718;6776.390124888783;6779.389854913082;6736.562123461959;6777.8644427111185;6785.59286442815;6799.184097908283;6803;6619.470442364599;6810.455163586901;6862.862742745217;6873.48448866337;6875.037494750739;6427.903581446376;6581.3418658135715;6582.8354291143105;6688.197416309879;6690.264070952288;6584.736610535525;6603.504737144637;6614.768483103068;6619.172603424572;6626;6837.62393068386;6840.281770414035;6846.691898864464;6851.623160726208;6853.7943861684225;4384.342348647729;4507.323901414814;4511.8646440606835;4541.296099104512;4581.106684196549;6589.703463344065;6591.044298576584;6592.241892182268;6659.433948114271;6673.132492775908;6468.741250349934;6478.352164783672;6484.027395890655;6486.708098135501;6487.929491633828;6235.189425374672;6469.061986012096;6472;6518.348165183444;6518.478521718156;6356.283803373156;6384.968075159594;6392.712327945346;6400.199975003125;6405.647689377129;6534.738610455529;6537.084808126771;6539.934600654123;6540.37866402691;6552.148220731275;6219.875602488016;6377.93622063792;6380.330065343072;6384.170057892445;6394.872102558016 12:57:53 INFO - PROCESS | 32422 | |5;yui.html;730.3828265115975;752.3379426105026;784.2118670735912;811.5982588618634;834.1700008491551;13325.067245292834;13646.454141834314;13653.863461365383;13669.043166978316;13675.452981880726;13024.153430027041;13048.347582620854;13053.086283960103;13055.41250643721;13090.738185236289;668.3550373889196;678.2539206872425;796.6295672512266;805.629410471184;818.7789296889836;797.2346547314556;802.5385403393043;806.939479539034;811.5414790643267;812.6302532347768;847.4872702015284;855.9443636163629;857.3655494933766;861.6811779641541;861.9784505387353;696.7770313499682;710.0981753173467;846.6740304982595;862.2412277196028;863.4646519158099;627.015585530717;634.7841733810527;637.3626373626373;637.4422380417135;637.7225906730587;12966.87033129666;13043.543475978295;13096.541621043312;13099.34503274842;13101.41043653038;11237.887621123766;11381.430928453545;11388.14588905827;11552.422378881023;11648.767024659459;10116.797664046751;10199.643012494602;10241.334313269614;10248.128909042665;10300.742481437948;3588.138846676805;3616.3129005488872;3616.9095772605633;3622.8913132606062;3746.6440688134585;46051;47075.293870591966;47491.76254118742;47493.76253118712;47558.28662570064;9665.600984928282;9782.51087445625;9807.460589667637;9925.553350099262;9972.351797133164;16861.662766744597;16949.322027119022;16966.15169241533;16983.91508042452;17209.913950430167;7121.71513139479;7142.178649455379;7227.7831665050135;7260.564366137943;7433.331000210007;3925.175713100281;3942.4677668514382;3965.7025723070883;3968.7817170055346;3972.3644216925154;3088.8918887838818;3091.1499337682317;3104.580881581003;3132.561441398206;3135.639401468815;568.9914651280234;580.2236299307792;582.0512564519805;590.9468147866712;605.5609682979892;590.7463028546083;623.9875202495924;630.5397060146119;632.3013070556968;694.486080300584;8655.56722163902;8728.956355218183;8732.301415886714;8733.126687331216;8846.115388461103;556.2129586634867;651.8305240637468;663.2174034639172;688.449240607512;702.8594281143792;3954.070793363557;3971.4638523799495;4032.1129351542613;4105.8973525662095;4145.983950709263;54473.45526544763;54943;55579.722101389234;55791.44208557862;59674.70162649246;46785.766071169426;47046.76476617595;47060.764696176986;49701.25448118281;49821;44401.55598443974;44567;45033.77483112564;45393;46565.30152047722;8320.557700086352;8342.83314333722;8647.610857511301;8688.348373871859;8722.65109395617;34195.658043419244;34851.82574087215;35031.47452788261;35500.64499354974;35621.465678014334;42676.65278409593;42935.14129717326;43406;44247.33628995632;44276.11447771091;11053.944730276296;11248.83126753083;11327.943360283145;11345.65303235531;11370.658880233606;11759.529618815493;11846.644600661994;11891.46488408041;11921.821172682243;12122.696932576757;10875.782484350111;11069.391183484986;11238.269512481662;11277.887221127683;11603.535858565563;10496.317739346918;10864.130869530261;11046.447677615926;11119.666410007712;11139.777204456028;11001.61494347726;11226.382548959886;11316.660500185008;11352.778288731291;11554.191206615456;9446.716598502057;9546.474943878153;9680;9766.46284454362;9786.951065244628;8498.235158835734;8842.15140752109;8899.777505562413;9614.519274036411;9668 12:57:53 INFO - PROCESS | 32422 | __end_tp_report 12:57:53 INFO - PROCESS | 32422 | __start_cc_report 12:57:53 INFO - PROCESS | 32422 | _x_x_mozilla_cycle_collect,1139 12:57:53 INFO - PROCESS | 32422 | __end_cc_report 12:57:53 INFO - PROCESS | 32422 | __startTimestamp1450904273696__endTimestamp 12:57:53 INFO - PROCESS | 32422 | 12:57:53 INFO - PROCESS | 32422 | ------- Summary: start ------- 12:57:53 INFO - PROCESS | 32422 | Number of tests: 6 12:57:53 INFO - PROCESS | 32422 | 12:57:53 INFO - PROCESS | 32422 | [#0] dojo.html Cycles:165 Average:5243.89 Median:5447.86 stddev:569.21 (10.4%) stddev-sans-first:545.33 12:57:53 INFO - PROCESS | 32422 | Values: 3091.1 3141.9 3180.3 3182.0 3196.7 5051.4 5246.2 5278.6 5323.4 5382.9 5180.8 5210.1 5240.6 5339.8 5363.0 4811.8 4858.5 4866.3 4869.8 4884.0 4888.9 4912.7 4922.3 4967.9 5002.5 4670.9 4723.0 4784.6 4827.3 4843.8 4802.3 4809.4 4815.8 4828.5 4865.9 4617.2 4780.1 4787.6 4810.1 4854.0 5023.3 5055.6 5074.0 5092.5 5093.9 5637.6 5644.4 5645.9 5657.1 5658.3 5504.8 5662.8 5682.1 5688.5 5695.7 5204.1 5269.5 5275.1 5304.4 5354.0 5773.9 5825.8 5830.1 5835.2 5884.2 5350.2 5444.4 5646.2 5647.3 5657.0 5493.5 5595.9 5607.5 5612.0 5628.8 5646.7 5648.4 5657.4 5662.6 5676.6 5462.2 5571.7 5574.8 5615.7 5664.9 4385.5 4414.8 4416.8 4438.2 4471.8 3904.6 3916.2 3920.4 3951.6 3971.7 5061.4 5143.1 5258.0 5279.0 5316.9 5585.6 5631.8 5726.1 5739.2 5750.5 5241.5 5248.1 5249.8 5255.1 5275.6 4746.0 4839.2 4929.3 4933.4 4966.6 5762.3 5804.2 5807.6 5818.2 5874.1 5658.8 5672.8 5691.3 5698.3 5700.1 5566.6 5621.9 5684.3 5769.8 5792.3 5447.9 5513.1 5514.5 5555.4 5558.7 5716.2 5718.6 5736.8 5752.0 5754.8 5398.4 5496.4 5498.5 5637.4 5650.8 5458.0 5508.2 5509.3 5509.6 5545.7 5495.7 5528.9 5532.8 5534.8 5534.9 5382.5 5422.1 5442.7 5618.0 5663.9 5436.3 5455.6 5456.7 5457.7 5458.0 12:57:53 INFO - PROCESS | 32422 | 12:57:53 INFO - PROCESS | 32422 | [#1] ext.html Cycles:180 Average:49081.69 Median:31276.80 stddev:86592.17 (276.9%) stddev-sans-first:86758.40 12:57:53 INFO - PROCESS | 32422 | Values: 547.1 586.3 592.0 604.7 612.8 38732.4 39228.2 39402.4 39414.4 39440.6 41819.0 42495.4 42497.4 42510.6 42520.0 7408.8 7535.8 7550.0 8646.9 8737.0 10329.6 10550.3 10560.3 10562.8 10578.0 10211.3 10397.8 10408.9 10409.7 10412.9 7715.2 7910.8 7916.2 10309.8 10439.3 10080.9 10309.3 10310.1 10311.7 10312.7 39576.6 39604.4 40029.4 40030.0 40090.6 3184.7 3219.5 3252.7 3276.7 3350.5 30196.0 30326.2 30572.1 30809.8 31460.5 3591.5 3625.3 3635.5 3918.2 4080.8 276027.0 276427.0 277707.0 279035.6 279411.0 56507.4 57754.1 59648.7 60054.4 60063.6 70595.3 71493.6 71827.6 71927.0 71946.6 15801.5 16004.0 16069.0 16072.4 16098.2 10608.5 10616.0 10632.5 10643.3 10674.1 19793.4 20242.4 20275.8 20303.5 20365.0 7989.4 8021.0 8088.0 8135.9 8246.9 953.3 1039.9 1058.1 1072.3 1082.2 27162.0 27720.0 27907.7 28201.0 28362.9 1046.8 1050.4 1068.8 1144.6 1157.7 14655.9 16084.4 16829.4 16947.5 16962.1 390637.0 396160.0 396851.0 397106.0 397921.0 54033.2 54585.7 54629.0 54722.7 54745.2 1368.5 1382.9 1396.3 1413.9 1415.2 25878.0 28740.1 28971.3 29764.9 30687.0 47369.5 48046.3 48059.0 48140.3 48151.0 299495.0 301721.0 303202.0 303975.0 304582.0 26762.2 27032.5 30220.7 30629.8 31427.0 35759.5 36147.8 36453.8 36546.8 36837.8 30801.5 31183.2 31370.4 31601.5 31723.2 31719.8 32046.8 32358.8 32661.8 32750.2 32953.8 33152.7 33306.0 33373.5 33418.0 29216.0 30156.2 30640.0 30674.0 30687.0 23622.2 23936.5 27377.6 27727.4 27914.0 12:57:53 INFO - PROCESS | 32422 | 12:57:53 INFO - PROCESS | 32422 | [#2] jquery.html Cycles:180 Average:28839.39 Median:17771.64 stddev:89346.67 (502.7%) stddev-sans-first:89571.69 12:57:53 INFO - PROCESS | 32422 | Values: 345.0 347.0 350.2 353.5 353.9 13756.0 14175.1 16220.0 16932.7 18497.8 16129.3 16130.8 16145.8 16146.8 16219.5 5242.1 5525.7 5550.8 5551.8 5553.7 3996.4 4129.3 5511.6 5937.9 6075.6 6032.8 6037.8 6059.5 6076.2 6081.9 4950.4 5025.8 5073.5 5079.3 5083.1 4886.5 4888.2 5015.4 5217.3 5232.7 19345.4 19580.0 19948.9 19979.4 20078.1 2050.4 2056.9 2070.4 2099.3 2179.5 8973.4 9143.5 9146.1 9192.4 9212.4 1792.3 1843.6 1847.4 1869.8 1873.4 58470.4 60158.1 60724.7 61721.0 61730.4 10035.8 10152.1 10238.2 10255.7 10307.1 13252.5 13267.3 13269.9 13279.0 13285.1 7612.8 7720.7 7744.4 7759.3 7785.1 7576.0 7598.1 7639.8 7653.7 7656.3 4293.8 4336.8 4376.5 4393.4 4500.8 1623.6 1673.8 1780.5 1828.1 1850.6 837.6 916.1 995.7 1026.5 1052.0 14004.4 16495.5 16513.2 17070.5 17122.9 902.2 962.6 1002.3 1008.5 1022.7 8242.4 9623.6 9800.6 9851.0 9868.8 539676.6 541525.0 549991.0 551921.0 551963.0 77217.6 77584.0 78910.0 79048.0 81019.6 1090.8 1091.9 1121.4 1134.1 1134.2 14460.7 15535.6 15580.5 15582.0 15757.1 32551.5 34818.8 35189.8 36104.8 36338.0 42441.0 43826.3 44494.8 45190.5 45819.0 9050.2 9499.8 9637.0 9656.2 9664.3 11285.7 11333.2 16520.0 17875.2 17955.7 14277.4 14440.1 14806.7 15086.7 15130.1 14334.6 14373.5 14651.7 14906.9 14974.2 14998.9 15025.6 15253.9 15285.5 15357.3 9366.6 9420.6 9437.2 9488.2 9497.6 11513.3 11680.9 12744.6 14126.0 14244.2 12:57:53 INFO - PROCESS | 32422 | 12:57:53 INFO - PROCESS | 32422 | [#3] mootools.html Cycles:180 Average:5212.84 Median:6043.11 stddev:2688.93 (44.5%) stddev-sans-first:2680.91 12:57:53 INFO - PROCESS | 32422 | Values: 1363.0 1498.5 1553.7 1688.1 1808.8 6572.0 7208.2 7348.8 7368.2 7403.2 7454.5 7529.8 7599.8 7604.5 7616.6 2146.4 2194.7 2199.1 2202.0 2203.5 2163.2 2189.9 2272.8 2280.1 2280.2 2156.9 2171.2 2191.5 2194.3 2194.6 2164.8 2182.6 2185.4 2185.5 2186.2 2188.6 2221.9 2224.8 2232.6 2235.4 7324.0 7333.7 7401.7 7412.5 7414.9 4448.4 4449.9 4463.3 4539.6 4540.7 2926.5 2979.9 3009.8 3024.3 3034.8 968.9 987.6 1004.5 1015.2 1030.8 10140.7 10144.6 10146.3 10151.5 10175.6 4036.7 4046.0 4046.5 4131.1 4134.7 8636.7 8651.9 8659.5 8679.2 8679.9 4498.6 4505.3 4549.1 4551.6 4577.2 3630.9 3730.3 4078.3 4132.9 4133.2 3504.5 3521.7 3551.5 3557.3 3584.8 1142.9 1149.3 1152.5 1155.1 1165.5 968.3 969.2 995.7 1009.5 1017.1 6851.6 6889.6 6892.5 6899.8 6908.8 458.9 461.4 1170.3 1180.0 1225.9 5523.5 5562.4 5563.2 5565.5 5597.7 8556.6 8579.1 8851.1 8855.4 8935.4 8781.6 8788.4 8789.0 8854.9 8868.2 7022.2 7043.0 7125.8 7128.4 7192.1 6776.4 6844.2 6845.2 6871.8 6908.4 7755.4 7932.2 8074.8 8141.9 8147.5 8135.7 8327.5 8501.5 8503.0 8513.1 5637.0 5710.0 6417.8 6442.3 6470.8 7228.7 7264.4 7277.9 7303.8 7310.9 6726.8 6784.0 6792.8 6849.5 6954.3 6716.9 6773.5 6795.9 6901.7 6929.5 6691.4 6764.1 6792.7 6844.0 6845.7 5989.6 6016.0 6020.3 6032.2 6054.0 6233.3 6252.9 6256.2 6260.9 6299.1 12:57:53 INFO - PROCESS | 32422 | 12:57:53 INFO - PROCESS | 32422 | [#4] prototype.html Cycles:180 Average:5350.71 Median:6028.21 stddev:1616.71 (26.8%) stddev-sans-first:1576.66 12:57:53 INFO - PROCESS | 32422 | Values: 326.9 327.4 332.9 336.5 341.9 5976.3 5996.4 6025.6 6067.6 6114.2 5797.8 5899.2 5961.4 5961.7 5961.9 4619.7 4628.9 4633.2 4634.4 4637.6 4441.4 4529.4 4540.4 4615.9 4640.8 4561.1 4576.0 4599.7 4604.9 4605.3 4592.3 4601.6 4610.7 4624.8 4628.8 4069.7 4070.4 4076.6 4080.0 4088.2 5613.2 5693.3 5708.8 5711.7 5738.8 5368.5 5368.9 5370.8 5374.4 5379.5 6049.4 6350.2 6362.5 6364.5 6368.0 4360.4 4377.8 4435.0 4442.4 4451.0 6495.4 6540.3 6587.0 6591.1 6613.2 4593.4 4595.9 4598.8 4603.1 4605.0 4399.6 4499.8 4501.6 4671.2 4671.5 5246.2 5278.0 5281.8 5282.6 5289.9 6431.5 6444.2 6449.4 6453.4 6460.4 1587.4 1612.0 1613.1 1613.7 1614.7 1058.5 1062.7 1064.0 1072.9 1096.2 6001.6 6009.7 6041.9 6050.7 6055.0 6603.7 6620.9 6621.4 6625.3 6633.4 5915.3 6030.8 6035.4 6035.5 6036.7 3553.5 3583.0 3584.2 3584.7 3588.7 6766.9 6770.4 6771.9 6776.4 6779.4 6736.6 6777.9 6785.6 6799.2 6803.0 6619.5 6810.5 6862.9 6873.5 6875.0 6427.9 6581.3 6582.8 6688.2 6690.3 6584.7 6603.5 6614.8 6619.2 6626.0 6837.6 6840.3 6846.7 6851.6 6853.8 4384.3 4507.3 4511.9 4541.3 4581.1 6589.7 6591.0 6592.2 6659.4 6673.1 6468.7 6478.4 6484.0 6486.7 6487.9 6235.2 6469.1 6472.0 6518.3 6518.5 6356.3 6385.0 6392.7 6400.2 6405.6 6534.7 6537.1 6539.9 6540.4 6552.1 6219.9 6377.9 6380.3 6384.2 6394.9 12:57:53 INFO - PROCESS | 32422 | 12:57:53 INFO - PROCESS | 32422 | [#5] yui.html Cycles:180 Average:13455.02 Median:46675.53 stddev:15461.91 (33.1%) stddev-sans-first:15475.76 12:57:53 INFO - PROCESS | 32422 | Values: 730.4 752.3 784.2 811.6 834.2 13325.1 13646.5 13653.9 13669.0 13675.5 13024.2 13048.3 13053.1 13055.4 13090.7 668.4 678.3 796.6 805.6 818.8 797.2 802.5 806.9 811.5 812.6 847.5 855.9 857.4 861.7 862.0 696.8 710.1 846.7 862.2 863.5 627.0 634.8 637.4 637.4 637.7 12966.9 13043.5 13096.5 13099.3 13101.4 11237.9 11381.4 11388.1 11552.4 11648.8 10116.8 10199.6 10241.3 10248.1 10300.7 3588.1 3616.3 3616.9 3622.9 3746.6 46051.0 47075.3 47491.8 47493.8 47558.3 9665.6 9782.5 9807.5 9925.6 9972.4 16861.7 16949.3 16966.2 16983.9 17209.9 7121.7 7142.2 7227.8 7260.6 7433.3 3925.2 3942.5 3965.7 3968.8 3972.4 3088.9 3091.1 3104.6 3132.6 3135.6 569.0 580.2 582.1 590.9 605.6 590.7 624.0 630.5 632.3 694.5 8655.6 8729.0 8732.3 8733.1 8846.1 556.2 651.8 663.2 688.4 702.9 3954.1 3971.5 4032.1 4105.9 4146.0 54473.5 54943.0 55579.7 55791.4 59674.7 46785.8 47046.8 47060.8 49701.3 49821.0 44401.6 44567.0 45033.8 45393.0 46565.3 8320.6 8342.8 8647.6 8688.3 8722.7 34195.7 34851.8 35031.5 35500.6 35621.5 42676.7 42935.1 43406.0 44247.3 44276.1 11053.9 11248.8 11327.9 11345.7 11370.7 11759.5 11846.6 11891.5 11921.8 12122.7 10875.8 11069.4 11238.3 11277.9 11603.5 10496.3 10864.1 11046.4 11119.7 11139.8 11001.6 11226.4 11316.7 11352.8 11554.2 9446.7 9546.5 9680.0 9766.5 9787.0 8498.2 8842.2 8899.8 9614.5 9668.0 12:57:53 INFO - PROCESS | 32422 | -------- Summary: end -------- 12:57:53 INFO - PROCESS | 32422 | 12:57:54 INFO - TEST-INFO | 32422: exit 0 12:57:54 INFO - TEST-OK | dromaeo_css | took 1112713ms 12:57:54 INFO - TEST-START | kraken 12:57:54 INFO - operating with platform_type : linux_ 12:57:54 INFO - Initialising browser for kraken test... 12:57:54 INFO - TEST-INFO | started process 32622 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSpYydx/profile http://localhost:35682/getInfo.html) 12:57:58 INFO - PROCESS | 32622 | __metrics Screen width/height:1600/1200 12:57:58 INFO - PROCESS | 32622 | colorDepth:24 12:57:58 INFO - PROCESS | 32622 | Browser inner width/height: 1024/697 12:57:58 INFO - PROCESS | 32622 | __metrics 12:57:58 INFO - PROCESS | 32622 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:57:58 INFO - PROCESS | 32622 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:57:59 INFO - TEST-INFO | 32622: exit 0 12:57:59 INFO - Browser initialized. 12:57:59 INFO - Running cycle 1/1 for kraken test... 12:57:59 INFO - TEST-INFO | started process 32703 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSpYydx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:11 INFO - PROCESS | 32703 | RSS: Main: 148414464 12:58:11 INFO - PROCESS | 32703 | 12:58:13 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35682/tests/kraken/driver.html?testName=audio-beat-detection) 12:58:14 INFO - PROCESS | 32703 | RSS: Main: 184811520 12:58:14 INFO - PROCESS | 32703 | 12:58:16 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35682/tests/kraken/driver.html?testName=audio-dft) 12:58:17 INFO - PROCESS | 32703 | RSS: Main: 174501888 12:58:17 INFO - PROCESS | 32703 | 12:58:20 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35682/tests/kraken/driver.html?testName=audio-fft) 12:58:20 INFO - PROCESS | 32703 | RSS: Main: 160030720 12:58:20 INFO - PROCESS | 32703 | 12:58:22 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35682/tests/kraken/driver.html?testName=audio-oscillator) 12:58:23 INFO - PROCESS | 32703 | RSS: Main: 163352576 12:58:23 INFO - PROCESS | 32703 | 12:58:25 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35682/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:58:26 INFO - PROCESS | 32703 | RSS: Main: 165400576 12:58:26 INFO - PROCESS | 32703 | 12:58:29 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35682/tests/kraken/driver.html?testName=imaging-darkroom) 12:58:29 INFO - PROCESS | 32703 | RSS: Main: 164720640 12:58:29 INFO - PROCESS | 32703 | 12:58:32 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35682/tests/kraken/driver.html?testName=imaging-desaturate) 12:58:33 INFO - PROCESS | 32703 | RSS: Main: 165756928 12:58:33 INFO - PROCESS | 32703 | 12:58:36 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35682/tests/kraken/driver.html?testName=json-parse-financial) 12:58:36 INFO - PROCESS | 32703 | RSS: Main: 165797888 12:58:36 INFO - PROCESS | 32703 | 12:58:38 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35682/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:58:38 INFO - PROCESS | 32703 | RSS: Main: 176209920 12:58:38 INFO - PROCESS | 32703 | 12:58:40 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35682/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:58:41 INFO - PROCESS | 32703 | RSS: Main: 173035520 12:58:41 INFO - PROCESS | 32703 | 12:58:43 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35682/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:58:44 INFO - PROCESS | 32703 | RSS: Main: 186204160 12:58:44 INFO - PROCESS | 32703 | 12:58:46 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:58:46 INFO - PROCESS | 32703 | RSS: Main: 192262144 12:58:46 INFO - PROCESS | 32703 | 12:58:49 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:58:50 INFO - PROCESS | 32703 | RSS: Main: 189825024 12:58:50 INFO - PROCESS | 32703 | 12:58:51 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:35682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35682/tests/kraken/driver.html?testName=ai-astar) 12:58:52 INFO - PROCESS | 32703 | RSS: Main: 248598528 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | __start_tp_report 12:58:52 INFO - PROCESS | 32703 | _x_x_mozilla_page_load 12:58:52 INFO - PROCESS | 32703 | _x_x_mozilla_page_load_details 12:58:52 INFO - PROCESS | 32703 | |i|pagename|runs| 12:58:52 INFO - PROCESS | 32703 | |0;ai-astar;109;111;103;111;112;110;100;109;109;111 12:58:52 INFO - PROCESS | 32703 | |1;audio-beat-detection;154;124;147;163;139;150;150;131;163;131 12:58:52 INFO - PROCESS | 32703 | |2;audio-dft;168;159;164;161;162;163;162;164;161;161 12:58:52 INFO - PROCESS | 32703 | |3;audio-fft;73;73;85;94;72;75;75;96;91;71 12:58:52 INFO - PROCESS | 32703 | |4;audio-oscillator;93;94;141;93;93;93;150;92;94;134 12:58:52 INFO - PROCESS | 32703 | |5;imaging-gaussian-blur;109;109;109;110;110;110;109;110;110;110 12:58:52 INFO - PROCESS | 32703 | |6;imaging-darkroom;145;146;145;161;146;145;144;145;146;145 12:58:52 INFO - PROCESS | 32703 | |7;imaging-desaturate;95;96;96;96;96;95;97;97;96;95 12:58:52 INFO - PROCESS | 32703 | |8;json-parse-financial;60;59;61;58;59;59;59;69;56;57 12:58:52 INFO - PROCESS | 32703 | |9;json-stringify-tinderbox;68;68;68;68;68;69;68;68;69;68 12:58:52 INFO - PROCESS | 32703 | |10;stanford-crypto-aes;90;84;84;84;85;85;83;83;84;85 12:58:52 INFO - PROCESS | 32703 | |11;stanford-crypto-ccm;113;112;124;122;120;120;124;123;124;122 12:58:52 INFO - PROCESS | 32703 | |12;stanford-crypto-pbkdf2;151;141;156;147;149;138;152;156;147;140 12:58:52 INFO - PROCESS | 32703 | |13;stanford-crypto-sha256-iterative;66;69;70;65;68;67;66;65;65;65 12:58:52 INFO - PROCESS | 32703 | __end_tp_report 12:58:52 INFO - PROCESS | 32703 | __start_cc_report 12:58:52 INFO - PROCESS | 32703 | _x_x_mozilla_cycle_collect,969 12:58:52 INFO - PROCESS | 32703 | __end_cc_report 12:58:52 INFO - PROCESS | 32703 | __startTimestamp1450904332049__endTimestamp 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | ------- Summary: start ------- 12:58:52 INFO - PROCESS | 32703 | Number of tests: 14 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.50 stddev:3.89 (3.5%) stddev-sans-first:4.13 12:58:52 INFO - PROCESS | 32703 | Values: 109.0 111.0 103.0 111.0 112.0 110.0 100.0 109.0 109.0 111.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:150.00 stddev:13.55 (9.0%) stddev-sans-first:13.99 12:58:52 INFO - PROCESS | 32703 | Values: 154.0 124.0 147.0 163.0 139.0 150.0 150.0 131.0 163.0 131.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:2.46 (1.5%) stddev-sans-first:1.62 12:58:52 INFO - PROCESS | 32703 | Values: 168.0 159.0 164.0 161.0 162.0 163.0 162.0 164.0 161.0 161.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#3] audio-fft Cycles:10 Average:80.50 Median:80.00 stddev:9.94 (12.4%) stddev-sans-first:10.16 12:58:52 INFO - PROCESS | 32703 | Values: 73.0 73.0 85.0 94.0 72.0 75.0 75.0 96.0 91.0 71.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.00 stddev:23.75 (25.5%) stddev-sans-first:24.59 12:58:52 INFO - PROCESS | 32703 | Values: 93.0 94.0 141.0 93.0 93.0 93.0 150.0 92.0 94.0 134.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:58:52 INFO - PROCESS | 32703 | Values: 109.0 109.0 109.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:145.50 stddev:5.03 (3.5%) stddev-sans-first:5.29 12:58:52 INFO - PROCESS | 32703 | Values: 145.0 146.0 145.0 161.0 146.0 145.0 144.0 145.0 146.0 145.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 12:58:52 INFO - PROCESS | 32703 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 97.0 97.0 96.0 95.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:59.00 stddev:3.56 (6.0%) stddev-sans-first:3.77 12:58:52 INFO - PROCESS | 32703 | Values: 60.0 59.0 61.0 58.0 59.0 59.0 59.0 69.0 56.0 57.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 12:58:52 INFO - PROCESS | 32703 | Values: 68.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 69.0 68.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.50 stddev:2.00 (2.4%) stddev-sans-first:0.78 12:58:52 INFO - PROCESS | 32703 | Values: 90.0 84.0 84.0 84.0 85.0 85.0 83.0 83.0 84.0 85.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:122.50 stddev:4.43 (3.6%) stddev-sans-first:3.80 12:58:52 INFO - PROCESS | 32703 | Values: 113.0 112.0 124.0 122.0 120.0 120.0 124.0 123.0 124.0 122.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:150.00 stddev:6.40 (4.3%) stddev-sans-first:6.67 12:58:52 INFO - PROCESS | 32703 | Values: 151.0 141.0 156.0 147.0 149.0 138.0 152.0 156.0 147.0 140.0 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - PROCESS | 32703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.84 (2.8%) stddev-sans-first:1.94 12:58:52 INFO - PROCESS | 32703 | Values: 66.0 69.0 70.0 65.0 68.0 67.0 66.0 65.0 65.0 65.0 12:58:52 INFO - PROCESS | 32703 | -------- Summary: end -------- 12:58:52 INFO - PROCESS | 32703 | 12:58:52 INFO - TEST-INFO | 32703: exit 0 12:58:52 INFO - TEST-OK | kraken | took 58469ms 12:58:52 INFO - TEST-START | v8_7 12:58:52 INFO - operating with platform_type : linux_ 12:58:52 INFO - Initialising browser for v8_7 test... 12:58:52 INFO - TEST-INFO | started process 485 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOec2Kl/profile http://localhost:35682/getInfo.html) 12:58:56 INFO - PROCESS | 485 | __metrics Screen width/height:1600/1200 12:58:56 INFO - PROCESS | 485 | colorDepth:24 12:58:56 INFO - PROCESS | 485 | Browser inner width/height: 1024/697 12:58:56 INFO - PROCESS | 485 | __metrics 12:58:56 INFO - PROCESS | 485 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:58:56 INFO - PROCESS | 485 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:58:57 INFO - TEST-INFO | 485: exit 0 12:58:57 INFO - Browser initialized. 12:58:57 INFO - Running cycle 1/1 for v8_7 test... 12:58:57 INFO - TEST-INFO | started process 567 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOec2Kl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:09 INFO - PROCESS | 567 | RSS: Main: 149491712 12:59:09 INFO - PROCESS | 567 | 12:59:30 INFO - PROCESS | 567 | Cycle 1(1): loaded http://localhost:35682/tests/v8_7/run.html (next: http://localhost:35682/tests/v8_7/run.html) 12:59:31 INFO - PROCESS | 567 | RSS: Main: 614260736 12:59:31 INFO - PROCESS | 567 | 12:59:31 INFO - PROCESS | 567 | __start_tp_report 12:59:31 INFO - PROCESS | 567 | _x_x_mozilla_page_load 12:59:31 INFO - PROCESS | 567 | _x_x_mozilla_page_load_details 12:59:31 INFO - PROCESS | 567 | |i|pagename|runs| 12:59:31 INFO - PROCESS | 567 | |0;Richards;166.00265604249668 12:59:31 INFO - PROCESS | 567 | |1;DeltaBlue;195.61815336463224 12:59:31 INFO - PROCESS | 567 | |2;Encrypt;283.36639274582035 12:59:31 INFO - PROCESS | 567 | |3;Decrypt;5202.072538860104 12:59:31 INFO - PROCESS | 567 | |4;RayTrace;1100.1100110011 12:59:31 INFO - PROCESS | 567 | |5;Earley;803.370786516854 12:59:31 INFO - PROCESS | 567 | |6;Boyer;12390.243902439024 12:59:31 INFO - PROCESS | 567 | |7;RegExp;25846.153846153848 12:59:31 INFO - PROCESS | 567 | |8;Splay;665.7789613848203 12:59:31 INFO - PROCESS | 567 | |9;NavierStokes;4864.077669902913 12:59:31 INFO - PROCESS | 567 | __end_tp_report 12:59:31 INFO - PROCESS | 567 | __startTimestamp1450904371217__endTimestamp 12:59:31 INFO - PROCESS | 567 | 12:59:31 INFO - PROCESS | 567 | ------- Summary: start ------- 12:59:31 INFO - PROCESS | 567 | Number of tests: 10 12:59:31 INFO - PROCESS | 567 | 12:59:31 INFO - PROCESS | 567 | [#0] Richards Cycles:1 Average:166.00 Median:166.00 stddev:0.00 (0.0%) 12:59:31 INFO - PROCESS | 567 | Values: 166.0 12:59:31 INFO - PROCESS | 567 | 12:59:31 INFO - PROCESS | 567 | [#1] DeltaBlue Cycles:1 Average:195.62 Median:195.62 stddev:0.00 (0.0%) 12:59:31 INFO - PROCESS | 567 | Values: 195.6 12:59:31 INFO - PROCESS | 567 | 12:59:31 INFO - PROCESS | 567 | [#2] Encrypt Cycles:1 Average:283.37 Median:283.37 stddev:0.00 (0.0%) 12:59:31 INFO - PROCESS | 567 | Values: 283.4 12:59:31 INFO - PROCESS | 567 | 12:59:31 INFO - PROCESS | 567 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 12:59:31 INFO - PROCESS | 567 | Values: 5202.1 12:59:31 INFO - PROCESS | 567 | 12:59:31 INFO - PROCESS | 567 | [#4] RayTrace Cycles:1 Average:1100.11 Median:1100.11 stddev:0.00 (0.0%) 12:59:31 INFO - PROCESS | 567 | Values: 1100.1 12:59:31 INFO - PROCESS | 567 | 12:59:31 INFO - PROCESS | 567 | [#5] Earley Cycles:1 Average:803.37 Median:803.37 stddev:0.00 (0.0%) 12:59:31 INFO - PROCESS | 567 | Values: 803.4 12:59:31 INFO - PROCESS | 567 | 12:59:31 INFO - PROCESS | 567 | [#6] Boyer Cycles:1 Average:12390.24 Median:12390.24 stddev:0.00 (0.0%) 12:59:31 INFO - PROCESS | 567 | Values: 12390.2 12:59:31 INFO - PROCESS | 567 | 12:59:31 INFO - PROCESS | 567 | [#7] RegExp Cycles:1 Average:25846.15 Median:25846.15 stddev:0.00 (0.0%) 12:59:31 INFO - PROCESS | 567 | Values: 25846.2 12:59:31 INFO - PROCESS | 567 | 12:59:31 INFO - PROCESS | 567 | [#8] Splay Cycles:1 Average:665.78 Median:665.78 stddev:0.00 (0.0%) 12:59:31 INFO - PROCESS | 567 | Values: 665.8 12:59:31 INFO - PROCESS | 567 | 12:59:31 INFO - PROCESS | 567 | [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 12:59:31 INFO - PROCESS | 567 | Values: 4864.1 12:59:31 INFO - PROCESS | 567 | -------- Summary: end -------- 12:59:31 INFO - PROCESS | 567 | 12:59:32 INFO - TEST-INFO | 567: exit 0 12:59:32 INFO - TEST-OK | v8_7 | took 39155ms 12:59:32 INFO - SUITE-END | took 1210s 12:59:32 INFO - Completed test suite (00:20:10) 12:59:32 INFO - Working with test: dromaeo_css 12:59:32 INFO - Generating results file: dromaeo_css 12:59:32 INFO - Working with test: kraken 12:59:32 INFO - Generating results file: kraken 12:59:32 INFO - javascript benchmark 12:59:32 INFO - Working with test: v8_7 12:59:32 INFO - Generating results file: v8_7 12:59:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:59:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 12:59:32 INFO - process_Request line: dromaeo_css 6919.24 graph.html#tests=[[72,64,35]] 12:59:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:59:32 INFO - process_Request line: kraken 1504.00 graph.html#tests=[[232,64,35]] 12:59:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:59:32 INFO - process_Request line: v8_7 20666.15 graph.html#tests=[[230,64,35]] 12:59:32 INFO - RETURN: dromaeo_css: 6919.24 12:59:32 INFO - RETURN: kraken: 1504.00 12:59:32 INFO - RETURN: v8_7: 20666.15 12:59:32 INFO - javascript benchmark 12:59:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3091.1035799618107, 3141.905742827716, 3180.348028654126, 3182.013575791505, 3196.680331966803, 5051.419086805018, 5246.1606143017125, 5278.630495865286, 5323.414424413311, 5382.946170538294, 5180.766865491052, 5210.062188806013, 5240.554552863002, 5339.813106541272, 5362.973185134078, 4811.78346974387, 4858.538438848322, 4866.31871537985, 4869.756512174377, 4883.9511604883855, 4888.853334399973, 4912.656114072016, 4922.3354847095725, 4967.875803104916, 5002.524760147799, 4670.859874203779, 4723.0, 4784.5933095686905, 4827.324174615556, 4843.830465933675, 4802.279658051285, 4809.446913604946, 4815.831445899376, 4828.517148285178, 4865.854024379274, 4617.215073437524, 4780.11567859947, 4787.593054590364, 4810.06203790261, 4854.0, 5023.346964894577, 5055.646104772667, 5073.974630126862, 5092.541671249568, 5093.949060509384, 5637.633553818989, 5644.435556444364, 5645.8588535286535, 5657.066584013633, 5658.321001479849, 5504.752286147133, 5662.801801936913, 5682.119271512881, 5688.459596338341, 5695.715214239312, 5204.115300398941, 5269.525742683177, 5275.103232450454, 5304.363476382859, 5353.973230133864, 5773.884522309614, 5825.79609713658, 5830.067189249699, 5835.2414186156375, 5884.176215329857, 5350.224217488442, 5444.428335024765, 5646.181303711021, 5647.322321321468, 5657.038303488417, 5493.450654934554, 5595.8601034973635, 5607.495325420732, 5612.0, 5628.802991895264, 5646.661200327993, 5648.435156484319, 5657.377688454267, 5662.631928924607, 5676.631018983753, 5462.235287059815, 5571.749271282802, 5574.777008919679, 5615.6630602164005, 5664.8867022659315, 4385.473743150778, 4414.845480408235, 4416.823327066945, 4438.1567502174485, 4471.754053527022, 3904.570497245301, 3916.1971795781797, 3920.4315374270573, 3951.644352008333, 3971.72197946141, 5061.392632884003, 5143.099957507496, 5257.973710131425, 5279.023380674587, 5316.946830531722, 5585.58108141891, 5631.7747290108755, 5726.141078838207, 5739.16782066598, 5750.539956803445, 5241.475852414805, 5248.081585722483, 5249.763760630781, 5255.13290307095, 5275.63070585063, 4745.976270118627, 4839.249916262985, 4929.260610908393, 4933.383327084114, 4966.553010229097, 5762.337331206881, 5804.216430781875, 5807.5644326675665, 5818.156367326798, 5874.060150375919, 5658.773649053992, 5672.829815105553, 5691.345495268097, 5698.344690360662, 5700.087985922232, 5566.554675626021, 5621.887562248814, 5684.346300175367, 5769.769209231584, 5792.304923409218, 5447.863803404788, 5513.09034009384, 5514.503694667499, 5555.444455554412, 5558.749856256397, 5716.199732037435, 5718.628289161191, 5736.766595182056, 5751.97124014394, 5754.827355179351, 5398.433164517669, 5496.367917689517, 5498.532624726943, 5637.351704554028, 5650.773969041193, 5458.044842152528, 5508.20131080999, 5509.338879334506, 5509.559235261249, 5545.694986775766, 5495.725213739377, 5528.944710552843, 5532.834014979557, 5534.7509362078, 5534.889302213853, 5382.515573598395, 5422.132458806572, 5442.700651464049, 5617.971910140586, 5663.886722265449, 5436.266104076058, 5455.563554915518, 5456.727163641882, 5457.672539647475, 5457.972710136424], "unit": "score", "name": "dojo.html", "value": 5207.8554147976465}, {"lowerIsBetter": false, "replicates": [547.0969726980343, 586.2525280267658, 591.964482131072, 604.6613896218118, 612.7947137708867, 38732.41901371482, 39228.21543569127, 39402.408963865564, 39414.40878386823, 39440.60559394405, 41819.0, 42495.36256956148, 42497.36253956193, 42510.57489425105, 42520.0, 7408.814779630526, 7535.773926782205, 7549.980752598384, 8646.870296945535, 8736.956315218447, 10329.58681652733, 10550.261481696285, 10560.26078174528, 10562.78874422511, 10578.0, 10211.336263142872, 10397.792044159112, 10408.895911040869, 10409.73975650611, 10412.895871041268, 7715.189905059972, 7910.841783164305, 7916.208379162095, 10309.793804123912, 10439.269251152422, 10080.94959525205, 10309.32989355697, 10310.07209351162, 10311.742206444898, 10312.742181445448, 39576.60423395758, 39604.40593391102, 40029.39955900664, 40030.0, 40090.599094008976, 3184.7452203823636, 3219.4848824188252, 3252.7235185009304, 3276.655951125121, 3350.4974253861874, 30196.0, 30326.241843953856, 30572.08283751491, 30809.845950770326, 31460.528092078635, 3591.497190393321, 3625.274945011008, 3635.5092062571744, 3918.2163567286657, 4080.775557344345, 276027.0, 276427.0, 277707.0, 279035.6048219766, 279411.0, 56507.43492565104, 57754.13368799471, 59648.701756491806, 60054.399456005754, 60063.59745610127, 70595.2940470599, 71493.642531787, 71827.6408617964, 71927.0, 71946.64026679938, 15801.525954221392, 16004.0, 16069.035857848332, 16072.437464688679, 16098.195090245441, 10608.469576521144, 10616.044555989998, 10632.521536530874, 10643.25497215203, 10674.146068314516, 19793.40619781409, 20242.392728218176, 20275.797242027686, 20303.4924126898, 20364.963503649516, 7989.400794940403, 8021.0, 8087.959560202161, 8135.877961830577, 8246.917530824734, 953.2802733935835, 1039.880413752413, 1058.0583280880023, 1072.3137192197, 1082.1883587309517, 27162.0, 27720.0, 27907.72092279092, 28201.0, 28362.858185709352, 1046.842973553973, 1050.3750268590177, 1068.7862427514528, 1144.6337172105013, 1157.6989982604584, 14655.853441465662, 16084.356625735074, 16829.410970616216, 16947.491575252763, 16962.06708631037, 390637.0, 396160.0, 396851.0, 397106.0, 397921.0, 54033.1895021575, 54585.72707136439, 54629.0, 54722.72638636861, 54745.1788223169, 1368.473137841938, 1382.861713828609, 1396.322783450026, 1413.886889048894, 1415.2499175437035, 25878.0, 28740.137795866158, 28971.275718107216, 29764.85117574398, 30687.0, 47369.52630473789, 48046.27930581114, 48059.0, 48140.27789583089, 48151.0, 299495.0, 301721.0, 303202.0, 303975.0, 304582.0, 26762.197134086007, 27032.459350813268, 30220.697793021787, 30629.846850765603, 31427.0, 35759.46360804642, 36147.819260903525, 36453.81773091118, 36546.8172659135, 36837.81581092077, 30801.537976929914, 31183.220419489695, 31370.372592548476, 31601.5259771099, 31723.20691982719, 31719.841400792848, 32046.83976580102, 32358.83820580882, 32661.836690816395, 32750.181245469055, 32953.83523082369, 33152.66847331496, 33306.0, 33373.499397508574, 33418.0, 29216.0, 30156.24609384783, 30640.0, 30674.0, 30687.0, 23622.173223937767, 23936.52126957486, 27377.589336159574, 27727.44545109046, 27914.0], "unit": "score", "name": "ext.html", "value": 18769.276572330553}, {"lowerIsBetter": false, "replicates": [344.9620541740408, 346.95663042119736, 350.1858179732122, 353.46097201767304, 353.8973697627688, 13756.0, 14175.149491030545, 16220.0, 16932.746008809863, 18497.815021849776, 16129.274182661778, 16130.758038629401, 16145.838541614581, 16146.757798633, 16219.51341459758, 5242.135047717122, 5525.723713814314, 5550.77796888124, 5551.750171242304, 5553.694546799924, 3996.3605823068315, 4129.339305711087, 5511.614187006911, 5937.88124237515, 6075.63546187228, 6032.758689652409, 6037.818865434044, 6059.484943779784, 6076.179715738385, 6081.908771368433, 4950.381202349707, 5025.84922452327, 5073.543381095682, 5079.288899554065, 5083.135866902617, 4886.486918873538, 4888.169011268057, 5015.423226328946, 5217.3217481727515, 5232.6598771080135, 19345.4196374109, 19580.0, 19948.90025549863, 19979.400617981482, 20078.09648565818, 2050.3541384463997, 2056.92800751973, 2070.358188961427, 2099.254764558575, 2179.5096103376773, 8973.416727912665, 9143.451392916446, 9146.131117543822, 9192.448453092837, 9212.447253164832, 1792.345793785259, 1843.557546188905, 1847.3718935561974, 1869.8317151456433, 1873.4473330367575, 58470.41529584692, 60158.09762853517, 60724.69637651827, 61721.0, 61730.382696173365, 10035.849462258071, 10152.086312231935, 10238.18094552434, 10255.7436064099, 10307.072363487172, 13252.469901204036, 13267.270300133392, 13269.867301326864, 13279.004074694436, 13285.13646612967, 7612.8477430451085, 7720.652570634335, 7744.41916856238, 7759.262870027451, 7785.065792104983, 7575.962120189474, 7598.112717167441, 7639.847203055908, 7653.693852245848, 7656.349210317074, 4293.763842988666, 4336.783160842008, 4376.496702879146, 4393.362962370502, 4500.774961251925, 1623.6427985843095, 1673.8493535581613, 1780.5459607800187, 1828.1133650179652, 1850.5928695686928, 837.5644664774284, 916.0518862976787, 995.7311525887969, 1026.5380578739598, 1051.952662130206, 14004.439822407194, 16495.505134845975, 16513.174341282887, 17070.48788536321, 17122.898058979044, 902.2331018634239, 962.6390103711109, 1002.3484734922358, 1008.505832142245, 1022.6676330192718, 8242.381821363422, 9623.615055397706, 9800.55897484615, 9850.950745246228, 9868.802623947624, 539676.6032339705, 541525.0, 549991.0, 551921.0, 551963.0, 77217.61391193008, 77584.0, 78910.0, 79048.0, 81019.59490202629, 1090.7654854206385, 1091.8525998990194, 1121.3944469986116, 1134.1493879590307, 1134.1663877050526, 14460.710785784437, 15535.611609709396, 15580.454684086002, 15582.0, 15757.133357665438, 32551.51172732458, 34818.82590587031, 35189.824050880605, 36104.819475902455, 36338.0, 42441.0, 43826.34260486159, 44494.777526112164, 45190.548094518635, 45819.0, 9050.244148678225, 9499.762505937408, 9637.036296370587, 9656.179224765974, 9664.275179361435, 11285.661430157108, 11333.206675532634, 16520.0, 17875.19561619756, 17955.730664039787, 14277.357518911465, 14440.133591984515, 14806.703865922405, 15086.698266034398, 15130.092194468367, 14334.569962901129, 14373.496927607484, 14651.706965860836, 14906.850931490546, 14974.176420296988, 14998.925005374904, 15025.624359391102, 15253.923730381277, 15285.465008724641, 15357.3089210988, 9366.578503967201, 9420.576074076545, 9437.197838183556, 9488.193503552275, 9497.572609232739, 11513.251638643462, 11680.94159529231, 12744.61766147017, 14126.0, 14244.21656808844], "unit": "score", "name": "jquery.html", "value": 8789.479866436339}, {"lowerIsBetter": false, "replicates": [1362.9591112266635, 1498.512983280434, 1553.7436323006705, 1688.130612734442, 1808.7700363752651, 6572.0, 7208.171060328057, 7348.779536613897, 7368.189499155089, 7403.185649578542, 7454.515456495324, 7529.811754706121, 7599.810004749884, 7604.543727376347, 7616.61916904154, 2146.37755051035, 2194.703714998471, 2199.076387917071, 2201.966970495436, 2203.493196564791, 2163.167180635459, 2189.9343019709436, 2272.7727227277305, 2280.1107568048474, 2280.2133264023887, 2156.8598041127275, 2171.207509259125, 2191.4521369657587, 2194.2539536557565, 2194.572058448603, 2164.8051675349216, 2182.5962196993605, 2185.3880913344287, 2185.4536365908525, 2186.169255682846, 2188.6060509108356, 2221.9000144993515, 2224.799768020886, 2232.5758105959817, 2235.3964429603916, 7323.963380183119, 7333.706651733924, 7401.70393184272, 7412.4811263211595, 7414.851702965964, 4448.377227188196, 4449.866504004853, 4463.33050042493, 4539.6368290536675, 4540.682152249344, 2926.4732348177317, 2979.925501862449, 3009.8043627164166, 3024.259056531164, 3034.8179109253515, 968.8692026576463, 987.5950860147377, 1004.5278719002057, 1015.2385710716962, 1030.7629245273554, 10140.695779126638, 10144.644937427154, 10146.34048786834, 10151.492425378701, 10175.643852465202, 4036.65688416482, 4046.0491784430637, 4046.47395838545, 4131.132462182975, 4134.710570260053, 8636.740897773077, 8651.91348086511, 8659.48043117415, 8679.17547832955, 8679.869801952977, 4498.572635599613, 4505.324201369755, 4549.09018196362, 4551.635869130461, 4577.176108300538, 3630.945535816965, 3730.2725968435893, 4078.347464405681, 4132.91734165315, 4133.21468920904, 3504.491848681927, 3521.735869809723, 3551.5027896094566, 3557.3241084194437, 3584.8386822593047, 1142.8628564572305, 1149.2759561476216, 1152.4698638626326, 1155.1278784517635, 1165.4813607944384, 968.2592816495387, 969.1519920069939, 995.66147509847, 1009.4548943570389, 1017.064300843226, 6851.554648947803, 6889.552179108342, 6892.483063770137, 6899.827504312432, 6908.827279317957, 458.9105124500757, 461.42091674947727, 1170.309517384747, 1179.988200118005, 1225.8957988570894, 5523.530499907552, 5562.360328562268, 5563.193336966198, 5565.471280228372, 5597.720113994284, 8556.572171391406, 8579.14208579137, 8851.114888511098, 8855.38012339143, 8935.374523783403, 8781.604827782765, 8788.42875213109, 8788.956055219684, 8854.86717699235, 8868.15752503511, 7022.227554968949, 7042.964785176144, 7125.82185445368, 7128.358447739728, 7192.065031545865, 6776.424003959719, 6844.247132815287, 6845.178578570603, 6871.793846184622, 6908.378245957687, 7755.418343624138, 7932.246436588515, 8074.798130046795, 8141.877871831809, 8147.511149331059, 8135.674573017013, 8327.541985190872, 8501.489910605136, 8503.022152452548, 8513.106123856905, 5636.9718151410625, 5710.0, 6417.807465776034, 6442.259140198749, 6470.773522926675, 7228.674709638184, 7264.418846492163, 7277.8908316376355, 7303.817404564928, 7310.853782924418, 6726.764563240459, 6783.966080169765, 6792.796216113525, 6849.452043836581, 6954.3393377629045, 6716.932830671631, 6773.458123350219, 6795.93204067953, 6901.654917254017, 6929.549579277331, 6691.43122834545, 6764.053032575345, 6792.694328755119, 6843.965780171067, 6845.691943862438, 5989.64062156272, 6016.0, 6020.307664618625, 6032.215811944419, 6054.0, 6233.314335423191, 6252.9374706254175, 6256.155419018374, 6260.874782504416, 6299.149614801943], "unit": "score", "name": "mootools.html", "value": 4278.473581019784}, {"lowerIsBetter": false, "replicates": [326.9280758233188, 327.4302713278894, 332.8585351225729, 336.4767786092628, 341.9213580876398, 5976.282846058468, 5996.400359964002, 6025.638461692296, 6067.575269731121, 6114.1745864308305, 5797.826065218051, 5899.174115623816, 5961.374055724152, 5961.672108034057, 5961.910571341434, 4619.676622636417, 4628.907421851561, 4633.1891918914225, 4634.37435946148, 4637.582617564419, 4441.422615060038, 4529.433820772403, 4540.432445944257, 4615.93076103857, 4640.814367425299, 4561.087782443508, 4575.970406658492, 4599.678022538424, 4604.930926036112, 4605.263157894738, 4592.288195329713, 4601.608863246628, 4610.746408947506, 4624.838130665411, 4628.83799067031, 4069.6540794032544, 4070.3894415837567, 4076.5515793262716, 4080.0207950091763, 4088.2232375848494, 5613.2422123013275, 5693.316801983747, 5708.828735137952, 5711.685857277848, 5738.799142030009, 5368.543673787733, 5368.899375627987, 5370.785168593252, 5374.408815030343, 5379.515843574097, 6049.395060493959, 6350.237971443456, 6362.491000719931, 6364.459020983222, 6368.0, 4360.4331436913, 4377.839872433808, 4434.955650443487, 4442.444694413199, 4450.954025803933, 6495.447886929616, 6540.3132671069325, 6587.044878492592, 6591.143151390336, 6613.239477460057, 4593.402857628487, 4595.862124136282, 4598.770061496912, 4603.102395032936, 4604.953950460453, 4399.64802815774, 4499.785058034312, 4501.572350626685, 4671.15919134559, 4671.48613652498, 5246.213068039825, 5278.0, 5281.815136470205, 5282.596418629514, 5289.920651190235, 6431.485481161496, 6444.194475690539, 6449.355064493513, 6453.354664533509, 6460.353964603502, 1587.3888003676277, 1612.040835702755, 1613.0805440898575, 1613.693398254328, 1614.7497137943403, 1058.5077938758513, 1062.6652604429735, 1064.0, 1072.9034386905216, 1096.1723898456614, 6001.609895356788, 6009.699515024318, 6041.909371359433, 6050.6974651267265, 6055.0, 6603.70283337251, 6620.933790662128, 6621.437177839841, 6625.271220165778, 6633.436157926534, 5915.349311575723, 6030.7889223876955, 6035.39646035393, 6035.517158627299, 6036.728347224298, 3553.466979953028, 3582.982085089558, 3584.175639602906, 3584.6773790358993, 3588.748787584896, 6766.898496522556, 6770.390664840188, 6771.864562708718, 6776.390124888783, 6779.389854913082, 6736.562123461959, 6777.8644427111185, 6785.59286442815, 6799.184097908283, 6803.0, 6619.470442364599, 6810.455163586901, 6862.862742745217, 6873.48448866337, 6875.037494750739, 6427.903581446376, 6581.3418658135715, 6582.8354291143105, 6688.197416309879, 6690.264070952288, 6584.736610535525, 6603.504737144637, 6614.768483103068, 6619.172603424572, 6626.0, 6837.62393068386, 6840.281770414035, 6846.691898864464, 6851.623160726208, 6853.7943861684225, 4384.342348647729, 4507.323901414814, 4511.8646440606835, 4541.296099104512, 4581.106684196549, 6589.703463344065, 6591.044298576584, 6592.241892182268, 6659.433948114271, 6673.132492775908, 6468.741250349934, 6478.352164783672, 6484.027395890655, 6486.708098135501, 6487.929491633828, 6235.189425374672, 6469.061986012096, 6472.0, 6518.348165183444, 6518.478521718156, 6356.283803373156, 6384.968075159594, 6392.712327945346, 6400.199975003125, 6405.647689377129, 6534.738610455529, 6537.084808126771, 6539.934600654123, 6540.37866402691, 6552.148220731275, 6219.875602488016, 6377.93622063792, 6380.330065343072, 6384.170057892445, 6394.872102558016], "unit": "score", "name": "prototype.html", "value": 4821.616595778025}, {"lowerIsBetter": false, "replicates": [730.3828265115975, 752.3379426105026, 784.2118670735912, 811.5982588618634, 834.1700008491551, 13325.067245292834, 13646.454141834314, 13653.863461365383, 13669.043166978316, 13675.452981880726, 13024.153430027041, 13048.347582620854, 13053.086283960103, 13055.41250643721, 13090.738185236289, 668.3550373889196, 678.2539206872425, 796.6295672512266, 805.629410471184, 818.7789296889836, 797.2346547314556, 802.5385403393043, 806.939479539034, 811.5414790643267, 812.6302532347768, 847.4872702015284, 855.9443636163629, 857.3655494933766, 861.6811779641541, 861.9784505387353, 696.7770313499682, 710.0981753173467, 846.6740304982595, 862.2412277196028, 863.4646519158099, 627.015585530717, 634.7841733810527, 637.3626373626373, 637.4422380417135, 637.7225906730587, 12966.87033129666, 13043.543475978295, 13096.541621043312, 13099.34503274842, 13101.41043653038, 11237.887621123766, 11381.430928453545, 11388.14588905827, 11552.422378881023, 11648.767024659459, 10116.797664046751, 10199.643012494602, 10241.334313269614, 10248.128909042665, 10300.742481437948, 3588.138846676805, 3616.3129005488872, 3616.9095772605633, 3622.8913132606062, 3746.6440688134585, 46051.0, 47075.293870591966, 47491.76254118742, 47493.76253118712, 47558.28662570064, 9665.600984928282, 9782.51087445625, 9807.460589667637, 9925.553350099262, 9972.351797133164, 16861.662766744597, 16949.322027119022, 16966.15169241533, 16983.91508042452, 17209.913950430167, 7121.71513139479, 7142.178649455379, 7227.7831665050135, 7260.564366137943, 7433.331000210007, 3925.175713100281, 3942.4677668514382, 3965.7025723070883, 3968.7817170055346, 3972.3644216925154, 3088.8918887838818, 3091.1499337682317, 3104.580881581003, 3132.561441398206, 3135.639401468815, 568.9914651280234, 580.2236299307792, 582.0512564519805, 590.9468147866712, 605.5609682979892, 590.7463028546083, 623.9875202495924, 630.5397060146119, 632.3013070556968, 694.486080300584, 8655.56722163902, 8728.956355218183, 8732.301415886714, 8733.126687331216, 8846.115388461103, 556.2129586634867, 651.8305240637468, 663.2174034639172, 688.449240607512, 702.8594281143792, 3954.070793363557, 3971.4638523799495, 4032.1129351542613, 4105.8973525662095, 4145.983950709263, 54473.45526544763, 54943.0, 55579.722101389234, 55791.44208557862, 59674.70162649246, 46785.766071169426, 47046.76476617595, 47060.764696176986, 49701.25448118281, 49821.0, 44401.55598443974, 44567.0, 45033.77483112564, 45393.0, 46565.30152047722, 8320.557700086352, 8342.83314333722, 8647.610857511301, 8688.348373871859, 8722.65109395617, 34195.658043419244, 34851.82574087215, 35031.47452788261, 35500.64499354974, 35621.465678014334, 42676.65278409593, 42935.14129717326, 43406.0, 44247.33628995632, 44276.11447771091, 11053.944730276296, 11248.83126753083, 11327.943360283145, 11345.65303235531, 11370.658880233606, 11759.529618815493, 11846.644600661994, 11891.46488408041, 11921.821172682243, 12122.696932576757, 10875.782484350111, 11069.391183484986, 11238.269512481662, 11277.887221127683, 11603.535858565563, 10496.317739346918, 10864.130869530261, 11046.447677615926, 11119.666410007712, 11139.777204456028, 11001.61494347726, 11226.382548959886, 11316.660500185008, 11352.778288731291, 11554.191206615456, 9446.716598502057, 9546.474943878153, 9680.0, 9766.46284454362, 9786.951065244628, 8498.235158835734, 8842.15140752109, 8899.777505562413, 9614.519274036411, 9668.0], "unit": "score", "name": "yui.html", "value": 6190.959584866449}], "name": "dromaeo_css", "value": 6919.239517786451}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 103.0, 111.0, 112.0, 110.0, 100.0, 109.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 147.0, 163.0, 139.0, 150.0, 150.0, 131.0, 163.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [168.0, 159.0, 164.0, 161.0, 162.0, 163.0, 162.0, 164.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 85.0, 94.0, 72.0, 75.0, 75.0, 96.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 141.0, 93.0, 93.0, 93.0, 150.0, 92.0, 94.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 161.0, 146.0, 145.0, 144.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 97.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 61.0, 58.0, 59.0, 59.0, 59.0, 69.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [90.0, 84.0, 84.0, 84.0, 85.0, 85.0, 83.0, 83.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [113.0, 112.0, 124.0, 122.0, 120.0, 120.0, 124.0, 123.0, 124.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [151.0, 141.0, 156.0, 147.0, 149.0, 138.0, 152.0, 156.0, 147.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 70.0, 65.0, 68.0, 67.0, 66.0, 65.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1504.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.00265604249668], "unit": "score", "name": "Richards", "value": 212.659248}, {"lowerIsBetter": false, "replicates": [195.61815336463224], "unit": "score", "name": "DeltaBlue", "value": 337.99521599999997}, {"lowerIsBetter": false, "replicates": [283.36639274582035], "unit": "score", "name": "Encrypt", "value": 939.3527489999996}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1100.1100110011], "unit": "score", "name": "RayTrace", "value": 672.6500009999999}, {"lowerIsBetter": false, "replicates": [803.370786516854], "unit": "score", "name": "Earley", "value": 829.5833146853149}, {"lowerIsBetter": false, "replicates": [12390.243902439024], "unit": "score", "name": "Boyer", "value": 53.789336614173266}, {"lowerIsBetter": false, "replicates": [25846.153846153848], "unit": "score", "name": "RegExp", "value": 35.24644345238097}, {"lowerIsBetter": false, "replicates": [665.7789613848203], "unit": "score", "name": "Splay", "value": 122.39948199999999}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 20666.147099242193}]} 12:59:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20666.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1504.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6919.24"}}} 12:59:32 INFO - Return code: 0 12:59:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 12:59:32 INFO - # TBPL SUCCESS # 12:59:32 INFO - Running post-action listener: _resource_record_post_action 12:59:32 INFO - Running post-run listener: _resource_record_post_run 12:59:33 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 554647552; Read time: 52; Write time: 707532 12:59:33 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 245415936; Read time: 0; Write time: 416568 12:59:33 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 309231616; Read time: 52; Write time: 290964 12:59:33 INFO - Running post-run listener: _upload_blobber_files 12:59:33 INFO - Blob upload gear active. 12:59:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 12:59:33 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 12:59:33 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'] 12:59:33 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 12:59:33 INFO - (blobuploader) - INFO - Open directory for files ... 12:59:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 12:59:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:59:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:59:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:59:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:59:34 INFO - (blobuploader) - INFO - Done attempting. 12:59:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:59:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:59:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:59:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:59:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:59:35 INFO - (blobuploader) - INFO - Done attempting. 12:59:35 INFO - (blobuploader) - INFO - Iteration through files over. 12:59:35 INFO - Return code: 0 12:59:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 12:59:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 12:59:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6018dd555e4d27d81feb1ed5a5d7b3da93f147c85beb41d46914586f5d88a16678abd584f3bd8fa2baa76e5b7f118be44d2832d484da6307dc2103a789ea77b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcee39d7d11c7b3611adabc09a590b63b388d2b4061cd2c39f8162be2f2cb57c1f63aebdffa6b00df19afc1528d762e219a6ec204798928e9722506bfd27d023"} 12:59:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 12:59:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 12:59:35 INFO - Contents: 12:59:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6018dd555e4d27d81feb1ed5a5d7b3da93f147c85beb41d46914586f5d88a16678abd584f3bd8fa2baa76e5b7f118be44d2832d484da6307dc2103a789ea77b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcee39d7d11c7b3611adabc09a590b63b388d2b4061cd2c39f8162be2f2cb57c1f63aebdffa6b00df19afc1528d762e219a6ec204798928e9722506bfd27d023"} 12:59:35 INFO - Copying logs to upload dir... 12:59:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.484902 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-12-23 12:59:34.599761) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 12:59:34.602820) ========= 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=edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761 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/6018dd555e4d27d81feb1ed5a5d7b3da93f147c85beb41d46914586f5d88a16678abd584f3bd8fa2baa76e5b7f118be44d2832d484da6307dc2103a789ea77b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcee39d7d11c7b3611adabc09a590b63b388d2b4061cd2c39f8162be2f2cb57c1f63aebdffa6b00df19afc1528d762e219a6ec204798928e9722506bfd27d023"} build_url:https://queue.taskcluster.net/v1/task/AYNW0dZET4imfbnoe-YXpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/AYNW0dZET4imfbnoe-YXpQ/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/6018dd555e4d27d81feb1ed5a5d7b3da93f147c85beb41d46914586f5d88a16678abd584f3bd8fa2baa76e5b7f118be44d2832d484da6307dc2103a789ea77b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcee39d7d11c7b3611adabc09a590b63b388d2b4061cd2c39f8162be2f2cb57c1f63aebdffa6b00df19afc1528d762e219a6ec204798928e9722506bfd27d023"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 12:59:34.626921) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:59:34.627207) ========= 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=edca6ca23558fe0608d91a4e00000196-1450903110.600320-92297761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:59:34.710909) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 12:59:34.711209) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 12:59:34.711475) ========= ========= Total master_lag: 0.22 =========