builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1452041369.3 results: success (0) buildid: 20160105143019 builduid: 10b6219b50d64fe088db8ab0c0382abe revision: c342816f76c048db725e4c44e64bb3cfdcde7aa9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.298617) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.299273) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.299781) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006329 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.333214) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.333652) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.372064) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.372348) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.422834) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.423145) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.423515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.423860) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 16:49:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-01-05 16:49:29 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096815 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.533209) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.533540) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022497 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.582840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:29.583159) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c342816f76c048db725e4c44e64bb3cfdcde7aa9 --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 c342816f76c048db725e4c44e64bb3cfdcde7aa9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 16:49:30,071 truncating revision to first 12 chars 2016-01-05 16:49:30,071 Setting DEBUG logging. 2016-01-05 16:49:30,071 attempt 1/10 2016-01-05 16:49:30,071 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c342816f76c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 16:49:30,314 unpacking tar archive at: fx-team-c342816f76c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.863558 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:30.462143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:30.462443) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:30.473050) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:30.473322) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 16:49:30.473715) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-05 16:49:30.474003) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:49:31 INFO - MultiFileLogger online at 20160105 16:49:31 in /builds/slave/test-pgo 16:49:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:49:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:49:31 INFO - {'append_to_log': False, 16:49:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:49:31 INFO - 'blob_upload_branch': 'Fx-Team', 16:49:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:49:31 INFO - 'branch': 'Fx-Team', 16:49:31 INFO - 'buildbot_json_path': 'buildprops.json', 16:49:31 INFO - 'config_files': ('talos/linux_config.py',), 16:49:31 INFO - 'default_actions': ('clobber', 16:49:31 INFO - 'read-buildbot-config', 16:49:31 INFO - 'download-and-extract', 16:49:31 INFO - 'populate-webroot', 16:49:31 INFO - 'create-virtualenv', 16:49:31 INFO - 'install', 16:49:31 INFO - 'run-tests'), 16:49:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:49:31 INFO - 'download_minidump_stackwalk': True, 16:49:31 INFO - 'download_symbols': 'ondemand', 16:49:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:49:31 INFO - 'tooltool.py': '/tools/tooltool.py', 16:49:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:49:31 INFO - '/tools/misc-python/virtualenv.py')}, 16:49:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:49:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:49:31 INFO - 'installer_path': 'installer.exe', 16:49:31 INFO - 'log_level': 'info', 16:49:31 INFO - 'log_name': 'talos', 16:49:31 INFO - 'log_to_console': True, 16:49:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:49:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:49:31 INFO - 'opt_config_files': (), 16:49:31 INFO - 'pip_index': False, 16:49:31 INFO - 'sps_profile': False, 16:49:31 INFO - 'sps_profile_interval': 0, 16:49:31 INFO - 'suite': 'dromaeojs', 16:49:31 INFO - 'system_bits': '32', 16:49:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:49:31 INFO - 'title': 'talos-linux64-ix-056', 16:49:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:49:31 INFO - 'use_talos_json': True, 16:49:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:49:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:49:31 INFO - 'work_dir': 'build'} 16:49:31 INFO - ##### 16:49:31 INFO - ##### Running clobber step. 16:49:31 INFO - ##### 16:49:31 INFO - Running pre-action listener: _resource_record_pre_action 16:49:31 INFO - Running main action method: clobber 16:49:31 INFO - rmtree: /builds/slave/test-pgo/build 16:49:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:49:31 INFO - Running post-action listener: _resource_record_post_action 16:49:31 INFO - ##### 16:49:31 INFO - ##### Running read-buildbot-config step. 16:49:31 INFO - ##### 16:49:31 INFO - Running pre-action listener: _resource_record_pre_action 16:49:31 INFO - Running main action method: read_buildbot_config 16:49:31 INFO - Using buildbot properties: 16:49:31 INFO - { 16:49:31 INFO - "project": "", 16:49:31 INFO - "product": "firefox", 16:49:31 INFO - "script_repo_revision": "production", 16:49:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:49:31 INFO - "repository": "", 16:49:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:49:31 INFO - "buildid": "20160105143019", 16:49:31 INFO - "pgo_build": "True", 16:49:31 INFO - "basedir": "/builds/slave/test-pgo", 16:49:31 INFO - "buildnumber": 400, 16:49:31 INFO - "slavename": "talos-linux64-ix-056", 16:49:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:49:31 INFO - "platform": "ubuntu64_hw", 16:49:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:49:31 INFO - "branch": "fx-team", 16:49:31 INFO - "repo_path": "integration/fx-team", 16:49:31 INFO - "revision": "c342816f76c048db725e4c44e64bb3cfdcde7aa9", 16:49:31 INFO - "stage_platform": "linux64-pgo", 16:49:31 INFO - "builduid": "10b6219b50d64fe088db8ab0c0382abe", 16:49:31 INFO - "slavebuilddir": "test" 16:49:31 INFO - } 16:49:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:49:31 INFO - Running post-action listener: _resource_record_post_action 16:49:31 INFO - ##### 16:49:31 INFO - ##### Running download-and-extract step. 16:49:31 INFO - ##### 16:49:31 INFO - Running pre-action listener: _resource_record_pre_action 16:49:31 INFO - Running main action method: download_and_extract 16:49:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:31 INFO - https://queue.taskcluster.net/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/test_packages.json 16:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/test_packages.json 16:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:49:37 INFO - Downloaded 1302 bytes. 16:49:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:49:37 INFO - Using the following test package requirements: 16:49:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:49:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:49:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:37 INFO - u'jsshell-linux-x86_64.zip'], 16:49:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:49:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:49:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:49:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:49:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:49:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:49:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:49:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:37 INFO - https://queue.taskcluster.net/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:49:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/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 16:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/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 16:49:39 INFO - Downloaded 24051424 bytes. 16:49:39 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 16:49:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:39 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 16:49:40 INFO - Return code: 0 16:49:40 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 16:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:40 INFO - https://queue.taskcluster.net/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:49:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/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 16:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/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 16:49:44 INFO - Downloaded 24051424 bytes. 16:49:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:49:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:49:46 INFO - Return code: 0 16:49: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')]} 16:49:46 INFO - https://queue.taskcluster.net/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:49:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:49:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:49:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/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 16:49:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/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 16:49:47 INFO - Downloaded 11132285 bytes. 16:49:47 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 16:49:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:49:47 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 16:49:47 INFO - Return code: 0 16:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:47 INFO - https://queue.taskcluster.net/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:49:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/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 16:49:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0urGjpRS8qk1eOt-uBB_g/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 16:49:49 INFO - Downloaded 55004014 bytes. 16:49:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:49 INFO - mkdir: /builds/slave/test-pgo/properties 16:49:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:49:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:49:49 INFO - Contents: 16:49:49 INFO - build_url:https://queue.taskcluster.net/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:49 INFO - Running post-action listener: _resource_record_post_action 16:49:49 INFO - Running post-action listener: set_extra_try_arguments 16:49:49 INFO - ##### 16:49:49 INFO - ##### Running populate-webroot step. 16:49:49 INFO - ##### 16:49:49 INFO - Running pre-action listener: _resource_record_pre_action 16:49:49 INFO - Running main action method: populate_webroot 16:49:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:49:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:49:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:49:49 INFO - '--tppagecycles', 16:49:49 INFO - '7'], 16:49:49 INFO - 'tests': ['tsvgm']}}, 16:49:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:49:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:49:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:49:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:49:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:49:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:49:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:49 INFO - 'talos_options': ['--e10s'], 16:49:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:49 INFO - 'tests': ['damp', 'tps']}, 16:49:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:49 INFO - 'talos_options': ['--e10s'], 16:49:49 INFO - 'tests': ['damp', 'tps']}, 16:49:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:49:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:49:49 INFO - 'other': {'tests': ['a11yr', 16:49:49 INFO - 'ts_paint', 16:49:49 INFO - 'tpaint', 16:49:49 INFO - 'sessionrestore', 16:49:49 INFO - 'sessionrestore_no_auto_restore']}, 16:49:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:49:49 INFO - 'tests': ['a11yr', 16:49:49 INFO - 'ts_paint', 16:49:49 INFO - 'tpaint', 16:49:49 INFO - 'sessionrestore', 16:49:49 INFO - 'sessionrestore_no_auto_restore']}, 16:49:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:49:49 INFO - 'tests': ['a11yr', 16:49:49 INFO - 'ts_paint', 16:49:49 INFO - 'tpaint', 16:49:49 INFO - 'sessionrestore', 16:49:49 INFO - 'sessionrestore_no_auto_restore']}, 16:49:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:49:49 INFO - 'tests': ['a11yr', 16:49:49 INFO - 'ts_paint', 16:49:49 INFO - 'tpaint', 16:49:49 INFO - 'sessionrestore', 16:49:49 INFO - 'sessionrestore_no_auto_restore']}, 16:49:49 INFO - 'other_l64': {'tests': ['a11yr', 16:49:49 INFO - 'ts_paint', 16:49:49 INFO - 'tpaint', 16:49:49 INFO - 'sessionrestore', 16:49:49 INFO - 'sessionrestore_no_auto_restore']}, 16:49:49 INFO - 'other_nol64': {'tests': ['a11yr', 16:49:49 INFO - 'ts_paint', 16:49:49 INFO - 'tpaint', 16:49:49 INFO - 'sessionrestore', 16:49:49 INFO - 'sessionrestore_no_auto_restore']}, 16:49:49 INFO - 'svgr': {'tests': ['tsvgx', 16:49:49 INFO - 'tsvgr_opacity', 16:49:49 INFO - 'tart', 16:49:49 INFO - 'tscrollx', 16:49:49 INFO - 'cart']}, 16:49:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:49:49 INFO - 'tests': ['tsvgx', 16:49:49 INFO - 'tsvgr_opacity', 16:49:49 INFO - 'tart', 16:49:49 INFO - 'tscrollx', 16:49:49 INFO - 'cart']}, 16:49:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:49 INFO - 'tests': ['tp5o']}, 16:49:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:49 INFO - 'talos_options': ['--e10s'], 16:49:49 INFO - 'tests': ['tp5o']}, 16:49:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:49 INFO - 'talos_options': ['--xperf_path', 16:49:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:49 INFO - 'tests': ['tp5n']}, 16:49:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:49 INFO - 'talos_options': ['--e10s', 16:49:49 INFO - '--xperf_path', 16:49:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:49 INFO - 'tests': ['tp5n']}}, 16:49:49 INFO - 'talos.zip': {'path': '', 16:49:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:49:49 INFO - Running post-action listener: _resource_record_post_action 16:49:49 INFO - ##### 16:49:49 INFO - ##### Running create-virtualenv step. 16:49:49 INFO - ##### 16:49:49 INFO - Running pre-action listener: _resource_record_pre_action 16:49:49 INFO - Running main action method: create_virtualenv 16:49:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:49:49 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 16:49:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:49:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:49:49 INFO - Using real prefix '/usr' 16:49:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:49:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:49:52 INFO - Installing pip.................done. 16:49:52 INFO - Return code: 0 16:49:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9b8e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2840>, '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 0x1a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', '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 16:49:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:49:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:49:52 INFO - Using env: {'DISPLAY': ':0', 16:49:52 INFO - 'HOME': '/home/cltbld', 16:49:52 INFO - 'LANG': 'en_US.UTF-8', 16:49:52 INFO - 'LANGUAGE': 'en_US:en', 16:49:52 INFO - 'LOGNAME': 'cltbld', 16:49:52 INFO - 'MAIL': '/var/mail/cltbld', 16:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:52 INFO - 'MOZ_NO_REMOTE': '1', 16:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:52 INFO - 'NO_EM_RESTART': '1', 16:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:52 INFO - 'SHELL': '/bin/bash', 16:49:52 INFO - 'SHLVL': '1', 16:49:52 INFO - 'TERM': 'linux', 16:49:52 INFO - 'TMOUT': '86400', 16:49:52 INFO - 'USER': 'cltbld', 16:49:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', 16:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:52 INFO - '_': '/tools/buildbot/bin/python'} 16:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:52 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 16:49:52 INFO - Cleaning up... 16:49:52 INFO - Return code: 0 16:49:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb9b8e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2840>, '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 0x1a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', '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 16:49:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:49:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:49:52 INFO - Using env: {'DISPLAY': ':0', 16:49:52 INFO - 'HOME': '/home/cltbld', 16:49:52 INFO - 'LANG': 'en_US.UTF-8', 16:49:52 INFO - 'LANGUAGE': 'en_US:en', 16:49:52 INFO - 'LOGNAME': 'cltbld', 16:49:52 INFO - 'MAIL': '/var/mail/cltbld', 16:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:52 INFO - 'MOZ_NO_REMOTE': '1', 16:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:52 INFO - 'NO_EM_RESTART': '1', 16:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:52 INFO - 'SHELL': '/bin/bash', 16:49:52 INFO - 'SHLVL': '1', 16:49:52 INFO - 'TERM': 'linux', 16:49:52 INFO - 'TMOUT': '86400', 16:49:52 INFO - 'USER': 'cltbld', 16:49:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', 16:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:52 INFO - '_': '/tools/buildbot/bin/python'} 16:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:52 INFO - Downloading/unpacking psutil>=0.7.1 16:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:49:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:49:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:49:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:54 INFO - Installing collected packages: psutil 16:49:54 INFO - Running setup.py install for psutil 16:49:54 INFO - building 'psutil._psutil_linux' extension 16:49:54 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 16:49:54 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 16:49:54 INFO - building 'psutil._psutil_posix' extension 16:49:54 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 16:49:54 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 16:49:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:54 INFO - Successfully installed psutil 16:49:54 INFO - Cleaning up... 16:49:54 INFO - Return code: 0 16:49:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:49: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')]} 16:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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')]} 16:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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', '--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 0x7fb9b8e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2840>, '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 0x1a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', '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 16:49:54 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 16:49:54 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 16:49:54 INFO - Using env: {'DISPLAY': ':0', 16:49:54 INFO - 'HOME': '/home/cltbld', 16:49:54 INFO - 'LANG': 'en_US.UTF-8', 16:49:54 INFO - 'LANGUAGE': 'en_US:en', 16:49:54 INFO - 'LOGNAME': 'cltbld', 16:49:54 INFO - 'MAIL': '/var/mail/cltbld', 16:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:54 INFO - 'MOZ_NO_REMOTE': '1', 16:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:54 INFO - 'NO_EM_RESTART': '1', 16:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:54 INFO - 'SHELL': '/bin/bash', 16:49:54 INFO - 'SHLVL': '1', 16:49:54 INFO - 'TERM': 'linux', 16:49:54 INFO - 'TMOUT': '86400', 16:49:54 INFO - 'USER': 'cltbld', 16:49:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', 16:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:54 INFO - '_': '/tools/buildbot/bin/python'} 16:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:49:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:49:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:49:56 INFO - Installing collected packages: mozsystemmonitor 16:49:56 INFO - Running setup.py install for mozsystemmonitor 16:49:57 INFO - Successfully installed mozsystemmonitor 16:49:57 INFO - Cleaning up... 16:49:57 INFO - Return code: 0 16:49:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:49:57 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')]} 16:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:57 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')]} 16:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:57 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 0x7fb9b8e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2840>, '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 0x1a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', '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 16:49:57 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 16:49:57 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 16:49:57 INFO - Using env: {'DISPLAY': ':0', 16:49:57 INFO - 'HOME': '/home/cltbld', 16:49:57 INFO - 'LANG': 'en_US.UTF-8', 16:49:57 INFO - 'LANGUAGE': 'en_US:en', 16:49:57 INFO - 'LOGNAME': 'cltbld', 16:49:57 INFO - 'MAIL': '/var/mail/cltbld', 16:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:57 INFO - 'MOZ_NO_REMOTE': '1', 16:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:57 INFO - 'NO_EM_RESTART': '1', 16:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:57 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:57 INFO - 'SHELL': '/bin/bash', 16:49:57 INFO - 'SHLVL': '1', 16:49:57 INFO - 'TERM': 'linux', 16:49:57 INFO - 'TMOUT': '86400', 16:49:57 INFO - 'USER': 'cltbld', 16:49:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', 16:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:57 INFO - '_': '/tools/buildbot/bin/python'} 16:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:57 INFO - Downloading/unpacking blobuploader==1.2.4 16:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:58 INFO - Downloading blobuploader-1.2.4.tar.gz 16:49:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:49:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:49:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:49:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:49:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49: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 16:49:59 INFO - Downloading docopt-0.6.1.tar.gz 16:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:49:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:49:59 INFO - Installing collected packages: blobuploader, requests, docopt 16:49:59 INFO - Running setup.py install for blobuploader 16:49:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:49:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:49:59 INFO - Running setup.py install for requests 16:50:00 INFO - Running setup.py install for docopt 16:50:00 INFO - Successfully installed blobuploader requests docopt 16:50:00 INFO - Cleaning up... 16:50:00 INFO - Return code: 0 16:50:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50:00 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')]} 16:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:00 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')]} 16:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:00 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 0x7fb9b8e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2840>, '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 0x1a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', '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 16:50:00 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 16:50:00 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 16:50:00 INFO - Using env: {'DISPLAY': ':0', 16:50:00 INFO - 'HOME': '/home/cltbld', 16:50:00 INFO - 'LANG': 'en_US.UTF-8', 16:50:00 INFO - 'LANGUAGE': 'en_US:en', 16:50:00 INFO - 'LOGNAME': 'cltbld', 16:50:00 INFO - 'MAIL': '/var/mail/cltbld', 16:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:00 INFO - 'MOZ_NO_REMOTE': '1', 16:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:00 INFO - 'NO_EM_RESTART': '1', 16:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:00 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:00 INFO - 'SHELL': '/bin/bash', 16:50:00 INFO - 'SHLVL': '1', 16:50:00 INFO - 'TERM': 'linux', 16:50:00 INFO - 'TMOUT': '86400', 16:50:00 INFO - 'USER': 'cltbld', 16:50:00 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', 16:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:00 INFO - '_': '/tools/buildbot/bin/python'} 16:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:00 INFO - Running setup.py (path:/tmp/pip-7BcOR9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:00 INFO - Running setup.py (path:/tmp/pip-o62lnm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:00 INFO - Running setup.py (path:/tmp/pip-9SdpvC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:00 INFO - Running setup.py (path:/tmp/pip-1rD8qO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:00 INFO - Running setup.py (path:/tmp/pip-ZTQh4P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:00 INFO - Running setup.py (path:/tmp/pip-mpgNYH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:00 INFO - Running setup.py (path:/tmp/pip-JPZane-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:00 INFO - Running setup.py (path:/tmp/pip-abObjo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:01 INFO - Running setup.py (path:/tmp/pip-8rNWLm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:01 INFO - Running setup.py (path:/tmp/pip-vbWQMT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:01 INFO - Running setup.py (path:/tmp/pip-StYYTx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:01 INFO - Running setup.py (path:/tmp/pip-pB7ItO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:01 INFO - Running setup.py (path:/tmp/pip-55SrIL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:01 INFO - Running setup.py (path:/tmp/pip-naqlV1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:01 INFO - Running setup.py (path:/tmp/pip-CIvawQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:01 INFO - Running setup.py (path:/tmp/pip-I5TJ_R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:01 INFO - Running setup.py (path:/tmp/pip-H7G0A7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:50:01 INFO - Running setup.py install for manifestparser 16:50:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:50:01 INFO - Running setup.py install for mozcrash 16:50:01 INFO - Running setup.py install for mozdebug 16:50:02 INFO - Running setup.py install for mozdevice 16:50:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Running setup.py install for mozfile 16:50:02 INFO - Running setup.py install for mozhttpd 16:50:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Running setup.py install for mozinfo 16:50:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Running setup.py install for mozInstall 16:50:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Running setup.py install for mozleak 16:50:02 INFO - Running setup.py install for mozlog 16:50:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Running setup.py install for moznetwork 16:50:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:50:02 INFO - Running setup.py install for mozprocess 16:50:02 INFO - Running setup.py install for mozprofile 16:50:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Running setup.py install for mozrunner 16:50:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Running setup.py install for mozscreenshot 16:50:03 INFO - Running setup.py install for moztest 16:50:03 INFO - Running setup.py install for mozversion 16:50:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:50:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:50:03 INFO - Cleaning up... 16:50:03 INFO - Return code: 0 16:50:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fb9b8e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2840>, '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 0x1a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', '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 16:50:03 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 16:50:03 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 16:50:03 INFO - Using env: {'DISPLAY': ':0', 16:50:03 INFO - 'HOME': '/home/cltbld', 16:50:03 INFO - 'LANG': 'en_US.UTF-8', 16:50:03 INFO - 'LANGUAGE': 'en_US:en', 16:50:03 INFO - 'LOGNAME': 'cltbld', 16:50:03 INFO - 'MAIL': '/var/mail/cltbld', 16:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:03 INFO - 'MOZ_NO_REMOTE': '1', 16:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:03 INFO - 'NO_EM_RESTART': '1', 16:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:03 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:03 INFO - 'SHELL': '/bin/bash', 16:50:03 INFO - 'SHLVL': '1', 16:50:03 INFO - 'TERM': 'linux', 16:50:03 INFO - 'TMOUT': '86400', 16:50:03 INFO - 'USER': 'cltbld', 16:50:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', 16:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:03 INFO - '_': '/tools/buildbot/bin/python'} 16:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:03 INFO - Running setup.py (path:/tmp/pip-DuvIAz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:03 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)) 16:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:03 INFO - Running setup.py (path:/tmp/pip-Ea8SSj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:03 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)) 16:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:03 INFO - Running setup.py (path:/tmp/pip-_YTGGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:03 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)) 16:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:03 INFO - Running setup.py (path:/tmp/pip-2hM8sa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:04 INFO - Running setup.py (path:/tmp/pip-8zJrWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:04 INFO - Running setup.py (path:/tmp/pip-6c_pqQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:04 INFO - Running setup.py (path:/tmp/pip-01avCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:04 INFO - Running setup.py (path:/tmp/pip-xQH3u4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:04 INFO - Running setup.py (path:/tmp/pip-ZmwVdf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:04 INFO - Running setup.py (path:/tmp/pip-Aka08B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:04 INFO - Running setup.py (path:/tmp/pip-Mggo5R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:04 INFO - Running setup.py (path:/tmp/pip-vYsChd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:04 INFO - Running setup.py (path:/tmp/pip-odsAKP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:04 INFO - Running setup.py (path:/tmp/pip-i3Csd4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:04 INFO - Running setup.py (path:/tmp/pip-WTwzDv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:04 INFO - Running setup.py (path:/tmp/pip-02mKT7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:04 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)) 16:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:04 INFO - Running setup.py (path:/tmp/pip-eZN2Yl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:05 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)) 16:50:05 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)) 16:50:05 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)) 16:50:05 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)) 16:50:05 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)) 16:50:05 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)) 16:50:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:06 INFO - Downloading blessings-1.5.1.tar.gz 16:50:06 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 16:50:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:50:06 INFO - Installing collected packages: blessings 16:50:06 INFO - Running setup.py install for blessings 16:50:06 INFO - Successfully installed blessings 16:50:06 INFO - Cleaning up... 16:50:06 INFO - Return code: 0 16:50:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:50:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:50:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:50:07 INFO - Reading from file tmpfile_stdout 16:50:07 INFO - Current package versions: 16:50:07 INFO - argparse == 1.2.1 16:50:07 INFO - blessings == 1.5.1 16:50:07 INFO - blobuploader == 1.2.4 16:50:07 INFO - docopt == 0.6.1 16:50:07 INFO - manifestparser == 1.1 16:50:07 INFO - mozInstall == 1.12 16:50:07 INFO - mozcrash == 0.16 16:50:07 INFO - mozdebug == 0.1 16:50:07 INFO - mozdevice == 0.47 16:50:07 INFO - mozfile == 1.2 16:50:07 INFO - mozhttpd == 0.7 16:50:07 INFO - mozinfo == 0.9 16:50:07 INFO - mozleak == 0.1 16:50:07 INFO - mozlog == 3.1 16:50:07 INFO - moznetwork == 0.27 16:50:07 INFO - mozprocess == 0.22 16:50:07 INFO - mozprofile == 0.28 16:50:07 INFO - mozrunner == 6.11 16:50:07 INFO - mozscreenshot == 0.1 16:50:07 INFO - mozsystemmonitor == 0.0 16:50:07 INFO - moztest == 0.7 16:50:07 INFO - mozversion == 1.4 16:50:07 INFO - psutil == 3.1.1 16:50:07 INFO - requests == 1.2.3 16:50:07 INFO - wsgiref == 0.1.2 16:50:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50:07 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')]} 16:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:07 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')]} 16:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:07 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 0x7fb9b8e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2840>, '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 0x1a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', '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 16:50:07 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 16:50:07 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 16:50:07 INFO - Using env: {'DISPLAY': ':0', 16:50:07 INFO - 'HOME': '/home/cltbld', 16:50:07 INFO - 'LANG': 'en_US.UTF-8', 16:50:07 INFO - 'LANGUAGE': 'en_US:en', 16:50:07 INFO - 'LOGNAME': 'cltbld', 16:50:07 INFO - 'MAIL': '/var/mail/cltbld', 16:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:07 INFO - 'MOZ_NO_REMOTE': '1', 16:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:07 INFO - 'NO_EM_RESTART': '1', 16:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:07 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:07 INFO - 'SHELL': '/bin/bash', 16:50:07 INFO - 'SHLVL': '1', 16:50:07 INFO - 'TERM': 'linux', 16:50:07 INFO - 'TMOUT': '86400', 16:50:07 INFO - 'USER': 'cltbld', 16:50:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', 16:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:07 INFO - '_': '/tools/buildbot/bin/python'} 16:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:07 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)) 16:50:07 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)) 16:50:07 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)) 16:50:07 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)) 16:50:07 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)) 16:50:07 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)) 16:50:07 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)) 16:50:07 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)) 16:50:07 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)) 16:50:07 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)) 16:50:07 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)) 16:50:07 INFO - Cleaning up... 16:50:07 INFO - Return code: 0 16:50:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:50:07 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')]} 16:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:07 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')]} 16:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:07 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 0x7fb9b8e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2840>, '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 0x1a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', '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 16:50:07 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 16:50:07 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 16:50:07 INFO - Using env: {'DISPLAY': ':0', 16:50:07 INFO - 'HOME': '/home/cltbld', 16:50:07 INFO - 'LANG': 'en_US.UTF-8', 16:50:07 INFO - 'LANGUAGE': 'en_US:en', 16:50:07 INFO - 'LOGNAME': 'cltbld', 16:50:07 INFO - 'MAIL': '/var/mail/cltbld', 16:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:07 INFO - 'MOZ_NO_REMOTE': '1', 16:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:07 INFO - 'NO_EM_RESTART': '1', 16:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:07 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:07 INFO - 'SHELL': '/bin/bash', 16:50:07 INFO - 'SHLVL': '1', 16:50:07 INFO - 'TERM': 'linux', 16:50:07 INFO - 'TMOUT': '86400', 16:50:07 INFO - 'USER': 'cltbld', 16:50:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', 16:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:07 INFO - '_': '/tools/buildbot/bin/python'} 16:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:07 INFO - Downloading/unpacking jsonschema 16:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:50:09 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 16:50:09 INFO - Downloading/unpacking functools32 (from jsonschema) 16:50:09 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 16:50:09 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 16:50:09 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 16:50:09 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 16:50:09 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 16:50:09 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 16:50:09 INFO - Downloading functools32-3.2.3-2.tar.gz 16:50:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:50:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:50:09 INFO - warning: no files found matching '*.txt' 16:50:09 INFO - no previously-included directories found matching 'build' 16:50:09 INFO - no previously-included directories found matching 'dist' 16:50:09 INFO - no previously-included directories found matching '.git*' 16:50:09 INFO - Installing collected packages: jsonschema, functools32 16:50:09 INFO - Running setup.py install for functools32 16:50:09 INFO - warning: no files found matching '*.txt' 16:50:09 INFO - no previously-included directories found matching 'build' 16:50:09 INFO - no previously-included directories found matching 'dist' 16:50:09 INFO - no previously-included directories found matching '.git*' 16:50:09 INFO - Successfully installed jsonschema functools32 16:50:09 INFO - Cleaning up... 16:50:09 INFO - Return code: 0 16:50:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:50:09 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')]} 16:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:09 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')]} 16:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:09 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 0x7fb9b8e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2840>, '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 0x1a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', '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 16:50:09 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 16:50:09 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 16:50:09 INFO - Using env: {'DISPLAY': ':0', 16:50:09 INFO - 'HOME': '/home/cltbld', 16:50:09 INFO - 'LANG': 'en_US.UTF-8', 16:50:09 INFO - 'LANGUAGE': 'en_US:en', 16:50:09 INFO - 'LOGNAME': 'cltbld', 16:50:09 INFO - 'MAIL': '/var/mail/cltbld', 16:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:09 INFO - 'MOZ_NO_REMOTE': '1', 16:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:09 INFO - 'NO_EM_RESTART': '1', 16:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:09 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:09 INFO - 'SHELL': '/bin/bash', 16:50:09 INFO - 'SHLVL': '1', 16:50:09 INFO - 'TERM': 'linux', 16:50:09 INFO - 'TMOUT': '86400', 16:50:09 INFO - 'USER': 'cltbld', 16:50:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', 16:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:09 INFO - '_': '/tools/buildbot/bin/python'} 16:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:10 INFO - Downloading/unpacking flake8 16:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:50:11 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 16:50:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:50:11 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 16:50:11 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 16:50:11 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 16:50:11 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 16:50:11 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 16:50:11 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 16:50:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:50:11 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 16:50:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:50:11 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 16:50:11 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 16:50:11 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 16:50:11 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 16:50:11 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 16:50:11 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 16:50:12 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 16:50:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:50:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:50:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:50:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:50:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:50:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:50:12 INFO - no previously-included directories found matching 'docs/_build' 16:50:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:50:12 INFO - Running setup.py install for pep8 16:50:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:50:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:50:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:50:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:50:12 INFO - no previously-included directories found matching 'docs/_build' 16:50:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:50:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:50:12 INFO - Cleaning up... 16:50:12 INFO - Return code: 0 16:50:12 INFO - Running post-action listener: _resource_record_post_action 16:50:12 INFO - Running post-action listener: _start_resource_monitoring 16:50:12 INFO - Starting resource monitoring. 16:50:12 INFO - ##### 16:50:12 INFO - ##### Running install step. 16:50:12 INFO - ##### 16:50:12 INFO - Running pre-action listener: _resource_record_pre_action 16:50:12 INFO - Running main action method: install 16:50:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:50:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:50:12 INFO - Reading from file tmpfile_stdout 16:50:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:50:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:50:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:50:13 INFO - Reading from file tmpfile_stdout 16:50:13 INFO - Output received: 16:50:13 INFO - Usage: mozinstall [options] installer 16:50:13 INFO - Options: 16:50:13 INFO - -h, --help show this help message and exit 16:50:13 INFO - -d DEST, --destination=DEST 16:50:13 INFO - Directory to install application into. [default: 16:50:13 INFO - "/builds/slave/test-pgo"] 16:50:13 INFO - --app=APP Application being installed. [default: firefox] 16:50:13 INFO - mkdir: /builds/slave/test-pgo/build/application 16:50:13 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'] 16:50:13 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 16:50:28 INFO - Reading from file tmpfile_stdout 16:50:28 INFO - Output received: 16:50:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:50:28 INFO - Running post-action listener: _resource_record_post_action 16:50:28 INFO - ##### 16:50:28 INFO - ##### Running run-tests step. 16:50:28 INFO - ##### 16:50:28 INFO - Running pre-action listener: _resource_record_pre_action 16:50:28 INFO - Running main action method: run_tests 16:50:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:50:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:50:28 INFO - Python 2.7.3 16:50:28 INFO - Return code: 0 16:50:28 INFO - grabbing minidump binary from tooltool 16:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:28 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 0x1ac2840>, '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 0x1a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:50:28 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 16:50:28 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 16:50:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:50:28 INFO - Return code: 0 16:50:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:50:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:50:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:50:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:50:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:50:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:50:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:50:29 INFO - Return code: 0 16:50:29 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/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 16:50:29 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/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 16:50:29 INFO - Using env: {'DISPLAY': ':0', 16:50:29 INFO - 'HOME': '/home/cltbld', 16:50:29 INFO - 'LANG': 'en_US.UTF-8', 16:50:29 INFO - 'LANGUAGE': 'en_US:en', 16:50:29 INFO - 'LOGNAME': 'cltbld', 16:50:29 INFO - 'MAIL': '/var/mail/cltbld', 16:50:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:50:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:29 INFO - 'MOZ_NO_REMOTE': '1', 16:50:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:29 INFO - 'NO_EM_RESTART': '1', 16:50:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:29 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:50:29 INFO - 'SHELL': '/bin/bash', 16:50:29 INFO - 'SHLVL': '1', 16:50:29 INFO - 'TERM': 'linux', 16:50:29 INFO - 'TMOUT': '86400', 16:50:29 INFO - 'USER': 'cltbld', 16:50:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953', 16:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:29 INFO - '_': '/tools/buildbot/bin/python'} 16:50:29 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/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:50:30 INFO - mozversion application_buildid: 20160105143019 16:50:30 INFO - mozversion application_changeset: c342816f76c048db725e4c44e64bb3cfdcde7aa9 16:50:30 INFO - mozversion application_display_name: Nightly 16:50:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:50:30 INFO - mozversion application_name: Firefox 16:50:30 INFO - mozversion application_remotingname: firefox 16:50:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:50:30 INFO - mozversion application_vendor: Mozilla 16:50:30 INFO - mozversion application_version: 46.0a1 16:50:30 INFO - mozversion platform_buildid: 20160105143019 16:50:30 INFO - mozversion platform_changeset: c342816f76c048db725e4c44e64bb3cfdcde7aa9 16:50:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:50:30 INFO - mozversion platform_version: 46.0a1 16:50:30 INFO - using testdate: 1452041430 16:50:30 INFO - actual date: 1452041430 16:50:30 INFO - starting webserver on 'localhost:39526' 16:50:30 INFO - SUITE-START | Running 3 tests 16:50:30 INFO - TEST-START | dromaeo_css 16:50:30 INFO - operating with platform_type : linux_ 16:50:30 INFO - Initialising browser for dromaeo_css test... 16:50:30 INFO - TEST-INFO | started process 26223 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw1bxUy/profile http://localhost:39526/getInfo.html) 16:50:34 INFO - PROCESS | 26223 | __metrics Screen width/height:1600/1200 16:50:34 INFO - PROCESS | 26223 | colorDepth:24 16:50:34 INFO - PROCESS | 26223 | Browser inner width/height: 1024/697 16:50:34 INFO - PROCESS | 26223 | __metrics 16:50:34 INFO - PROCESS | 26223 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:50:34 INFO - PROCESS | 26223 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:50:35 INFO - TEST-INFO | 26223: exit 0 16:50:35 INFO - Browser initialized. 16:50:35 INFO - Running cycle 1/1 for dromaeo_css test... 16:50:35 INFO - TEST-INFO | started process 26317 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw1bxUy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:47 INFO - PROCESS | 26317 | RSS: Main: 149991424 16:50:47 INFO - PROCESS | 26317 | 16:51:38 INFO - PROCESS | 26317 | 1452041498646 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] 16:53:47 INFO - PROCESS | 26317 | Cycle 1(1): loaded http://localhost:39526/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39526/tests/dromaeo/cssquery-ext.html) 16:53:48 INFO - PROCESS | 26317 | RSS: Main: 271077376 16:53:48 INFO - PROCESS | 26317 | 16:56:51 INFO - PROCESS | 26317 | Cycle 1(1): loaded http://localhost:39526/tests/dromaeo/cssquery-ext.html (next: http://localhost:39526/tests/dromaeo/cssquery-jquery.html) 16:56:51 INFO - PROCESS | 26317 | RSS: Main: 241250304 16:56:51 INFO - PROCESS | 26317 | 16:59:53 INFO - PROCESS | 26317 | Cycle 1(1): loaded http://localhost:39526/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39526/tests/dromaeo/cssquery-mootools.html) 16:59:54 INFO - PROCESS | 26317 | RSS: Main: 232165376 16:59:54 INFO - PROCESS | 26317 | 17:02:56 INFO - PROCESS | 26317 | Cycle 1(1): loaded http://localhost:39526/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39526/tests/dromaeo/cssquery-prototype.html) 17:02:56 INFO - PROCESS | 26317 | RSS: Main: 215777280 17:02:56 INFO - PROCESS | 26317 | 17:05:59 INFO - PROCESS | 26317 | Cycle 1(1): loaded http://localhost:39526/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39526/tests/dromaeo/cssquery-yui.html) 17:05:59 INFO - PROCESS | 26317 | RSS: Main: 219889664 17:05:59 INFO - PROCESS | 26317 | 17:09:02 INFO - PROCESS | 26317 | Cycle 1(1): loaded http://localhost:39526/tests/dromaeo/cssquery-yui.html (next: http://localhost:39526/tests/dromaeo/cssquery-dojo.html) 17:09:02 INFO - PROCESS | 26317 | RSS: Main: 275218432 17:09:02 INFO - PROCESS | 26317 | 17:09:02 INFO - PROCESS | 26317 | __start_tp_report 17:09:02 INFO - PROCESS | 26317 | _x_x_mozilla_page_load 17:09:02 INFO - PROCESS | 26317 | _x_x_mozilla_page_load_details 17:09:02 INFO - PROCESS | 26317 | |i|pagename|runs| 17:09:02 INFO - PROCESS | 26317 | |0;dojo.html;3069.0946170879597;3110.7355874750647;3156.9210769730753;3159.652438231794;3176.301213732978;5099.694018358892;5211.45279745627;5231.319928409306;5236.266922630834;5264.710440925747;5140.485951404867;5165.896682066356;5176.974115129419;5209.791608335662;5241.790328386869;4587.678862479611;4734;4759.190937540618;4824.879378015543;4834.419869615651;4733.219018861883;4795.736234507101;4835.274708793674;4851.854444366657;4899.706017638935;4689.390379250693;4779.139754844126;4783.067301876135;4802.687825291345;4806.327114204014;4756.7145971241835;4760.904781904343;4789.066132104241;4789.880252993668;4821.807127714887;4661.95338046622;4745.074710431467;4755.048990201939;4759.143354196243;4815.711057336571;5011.098002359574;5026.79892804291;5045.84862454127;5046.369203849519;5064.316317297192;5539.612227144102;5540.584456165763;5540.695261760601;5540.750666220029;5542.944570554324;5574.526165275956;5588.161775733673;5588.692621905793;5669.801556945487;5782.710864456761;5254;5297.152455607123;5308.177232528964;5332.3601167859715;5359.624826262163;5736.082226843685;5757.683327417032;5779.682117483495;5783.103618939072;5789.507891829157;5349.438308977579;5476.151196564539;5511.696856672921;5543.501084902378;5547.611667183259;5636.351819540723;5643.887122257614;5647.915281270784;5651.858703532444;5686.2323586315315;5582.7766889324785;5600.299962504687;5601.327840659147;5610.354809196913;5617.101263797773;5448.645838020516;5560.249366335493;5581.023320918823;5589.413111623302;5596.2165296858475;4322.416473776063;4352.129574085196;4378.6278166356215;4386.1008493258805;4410.669199810027;3878.9612103879163;3884.0095775577047;3889.2221555688975;3912.667423268997;3914.432407300925;5143.434222235551;5224.216367544898;5225.608079394061;5249.658772179796;5279.9208011879855;5559.63862348946;5594.692291923983;5632.436756324417;5641.984442800253;5671.546276297886;5182.404023537341;5194.378481712165;5195.766190521435;5198.220266959911;5199.29809475716;4614.653900957442;4694.319323698045;4798.4001999750035;4802.447718512416;4846;5755.827325180251;5811.651300921958;5823.534117270524;5823.82528524145;5863.120531920246;5605.635633683797;5607.186957891165;5609.915851262316;5617.157426386075;5618.971905140448;5614.410486898817;5721.599488035798;5761.596688231783;5810.244668193108;5812.883742325214;5526.861828454321;5556.583256255716;5584.776608935597;5585.106382978866;5639.464250896158;5621.4659607337235;5659.094544872801;5670.914936275876;5671.943280567307;5676;5374.57003439716;5467.863303417446;5538.556915446835;5554.944450555605;5555.527780138734;5480.890382192254;5552.472515111058;5554.055810512304;5597.916031259616;5610.691411972381;5408.4321146280645;5411.080116380146;5417.377001644862;5444.8094316698725;5451.20957461158;5328.520433161034;5358.839234822962;5499.092649712913;5526.50261476469;5565.471280228372;5329.467053294639;5397.649152805055;5398.244245805512;5410.83767486976;5437.510624043855 17:09:02 INFO - PROCESS | 26317 | |1;ext.html;528.1391332128629;534.9224362467445;536.110057304874;550.7714298566095;581.5696384675339;27483.450330993393;28185.15444536662;35258.823705881434;35742.64257357426;35882.46176307351;38255.61744382562;38728.612713872855;38744.80627596865;38754.224915501676;38959;7391.6304184790815;8490.363222758288;8664.39349245553;8679.17547832955;8685.565721713921;7440.516366436164;10109.443980581065;10289.3311934724;10336.483175841215;10338.121259692934;10039.247056470758;10068.647597334095;10082.596696132183;10093.596256149745;10116.089551940324;7536.510126841793;7666.233376662345;10032.448215348153;10151.086402223762;10157.796844063114;9905;10005.59977600895;10026.899731002743;10029.749256268578;10030.949845250727;33027.174320641934;33371.332573348394;33389.83305083483;33415.498767518504;33535.49696754551;3176.698213669698;3196.744260459158;3212.8714851405916;3252.463343548335;3576.7675101118343;28027.719722802714;29536.704632953824;29803.403931921457;29838.55242171369;30642.080737577908;4011.859584914543;4019;4035.8385664573384;4100.077482566428;4158.4178215049915;202904;203696;204324;204485.99999999852;205351;49073.50926490761;50951;56722.43277567254;57421.71289143527;57549.13676294859;52186.21720674193;52353.476465235624;52413.213801793005;52688.20967685488;52731.20903186455;14501.274936253145;14690.632734181518;14726.852731472549;14947.775783363259;14993.400263989319;10695.465226738788;10846.078083363003;10871.945640271748;10887.510062047228;10919.617813376493;19042.238310467426;19153.233870645017;19289.228430862608;19292.517687057934;19295.614087718168;7548.886766698504;7810.765677029698;7814.179511151247;7926.920730792734;7929.207079292025;948.5636607160783;952.5284983932997;1014.4521958142668;1027.4503140819625;1061.9804987212362;25090.372740681265;25287.36781580475;25393.746062539507;29557.556636650468;30341.24146896301;925.379995403068;1006.713086770267;1008.2992320337441;1073.5920350267004;1078.6710053433778;15529.22353882324;15646.843531564538;15709.528714138594;15766.68466630661;16093;362866;367673;368824;369134;370058;50735;50842;50944.490555094715;51165.48834511681;51201.487985119675;1327.4955516903515;1336.2917653643585;1338.9866101338862;1341.6511706956262;1342.4026308292912;24159.4739821814;27892;29649.517813023616;30354.241143971576;30586.84706576453;45659;46224.53775462337;46543.301850471595;46546.34536546318;46550.53449465462;226156;226741;227062;227745;227773;26804.19587412381;29683.257918551346;29881.402371952874;30044;30090;35417;38800.41799373068;39129.02177445587;39392;39574.60425395824;32042.839785800923;32635.34729305448;32682.509762353107;33026.66973330332;33313.333733325686;33054.17364565905;33085.33829323448;33728.83135584404;33855.492167617995;33989.49015764716;32548.51177232296;33026.66973330332;33048.33903321872;33331;33471.83264083664;29227.269318266364;29909.551356729233;30179.09462716122;30480.390392192476;30626.387472249986;21540.676889846352;22120.557588847812;22183.667244991662;22200.66698999484;22302.773347466045 17:09:02 INFO - PROCESS | 26317 | |2;jquery.html;361.72870347239586;363.0397598352357;365.3113880335567;366.47593940664854;367.5699431664952;13120.163177155182;13397.397117129729;16111.113888736114;16203.594910127253;16737.33050677973;15923.84076159238;15952.84047159528;16025.358985640589;16072.839271607281;16122.516324510283;5091.083604951116;5398.4871437213405;5399.19012148179;5405.162199859028;5407.053765591006;4002.919941601166;4116.279651061067;5357.1696387060065;5884.117382392633;6017.277926648809;5897.203877476529;5929.88140237195;5935.436133567304;5961.344252132262;5964.194833697438;5779.422057794229;5922.940770592282;5932.228810254661;5932.3474417814;5932.525397968152;5137.691738495665;5181.896362072775;5213.139831927728;5219.817306394258;5250.921236181461;20727.170913163456;20745.481362965897;21183.68224476634;21322.253721119687;21380.57238855214;2076.8546201765885;2168.8590241634242;2248.4491299631695;2452.828302018859;2501.0072672466545;12390.504379824797;12543.184692994926;12628;12733.42699578512;13067.673308167277;1674.7069262878947;1682.966340673192;1686.8228835972168;1705.3263960735565;1722.9913850430794;59211.703941480446;59566.40433595652;59681.40318596802;62310.06534901935;63558;9660.227181825438;9851.75370615726;9877.851832222523;9908.80182396348;9956.601735930626;13204.867951320555;13210.27343496117;13216.537421190213;13224.338783060808;13258.403371848097;7353.007344008597;7372.483926125227;7416.3683989522215;7436.293552112541;7511.962440187874;7064.788056358318;7177.605231712306;7492.138404083491;7528.661210245552;7574.962125189449;5852.619579727304;5938;5945.881082378328;6012.939870601238;6118.969405152946;1680.949571512832;1736.4182998695326;1782.875198736076;1790.0691640346947;1808.1953530678722;428.87133859842544;839.2195258409615;961.0437614573405;965.0928127560211;973.1873885305707;9276.25789936817;10041.548130334153;10538.367697938149;10697.893021069689;11106.222564420576;437.02107279693894;438.82008376565454;446.46201327400405;448.8002838736731;449.73240921651563;5867.970660146672;9283.814323713488;9869.75325616851;9878.110970012733;9919.206463482904;532650.5257717617;536287;537572;540769;550529;39311.01722456904;42457.51398701031;42495.15009699789;73067.2693273071;75407;1143.1369316166242;1149.98275025873;1158.4960542164017;1188.2217147768226;1191.2614179208947;14689.706205876037;15303.770443443134;15325.233738313264;15548.300326485109;15623.921880390526;33734.83132584419;33862;33888.66111338855;34191.14522136966;34418.139546511535;45527.544724553656;46767.532324676315;46787.29819052785;46969;47380;8807.823843523222;8914.0194578595;8923.241524470493;8960.68637597681;9035.186833185046;16875.662486750443;17228.310867565157;17251.309947601956;17518.91240543789;17583.560410989827;13260.801087983495;13497.39261733244;13499.055066145276;13862.65343366424;14641.63395915068;10345;13966.720665586428;14054.227017514135;14504.782428263374;14567.490137845125;13622.046456747932;13977.650558736113;14139.151650900978;14506.564803055926;14694.77957830612;9314.25485961135;9401;9438.48088355147;9574.712758617252;9746.610135594497;10071.295009349275;10174.186065114922;12021.218620789621;13781.448742050206;14132.222727750073 17:09:02 INFO - PROCESS | 26317 | |3;mootools.html;1322.4644019172226;1462.2104063805543;1465.54568083894;1612.9596760080997;1787.1153778879457;6517.446017088547;7082.610456424894;7130.500864939457;7146.963690264908;7153.499255052136;7059.7882063538045;7141.285871412856;7153.427725781938;7155.24869888662;7261.891071633917;1912.9904350478228;1932.8743631663897;2173.956520869586;2199.4611320226486;2210.613142700029;2236.865788052722;2247.325802259324;2250.22367283287;2252.031626400647;2253.8873056347197;2155.8059774620283;2252.4481502031945;2253.267688001406;2253.8084262837597;2255.5150642611834;2201.6587428948537;2204.526026904215;2227.6213043782514;2244.921427750021;2249.044156233594;2265.048679554591;2265.3090807303765;2297.7012988311412;2301.102569997702;2321.9187328443422;7433.070866141732;7490.176080631126;7520.210377910295;7520.5487670739385;7521;4452.265376212921;4524.932126018112;4541.500434952152;4541.591256786872;4544.8865028068;3006.7143621356154;3017.8792848286043;3031.9545206821917;3035.362573859492;3172.6351469581064;1009.4145395670566;1015.8831734350497;1026.2969865641985;1051.658211081394;1072.635303996637;10466.63366782159;10479.63321283759;10516.631917882914;10532.26274160809;10549;4150.979245103756;4232.217039847638;4277.615014648696;4284.421603083606;4289.03496713237;8897.199252067345;8900.554972251362;8901.910980890238;8905;8914.37599368038;4646.09401166776;4676.883077923011;4708.246680531099;4709.270063140219;4714.269288260325;4208.810603522848;4212.052288235122;4256.042390462183;4260.25445547028;4262;3341.74936879735;3391.2030672791875;3527.5237842891393;3554.449060395643;3614.746967712235;1144.7710457908452;1172.7302720374362;1175.2008634128874;1177.7585594953014;1180.9586664466703;988.6786794291884;989.1542730965065;1054.2409465185056;1096.6052221200362;1289.2200218867638;6664.900026499607;6666.899996500057;6671.132752742113;6678.53250272486;6690.264070952191;1087.782443511301;1098.3849044535086;1106.419129956763;1123.5112725964232;1128.328644456547;5606.383297837235;5690.0895856663565;5708.80019199326;5711.828645140569;5715.942840571624;8610.182032706884;9064.320175986695;9229.307801914883;9238.538073096319;9245.72262832116;8976.281897448189;9144.54277286133;9159.816803663889;9160.083991600786;9160.312976526788;6885;6964.373206411548;7059.470539709542;7064.32888875556;7064.364207221375;7045.506814522934;7114.14630244374;7125.714971401293;7131.643417829192;7136.250693677089;7895.881561776463;8027.157148499324;8041.477303975223;8136.918630813616;8220.712275070344;8186.222308880647;8226.42415030966;8380.748577542683;8406.369522285731;8421.62102705392;7121.857562848818;7330.413566914527;7351.963240183765;7352.926470735224;7360.668769905475;6586.50601204902;6703.832404189934;7128.893066604109;7253.310935461122;7258.528195667264;6514.54398192122;6674.699638516181;6799.762008329685;6915.827104322432;7005.614691192033;6696.732130714911;6727.562708423937;6756.155480564929;6845.247022827385;7024.789256322319;6547.672616369257;6608.4382827458285;6614.437772789367;6627.900581491378;6659.966700166468;6303.928332183448;6402.423781859468;6441.323661015525;6446.4520515756685;6478.935210647834;6238.376162383725;6264.342244064308;6294.937050629618;6303.991361382157;6308.779192728416 17:09:02 INFO - PROCESS | 26317 | |4;prototype.html;341.0739841330786;343.71986830732965;344.89997900608824;345.2663090931771;351.3166890398175;5767.33675627303;5863.912041319379;5883.676397798114;5898.764049438023;5914;5696.943030569693;5812.534997200224;5815.47660710536;5840;5846.619969701977;4551;4553.27147656375;4555.544445555451;4555.954440455586;4567.840125595605;4349.325854492558;4428.6014258716705;4430.7784610769495;4436.55634436557;4572.542745725417;4466.82132714691;4479.776011199443;4491.528389519102;4492.932606010912;4498.190325741365;4460.732356058615;4481.753503557303;4486.259767138418;4486.304622783474;4487.237169681162;4001.4998125234347;4004.0590461241586;4006.719529632927;4011.458453108822;4017.6384125428854;5435.891282174374;5559.527440167591;5569.526590239794;5592.552595792326;5640.097584386478;5232.973835130838;5233.895322093575;5240.4759524047295;5241.9213711794355;5252.658577192508;5904.675242861641;6210.130581718563;6260.686965651745;6271.623702577815;6279.686015699197;4244.214820258262;4249.957500424987;4298.46269216348;4302.290122129845;4304.246756817544;6363.7772677956045;6487.481001519867;6496.317886621884;6517.804465866032;6522.315156908551;4460.687751857404;4466.486354069259;4471.463424389029;4473.5526447355005;4475.597196252353;4363.47638283408;4502.392177056121;4521.706089104197;4528.88677783058;4529.184746745617;5161.3032240647035;5165.1219292720325;5171.50870667286;5175.378954525481;5231.8168864089575;6263.906041409383;6274;6274.090256912722;6278.089676996809;6287.622742635456;1581.3121292237913;1602.9358825647078;1603.4628399486069;1603.9679206415806;1606.8875178737376;1070.8982646648556;1073.9248252622397;1079.4980334144661;1095.4686976816238;1102.459794700591;5926.081457374114;5931.822045338647;5937.198478205473;5944.7027648617395;5955.34491205967;6337.366263373718;6495.610263384212;6500.219973603198;6508.8047358579315;6512.609243445314;5865.912011319833;5876.08920617305;5887.528997680175;5888.4700376966275;5891.263592050994;3398.4562470005176;3480.164760457472;3487.633798451177;3487.7035451986358;3489.2323688788424;6679.899801502981;6686.331366863372;6689;6689.76585819494;6695.096162018162;6605.900911486331;6691;6709.29552397001;6715.932840671629;6734.8989765153565;6535.607863528108;6726.630035348103;6757.425618822357;6765.35729105744;6777.6272305023695;6266.185395898504;6382.393672601095;6480.351964803671;6489.448396886318;6499.935000649933;6282.591631543935;6361.713722882574;6384.904226436514;6394.680265986589;6461.515386345949;6754.324567543206;6755.527113102035;6756.8648627026205;6764.289749576224;6770.221424536241;4471.217536930959;4558.88602784933;4603;4606.401167848292;4612.838550650711;6480.513961452815;6481.0926470295135;6485.513586481127;6497.610143391412;6498.187726534184;6292.276388215414;6293.087502312231;6302.936970630235;6307.779227727007;6311.589746666452;6198.318184999736;6266.060090986389;6266.122742816101;6292.842678933063;6299.181106456132;6165.660888651168;6167.229096362955;6173.753049878134;6177.752889884354;6179.876402471836;6271.059341098871;6290.49676025926;6299.803037422875;6314.55798094129;6325.430711236011;6068.332483426908;6154.076888466587;6165.445109940127;6176.289726681489;6178.783742568989 17:09:02 INFO - PROCESS | 26317 | |5;yui.html;652.6704014472691;683.8529716111038;737.6311844077961;830.6262182018094;842.1914961636828;13181.670458238548;13508.257045862474;13614.183149011067;13629.795553066688;13641.795373069386;11928.403579820995;12697.682557936056;12807.551735689252;13785.586432407019;13845.376958036888;815.592203898051;821.2444551013082;827.3381294964034;828.2752591482453;828.6395417993192;815.759350991459;824.5135370131621;824.7608193623842;825.0182283083142;826.89663792026;854.7435769269225;858.8797568340437;861.7414775567336;861.8922634670666;862.8662557303596;857.185673610073;857.9270761985239;859.0507489224411;859.2309882654989;860.1613426908746;628.8930881750114;632.601461079517;633.1737083106544;634.2484156274783;634.7302396481523;12885.742285154338;12892.162009469355;12930.806037909439;13034.869651303556;13040.739185216242;11911.166218364719;11939.403029848472;12114.273143611412;12168.634940951786;12351.629451116482;9684.515774211332;10135.341202821794;10208.948955255251;10410.68767936963;10487.528061237263;3523.8547472071423;3556.1643013891717;3590.605033446319;3600.369935261319;3626.057225121461;43414.782926085165;44041;45835.31247031297;46460.30309545359;46770.76614616939;8913.55432228386;8922.330825188137;8962.86555701665;9086.909130908738;9261.861072083924;16974.40589579359;17176.22706978189;17205;17205.483835484705;17216.569585760455;7121.252268511836;7233.348998590152;7305.5981920994855;7415.666295016737;7443.813904652427;4046.7576672920077;4154.459920210354;4209;4225.260579398593;4252.85115020979;3043.8478076096108;3084.552739852754;3089.1041597936796;3089.6137982752157;3092.1187461573345;531.5641174237165;552.5745176214292;556.1074475466818;558.6536347464598;566.4901588570237;473.673165515793;505.01774049474153;550.1170621153071;568.1931657047003;677.3303806117943;7915.683372665144;8256.25693687571;8498.235158835734;8645.30069853476;8687.52218627969;651.9902201466982;652.8139480248107;662.4766434516678;673.5655502201053;689.1454596300551;3633.72886486914;3951.328274193394;3990.86031988879;4009.298372784751;4123.958760412417;57522.7123864378;59363;59793;59822.70088649529;59834.70082649559;50385.49614503808;50741.746291268304;51509.48490515122;52011.73994130005;52136.43590692285;43417;47205.76397117993;51156;52300.476995230325;52858.735706321226;8479.69660623029;8569.185927336894;8600.053994060774;8614.3108551317;8797.067644118699;34957.47563786596;35552.28895422129;36121.45817812682;36123;36451.45322820107;41786;42289;46045;46247;46289.305660414444;9725.319227653996;10654.62708805188;10737.46312684347;10943.562257509611;11051.613193538187;11401.258918170292;11720.88279117198;11731.648050558497;11965.461554230254;12182.634520964386;10004.649837255662;10225;10572.154227661922;10595.364278143335;10671.039606435457;10240.385576865114;10452.163826893982;10957.287776294515;10988.505517251902;11028.062614677843;10557.683269501927;10779.946100269448;10843.837342439712;11014.44927753593;11045.835475450249;9486.241100712065;9600.85598716006;9771.511424428892;9919.65281215154;10073.294869359075;8630.654773808978;9472.194863436409;9668.419894806335;9834.803303934024;9887.653932112342 17:09:02 INFO - PROCESS | 26317 | __end_tp_report 17:09:02 INFO - PROCESS | 26317 | __start_cc_report 17:09:02 INFO - PROCESS | 26317 | _x_x_mozilla_cycle_collect,995 17:09:02 INFO - PROCESS | 26317 | __end_cc_report 17:09:02 INFO - PROCESS | 26317 | __startTimestamp1452042542692__endTimestamp 17:09:02 INFO - PROCESS | 26317 | 17:09:02 INFO - PROCESS | 26317 | ------- Summary: start ------- 17:09:02 INFO - PROCESS | 26317 | Number of tests: 6 17:09:02 INFO - PROCESS | 26317 | 17:09:02 INFO - PROCESS | 26317 | [#0] dojo.html Cycles:165 Average:5206.10 Median:5408.43 stddev:574.80 (10.6%) stddev-sans-first:551.58 17:09:02 INFO - PROCESS | 26317 | Values: 3069.1 3110.7 3156.9 3159.7 3176.3 5099.7 5211.5 5231.3 5236.3 5264.7 5140.5 5165.9 5177.0 5209.8 5241.8 4587.7 4734.0 4759.2 4824.9 4834.4 4733.2 4795.7 4835.3 4851.9 4899.7 4689.4 4779.1 4783.1 4802.7 4806.3 4756.7 4760.9 4789.1 4789.9 4821.8 4662.0 4745.1 4755.0 4759.1 4815.7 5011.1 5026.8 5045.8 5046.4 5064.3 5539.6 5540.6 5540.7 5540.8 5542.9 5574.5 5588.2 5588.7 5669.8 5782.7 5254.0 5297.2 5308.2 5332.4 5359.6 5736.1 5757.7 5779.7 5783.1 5789.5 5349.4 5476.2 5511.7 5543.5 5547.6 5636.4 5643.9 5647.9 5651.9 5686.2 5582.8 5600.3 5601.3 5610.4 5617.1 5448.6 5560.2 5581.0 5589.4 5596.2 4322.4 4352.1 4378.6 4386.1 4410.7 3879.0 3884.0 3889.2 3912.7 3914.4 5143.4 5224.2 5225.6 5249.7 5279.9 5559.6 5594.7 5632.4 5642.0 5671.5 5182.4 5194.4 5195.8 5198.2 5199.3 4614.7 4694.3 4798.4 4802.4 4846.0 5755.8 5811.7 5823.5 5823.8 5863.1 5605.6 5607.2 5609.9 5617.2 5619.0 5614.4 5721.6 5761.6 5810.2 5812.9 5526.9 5556.6 5584.8 5585.1 5639.5 5621.5 5659.1 5670.9 5671.9 5676.0 5374.6 5467.9 5538.6 5554.9 5555.5 5480.9 5552.5 5554.1 5597.9 5610.7 5408.4 5411.1 5417.4 5444.8 5451.2 5328.5 5358.8 5499.1 5526.5 5565.5 5329.5 5397.6 5398.2 5410.8 5437.5 17:09:02 INFO - PROCESS | 26317 | 17:09:02 INFO - PROCESS | 26317 | [#1] ext.html Cycles:180 Average:42750.95 Median:3186.72 stddev:72423.67 (2272.7%) stddev-sans-first:72557.45 17:09:02 INFO - PROCESS | 26317 | Values: 528.1 534.9 536.1 550.8 581.6 27483.5 28185.2 35258.8 35742.6 35882.5 38255.6 38728.6 38744.8 38754.2 38959.0 7391.6 8490.4 8664.4 8679.2 8685.6 7440.5 10109.4 10289.3 10336.5 10338.1 10039.2 10068.6 10082.6 10093.6 10116.1 7536.5 7666.2 10032.4 10151.1 10157.8 9905.0 10005.6 10026.9 10029.7 10030.9 33027.2 33371.3 33389.8 33415.5 33535.5 3176.7 3196.7 3212.9 3252.5 3576.8 28027.7 29536.7 29803.4 29838.6 30642.1 4011.9 4019.0 4035.8 4100.1 4158.4 202904.0 203696.0 204324.0 204486.0 205351.0 49073.5 50951.0 56722.4 57421.7 57549.1 52186.2 52353.5 52413.2 52688.2 52731.2 14501.3 14690.6 14726.9 14947.8 14993.4 10695.5 10846.1 10871.9 10887.5 10919.6 19042.2 19153.2 19289.2 19292.5 19295.6 7548.9 7810.8 7814.2 7926.9 7929.2 948.6 952.5 1014.5 1027.5 1062.0 25090.4 25287.4 25393.7 29557.6 30341.2 925.4 1006.7 1008.3 1073.6 1078.7 15529.2 15646.8 15709.5 15766.7 16093.0 362866.0 367673.0 368824.0 369134.0 370058.0 50735.0 50842.0 50944.5 51165.5 51201.5 1327.5 1336.3 1339.0 1341.7 1342.4 24159.5 27892.0 29649.5 30354.2 30586.8 45659.0 46224.5 46543.3 46546.3 46550.5 226156.0 226741.0 227062.0 227745.0 227773.0 26804.2 29683.3 29881.4 30044.0 30090.0 35417.0 38800.4 39129.0 39392.0 39574.6 32042.8 32635.3 32682.5 33026.7 33313.3 33054.2 33085.3 33728.8 33855.5 33989.5 32548.5 33026.7 33048.3 33331.0 33471.8 29227.3 29909.6 30179.1 30480.4 30626.4 21540.7 22120.6 22183.7 22200.7 22302.8 17:09:02 INFO - PROCESS | 26317 | 17:09:02 INFO - PROCESS | 26317 | [#2] jquery.html Cycles:180 Average:27893.62 Median:4059.60 stddev:87919.04 (2165.7%) stddev-sans-first:88141.37 17:09:02 INFO - PROCESS | 26317 | Values: 361.7 363.0 365.3 366.5 367.6 13120.2 13397.4 16111.1 16203.6 16737.3 15923.8 15952.8 16025.4 16072.8 16122.5 5091.1 5398.5 5399.2 5405.2 5407.1 4002.9 4116.3 5357.2 5884.1 6017.3 5897.2 5929.9 5935.4 5961.3 5964.2 5779.4 5922.9 5932.2 5932.3 5932.5 5137.7 5181.9 5213.1 5219.8 5250.9 20727.2 20745.5 21183.7 21322.3 21380.6 2076.9 2168.9 2248.4 2452.8 2501.0 12390.5 12543.2 12628.0 12733.4 13067.7 1674.7 1683.0 1686.8 1705.3 1723.0 59211.7 59566.4 59681.4 62310.1 63558.0 9660.2 9851.8 9877.9 9908.8 9956.6 13204.9 13210.3 13216.5 13224.3 13258.4 7353.0 7372.5 7416.4 7436.3 7512.0 7064.8 7177.6 7492.1 7528.7 7575.0 5852.6 5938.0 5945.9 6012.9 6119.0 1680.9 1736.4 1782.9 1790.1 1808.2 428.9 839.2 961.0 965.1 973.2 9276.3 10041.5 10538.4 10697.9 11106.2 437.0 438.8 446.5 448.8 449.7 5868.0 9283.8 9869.8 9878.1 9919.2 532650.5 536287.0 537572.0 540769.0 550529.0 39311.0 42457.5 42495.2 73067.3 75407.0 1143.1 1150.0 1158.5 1188.2 1191.3 14689.7 15303.8 15325.2 15548.3 15623.9 33734.8 33862.0 33888.7 34191.1 34418.1 45527.5 46767.5 46787.3 46969.0 47380.0 8807.8 8914.0 8923.2 8960.7 9035.2 16875.7 17228.3 17251.3 17518.9 17583.6 13260.8 13497.4 13499.1 13862.7 14641.6 10345.0 13966.7 14054.2 14504.8 14567.5 13622.0 13977.7 14139.2 14506.6 14694.8 9314.3 9401.0 9438.5 9574.7 9746.6 10071.3 10174.2 12021.2 13781.4 14132.2 17:09:02 INFO - PROCESS | 26317 | 17:09:02 INFO - PROCESS | 26317 | [#3] mootools.html Cycles:180 Average:5293.77 Median:6299.43 stddev:2719.29 (43.2%) stddev-sans-first:2710.53 17:09:02 INFO - PROCESS | 26317 | Values: 1322.5 1462.2 1465.5 1613.0 1787.1 6517.4 7082.6 7130.5 7147.0 7153.5 7059.8 7141.3 7153.4 7155.2 7261.9 1913.0 1932.9 2174.0 2199.5 2210.6 2236.9 2247.3 2250.2 2252.0 2253.9 2155.8 2252.4 2253.3 2253.8 2255.5 2201.7 2204.5 2227.6 2244.9 2249.0 2265.0 2265.3 2297.7 2301.1 2321.9 7433.1 7490.2 7520.2 7520.5 7521.0 4452.3 4524.9 4541.5 4541.6 4544.9 3006.7 3017.9 3032.0 3035.4 3172.6 1009.4 1015.9 1026.3 1051.7 1072.6 10466.6 10479.6 10516.6 10532.3 10549.0 4151.0 4232.2 4277.6 4284.4 4289.0 8897.2 8900.6 8901.9 8905.0 8914.4 4646.1 4676.9 4708.2 4709.3 4714.3 4208.8 4212.1 4256.0 4260.3 4262.0 3341.7 3391.2 3527.5 3554.4 3614.7 1144.8 1172.7 1175.2 1177.8 1181.0 988.7 989.2 1054.2 1096.6 1289.2 6664.9 6666.9 6671.1 6678.5 6690.3 1087.8 1098.4 1106.4 1123.5 1128.3 5606.4 5690.1 5708.8 5711.8 5715.9 8610.2 9064.3 9229.3 9238.5 9245.7 8976.3 9144.5 9159.8 9160.1 9160.3 6885.0 6964.4 7059.5 7064.3 7064.4 7045.5 7114.1 7125.7 7131.6 7136.3 7895.9 8027.2 8041.5 8136.9 8220.7 8186.2 8226.4 8380.7 8406.4 8421.6 7121.9 7330.4 7352.0 7352.9 7360.7 6586.5 6703.8 7128.9 7253.3 7258.5 6514.5 6674.7 6799.8 6915.8 7005.6 6696.7 6727.6 6756.2 6845.2 7024.8 6547.7 6608.4 6614.4 6627.9 6660.0 6303.9 6402.4 6441.3 6446.5 6478.9 6238.4 6264.3 6294.9 6304.0 6308.8 17:09:02 INFO - PROCESS | 26317 | 17:09:02 INFO - PROCESS | 26317 | [#4] prototype.html Cycles:180 Average:5235.84 Median:5888.00 stddev:1573.57 (26.7%) stddev-sans-first:1534.50 17:09:02 INFO - PROCESS | 26317 | Values: 341.1 343.7 344.9 345.3 351.3 5767.3 5863.9 5883.7 5898.8 5914.0 5696.9 5812.5 5815.5 5840.0 5846.6 4551.0 4553.3 4555.5 4556.0 4567.8 4349.3 4428.6 4430.8 4436.6 4572.5 4466.8 4479.8 4491.5 4492.9 4498.2 4460.7 4481.8 4486.3 4486.3 4487.2 4001.5 4004.1 4006.7 4011.5 4017.6 5435.9 5559.5 5569.5 5592.6 5640.1 5233.0 5233.9 5240.5 5241.9 5252.7 5904.7 6210.1 6260.7 6271.6 6279.7 4244.2 4250.0 4298.5 4302.3 4304.2 6363.8 6487.5 6496.3 6517.8 6522.3 4460.7 4466.5 4471.5 4473.6 4475.6 4363.5 4502.4 4521.7 4528.9 4529.2 5161.3 5165.1 5171.5 5175.4 5231.8 6263.9 6274.0 6274.1 6278.1 6287.6 1581.3 1602.9 1603.5 1604.0 1606.9 1070.9 1073.9 1079.5 1095.5 1102.5 5926.1 5931.8 5937.2 5944.7 5955.3 6337.4 6495.6 6500.2 6508.8 6512.6 5865.9 5876.1 5887.5 5888.5 5891.3 3398.5 3480.2 3487.6 3487.7 3489.2 6679.9 6686.3 6689.0 6689.8 6695.1 6605.9 6691.0 6709.3 6715.9 6734.9 6535.6 6726.6 6757.4 6765.4 6777.6 6266.2 6382.4 6480.4 6489.4 6499.9 6282.6 6361.7 6384.9 6394.7 6461.5 6754.3 6755.5 6756.9 6764.3 6770.2 4471.2 4558.9 4603.0 4606.4 4612.8 6480.5 6481.1 6485.5 6497.6 6498.2 6292.3 6293.1 6302.9 6307.8 6311.6 6198.3 6266.1 6266.1 6292.8 6299.2 6165.7 6167.2 6173.8 6177.8 6179.9 6271.1 6290.5 6299.8 6314.6 6325.4 6068.3 6154.1 6165.4 6176.3 6178.8 17:09:02 INFO - PROCESS | 26317 | 17:09:02 INFO - PROCESS | 26317 | [#5] yui.html Cycles:180 Average:13692.94 Median:23839.72 stddev:16173.42 (67.8%) stddev-sans-first:16189.15 17:09:02 INFO - PROCESS | 26317 | Values: 652.7 683.9 737.6 830.6 842.2 13181.7 13508.3 13614.2 13629.8 13641.8 11928.4 12697.7 12807.6 13785.6 13845.4 815.6 821.2 827.3 828.3 828.6 815.8 824.5 824.8 825.0 826.9 854.7 858.9 861.7 861.9 862.9 857.2 857.9 859.1 859.2 860.2 628.9 632.6 633.2 634.2 634.7 12885.7 12892.2 12930.8 13034.9 13040.7 11911.2 11939.4 12114.3 12168.6 12351.6 9684.5 10135.3 10208.9 10410.7 10487.5 3523.9 3556.2 3590.6 3600.4 3626.1 43414.8 44041.0 45835.3 46460.3 46770.8 8913.6 8922.3 8962.9 9086.9 9261.9 16974.4 17176.2 17205.0 17205.5 17216.6 7121.3 7233.3 7305.6 7415.7 7443.8 4046.8 4154.5 4209.0 4225.3 4252.9 3043.8 3084.6 3089.1 3089.6 3092.1 531.6 552.6 556.1 558.7 566.5 473.7 505.0 550.1 568.2 677.3 7915.7 8256.3 8498.2 8645.3 8687.5 652.0 652.8 662.5 673.6 689.1 3633.7 3951.3 3990.9 4009.3 4124.0 57522.7 59363.0 59793.0 59822.7 59834.7 50385.5 50741.7 51509.5 52011.7 52136.4 43417.0 47205.8 51156.0 52300.5 52858.7 8479.7 8569.2 8600.1 8614.3 8797.1 34957.5 35552.3 36121.5 36123.0 36451.5 41786.0 42289.0 46045.0 46247.0 46289.3 9725.3 10654.6 10737.5 10943.6 11051.6 11401.3 11720.9 11731.6 11965.5 12182.6 10004.6 10225.0 10572.2 10595.4 10671.0 10240.4 10452.2 10957.3 10988.5 11028.1 10557.7 10779.9 10843.8 11014.4 11045.8 9486.2 9600.9 9771.5 9919.7 10073.3 8630.7 9472.2 9668.4 9834.8 9887.7 17:09:02 INFO - PROCESS | 26317 | -------- Summary: end -------- 17:09:02 INFO - PROCESS | 26317 | 17:09:03 INFO - TEST-INFO | 26317: exit 0 17:09:03 INFO - TEST-OK | dromaeo_css | took 1113243ms 17:09:03 INFO - TEST-START | kraken 17:09:03 INFO - operating with platform_type : linux_ 17:09:03 INFO - Initialising browser for kraken test... 17:09:03 INFO - TEST-INFO | started process 26514 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWplXGp/profile http://localhost:39526/getInfo.html) 17:09:07 INFO - PROCESS | 26514 | __metrics Screen width/height:1600/1200 17:09:07 INFO - PROCESS | 26514 | colorDepth:24 17:09:07 INFO - PROCESS | 26514 | Browser inner width/height: 1024/697 17:09:07 INFO - PROCESS | 26514 | __metrics 17:09:07 INFO - PROCESS | 26514 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:09:07 INFO - PROCESS | 26514 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:09:08 INFO - PROCESS | 26514 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:09:08 INFO - TEST-INFO | 26514: exit 0 17:09:08 INFO - Browser initialized. 17:09:08 INFO - Running cycle 1/1 for kraken test... 17:09:08 INFO - TEST-INFO | started process 26598 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWplXGp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:20 INFO - PROCESS | 26598 | RSS: Main: 147218432 17:09:20 INFO - PROCESS | 26598 | 17:09:23 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39526/tests/kraken/driver.html?testName=audio-beat-detection) 17:09:23 INFO - PROCESS | 26598 | RSS: Main: 183463936 17:09:23 INFO - PROCESS | 26598 | 17:09:26 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39526/tests/kraken/driver.html?testName=audio-dft) 17:09:26 INFO - PROCESS | 26598 | RSS: Main: 172224512 17:09:26 INFO - PROCESS | 26598 | 17:09:29 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39526/tests/kraken/driver.html?testName=audio-fft) 17:09:30 INFO - PROCESS | 26598 | RSS: Main: 157171712 17:09:30 INFO - PROCESS | 26598 | 17:09:32 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39526/tests/kraken/driver.html?testName=audio-oscillator) 17:09:33 INFO - PROCESS | 26598 | RSS: Main: 161325056 17:09:33 INFO - PROCESS | 26598 | 17:09:35 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39526/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:09:35 INFO - PROCESS | 26598 | RSS: Main: 162746368 17:09:35 INFO - PROCESS | 26598 | 17:09:38 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39526/tests/kraken/driver.html?testName=imaging-darkroom) 17:09:39 INFO - PROCESS | 26598 | RSS: Main: 162279424 17:09:39 INFO - PROCESS | 26598 | 17:09:42 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39526/tests/kraken/driver.html?testName=imaging-desaturate) 17:09:43 INFO - PROCESS | 26598 | RSS: Main: 161824768 17:09:43 INFO - PROCESS | 26598 | 17:09:45 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39526/tests/kraken/driver.html?testName=json-parse-financial) 17:09:46 INFO - PROCESS | 26598 | RSS: Main: 162418688 17:09:46 INFO - PROCESS | 26598 | 17:09:48 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39526/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:09:48 INFO - PROCESS | 26598 | RSS: Main: 172285952 17:09:48 INFO - PROCESS | 26598 | 17:09:50 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39526/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:09:51 INFO - PROCESS | 26598 | RSS: Main: 171290624 17:09:51 INFO - PROCESS | 26598 | 17:09:53 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39526/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:09:53 INFO - PROCESS | 26598 | RSS: Main: 182710272 17:09:53 INFO - PROCESS | 26598 | 17:09:56 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:09:56 INFO - PROCESS | 26598 | RSS: Main: 189829120 17:09:56 INFO - PROCESS | 26598 | 17:09:59 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:09:59 INFO - PROCESS | 26598 | RSS: Main: 189493248 17:09:59 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | Cycle 1(1): loaded http://localhost:39526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39526/tests/kraken/driver.html?testName=ai-astar) 17:10:01 INFO - PROCESS | 26598 | RSS: Main: 246571008 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | __start_tp_report 17:10:01 INFO - PROCESS | 26598 | _x_x_mozilla_page_load 17:10:01 INFO - PROCESS | 26598 | _x_x_mozilla_page_load_details 17:10:01 INFO - PROCESS | 26598 | |i|pagename|runs| 17:10:01 INFO - PROCESS | 26598 | |0;ai-astar;109;112;105;111;112;111;101;111;109;110 17:10:01 INFO - PROCESS | 26598 | |1;audio-beat-detection;160;123;153;170;130;155;151;124;164;127 17:10:01 INFO - PROCESS | 26598 | |2;audio-dft;162;161;162;160;162;163;161;165;162;163 17:10:01 INFO - PROCESS | 26598 | |3;audio-fft;72;73;85;97;73;71;74;110;92;71 17:10:01 INFO - PROCESS | 26598 | |4;audio-oscillator;97;97;143;97;96;96;140;97;97;141 17:10:01 INFO - PROCESS | 26598 | |5;imaging-gaussian-blur;109;110;109;109;110;110;112;110;111;111 17:10:01 INFO - PROCESS | 26598 | |6;imaging-darkroom;147;147;146;147;146;147;145;145;145;146 17:10:01 INFO - PROCESS | 26598 | |7;imaging-desaturate;95;95;95;98;96;96;95;97;97;97 17:10:01 INFO - PROCESS | 26598 | |8;json-parse-financial;57;56;57;57;56;57;58;68;53;55 17:10:01 INFO - PROCESS | 26598 | |9;json-stringify-tinderbox;68;68;68;67;68;68;70;70;69;74 17:10:01 INFO - PROCESS | 26598 | |10;stanford-crypto-aes;84;86;85;85;86;84;86;86;86;85 17:10:01 INFO - PROCESS | 26598 | |11;stanford-crypto-ccm;118;123;118;119;117;123;117;115;122;114 17:10:01 INFO - PROCESS | 26598 | |12;stanford-crypto-pbkdf2;147;144;151;158;143;143;153;151;153;156 17:10:01 INFO - PROCESS | 26598 | |13;stanford-crypto-sha256-iterative;69;68;71;69;69;67;67;68;68;67 17:10:01 INFO - PROCESS | 26598 | __end_tp_report 17:10:01 INFO - PROCESS | 26598 | __start_cc_report 17:10:01 INFO - PROCESS | 26598 | _x_x_mozilla_cycle_collect,941 17:10:01 INFO - PROCESS | 26598 | __end_cc_report 17:10:01 INFO - PROCESS | 26598 | __startTimestamp1452042601784__endTimestamp 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | ------- Summary: start ------- 17:10:01 INFO - PROCESS | 26598 | Number of tests: 14 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.51 (3.2%) stddev-sans-first:3.72 17:10:01 INFO - PROCESS | 26598 | Values: 109.0 112.0 105.0 111.0 112.0 111.0 101.0 111.0 109.0 110.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:154.00 stddev:17.89 (11.6%) stddev-sans-first:18.21 17:10:01 INFO - PROCESS | 26598 | Values: 160.0 123.0 153.0 170.0 130.0 155.0 151.0 124.0 164.0 127.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.45 17:10:01 INFO - PROCESS | 26598 | Values: 162.0 161.0 162.0 160.0 162.0 163.0 161.0 165.0 162.0 163.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#3] audio-fft Cycles:10 Average:81.80 Median:73.50 stddev:13.69 (18.6%) stddev-sans-first:14.05 17:10:01 INFO - PROCESS | 26598 | Values: 72.0 73.0 85.0 97.0 73.0 71.0 74.0 110.0 92.0 71.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:97.00 stddev:21.57 (22.2%) stddev-sans-first:22.35 17:10:01 INFO - PROCESS | 26598 | Values: 97.0 97.0 143.0 97.0 96.0 96.0 140.0 97.0 97.0 141.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.99 (0.9%) stddev-sans-first:0.97 17:10:01 INFO - PROCESS | 26598 | Values: 109.0 110.0 109.0 109.0 110.0 110.0 112.0 110.0 111.0 111.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 17:10:01 INFO - PROCESS | 26598 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 145.0 145.0 145.0 146.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.50 stddev:1.10 (1.1%) stddev-sans-first:1.09 17:10:01 INFO - PROCESS | 26598 | Values: 95.0 95.0 95.0 98.0 96.0 96.0 95.0 97.0 97.0 97.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:3.98 (7.0%) stddev-sans-first:4.22 17:10:01 INFO - PROCESS | 26598 | Values: 57.0 56.0 57.0 57.0 56.0 57.0 58.0 68.0 53.0 55.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:68.50 stddev:2.00 (2.9%) stddev-sans-first:2.09 17:10:01 INFO - PROCESS | 26598 | Values: 68.0 68.0 68.0 67.0 68.0 68.0 70.0 70.0 69.0 74.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.00 stddev:0.82 (1.0%) stddev-sans-first:0.73 17:10:01 INFO - PROCESS | 26598 | Values: 84.0 86.0 85.0 85.0 86.0 84.0 86.0 86.0 86.0 85.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:118.50 stddev:3.17 (2.7%) stddev-sans-first:3.35 17:10:01 INFO - PROCESS | 26598 | Values: 118.0 123.0 118.0 119.0 117.0 123.0 117.0 115.0 122.0 114.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:152.00 stddev:5.40 (3.6%) stddev-sans-first:5.63 17:10:01 INFO - PROCESS | 26598 | Values: 147.0 144.0 151.0 158.0 143.0 143.0 153.0 151.0 153.0 156.0 17:10:01 INFO - PROCESS | 26598 | 17:10:01 INFO - PROCESS | 26598 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.25 (1.8%) stddev-sans-first:1.30 17:10:01 INFO - PROCESS | 26598 | Values: 69.0 68.0 71.0 69.0 69.0 67.0 67.0 68.0 68.0 67.0 17:10:01 INFO - PROCESS | 26598 | -------- Summary: end -------- 17:10:01 INFO - PROCESS | 26598 | 17:10:02 INFO - TEST-INFO | 26598: exit 0 17:10:02 INFO - TEST-OK | kraken | took 59217ms 17:10:02 INFO - TEST-START | v8_7 17:10:02 INFO - operating with platform_type : linux_ 17:10:02 INFO - Initialising browser for v8_7 test... 17:10:02 INFO - TEST-INFO | started process 26846 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC_zJaK/profile http://localhost:39526/getInfo.html) 17:10:06 INFO - PROCESS | 26846 | __metrics Screen width/height:1600/1200 17:10:06 INFO - PROCESS | 26846 | colorDepth:24 17:10:06 INFO - PROCESS | 26846 | Browser inner width/height: 1024/697 17:10:06 INFO - PROCESS | 26846 | __metrics 17:10:06 INFO - PROCESS | 26846 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:10:06 INFO - PROCESS | 26846 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:10:08 INFO - TEST-INFO | 26846: exit 0 17:10:08 INFO - Browser initialized. 17:10:08 INFO - Running cycle 1/1 for v8_7 test... 17:10:08 INFO - TEST-INFO | started process 26931 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC_zJaK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:19 INFO - PROCESS | 26931 | RSS: Main: 150278144 17:10:19 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | Cycle 1(1): loaded http://localhost:39526/tests/v8_7/run.html (next: http://localhost:39526/tests/v8_7/run.html) 17:10:41 INFO - PROCESS | 26931 | RSS: Main: 541868032 17:10:41 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | __start_tp_report 17:10:41 INFO - PROCESS | 26931 | _x_x_mozilla_page_load 17:10:41 INFO - PROCESS | 26931 | _x_x_mozilla_page_load_details 17:10:41 INFO - PROCESS | 26931 | |i|pagename|runs| 17:10:41 INFO - PROCESS | 26931 | |0;Richards;167.7570877369569 17:10:41 INFO - PROCESS | 26931 | |1;DeltaBlue;191.71779141104295 17:10:41 INFO - PROCESS | 26931 | |2;Encrypt;290.4443799012489 17:10:41 INFO - PROCESS | 26931 | |3;Decrypt;5291.005291005291 17:10:41 INFO - PROCESS | 26931 | |4;RayTrace;1117.31843575419 17:10:41 INFO - PROCESS | 26931 | |5;Earley;786.7820613690008 17:10:41 INFO - PROCESS | 26931 | |6;Boyer;12132.530120481928 17:10:41 INFO - PROCESS | 26931 | |7;RegExp;25692.30769230769 17:10:41 INFO - PROCESS | 26931 | |8;Splay;584.1121495327103 17:10:41 INFO - PROCESS | 26931 | |9;NavierStokes;4845.410628019324 17:10:41 INFO - PROCESS | 26931 | __end_tp_report 17:10:41 INFO - PROCESS | 26931 | __startTimestamp1452042641455__endTimestamp 17:10:41 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | ------- Summary: start ------- 17:10:41 INFO - PROCESS | 26931 | Number of tests: 10 17:10:41 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | [#0] Richards Cycles:1 Average:167.76 Median:167.76 stddev:0.00 (0.0%) 17:10:41 INFO - PROCESS | 26931 | Values: 167.8 17:10:41 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | [#1] DeltaBlue Cycles:1 Average:191.72 Median:191.72 stddev:0.00 (0.0%) 17:10:41 INFO - PROCESS | 26931 | Values: 191.7 17:10:41 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | [#2] Encrypt Cycles:1 Average:290.44 Median:290.44 stddev:0.00 (0.0%) 17:10:41 INFO - PROCESS | 26931 | Values: 290.4 17:10:41 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | [#3] Decrypt Cycles:1 Average:5291.01 Median:5291.01 stddev:0.00 (0.0%) 17:10:41 INFO - PROCESS | 26931 | Values: 5291.0 17:10:41 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | [#4] RayTrace Cycles:1 Average:1117.32 Median:1117.32 stddev:0.00 (0.0%) 17:10:41 INFO - PROCESS | 26931 | Values: 1117.3 17:10:41 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 17:10:41 INFO - PROCESS | 26931 | Values: 786.8 17:10:41 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 17:10:41 INFO - PROCESS | 26931 | Values: 12132.5 17:10:41 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | [#7] RegExp Cycles:1 Average:25692.31 Median:25692.31 stddev:0.00 (0.0%) 17:10:41 INFO - PROCESS | 26931 | Values: 25692.3 17:10:41 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | [#8] Splay Cycles:1 Average:584.11 Median:584.11 stddev:0.00 (0.0%) 17:10:41 INFO - PROCESS | 26931 | Values: 584.1 17:10:41 INFO - PROCESS | 26931 | 17:10:41 INFO - PROCESS | 26931 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 17:10:41 INFO - PROCESS | 26931 | Values: 4845.4 17:10:41 INFO - PROCESS | 26931 | -------- Summary: end -------- 17:10:41 INFO - PROCESS | 26931 | 17:10:42 INFO - TEST-INFO | 26931: exit 0 17:10:42 INFO - TEST-OK | v8_7 | took 39612ms 17:10:42 INFO - SUITE-END | took 1212s 17:10:42 INFO - Completed test suite (00:20:12) 17:10:42 INFO - Working with test: dromaeo_css 17:10:42 INFO - Generating results file: dromaeo_css 17:10:42 INFO - Working with test: kraken 17:10:42 INFO - Generating results file: kraken 17:10:42 INFO - javascript benchmark 17:10:42 INFO - Working with test: v8_7 17:10:42 INFO - Generating results file: v8_7 17:10:42 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:10:42 INFO - process_Request line: dromaeo_css 6805.39 graph.html#tests=[[72,64,35]] 17:10:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:42 INFO - process_Request line: kraken 1509.60 graph.html#tests=[[232,64,35]] 17:10:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:42 INFO - process_Request line: v8_7 20945.95 graph.html#tests=[[230,64,35]] 17:10:42 INFO - RETURN: dromaeo_css: 6805.39 17:10:42 INFO - RETURN: kraken: 1509.60 17:10:42 INFO - RETURN: v8_7: 20945.95 17:10:42 INFO - javascript benchmark 17:10:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3069.0946170879597, 3110.7355874750647, 3156.9210769730753, 3159.652438231794, 3176.301213732978, 5099.694018358892, 5211.45279745627, 5231.319928409306, 5236.266922630834, 5264.710440925747, 5140.485951404867, 5165.896682066356, 5176.974115129419, 5209.791608335662, 5241.790328386869, 4587.678862479611, 4734.0, 4759.190937540618, 4824.879378015543, 4834.419869615651, 4733.219018861883, 4795.736234507101, 4835.274708793674, 4851.854444366657, 4899.706017638935, 4689.390379250693, 4779.139754844126, 4783.067301876135, 4802.687825291345, 4806.327114204014, 4756.7145971241835, 4760.904781904343, 4789.066132104241, 4789.880252993668, 4821.807127714887, 4661.95338046622, 4745.074710431467, 4755.048990201939, 4759.143354196243, 4815.711057336571, 5011.098002359574, 5026.79892804291, 5045.84862454127, 5046.369203849519, 5064.316317297192, 5539.612227144102, 5540.584456165763, 5540.695261760601, 5540.750666220029, 5542.944570554324, 5574.526165275956, 5588.161775733673, 5588.692621905793, 5669.801556945487, 5782.710864456761, 5254.0, 5297.152455607123, 5308.177232528964, 5332.3601167859715, 5359.624826262163, 5736.082226843685, 5757.683327417032, 5779.682117483495, 5783.103618939072, 5789.507891829157, 5349.438308977579, 5476.151196564539, 5511.696856672921, 5543.501084902378, 5547.611667183259, 5636.351819540723, 5643.887122257614, 5647.915281270784, 5651.858703532444, 5686.2323586315315, 5582.7766889324785, 5600.299962504687, 5601.327840659147, 5610.354809196913, 5617.101263797773, 5448.645838020516, 5560.249366335493, 5581.023320918823, 5589.413111623302, 5596.2165296858475, 4322.416473776063, 4352.129574085196, 4378.6278166356215, 4386.1008493258805, 4410.669199810027, 3878.9612103879163, 3884.0095775577047, 3889.2221555688975, 3912.667423268997, 3914.432407300925, 5143.434222235551, 5224.216367544898, 5225.608079394061, 5249.658772179796, 5279.9208011879855, 5559.63862348946, 5594.692291923983, 5632.436756324417, 5641.984442800253, 5671.546276297886, 5182.404023537341, 5194.378481712165, 5195.766190521435, 5198.220266959911, 5199.29809475716, 4614.653900957442, 4694.319323698045, 4798.4001999750035, 4802.447718512416, 4846.0, 5755.827325180251, 5811.651300921958, 5823.534117270524, 5823.82528524145, 5863.120531920246, 5605.635633683797, 5607.186957891165, 5609.915851262316, 5617.157426386075, 5618.971905140448, 5614.410486898817, 5721.599488035798, 5761.596688231783, 5810.244668193108, 5812.883742325214, 5526.861828454321, 5556.583256255716, 5584.776608935597, 5585.106382978866, 5639.464250896158, 5621.4659607337235, 5659.094544872801, 5670.914936275876, 5671.943280567307, 5676.0, 5374.57003439716, 5467.863303417446, 5538.556915446835, 5554.944450555605, 5555.527780138734, 5480.890382192254, 5552.472515111058, 5554.055810512304, 5597.916031259616, 5610.691411972381, 5408.4321146280645, 5411.080116380146, 5417.377001644862, 5444.8094316698725, 5451.20957461158, 5328.520433161034, 5358.839234822962, 5499.092649712913, 5526.50261476469, 5565.471280228372, 5329.467053294639, 5397.649152805055, 5398.244245805512, 5410.83767486976, 5437.510624043855], "unit": "score", "name": "dojo.html", "value": 5169.105988537909}, {"lowerIsBetter": false, "replicates": [528.1391332128629, 534.9224362467445, 536.110057304874, 550.7714298566095, 581.5696384675339, 27483.450330993393, 28185.15444536662, 35258.823705881434, 35742.64257357426, 35882.46176307351, 38255.61744382562, 38728.612713872855, 38744.80627596865, 38754.224915501676, 38959.0, 7391.6304184790815, 8490.363222758288, 8664.39349245553, 8679.17547832955, 8685.565721713921, 7440.516366436164, 10109.443980581065, 10289.3311934724, 10336.483175841215, 10338.121259692934, 10039.247056470758, 10068.647597334095, 10082.596696132183, 10093.596256149745, 10116.089551940324, 7536.510126841793, 7666.233376662345, 10032.448215348153, 10151.086402223762, 10157.796844063114, 9905.0, 10005.59977600895, 10026.899731002743, 10029.749256268578, 10030.949845250727, 33027.174320641934, 33371.332573348394, 33389.83305083483, 33415.498767518504, 33535.49696754551, 3176.698213669698, 3196.744260459158, 3212.8714851405916, 3252.463343548335, 3576.7675101118343, 28027.719722802714, 29536.704632953824, 29803.403931921457, 29838.55242171369, 30642.080737577908, 4011.859584914543, 4019.0, 4035.8385664573384, 4100.077482566428, 4158.4178215049915, 202904.0, 203696.0, 204324.0, 204485.99999999852, 205351.0, 49073.50926490761, 50951.0, 56722.43277567254, 57421.71289143527, 57549.13676294859, 52186.21720674193, 52353.476465235624, 52413.213801793005, 52688.20967685488, 52731.20903186455, 14501.274936253145, 14690.632734181518, 14726.852731472549, 14947.775783363259, 14993.400263989319, 10695.465226738788, 10846.078083363003, 10871.945640271748, 10887.510062047228, 10919.617813376493, 19042.238310467426, 19153.233870645017, 19289.228430862608, 19292.517687057934, 19295.614087718168, 7548.886766698504, 7810.765677029698, 7814.179511151247, 7926.920730792734, 7929.207079292025, 948.5636607160783, 952.5284983932997, 1014.4521958142668, 1027.4503140819625, 1061.9804987212362, 25090.372740681265, 25287.36781580475, 25393.746062539507, 29557.556636650468, 30341.24146896301, 925.379995403068, 1006.713086770267, 1008.2992320337441, 1073.5920350267004, 1078.6710053433778, 15529.22353882324, 15646.843531564538, 15709.528714138594, 15766.68466630661, 16093.0, 362866.0, 367673.0, 368824.0, 369134.0, 370058.0, 50735.0, 50842.0, 50944.490555094715, 51165.48834511681, 51201.487985119675, 1327.4955516903515, 1336.2917653643585, 1338.9866101338862, 1341.6511706956262, 1342.4026308292912, 24159.4739821814, 27892.0, 29649.517813023616, 30354.241143971576, 30586.84706576453, 45659.0, 46224.53775462337, 46543.301850471595, 46546.34536546318, 46550.53449465462, 226156.0, 226741.0, 227062.0, 227745.0, 227773.0, 26804.19587412381, 29683.257918551346, 29881.402371952874, 30044.0, 30090.0, 35417.0, 38800.41799373068, 39129.02177445587, 39392.0, 39574.60425395824, 32042.839785800923, 32635.34729305448, 32682.509762353107, 33026.66973330332, 33313.333733325686, 33054.17364565905, 33085.33829323448, 33728.83135584404, 33855.492167617995, 33989.49015764716, 32548.51177232296, 33026.66973330332, 33048.33903321872, 33331.0, 33471.83264083664, 29227.269318266364, 29909.551356729233, 30179.09462716122, 30480.390392192476, 30626.387472249986, 21540.676889846352, 22120.557588847812, 22183.667244991662, 22200.66698999484, 22302.773347466045], "unit": "score", "name": "ext.html", "value": 17699.915332337525}, {"lowerIsBetter": false, "replicates": [361.72870347239586, 363.0397598352357, 365.3113880335567, 366.47593940664854, 367.5699431664952, 13120.163177155182, 13397.397117129729, 16111.113888736114, 16203.594910127253, 16737.33050677973, 15923.84076159238, 15952.84047159528, 16025.358985640589, 16072.839271607281, 16122.516324510283, 5091.083604951116, 5398.4871437213405, 5399.19012148179, 5405.162199859028, 5407.053765591006, 4002.919941601166, 4116.279651061067, 5357.1696387060065, 5884.117382392633, 6017.277926648809, 5897.203877476529, 5929.88140237195, 5935.436133567304, 5961.344252132262, 5964.194833697438, 5779.422057794229, 5922.940770592282, 5932.228810254661, 5932.3474417814, 5932.525397968152, 5137.691738495665, 5181.896362072775, 5213.139831927728, 5219.817306394258, 5250.921236181461, 20727.170913163456, 20745.481362965897, 21183.68224476634, 21322.253721119687, 21380.57238855214, 2076.8546201765885, 2168.8590241634242, 2248.4491299631695, 2452.828302018859, 2501.0072672466545, 12390.504379824797, 12543.184692994926, 12628.0, 12733.42699578512, 13067.673308167277, 1674.7069262878947, 1682.966340673192, 1686.8228835972168, 1705.3263960735565, 1722.9913850430794, 59211.703941480446, 59566.40433595652, 59681.40318596802, 62310.06534901935, 63558.0, 9660.227181825438, 9851.75370615726, 9877.851832222523, 9908.80182396348, 9956.601735930626, 13204.867951320555, 13210.27343496117, 13216.537421190213, 13224.338783060808, 13258.403371848097, 7353.007344008597, 7372.483926125227, 7416.3683989522215, 7436.293552112541, 7511.962440187874, 7064.788056358318, 7177.605231712306, 7492.138404083491, 7528.661210245552, 7574.962125189449, 5852.619579727304, 5938.0, 5945.881082378328, 6012.939870601238, 6118.969405152946, 1680.949571512832, 1736.4182998695326, 1782.875198736076, 1790.0691640346947, 1808.1953530678722, 428.87133859842544, 839.2195258409615, 961.0437614573405, 965.0928127560211, 973.1873885305707, 9276.25789936817, 10041.548130334153, 10538.367697938149, 10697.893021069689, 11106.222564420576, 437.02107279693894, 438.82008376565454, 446.46201327400405, 448.8002838736731, 449.73240921651563, 5867.970660146672, 9283.814323713488, 9869.75325616851, 9878.110970012733, 9919.206463482904, 532650.5257717617, 536287.0, 537572.0, 540769.0, 550529.0, 39311.01722456904, 42457.51398701031, 42495.15009699789, 73067.2693273071, 75407.0, 1143.1369316166242, 1149.98275025873, 1158.4960542164017, 1188.2217147768226, 1191.2614179208947, 14689.706205876037, 15303.770443443134, 15325.233738313264, 15548.300326485109, 15623.921880390526, 33734.83132584419, 33862.0, 33888.66111338855, 34191.14522136966, 34418.139546511535, 45527.544724553656, 46767.532324676315, 46787.29819052785, 46969.0, 47380.0, 8807.823843523222, 8914.0194578595, 8923.241524470493, 8960.68637597681, 9035.186833185046, 16875.662486750443, 17228.310867565157, 17251.309947601956, 17518.91240543789, 17583.560410989827, 13260.801087983495, 13497.39261733244, 13499.055066145276, 13862.65343366424, 14641.63395915068, 10345.0, 13966.720665586428, 14054.227017514135, 14504.782428263374, 14567.490137845125, 13622.046456747932, 13977.650558736113, 14139.151650900978, 14506.564803055926, 14694.77957830612, 9314.25485961135, 9401.0, 9438.48088355147, 9574.712758617252, 9746.610135594497, 10071.295009349275, 10174.186065114922, 12021.218620789621, 13781.448742050206, 14132.222727750073], "unit": "score", "name": "jquery.html", "value": 8489.46942928519}, {"lowerIsBetter": false, "replicates": [1322.4644019172226, 1462.2104063805543, 1465.54568083894, 1612.9596760080997, 1787.1153778879457, 6517.446017088547, 7082.610456424894, 7130.500864939457, 7146.963690264908, 7153.499255052136, 7059.7882063538045, 7141.285871412856, 7153.427725781938, 7155.24869888662, 7261.891071633917, 1912.9904350478228, 1932.8743631663897, 2173.956520869586, 2199.4611320226486, 2210.613142700029, 2236.865788052722, 2247.325802259324, 2250.22367283287, 2252.031626400647, 2253.8873056347197, 2155.8059774620283, 2252.4481502031945, 2253.267688001406, 2253.8084262837597, 2255.5150642611834, 2201.6587428948537, 2204.526026904215, 2227.6213043782514, 2244.921427750021, 2249.044156233594, 2265.048679554591, 2265.3090807303765, 2297.7012988311412, 2301.102569997702, 2321.9187328443422, 7433.070866141732, 7490.176080631126, 7520.210377910295, 7520.5487670739385, 7521.0, 4452.265376212921, 4524.932126018112, 4541.500434952152, 4541.591256786872, 4544.8865028068, 3006.7143621356154, 3017.8792848286043, 3031.9545206821917, 3035.362573859492, 3172.6351469581064, 1009.4145395670566, 1015.8831734350497, 1026.2969865641985, 1051.658211081394, 1072.635303996637, 10466.63366782159, 10479.63321283759, 10516.631917882914, 10532.26274160809, 10549.0, 4150.979245103756, 4232.217039847638, 4277.615014648696, 4284.421603083606, 4289.03496713237, 8897.199252067345, 8900.554972251362, 8901.910980890238, 8905.0, 8914.37599368038, 4646.09401166776, 4676.883077923011, 4708.246680531099, 4709.270063140219, 4714.269288260325, 4208.810603522848, 4212.052288235122, 4256.042390462183, 4260.25445547028, 4262.0, 3341.74936879735, 3391.2030672791875, 3527.5237842891393, 3554.449060395643, 3614.746967712235, 1144.7710457908452, 1172.7302720374362, 1175.2008634128874, 1177.7585594953014, 1180.9586664466703, 988.6786794291884, 989.1542730965065, 1054.2409465185056, 1096.6052221200362, 1289.2200218867638, 6664.900026499607, 6666.899996500057, 6671.132752742113, 6678.53250272486, 6690.264070952191, 1087.782443511301, 1098.3849044535086, 1106.419129956763, 1123.5112725964232, 1128.328644456547, 5606.383297837235, 5690.0895856663565, 5708.80019199326, 5711.828645140569, 5715.942840571624, 8610.182032706884, 9064.320175986695, 9229.307801914883, 9238.538073096319, 9245.72262832116, 8976.281897448189, 9144.54277286133, 9159.816803663889, 9160.083991600786, 9160.312976526788, 6885.0, 6964.373206411548, 7059.470539709542, 7064.32888875556, 7064.364207221375, 7045.506814522934, 7114.14630244374, 7125.714971401293, 7131.643417829192, 7136.250693677089, 7895.881561776463, 8027.157148499324, 8041.477303975223, 8136.918630813616, 8220.712275070344, 8186.222308880647, 8226.42415030966, 8380.748577542683, 8406.369522285731, 8421.62102705392, 7121.857562848818, 7330.413566914527, 7351.963240183765, 7352.926470735224, 7360.668769905475, 6586.50601204902, 6703.832404189934, 7128.893066604109, 7253.310935461122, 7258.528195667264, 6514.54398192122, 6674.699638516181, 6799.762008329685, 6915.827104322432, 7005.614691192033, 6696.732130714911, 6727.562708423937, 6756.155480564929, 6845.247022827385, 7024.789256322319, 6547.672616369257, 6608.4382827458285, 6614.437772789367, 6627.900581491378, 6659.966700166468, 6303.928332183448, 6402.423781859468, 6441.323661015525, 6446.4520515756685, 6478.935210647834, 6238.376162383725, 6264.342244064308, 6294.937050629618, 6303.991361382157, 6308.779192728416], "unit": "score", "name": "mootools.html", "value": 4368.218622542245}, {"lowerIsBetter": false, "replicates": [341.0739841330786, 343.71986830732965, 344.89997900608824, 345.2663090931771, 351.3166890398175, 5767.33675627303, 5863.912041319379, 5883.676397798114, 5898.764049438023, 5914.0, 5696.943030569693, 5812.534997200224, 5815.47660710536, 5840.0, 5846.619969701977, 4551.0, 4553.27147656375, 4555.544445555451, 4555.954440455586, 4567.840125595605, 4349.325854492558, 4428.6014258716705, 4430.7784610769495, 4436.55634436557, 4572.542745725417, 4466.82132714691, 4479.776011199443, 4491.528389519102, 4492.932606010912, 4498.190325741365, 4460.732356058615, 4481.753503557303, 4486.259767138418, 4486.304622783474, 4487.237169681162, 4001.4998125234347, 4004.0590461241586, 4006.719529632927, 4011.458453108822, 4017.6384125428854, 5435.891282174374, 5559.527440167591, 5569.526590239794, 5592.552595792326, 5640.097584386478, 5232.973835130838, 5233.895322093575, 5240.4759524047295, 5241.9213711794355, 5252.658577192508, 5904.675242861641, 6210.130581718563, 6260.686965651745, 6271.623702577815, 6279.686015699197, 4244.214820258262, 4249.957500424987, 4298.46269216348, 4302.290122129845, 4304.246756817544, 6363.7772677956045, 6487.481001519867, 6496.317886621884, 6517.804465866032, 6522.315156908551, 4460.687751857404, 4466.486354069259, 4471.463424389029, 4473.5526447355005, 4475.597196252353, 4363.47638283408, 4502.392177056121, 4521.706089104197, 4528.88677783058, 4529.184746745617, 5161.3032240647035, 5165.1219292720325, 5171.50870667286, 5175.378954525481, 5231.8168864089575, 6263.906041409383, 6274.0, 6274.090256912722, 6278.089676996809, 6287.622742635456, 1581.3121292237913, 1602.9358825647078, 1603.4628399486069, 1603.9679206415806, 1606.8875178737376, 1070.8982646648556, 1073.9248252622397, 1079.4980334144661, 1095.4686976816238, 1102.459794700591, 5926.081457374114, 5931.822045338647, 5937.198478205473, 5944.7027648617395, 5955.34491205967, 6337.366263373718, 6495.610263384212, 6500.219973603198, 6508.8047358579315, 6512.609243445314, 5865.912011319833, 5876.08920617305, 5887.528997680175, 5888.4700376966275, 5891.263592050994, 3398.4562470005176, 3480.164760457472, 3487.633798451177, 3487.7035451986358, 3489.2323688788424, 6679.899801502981, 6686.331366863372, 6689.0, 6689.76585819494, 6695.096162018162, 6605.900911486331, 6691.0, 6709.29552397001, 6715.932840671629, 6734.8989765153565, 6535.607863528108, 6726.630035348103, 6757.425618822357, 6765.35729105744, 6777.6272305023695, 6266.185395898504, 6382.393672601095, 6480.351964803671, 6489.448396886318, 6499.935000649933, 6282.591631543935, 6361.713722882574, 6384.904226436514, 6394.680265986589, 6461.515386345949, 6754.324567543206, 6755.527113102035, 6756.8648627026205, 6764.289749576224, 6770.221424536241, 4471.217536930959, 4558.88602784933, 4603.0, 4606.401167848292, 4612.838550650711, 6480.513961452815, 6481.0926470295135, 6485.513586481127, 6497.610143391412, 6498.187726534184, 6292.276388215414, 6293.087502312231, 6302.936970630235, 6307.779227727007, 6311.589746666452, 6198.318184999736, 6266.060090986389, 6266.122742816101, 6292.842678933063, 6299.181106456132, 6165.660888651168, 6167.229096362955, 6173.753049878134, 6177.752889884354, 6179.876402471836, 6271.059341098871, 6290.49676025926, 6299.803037422875, 6314.55798094129, 6325.430711236011, 6068.332483426908, 6154.076888466587, 6165.445109940127, 6176.289726681489, 6178.783742568989], "unit": "score", "name": "prototype.html", "value": 4730.8015434717245}, {"lowerIsBetter": false, "replicates": [652.6704014472691, 683.8529716111038, 737.6311844077961, 830.6262182018094, 842.1914961636828, 13181.670458238548, 13508.257045862474, 13614.183149011067, 13629.795553066688, 13641.795373069386, 11928.403579820995, 12697.682557936056, 12807.551735689252, 13785.586432407019, 13845.376958036888, 815.592203898051, 821.2444551013082, 827.3381294964034, 828.2752591482453, 828.6395417993192, 815.759350991459, 824.5135370131621, 824.7608193623842, 825.0182283083142, 826.89663792026, 854.7435769269225, 858.8797568340437, 861.7414775567336, 861.8922634670666, 862.8662557303596, 857.185673610073, 857.9270761985239, 859.0507489224411, 859.2309882654989, 860.1613426908746, 628.8930881750114, 632.601461079517, 633.1737083106544, 634.2484156274783, 634.7302396481523, 12885.742285154338, 12892.162009469355, 12930.806037909439, 13034.869651303556, 13040.739185216242, 11911.166218364719, 11939.403029848472, 12114.273143611412, 12168.634940951786, 12351.629451116482, 9684.515774211332, 10135.341202821794, 10208.948955255251, 10410.68767936963, 10487.528061237263, 3523.8547472071423, 3556.1643013891717, 3590.605033446319, 3600.369935261319, 3626.057225121461, 43414.782926085165, 44041.0, 45835.31247031297, 46460.30309545359, 46770.76614616939, 8913.55432228386, 8922.330825188137, 8962.86555701665, 9086.909130908738, 9261.861072083924, 16974.40589579359, 17176.22706978189, 17205.0, 17205.483835484705, 17216.569585760455, 7121.252268511836, 7233.348998590152, 7305.5981920994855, 7415.666295016737, 7443.813904652427, 4046.7576672920077, 4154.459920210354, 4209.0, 4225.260579398593, 4252.85115020979, 3043.8478076096108, 3084.552739852754, 3089.1041597936796, 3089.6137982752157, 3092.1187461573345, 531.5641174237165, 552.5745176214292, 556.1074475466818, 558.6536347464598, 566.4901588570237, 473.673165515793, 505.01774049474153, 550.1170621153071, 568.1931657047003, 677.3303806117943, 7915.683372665144, 8256.25693687571, 8498.235158835734, 8645.30069853476, 8687.52218627969, 651.9902201466982, 652.8139480248107, 662.4766434516678, 673.5655502201053, 689.1454596300551, 3633.72886486914, 3951.328274193394, 3990.86031988879, 4009.298372784751, 4123.958760412417, 57522.7123864378, 59363.0, 59793.0, 59822.70088649529, 59834.70082649559, 50385.49614503808, 50741.746291268304, 51509.48490515122, 52011.73994130005, 52136.43590692285, 43417.0, 47205.76397117993, 51156.0, 52300.476995230325, 52858.735706321226, 8479.69660623029, 8569.185927336894, 8600.053994060774, 8614.3108551317, 8797.067644118699, 34957.47563786596, 35552.28895422129, 36121.45817812682, 36123.0, 36451.45322820107, 41786.0, 42289.0, 46045.0, 46247.0, 46289.305660414444, 9725.319227653996, 10654.62708805188, 10737.46312684347, 10943.562257509611, 11051.613193538187, 11401.258918170292, 11720.88279117198, 11731.648050558497, 11965.461554230254, 12182.634520964386, 10004.649837255662, 10225.0, 10572.154227661922, 10595.364278143335, 10671.039606435457, 10240.385576865114, 10452.163826893982, 10957.287776294515, 10988.505517251902, 11028.062614677843, 10557.683269501927, 10779.946100269448, 10843.837342439712, 11014.44927753593, 11045.835475450249, 9486.241100712065, 9600.85598716006, 9771.511424428892, 9919.65281215154, 10073.294869359075, 8630.654773808978, 9472.194863436409, 9668.419894806335, 9834.803303934024, 9887.653932112342], "unit": "score", "name": "yui.html", "value": 6188.320691888245}], "name": "dromaeo_css", "value": 6805.387847917664}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 105.0, 111.0, 112.0, 111.0, 101.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [160.0, 123.0, 153.0, 170.0, 130.0, 155.0, 151.0, 124.0, 164.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 160.0, 162.0, 163.0, 161.0, 165.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 85.0, 97.0, 73.0, 71.0, 74.0, 110.0, 92.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 143.0, 97.0, 96.0, 96.0, 140.0, 97.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 112.0, 110.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 98.0, 96.0, 96.0, 95.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 57.0, 56.0, 57.0, 58.0, 68.0, 53.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 70.0, 70.0, 69.0, 74.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 85.0, 86.0, 84.0, 86.0, 86.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [118.0, 123.0, 118.0, 119.0, 117.0, 123.0, 117.0, 115.0, 122.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [147.0, 144.0, 151.0, 158.0, 143.0, 143.0, 153.0, 151.0, 153.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.9}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 71.0, 69.0, 69.0, 67.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1509.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7570877369569], "unit": "score", "name": "Richards", "value": 210.43522200000004}, {"lowerIsBetter": false, "replicates": [191.71779141104295], "unit": "score", "name": "DeltaBlue", "value": 344.87148800000006}, {"lowerIsBetter": false, "replicates": [290.4443799012489], "unit": "score", "name": "Encrypt", "value": 916.4611830000002}, {"lowerIsBetter": false, "replicates": [5291.005291005291], "unit": "score", "name": "Decrypt", "value": 50.30820900000001}, {"lowerIsBetter": false, "replicates": [1117.31843575419], "unit": "score", "name": "RayTrace", "value": 662.290155}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [25692.30769230769], "unit": "score", "name": "RegExp", "value": 35.4575}, {"lowerIsBetter": false, "replicates": [584.1121495327103], "unit": "score", "name": "Splay", "value": 139.51259200000004}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20945.948143270874}]} 17:10:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20945.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1509.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6805.39"}}} 17:10:42 INFO - Return code: 0 17:10:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:10:42 INFO - # TBPL SUCCESS # 17:10:42 INFO - Running post-action listener: _resource_record_post_action 17:10:42 INFO - Running post-run listener: _resource_record_post_run 17:10:43 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 558809088; Read time: 0; Write time: 559448 17:10:43 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 238739456; Read time: 0; Write time: 362628 17:10:43 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 320069632; Read time: 0; Write time: 196820 17:10:43 INFO - Running post-run listener: _upload_blobber_files 17:10:43 INFO - Blob upload gear active. 17:10:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:10:43 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 17:10:43 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'] 17:10:43 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 17:10:44 INFO - (blobuploader) - INFO - Open directory for files ... 17:10:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:10:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:10:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:10:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:10:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:10:45 INFO - (blobuploader) - INFO - Done attempting. 17:10:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:10:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:10:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:10:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:10:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:10:46 INFO - (blobuploader) - INFO - Done attempting. 17:10:46 INFO - (blobuploader) - INFO - Iteration through files over. 17:10:46 INFO - Return code: 0 17:10:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:10:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:10:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f46b5fc56f4e1dc88d6fd95beb270aac7de128feb03366f867406edced102103159120f3607b5bba4d034e5b5932aaf682cd97fed0fa85244a73c0ff5111ef24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ba5310d0e78cc4df427ae73a34d8b2ae516d1acf4bfe7a8f7e517db586a9f2240e91b621ee4ce25dd0667c562e91eb018870d1f7a996b0b563f54820f91afa1"} 17:10:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:10:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:10:46 INFO - Contents: 17:10:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f46b5fc56f4e1dc88d6fd95beb270aac7de128feb03366f867406edced102103159120f3607b5bba4d034e5b5932aaf682cd97fed0fa85244a73c0ff5111ef24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ba5310d0e78cc4df427ae73a34d8b2ae516d1acf4bfe7a8f7e517db586a9f2240e91b621ee4ce25dd0667c562e91eb018870d1f7a996b0b563f54820f91afa1"} 17:10:46 INFO - Copying logs to upload dir... 17:10:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.425043 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-05 17:10:45.897935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 17:10:45.901942) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953 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/f46b5fc56f4e1dc88d6fd95beb270aac7de128feb03366f867406edced102103159120f3607b5bba4d034e5b5932aaf682cd97fed0fa85244a73c0ff5111ef24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ba5310d0e78cc4df427ae73a34d8b2ae516d1acf4bfe7a8f7e517db586a9f2240e91b621ee4ce25dd0667c562e91eb018870d1f7a996b0b563f54820f91afa1"} build_url:https://queue.taskcluster.net/v1/task/G0urGjpRS8qk1eOt-uBB_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/G0urGjpRS8qk1eOt-uBB_g/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/f46b5fc56f4e1dc88d6fd95beb270aac7de128feb03366f867406edced102103159120f3607b5bba4d034e5b5932aaf682cd97fed0fa85244a73c0ff5111ef24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ba5310d0e78cc4df427ae73a34d8b2ae516d1acf4bfe7a8f7e517db586a9f2240e91b621ee4ce25dd0667c562e91eb018870d1f7a996b0b563f54820f91afa1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 17:10:45.927211) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 17:10:45.927595) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1452041252.907826-1235344953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 17:10:46.010220) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 17:10:46.010598) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 17:10:46.011180) ========= ========= Total master_lag: 0.22 =========