builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1452484709.91 results: success (0) buildid: 20160110173002 builduid: 28afae3d45264f9bb6e97f725dd11b69 revision: 55d6be76fac90e93cfd335c68b31d5e42cc158cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:29.915399) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:29.915910) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:29.916250) ========= 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-1452481266.889989-2004671528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006273 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:29.943368) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:29.943700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:29.957535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:29.957948) ========= 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-1452481266.889989-2004671528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:30.008273) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:30.008727) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:30.009311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:30.009792) ========= 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-1452481266.889989-2004671528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-10 19:58:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 62.6M=0s 2016-01-10 19:58:31 (62.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187600 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:30.210380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:30.210723) ========= 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-1452481266.889989-2004671528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016947 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:30.261766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:30.262520) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55d6be76fac90e93cfd335c68b31d5e42cc158cd --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 55d6be76fac90e93cfd335c68b31d5e42cc158cd --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-1452481266.889989-2004671528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-10 19:58:31,595 truncating revision to first 12 chars 2016-01-10 19:58:31,595 Setting DEBUG logging. 2016-01-10 19:58:31,595 attempt 1/10 2016-01-10 19:58:31,596 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55d6be76fac9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-10 19:58:32,203 unpacking tar archive at: fx-team-55d6be76fac9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.912683 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:31.190639) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:31.190994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:31.207378) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:31.207689) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:31.208133) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-10 19:58:31.208451) ========= /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-1452481266.889989-2004671528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:58:32 INFO - MultiFileLogger online at 20160110 19:58:32 in /builds/slave/test-pgo 19:58:32 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 19:58:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:58:32 INFO - {'append_to_log': False, 19:58:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:58:32 INFO - 'blob_upload_branch': 'Fx-Team', 19:58:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:58:32 INFO - 'branch': 'Fx-Team', 19:58:32 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:32 INFO - 'config_files': ('talos/linux_config.py',), 19:58:32 INFO - 'default_actions': ('clobber', 19:58:32 INFO - 'read-buildbot-config', 19:58:32 INFO - 'download-and-extract', 19:58:32 INFO - 'populate-webroot', 19:58:32 INFO - 'create-virtualenv', 19:58:32 INFO - 'install', 19:58:32 INFO - 'run-tests'), 19:58:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:32 INFO - 'download_minidump_stackwalk': True, 19:58:32 INFO - 'download_symbols': 'ondemand', 19:58:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:32 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:32 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:32 INFO - 'installer_path': 'installer.exe', 19:58:32 INFO - 'log_level': 'info', 19:58:32 INFO - 'log_name': 'talos', 19:58:32 INFO - 'log_to_console': True, 19:58:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:58:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:58:32 INFO - 'opt_config_files': (), 19:58:32 INFO - 'pip_index': False, 19:58:32 INFO - 'sps_profile': False, 19:58:32 INFO - 'sps_profile_interval': 0, 19:58:32 INFO - 'suite': 'dromaeojs', 19:58:32 INFO - 'system_bits': '32', 19:58:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:32 INFO - 'title': 'talos-linux64-ix-056', 19:58:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:32 INFO - 'use_talos_json': True, 19:58:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:58:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:32 INFO - 'work_dir': 'build'} 19:58:32 INFO - ##### 19:58:32 INFO - ##### Running clobber step. 19:58:32 INFO - ##### 19:58:32 INFO - Running pre-action listener: _resource_record_pre_action 19:58:32 INFO - Running main action method: clobber 19:58:32 INFO - rmtree: /builds/slave/test-pgo/build 19:58:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:58:33 INFO - Running post-action listener: _resource_record_post_action 19:58:33 INFO - ##### 19:58:33 INFO - ##### Running read-buildbot-config step. 19:58:33 INFO - ##### 19:58:33 INFO - Running pre-action listener: _resource_record_pre_action 19:58:33 INFO - Running main action method: read_buildbot_config 19:58:33 INFO - Using buildbot properties: 19:58:33 INFO - { 19:58:33 INFO - "project": "", 19:58:33 INFO - "product": "firefox", 19:58:33 INFO - "script_repo_revision": "production", 19:58:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:58:33 INFO - "repository": "", 19:58:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:58:33 INFO - "buildid": "20160110173002", 19:58:33 INFO - "pgo_build": "True", 19:58:33 INFO - "basedir": "/builds/slave/test-pgo", 19:58:33 INFO - "buildnumber": 409, 19:58:33 INFO - "slavename": "talos-linux64-ix-056", 19:58:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:58:33 INFO - "platform": "ubuntu64_hw", 19:58:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:58:33 INFO - "branch": "fx-team", 19:58:33 INFO - "repo_path": "integration/fx-team", 19:58:33 INFO - "revision": "55d6be76fac90e93cfd335c68b31d5e42cc158cd", 19:58:33 INFO - "stage_platform": "linux64-pgo", 19:58:33 INFO - "builduid": "28afae3d45264f9bb6e97f725dd11b69", 19:58:33 INFO - "slavebuilddir": "test" 19:58:33 INFO - } 19:58:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:58:33 INFO - Running post-action listener: _resource_record_post_action 19:58:33 INFO - ##### 19:58:33 INFO - ##### Running download-and-extract step. 19:58:33 INFO - ##### 19:58:33 INFO - Running pre-action listener: _resource_record_pre_action 19:58:33 INFO - Running main action method: download_and_extract 19:58:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:33 INFO - https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:58:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/test_packages.json 19:58:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/test_packages.json 19:58:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:58:40 INFO - Downloaded 1302 bytes. 19:58:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:58:40 INFO - Using the following test package requirements: 19:58:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:58:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'jsshell-linux-x86_64.zip'], 19:58:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:58:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:58:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:58:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:58:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:58:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:58: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')]} 19:58:40 INFO - https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-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 19:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-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 19:58:54 INFO - Downloaded 24029761 bytes. 19:58:54 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 19:58:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:54 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 19:58:55 INFO - Return code: 0 19:58:55 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 19:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:55 INFO - https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-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 19:58:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-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 19:58:58 INFO - Downloaded 24029761 bytes. 19:58:58 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 19:58:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:58 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 19:58:59 INFO - Return code: 0 19:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:59 INFO - https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:58:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-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 19:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-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 19:59:01 INFO - Downloaded 11132285 bytes. 19:59:01 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 19:59:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:01 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 19:59:01 INFO - Return code: 0 19:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:01 INFO - https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:59:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-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 19:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-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 19:59:04 INFO - Downloaded 55909247 bytes. 19:59:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:04 INFO - mkdir: /builds/slave/test-pgo/properties 19:59:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:59:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:59:04 INFO - Contents: 19:59:04 INFO - build_url:https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:04 INFO - Running post-action listener: _resource_record_post_action 19:59:04 INFO - Running post-action listener: set_extra_try_arguments 19:59:04 INFO - ##### 19:59:04 INFO - ##### Running populate-webroot step. 19:59:04 INFO - ##### 19:59:04 INFO - Running pre-action listener: _resource_record_pre_action 19:59:04 INFO - Running main action method: populate_webroot 19:59:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:04 INFO - '--tppagecycles', 19:59:04 INFO - '7'], 19:59:04 INFO - 'tests': ['tsvgm']}}, 19:59:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:59:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:59:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:59:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:04 INFO - 'talos_options': ['--e10s'], 19:59:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:04 INFO - 'tests': ['damp', 'tps']}, 19:59:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:04 INFO - 'talos_options': ['--e10s'], 19:59:04 INFO - 'tests': ['damp', 'tps']}, 19:59:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:59:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:04 INFO - 'other': {'tests': ['a11yr', 19:59:04 INFO - 'ts_paint', 19:59:04 INFO - 'tpaint', 19:59:04 INFO - 'sessionrestore', 19:59:04 INFO - 'sessionrestore_no_auto_restore']}, 19:59:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:59:04 INFO - 'tests': ['a11yr', 19:59:04 INFO - 'ts_paint', 19:59:04 INFO - 'tpaint', 19:59:04 INFO - 'sessionrestore', 19:59:04 INFO - 'sessionrestore_no_auto_restore']}, 19:59:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:59:04 INFO - 'tests': ['a11yr', 19:59:04 INFO - 'ts_paint', 19:59:04 INFO - 'tpaint', 19:59:04 INFO - 'sessionrestore', 19:59:04 INFO - 'sessionrestore_no_auto_restore']}, 19:59:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:59:04 INFO - 'tests': ['a11yr', 19:59:04 INFO - 'ts_paint', 19:59:04 INFO - 'tpaint', 19:59:04 INFO - 'sessionrestore', 19:59:04 INFO - 'sessionrestore_no_auto_restore']}, 19:59:04 INFO - 'other_l64': {'tests': ['a11yr', 19:59:04 INFO - 'ts_paint', 19:59:04 INFO - 'tpaint', 19:59:04 INFO - 'sessionrestore', 19:59:04 INFO - 'sessionrestore_no_auto_restore']}, 19:59:04 INFO - 'other_nol64': {'tests': ['a11yr', 19:59:04 INFO - 'ts_paint', 19:59:04 INFO - 'tpaint', 19:59:04 INFO - 'sessionrestore', 19:59:04 INFO - 'sessionrestore_no_auto_restore']}, 19:59:04 INFO - 'svgr': {'tests': ['tsvgx', 19:59:04 INFO - 'tsvgr_opacity', 19:59:04 INFO - 'tart', 19:59:04 INFO - 'tscrollx', 19:59:04 INFO - 'cart']}, 19:59:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:59:04 INFO - 'tests': ['tsvgx', 19:59:04 INFO - 'tsvgr_opacity', 19:59:04 INFO - 'tart', 19:59:04 INFO - 'tscrollx', 19:59:04 INFO - 'cart']}, 19:59:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:04 INFO - 'tests': ['tp5o']}, 19:59:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:04 INFO - 'talos_options': ['--e10s'], 19:59:04 INFO - 'tests': ['tp5o']}, 19:59:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:04 INFO - 'talos_options': ['--xperf_path', 19:59:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:04 INFO - 'tests': ['tp5n']}, 19:59:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:04 INFO - 'talos_options': ['--e10s', 19:59:04 INFO - '--xperf_path', 19:59:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:04 INFO - 'tests': ['tp5n']}}, 19:59:04 INFO - 'talos.zip': {'path': '', 19:59:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:04 INFO - Running post-action listener: _resource_record_post_action 19:59:04 INFO - ##### 19:59:04 INFO - ##### Running create-virtualenv step. 19:59:04 INFO - ##### 19:59:04 INFO - Running pre-action listener: _resource_record_pre_action 19:59:04 INFO - Running main action method: create_virtualenv 19:59:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:59:04 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 19:59:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:59:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:04 INFO - Using real prefix '/usr' 19:59:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:59:05 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:07 INFO - Installing pip.................done. 19:59:07 INFO - Return code: 0 19:59:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:59: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')]} 19:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2447ae2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c840>, '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 0x14796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1479b60>, '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-1452481266.889989-2004671528', '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 19:59: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:59: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 pip>=1.5 19:59:07 INFO - Using env: {'DISPLAY': ':0', 19:59:07 INFO - 'HOME': '/home/cltbld', 19:59:07 INFO - 'LANG': 'en_US.UTF-8', 19:59:07 INFO - 'LANGUAGE': 'en_US:en', 19:59:07 INFO - 'LOGNAME': 'cltbld', 19:59:07 INFO - 'MAIL': '/var/mail/cltbld', 19:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:07 INFO - 'MOZ_NO_REMOTE': '1', 19:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:07 INFO - 'NO_EM_RESTART': '1', 19:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:07 INFO - 'SHELL': '/bin/bash', 19:59:07 INFO - 'SHLVL': '1', 19:59:07 INFO - 'TERM': 'linux', 19:59:07 INFO - 'TMOUT': '86400', 19:59:07 INFO - 'USER': 'cltbld', 19:59:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452481266.889989-2004671528', 19:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:07 INFO - '_': '/tools/buildbot/bin/python'} 19:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:07 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 19:59:07 INFO - Cleaning up... 19:59:07 INFO - Return code: 0 19:59:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:59: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')]} 19:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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', '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 0x7f2447ae2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c840>, '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 0x14796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1479b60>, '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-1452481266.889989-2004671528', '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 19:59: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:59: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 psutil>=0.7.1 19:59:07 INFO - Using env: {'DISPLAY': ':0', 19:59:07 INFO - 'HOME': '/home/cltbld', 19:59:07 INFO - 'LANG': 'en_US.UTF-8', 19:59:07 INFO - 'LANGUAGE': 'en_US:en', 19:59:07 INFO - 'LOGNAME': 'cltbld', 19:59:07 INFO - 'MAIL': '/var/mail/cltbld', 19:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:07 INFO - 'MOZ_NO_REMOTE': '1', 19:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:07 INFO - 'NO_EM_RESTART': '1', 19:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:07 INFO - 'SHELL': '/bin/bash', 19:59:07 INFO - 'SHLVL': '1', 19:59:07 INFO - 'TERM': 'linux', 19:59:07 INFO - 'TMOUT': '86400', 19:59:07 INFO - 'USER': 'cltbld', 19:59:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452481266.889989-2004671528', 19:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:07 INFO - '_': '/tools/buildbot/bin/python'} 19:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:07 INFO - Downloading/unpacking psutil>=0.7.1 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:59:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:59:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:09 INFO - Installing collected packages: psutil 19:59:09 INFO - Running setup.py install for psutil 19:59:09 INFO - building 'psutil._psutil_linux' extension 19:59:09 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 19:59:09 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 19:59:09 INFO - building 'psutil._psutil_posix' extension 19:59:09 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 19:59:09 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 19:59:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:10 INFO - Successfully installed psutil 19:59:10 INFO - Cleaning up... 19:59:10 INFO - Return code: 0 19:59:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:59:10 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')]} 19:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:10 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')]} 19:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:10 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 0x7f2447ae2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c840>, '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 0x14796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1479b60>, '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-1452481266.889989-2004671528', '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 19:59:10 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 19:59:10 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 19:59:10 INFO - Using env: {'DISPLAY': ':0', 19:59:10 INFO - 'HOME': '/home/cltbld', 19:59:10 INFO - 'LANG': 'en_US.UTF-8', 19:59:10 INFO - 'LANGUAGE': 'en_US:en', 19:59:10 INFO - 'LOGNAME': 'cltbld', 19:59:10 INFO - 'MAIL': '/var/mail/cltbld', 19:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:10 INFO - 'MOZ_NO_REMOTE': '1', 19:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:10 INFO - 'NO_EM_RESTART': '1', 19:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:10 INFO - 'SHELL': '/bin/bash', 19:59:10 INFO - 'SHLVL': '1', 19:59:10 INFO - 'TERM': 'linux', 19:59:10 INFO - 'TMOUT': '86400', 19:59:10 INFO - 'USER': 'cltbld', 19:59:10 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452481266.889989-2004671528', 19:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:10 INFO - '_': '/tools/buildbot/bin/python'} 19:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:59:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:59:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:59:12 INFO - Installing collected packages: mozsystemmonitor 19:59:12 INFO - Running setup.py install for mozsystemmonitor 19:59:12 INFO - Successfully installed mozsystemmonitor 19:59:12 INFO - Cleaning up... 19:59:12 INFO - Return code: 0 19:59:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2447ae2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c840>, '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 0x14796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1479b60>, '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-1452481266.889989-2004671528', '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 19:59:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:59:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:59:12 INFO - Using env: {'DISPLAY': ':0', 19:59:12 INFO - 'HOME': '/home/cltbld', 19:59:12 INFO - 'LANG': 'en_US.UTF-8', 19:59:12 INFO - 'LANGUAGE': 'en_US:en', 19:59:12 INFO - 'LOGNAME': 'cltbld', 19:59:12 INFO - 'MAIL': '/var/mail/cltbld', 19:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:12 INFO - 'MOZ_NO_REMOTE': '1', 19:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:12 INFO - 'NO_EM_RESTART': '1', 19:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:12 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:12 INFO - 'SHELL': '/bin/bash', 19:59:12 INFO - 'SHLVL': '1', 19:59:12 INFO - 'TERM': 'linux', 19:59:12 INFO - 'TMOUT': '86400', 19:59:12 INFO - 'USER': 'cltbld', 19:59:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452481266.889989-2004671528', 19:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:12 INFO - '_': '/tools/buildbot/bin/python'} 19:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:12 INFO - Downloading/unpacking blobuploader==1.2.4 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:14 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:59:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:59:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:59:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:14 INFO - Downloading docopt-0.6.1.tar.gz 19:59:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:59:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:14 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:14 INFO - Running setup.py install for blobuploader 19:59:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:59:15 INFO - Running setup.py install for requests 19:59:15 INFO - Running setup.py install for docopt 19:59:15 INFO - Successfully installed blobuploader requests docopt 19:59:15 INFO - Cleaning up... 19:59:15 INFO - Return code: 0 19:59:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:15 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 0x7f2447ae2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c840>, '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 0x14796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1479b60>, '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-1452481266.889989-2004671528', '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 19:59:15 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 19:59:15 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 19:59:15 INFO - Using env: {'DISPLAY': ':0', 19:59:15 INFO - 'HOME': '/home/cltbld', 19:59:15 INFO - 'LANG': 'en_US.UTF-8', 19:59:15 INFO - 'LANGUAGE': 'en_US:en', 19:59:15 INFO - 'LOGNAME': 'cltbld', 19:59:15 INFO - 'MAIL': '/var/mail/cltbld', 19:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:15 INFO - 'MOZ_NO_REMOTE': '1', 19:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:15 INFO - 'NO_EM_RESTART': '1', 19:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:15 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:15 INFO - 'SHELL': '/bin/bash', 19:59:15 INFO - 'SHLVL': '1', 19:59:15 INFO - 'TERM': 'linux', 19:59:15 INFO - 'TMOUT': '86400', 19:59:15 INFO - 'USER': 'cltbld', 19:59:15 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452481266.889989-2004671528', 19:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:15 INFO - '_': '/tools/buildbot/bin/python'} 19:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:15 INFO - Running setup.py (path:/tmp/pip-vSLlW3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:15 INFO - Running setup.py (path:/tmp/pip-8iH3hJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:15 INFO - Running setup.py (path:/tmp/pip-LI7AVZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:15 INFO - Running setup.py (path:/tmp/pip-25SWxy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:16 INFO - Running setup.py (path:/tmp/pip-sIvJwY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:16 INFO - Running setup.py (path:/tmp/pip-oQ8XpL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:16 INFO - Running setup.py (path:/tmp/pip-uE14iY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:16 INFO - Running setup.py (path:/tmp/pip-bBhsnZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:16 INFO - Running setup.py (path:/tmp/pip-VNHeGW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:16 INFO - Running setup.py (path:/tmp/pip-HinA_D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:16 INFO - Running setup.py (path:/tmp/pip-QOcQHh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:16 INFO - Running setup.py (path:/tmp/pip-EbqRdi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:16 INFO - Running setup.py (path:/tmp/pip-gwthZf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:16 INFO - Running setup.py (path:/tmp/pip-mZd542-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:16 INFO - Running setup.py (path:/tmp/pip-Jzs8RH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:16 INFO - Running setup.py (path:/tmp/pip-Ub39xq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:16 INFO - Running setup.py (path:/tmp/pip-QI5yLz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:59:16 INFO - Running setup.py install for manifestparser 19:59:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:59:17 INFO - Running setup.py install for mozcrash 19:59:17 INFO - Running setup.py install for mozdebug 19:59:17 INFO - Running setup.py install for mozdevice 19:59:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:59:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:59:17 INFO - Running setup.py install for mozfile 19:59:17 INFO - Running setup.py install for mozhttpd 19:59:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:59:17 INFO - Running setup.py install for mozinfo 19:59:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:59:17 INFO - Running setup.py install for mozInstall 19:59:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:59:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:59:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:59:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:59:17 INFO - Running setup.py install for mozleak 19:59:17 INFO - Running setup.py install for mozlog 19:59:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:59:18 INFO - Running setup.py install for moznetwork 19:59:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:59:18 INFO - Running setup.py install for mozprocess 19:59:18 INFO - Running setup.py install for mozprofile 19:59:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:59:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:59:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:59:18 INFO - Running setup.py install for mozrunner 19:59:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:59:18 INFO - Running setup.py install for mozscreenshot 19:59:18 INFO - Running setup.py install for moztest 19:59:18 INFO - Running setup.py install for mozversion 19:59:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:59:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:59:18 INFO - Cleaning up... 19:59:18 INFO - Return code: 0 19:59:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:18 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 0x7f2447ae2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c840>, '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 0x14796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1479b60>, '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-1452481266.889989-2004671528', '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 19:59:18 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 19:59:18 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 19:59:18 INFO - Using env: {'DISPLAY': ':0', 19:59:18 INFO - 'HOME': '/home/cltbld', 19:59:18 INFO - 'LANG': 'en_US.UTF-8', 19:59:18 INFO - 'LANGUAGE': 'en_US:en', 19:59:18 INFO - 'LOGNAME': 'cltbld', 19:59:18 INFO - 'MAIL': '/var/mail/cltbld', 19:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:18 INFO - 'MOZ_NO_REMOTE': '1', 19:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:18 INFO - 'NO_EM_RESTART': '1', 19:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:18 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:18 INFO - 'SHELL': '/bin/bash', 19:59:18 INFO - 'SHLVL': '1', 19:59:18 INFO - 'TERM': 'linux', 19:59:18 INFO - 'TMOUT': '86400', 19:59:18 INFO - 'USER': 'cltbld', 19:59:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452481266.889989-2004671528', 19:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:18 INFO - '_': '/tools/buildbot/bin/python'} 19:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:18 INFO - Running setup.py (path:/tmp/pip-APk369-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:19 INFO - Running setup.py (path:/tmp/pip-EEsgOq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:19 INFO - Running setup.py (path:/tmp/pip-HbdzUZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:19 INFO - Running setup.py (path:/tmp/pip-7CFo9i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:19 INFO - Running setup.py (path:/tmp/pip-cyrsyY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:19 INFO - Running setup.py (path:/tmp/pip-S1itQ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:19 INFO - Running setup.py (path:/tmp/pip-yNBhIN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:19 INFO - Running setup.py (path:/tmp/pip-E7uxxA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:19 INFO - Running setup.py (path:/tmp/pip-z58h5h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:19 INFO - Running setup.py (path:/tmp/pip-LaS7JK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:19 INFO - Running setup.py (path:/tmp/pip-MBFuqO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:19 INFO - Running setup.py (path:/tmp/pip-Z_NQf2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:19 INFO - Running setup.py (path:/tmp/pip-riKO5a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:19 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)) 19:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:19 INFO - Running setup.py (path:/tmp/pip-8uKe5h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:20 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)) 19:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:20 INFO - Running setup.py (path:/tmp/pip-nPLyA9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:20 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)) 19:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:20 INFO - Running setup.py (path:/tmp/pip-tcIrIJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:20 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)) 19:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:20 INFO - Running setup.py (path:/tmp/pip-UxNSug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:20 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)) 19:59:20 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)) 19:59:20 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)) 19:59:20 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)) 19:59:20 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)) 19:59:20 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)) 19:59:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:20 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 19:59:20 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 19:59:20 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 19:59:20 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 19:59:20 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 19:59:20 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 19:59:21 INFO - Downloading blessings-1.5.1.tar.gz 19:59:21 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 19:59:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:59:22 INFO - Installing collected packages: blessings 19:59:22 INFO - Running setup.py install for blessings 19:59:22 INFO - Successfully installed blessings 19:59:22 INFO - Cleaning up... 19:59:22 INFO - Return code: 0 19:59:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:59:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:59:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:59:22 INFO - Reading from file tmpfile_stdout 19:59:22 INFO - Current package versions: 19:59:22 INFO - argparse == 1.2.1 19:59:22 INFO - blessings == 1.5.1 19:59:22 INFO - blobuploader == 1.2.4 19:59:22 INFO - docopt == 0.6.1 19:59:22 INFO - manifestparser == 1.1 19:59:22 INFO - mozInstall == 1.12 19:59:22 INFO - mozcrash == 0.16 19:59:22 INFO - mozdebug == 0.1 19:59:22 INFO - mozdevice == 0.47 19:59:22 INFO - mozfile == 1.2 19:59:22 INFO - mozhttpd == 0.7 19:59:22 INFO - mozinfo == 0.9 19:59:22 INFO - mozleak == 0.1 19:59:22 INFO - mozlog == 3.1 19:59:22 INFO - moznetwork == 0.27 19:59:22 INFO - mozprocess == 0.22 19:59:22 INFO - mozprofile == 0.28 19:59:22 INFO - mozrunner == 6.11 19:59:22 INFO - mozscreenshot == 0.1 19:59:22 INFO - mozsystemmonitor == 0.0 19:59:22 INFO - moztest == 0.7 19:59:22 INFO - mozversion == 1.4 19:59:22 INFO - psutil == 3.1.1 19:59:22 INFO - requests == 1.2.3 19:59:22 INFO - wsgiref == 0.1.2 19:59:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:22 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')]} 19:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:22 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')]} 19:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:22 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 0x7f2447ae2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c840>, '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 0x14796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1479b60>, '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-1452481266.889989-2004671528', '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 19:59:22 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 19:59:22 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 19:59:22 INFO - Using env: {'DISPLAY': ':0', 19:59:22 INFO - 'HOME': '/home/cltbld', 19:59:22 INFO - 'LANG': 'en_US.UTF-8', 19:59:22 INFO - 'LANGUAGE': 'en_US:en', 19:59:22 INFO - 'LOGNAME': 'cltbld', 19:59:22 INFO - 'MAIL': '/var/mail/cltbld', 19:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:22 INFO - 'MOZ_NO_REMOTE': '1', 19:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:22 INFO - 'NO_EM_RESTART': '1', 19:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:22 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:22 INFO - 'SHELL': '/bin/bash', 19:59:22 INFO - 'SHLVL': '1', 19:59:22 INFO - 'TERM': 'linux', 19:59:22 INFO - 'TMOUT': '86400', 19:59:22 INFO - 'USER': 'cltbld', 19:59:22 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452481266.889989-2004671528', 19:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:22 INFO - '_': '/tools/buildbot/bin/python'} 19:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:22 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)) 19:59:22 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)) 19:59:22 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)) 19:59:22 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)) 19:59:22 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)) 19:59:22 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)) 19:59:22 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)) 19:59:22 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)) 19:59:22 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)) 19:59:22 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)) 19:59:22 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)) 19:59:22 INFO - Cleaning up... 19:59:22 INFO - Return code: 0 19:59:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:59:22 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')]} 19:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:22 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')]} 19:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:22 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 0x7f2447ae2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c840>, '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 0x14796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1479b60>, '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-1452481266.889989-2004671528', '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 19:59:22 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 19:59:22 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 19:59:22 INFO - Using env: {'DISPLAY': ':0', 19:59:22 INFO - 'HOME': '/home/cltbld', 19:59:22 INFO - 'LANG': 'en_US.UTF-8', 19:59:22 INFO - 'LANGUAGE': 'en_US:en', 19:59:22 INFO - 'LOGNAME': 'cltbld', 19:59:22 INFO - 'MAIL': '/var/mail/cltbld', 19:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:22 INFO - 'MOZ_NO_REMOTE': '1', 19:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:22 INFO - 'NO_EM_RESTART': '1', 19:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:22 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:22 INFO - 'SHELL': '/bin/bash', 19:59:22 INFO - 'SHLVL': '1', 19:59:22 INFO - 'TERM': 'linux', 19:59:22 INFO - 'TMOUT': '86400', 19:59:22 INFO - 'USER': 'cltbld', 19:59:22 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452481266.889989-2004671528', 19:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:22 INFO - '_': '/tools/buildbot/bin/python'} 19:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:22 INFO - Downloading/unpacking jsonschema 19:59:22 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 19:59:22 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 19:59:22 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 19:59:22 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 19:59:22 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 19:59:22 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 19:59:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:24 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 19:59:24 INFO - Downloading/unpacking functools32 (from jsonschema) 19:59:24 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 19:59:24 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 19:59:24 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 19:59:24 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 19:59:24 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 19:59:24 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 19:59:24 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:59:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:24 INFO - warning: no files found matching '*.txt' 19:59:24 INFO - no previously-included directories found matching 'build' 19:59:24 INFO - no previously-included directories found matching 'dist' 19:59:24 INFO - no previously-included directories found matching '.git*' 19:59:24 INFO - Installing collected packages: jsonschema, functools32 19:59:24 INFO - Running setup.py install for functools32 19:59:24 INFO - warning: no files found matching '*.txt' 19:59:24 INFO - no previously-included directories found matching 'build' 19:59:24 INFO - no previously-included directories found matching 'dist' 19:59:24 INFO - no previously-included directories found matching '.git*' 19:59:25 INFO - Successfully installed jsonschema functools32 19:59:25 INFO - Cleaning up... 19:59:25 INFO - Return code: 0 19:59:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:59:25 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')]} 19:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:25 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')]} 19:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:25 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 0x7f2447ae2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c840>, '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 0x14796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1479b60>, '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-1452481266.889989-2004671528', '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 19:59:25 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 19:59:25 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 19:59:25 INFO - Using env: {'DISPLAY': ':0', 19:59:25 INFO - 'HOME': '/home/cltbld', 19:59:25 INFO - 'LANG': 'en_US.UTF-8', 19:59:25 INFO - 'LANGUAGE': 'en_US:en', 19:59:25 INFO - 'LOGNAME': 'cltbld', 19:59:25 INFO - 'MAIL': '/var/mail/cltbld', 19:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:25 INFO - 'MOZ_NO_REMOTE': '1', 19:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:25 INFO - 'NO_EM_RESTART': '1', 19:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:25 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:25 INFO - 'SHELL': '/bin/bash', 19:59:25 INFO - 'SHLVL': '1', 19:59:25 INFO - 'TERM': 'linux', 19:59:25 INFO - 'TMOUT': '86400', 19:59:25 INFO - 'USER': 'cltbld', 19:59:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452481266.889989-2004671528', 19:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:25 INFO - '_': '/tools/buildbot/bin/python'} 19:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:25 INFO - Downloading/unpacking flake8 19:59:25 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 19:59:25 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 19:59:25 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 19:59:25 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 19:59:25 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 19:59:25 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 19:59:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:59:26 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 19:59:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:59:26 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 19:59:26 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 19:59:26 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 19:59:26 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 19:59:26 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 19:59:26 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 19:59:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:59:27 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 19:59:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:59:27 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 19:59:27 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 19:59:27 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 19:59:27 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 19:59:27 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 19:59:27 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 19:59:27 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 19:59:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:59:27 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 19:59:27 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 19:59:27 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 19:59:27 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 19:59:27 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 19:59:27 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 19:59:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:59:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:27 INFO - no previously-included directories found matching 'docs/_build' 19:59:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:59:27 INFO - Running setup.py install for pep8 19:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:27 INFO - no previously-included directories found matching 'docs/_build' 19:59:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:59:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:59:27 INFO - Cleaning up... 19:59:27 INFO - Return code: 0 19:59:27 INFO - Running post-action listener: _resource_record_post_action 19:59:27 INFO - Running post-action listener: _start_resource_monitoring 19:59:27 INFO - Starting resource monitoring. 19:59:27 INFO - ##### 19:59:27 INFO - ##### Running install step. 19:59:27 INFO - ##### 19:59:27 INFO - Running pre-action listener: _resource_record_pre_action 19:59:27 INFO - Running main action method: install 19:59:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:59:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:59:28 INFO - Reading from file tmpfile_stdout 19:59:28 INFO - Detecting whether we're running mozinstall >=1.0... 19:59:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:59:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:59:28 INFO - Reading from file tmpfile_stdout 19:59:28 INFO - Output received: 19:59:28 INFO - Usage: mozinstall [options] installer 19:59:28 INFO - Options: 19:59:28 INFO - -h, --help show this help message and exit 19:59:28 INFO - -d DEST, --destination=DEST 19:59:28 INFO - Directory to install application into. [default: 19:59:28 INFO - "/builds/slave/test-pgo"] 19:59:28 INFO - --app=APP Application being installed. [default: firefox] 19:59:28 INFO - mkdir: /builds/slave/test-pgo/build/application 19:59:28 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'] 19:59:28 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 19:59:44 INFO - Reading from file tmpfile_stdout 19:59:44 INFO - Output received: 19:59:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:59:44 INFO - Running post-action listener: _resource_record_post_action 19:59:44 INFO - ##### 19:59:44 INFO - ##### Running run-tests step. 19:59:44 INFO - ##### 19:59:44 INFO - Running pre-action listener: _resource_record_pre_action 19:59:44 INFO - Running main action method: run_tests 19:59:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:59:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:59:44 INFO - Python 2.7.3 19:59:44 INFO - Return code: 0 19:59:44 INFO - grabbing minidump binary from tooltool 19:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:44 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 0x150c840>, '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 0x14796b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1479b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:59:44 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 19:59:44 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 19:59:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:44 INFO - Return code: 0 19:59:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:59:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:59:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:59:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:59:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:59:45 INFO - Return code: 0 19:59:45 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/W9q1xNFtTrajvqSKXlrR-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 19:59:45 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/W9q1xNFtTrajvqSKXlrR-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 19:59:45 INFO - Using env: {'DISPLAY': ':0', 19:59:45 INFO - 'HOME': '/home/cltbld', 19:59:45 INFO - 'LANG': 'en_US.UTF-8', 19:59:45 INFO - 'LANGUAGE': 'en_US:en', 19:59:45 INFO - 'LOGNAME': 'cltbld', 19:59:45 INFO - 'MAIL': '/var/mail/cltbld', 19:59:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:45 INFO - 'MOZ_NO_REMOTE': '1', 19:59:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:45 INFO - 'NO_EM_RESTART': '1', 19:59:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:59:45 INFO - 'SHELL': '/bin/bash', 19:59:45 INFO - 'SHLVL': '1', 19:59:45 INFO - 'TERM': 'linux', 19:59:45 INFO - 'TMOUT': '86400', 19:59:45 INFO - 'USER': 'cltbld', 19:59:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452481266.889989-2004671528', 19:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:45 INFO - '_': '/tools/buildbot/bin/python'} 19:59:45 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/W9q1xNFtTrajvqSKXlrR-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 19:59:45 INFO - mozversion application_buildid: 20160110173002 19:59:45 INFO - mozversion application_changeset: 55d6be76fac90e93cfd335c68b31d5e42cc158cd 19:59:45 INFO - mozversion application_display_name: Nightly 19:59:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:45 INFO - mozversion application_name: Firefox 19:59:45 INFO - mozversion application_remotingname: firefox 19:59:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:59:45 INFO - mozversion application_vendor: Mozilla 19:59:45 INFO - mozversion application_version: 46.0a1 19:59:45 INFO - mozversion platform_buildid: 20160110173002 19:59:45 INFO - mozversion platform_changeset: 55d6be76fac90e93cfd335c68b31d5e42cc158cd 19:59:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:59:45 INFO - mozversion platform_version: 46.0a1 19:59:45 INFO - using testdate: 1452484785 19:59:45 INFO - actual date: 1452484785 19:59:45 INFO - starting webserver on 'localhost:39440' 19:59:45 INFO - SUITE-START | Running 3 tests 19:59:45 INFO - TEST-START | dromaeo_css 19:59:45 INFO - operating with platform_type : linux_ 19:59:45 INFO - Initialising browser for dromaeo_css test... 19:59:45 INFO - TEST-INFO | started process 11519 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP0mCuH/profile http://localhost:39440/getInfo.html) 19:59:50 INFO - PROCESS | 11519 | __metrics Screen width/height:1600/1200 19:59:50 INFO - PROCESS | 11519 | colorDepth:24 19:59:50 INFO - PROCESS | 11519 | Browser inner width/height: 1024/697 19:59:50 INFO - PROCESS | 11519 | __metrics 19:59:50 INFO - PROCESS | 11519 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:59:51 INFO - PROCESS | 11519 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:59:51 INFO - PROCESS | 11519 | 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. 19:59:51 INFO - TEST-INFO | 11519: exit 0 19:59:51 INFO - Browser initialized. 19:59:51 INFO - Running cycle 1/1 for dromaeo_css test... 19:59:51 INFO - TEST-INFO | started process 11618 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP0mCuH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:03 INFO - PROCESS | 11618 | RSS: Main: 147488768 20:00:03 INFO - PROCESS | 11618 | 20:00:55 INFO - PROCESS | 11618 | 1452484855097 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] 20:03:03 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:39440/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39440/tests/dromaeo/cssquery-ext.html) 20:03:04 INFO - PROCESS | 11618 | RSS: Main: 231399424 20:03:04 INFO - PROCESS | 11618 | 20:06:07 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:39440/tests/dromaeo/cssquery-ext.html (next: http://localhost:39440/tests/dromaeo/cssquery-jquery.html) 20:06:07 INFO - PROCESS | 11618 | RSS: Main: 240676864 20:06:07 INFO - PROCESS | 11618 | 20:09:10 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:39440/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39440/tests/dromaeo/cssquery-mootools.html) 20:09:10 INFO - PROCESS | 11618 | RSS: Main: 231809024 20:09:10 INFO - PROCESS | 11618 | 20:12:12 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:39440/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39440/tests/dromaeo/cssquery-prototype.html) 20:12:13 INFO - PROCESS | 11618 | RSS: Main: 220262400 20:12:13 INFO - PROCESS | 11618 | 20:15:15 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:39440/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39440/tests/dromaeo/cssquery-yui.html) 20:15:16 INFO - PROCESS | 11618 | RSS: Main: 221896704 20:15:16 INFO - PROCESS | 11618 | 20:18:18 INFO - PROCESS | 11618 | Cycle 1(1): loaded http://localhost:39440/tests/dromaeo/cssquery-yui.html (next: http://localhost:39440/tests/dromaeo/cssquery-dojo.html) 20:18:19 INFO - PROCESS | 11618 | RSS: Main: 271712256 20:18:19 INFO - PROCESS | 11618 | 20:18:19 INFO - PROCESS | 11618 | __start_tp_report 20:18:19 INFO - PROCESS | 11618 | _x_x_mozilla_page_load 20:18:19 INFO - PROCESS | 11618 | _x_x_mozilla_page_load_details 20:18:19 INFO - PROCESS | 11618 | |i|pagename|runs| 20:18:19 INFO - PROCESS | 11618 | |0;dojo.html;3086.1050295414325;3114.6106736657916;3146.968530314696;3155.2427417419826;3163.5729176561163;4964.304997300381;5024.598032157423;5040.294358789773;5054.115529782287;5071.16325806242;5011.373578302712;5054.444011158779;5107.080725469414;5108.948910510894;5140.691558506493;4442.577955094261;4560.133574620828;4598.816047358102;4634.629229661636;4716.646251531131;4514.932276015862;4642.489326174118;4675.906481870361;4688.531146885318;4781.6413768967295;4545.204589196877;4627.930581041287;4644.4658864230705;4649.5815376616265;4657.906841863144;4583.427071616048;4612.58486736192;4612.630989520831;4637.698549594265;4669.486356500782;4554.453465584118;4629.398178236807;4643.233866412038;4649.860504184846;4686.2267725825195;4954.355933728628;4955.776990035457;4960.032793605248;4963.354763880709;4971.1549036663855;5414.025475414423;5442.809501667462;5443.945560544384;5444.863878403072;5454.59090568209;5327.280817089682;5457.045017121988;5518.392976772552;5518.944810551883;5535.169724541351;5080.415752188509;5081.771320290596;5082.085224659597;5093.414257360414;5100.897982040338;5394.244805727123;5473.507384335429;5530.723463826873;5533.114701647717;5537.723113844291;5217.947820521822;5262.894742105136;5358.008768377863;5372.167314066326;5379.246905433242;5394.595405344615;5397.190421436816;5402.648827826258;5410.864728381822;5410.8917821643345;5287.4976877196605;5358.33020872391;5391.406945236021;5397.4062853086125;5442.591805614595;5356.651817631841;5404;5420.945790542044;5422.728863556807;5443.972780136153;4255.106427650167;4262.147570485915;4267.061246525759;4284.421603083606;4295.183915056129;3750.512433383697;3829;3832.4826148470156;3861.092643228839;3871.787051712183;5042.369703787027;5042.445331013586;5144.845654630367;5162.354705661793;5168.8449346519665;5475.753591088411;5498.670079795225;5504.174373843955;5508.421615730371;5508.44915508446;4959.82640607577;5053.545180933734;5105.463926287686;5108.157154069611;5138.743062846843;4635.1656701794;4665.813367465264;4699.036697477009;4724.881877953078;4768.451628062817;5593.664380137205;5600.383957764561;5605.635633683797;5611.410801865745;5645.153227015899;5273.762680679302;5398.217258497574;5442.183672449164;5451.727413629382;5458.235846981505;5572;5628.915566266591;5682.9431705684065;5725;5739.426057394394;5441.5102640762525;5459.945400546103;5461.208124821799;5461.617686761889;5469.343678758574;5462;5522.22688823557;5535.861603459945;5538.723063846711;5577.860553486195;5152.742362881916;5204.531592156724;5249.527542521191;5310.044192045469;5316.548093412103;5254.527092561688;5289.338832645919;5299.046171688979;5301.867453313698;5309.707966061904;5171.198464238049;5180.922286165635;5185.714785686823;5188.766505507337;5227.790888364423;5235.476452354734;5326.147816349366;5363.302770639948;5371.865703357447;5394.406615272395;5230.189320655304;5252.44849290819;5254.816081437131;5254.842354729364;5279.736013199402 20:18:19 INFO - PROCESS | 11618 | |1;ext.html;526.7682219823278;533.7384681506061;544.7031367904492;549.9862503437414;567.9858003549913;28261.43477130456;28824.56763148552;36382.63617363832;36592.45111323329;36803.07992300194;39663;40018.399724004164;40093.59906400935;40145.39781903267;40260.79869600648;7312.488125831194;7482.802751559751;8265.586720663972;8451.57742112895;8464.280536154403;9986.950065249664;10257.38455692657;10259.127974122208;10263.230257730662;10269.075783179513;9986.700398988041;10108.09027187553;10112.140468060186;10115.848262276035;10121.595136194543;7604.847903041936;7783.883241751379;9850.064243896853;10003.249756268237;10259.127974122208;9793.755156121155;9932.90067099327;9938.105570498617;9941.850872236922;9943;36572.81713591442;36766.080847978745;36968.07579810499;37020.629793701984;37037.62962370396;3280.475123980176;3417.2994536120036;3494.5981212160673;4001.9599804001878;4054.2499637567144;27609.447811043665;27838.3040423989;27852.582211266847;30821.845890770626;30921.226969325722;3952.7035472339403;3988.700847436454;3992.8003599819895;4036.6972477064046;4122.134351786129;266352;270174;271061;272311;273644.6317768418;53499.930001399756;54444.45555544473;58581;59039.40960590425;59379.109313360335;64207;65622;65652.67173664196;65706;65739.34260657428;15776.76334854978;16150.434734784227;16153;16160.67678646444;16164;11321.547138114547;11335.206535542433;11358.148138889615;11359;11360.091192704564;19210.00566696158;19539.873620220696;19546.70679939802;19572.412827615193;19629.116689748997;7318.707251709979;7427.925720742724;7526.09686837572;7556.395488360918;7580.279873412017;957.6025949230991;965.2278177458005;971.1405406215409;979.6718099436627;1134.2513940799033;27755.306117346823;28204.71795282021;28411.431771364456;28487.430251394857;28494.43011139807;1041.1150522056191;1053.8313869780798;1055.1875056206677;1109.1237922041496;1126.6507382711386;14456.20490873012;14644.780328295084;14718.926405367905;14984.250787460584;15069.924650376677;323445;328907;329766;329934;330389;51184.48815511871;51358.22962655563;51617;51620.48379516232;51651.483485165416;1311.4754098360731;1323.8676132386684;1328.8804007639164;1330.3082397153619;1337.2979185927272;27623.585646215724;28149.155525334274;28570.42859142847;28620.284492887844;28620.713792861803;45672.31491527696;46021.76989115167;46029;46085.53914460813;46089;310560.6023488029;312188;312290.1927451741;313217;313933;26749.866250668623;29097;31761.523577146825;31922;31939.840300798347;38702;39240;40360.3945940817;40387.798061009504;40423.191536168524;34826;34875.825620871736;35178.82410587931;35219.47170792389;35246.471302930986;30061.699383006766;34092.488612671325;34989.825050874584;35274;36791.81604091962;31903.202419939687;32045.83977080193;32071.839640801645;32075.839620801748;32098.6790132105;26930.730692693607;31897.840510797298;31992.520112198803;32195.678043219268;32303;23714.762852371256;23962;24122.75877241205;24406.26781196567;24678.383040424134 20:18:19 INFO - PROCESS | 11618 | |2;jquery.html;357.18027127741846;358.51242310457775;360.89173248025594;363.90720366306596;367.0603255665498;13544.796828047587;13994.510192143278;16165.919170404146;16174.514764557052;16925.49223523293;13293.202407855535;13712.17726936382;15058.247087645628;15846.3661453542;15855.127967961758;4672.929906051412;5090.592752579803;5462.863428414302;5464.9453505465035;5472.753726082316;3674.1365779041903;3833.7508061976023;5339.519443250107;6365.395287447685;6858.588484690909;6563.4247780532805;6723.966380168093;6842.213145488258;6852.143482064742;6857.108575885128;6451.870962580722;6761.729530818761;6778.186617605869;6804.319568043181;6812.965935170318;6505.349465053457;6509.088727578142;6511.576747511396;6513.706883190268;6519.282878883319;21228.257011004695;21730.8067200847;21747;22049.889750551305;22261.44346391337;2160.5570857974076;2252.887355632212;2431.8176136789634;2436.817238707104;2473.579491486452;13362.933185334108;13707.520236791665;13916.652083697887;13970.511032113827;14212.818545131908;1919.9520011999673;2024.4533975826444;2036.7352244208307;2036.9694454583193;2056.7429071366078;62389.68805156036;63767;63867.680661596394;63962;64055;14537;14706.426375384479;14780.852191478163;14821.77767333491;14834.554963351116;22626.208082717025;23042.769572304398;23065.423364416023;23150.07399703993;23174.53650926972;7244.963775181196;7452.703039983961;7686.385089192851;7723.729669461542;8947.792048073557;7470.402367810562;7486.288802563748;7555.659995300225;7595.772126836093;7603.847923041619;4158.563350848178;4292.849750258726;4392.099619577979;4478.753668548261;4517.864464066083;1757.1302205408404;1776.8845025073329;1793.704038833578;1861.26480040386;1862.422648978821;464.34991012582657;810.4772421787914;990.2869933647762;1001.6344034427527;1009.4195837393381;9875;9982.950085249673;10312.690619281433;10356.741081473023;10819.404932728617;403.98586049488125;415.27119904567894;429.1695569073852;436.6921320469062;461.3356766256647;5531.944680553223;5547.694876781735;5590.2453168821685;5695.743691533891;5719.170720245625;504469;522973;523382;527729;544272;69121.65439172772;70524.2947570528;70611.64694176496;72277.63861180766;75682.24317756863;460.7143570985943;469.69235150976164;471.7429001194289;472.45431526586844;472.6077355794682;9268.72193834186;9548.37935534188;9585.952070239604;9798.75503112428;9842.507874606097;29601.703982959894;30139.69860301369;30192.09423717292;30771;31181.376372472878;37867.431988520744;39812;40696.59303406928;41509.79245103755;42643.78678106589;7109.253528379652;7210.9278907210255;7258.383037441877;7496.4002879768395;7553.357964572853;8385;10153.695389138338;10641.414722190353;10969.561217551527;11405.828912566483;9385.765355866159;9402.670906518239;9421.481818500048;9586.424814511152;9767;7857;9940.502974851373;9949.875813955963;10158.847617285599;10420.11429028541;7876.488028278143;9121.498317592595;9632.47021413829;10074.44590547527;10144.64493742745;7153.463490238357;7311.524750891175;7400.925990740024;7510.098788145458;7513.812154696177;8721.21509064162;9553.761155970878;9686.897254729476;9802.215822734022;9913.900860991298 20:18:19 INFO - PROCESS | 11618 | |3;mootools.html;1360.0207850347758;1416.7308211439827;1444.1768192130482;1589.6170331811327;1796.2635319519;6660.100886380344;7088.3620474157315;7190.748323808668;7226.349628533438;7228.349448549629;7110.715571377139;7306.123265208183;7308.890366644505;7318.780436586911;7325.963370183142;2273.5793878132517;2303.8387312888103;2304.72343318802;2306.7116610423695;2307.0310469602723;2249.6063188941953;2278.4759505313787;2286.554121946221;2287.931362059141;2294.724633044037;2233.910643574255;2238.0600147937907;2251.4258863989658;2259.7401298850596;2261.027758064032;2249.325202439262;2285.5771682238837;2289.0386037864137;2291.324059402472;2292.4498120451053;2239.328201539548;2243.450354663118;2244.5510897820336;2245.315178870444;2245.8427910046303;7203.495755297131;7261.854762904765;7262.019627350346;7269.491135620508;7310.671019804122;4597.793099310539;4739.810407583693;4742.359781429497;4771.6898401603785;4773.403324584427;2971.1532213319315;3009.4733421651345;3082.029160814336;3105.673904240045;3126.0778070469037;918.967836125739;956.1346980982222;971.2958105373618;1001.4191768774093;1004.9648262310784;10142.543585538668;10149.543270552844;10164.085232329126;10175.185985121172;10189.694309170736;4282.850100246476;4314.158739045919;4353.521112677603;4363.2364336241035;4383.035732138925;8813.118688131135;8820.073892241351;8827;8833.205011548991;8837.381383303236;4755.643326750507;4786.44955830077;4787.2101103318255;4790.568848803624;4795.184818580849;3683.9447408288897;3779.640934111255;4136.586341365839;4222.387753775685;4307.375430562551;3682.779033258013;3709.387950988111;3710.870119545803;3743.232637309345;3751.493548370935;1120.994395028036;1212.1393660730737;1231.1074471008626;1231.9322437266037;1239.876012398753;895.7312806158127;1033.4419413516766;1074.0977578833817;1114.765899161169;1274.1272228523492;6849.554778939353;6860.6912688929115;6870.416014638712;6909.447244220451;6931.272216417305;1097.9231453798318;1110.6168371911679;1118.2284223885656;1126.971825704364;1147.4549588945351;5238.60710446718;5330.653507521999;5334.5732341412595;5345.278387417727;5349.839504814861;8475.27960123384;8499.36254780894;8500;8502.787430314167;8646.827063458695;8468.745937621881;8563.357748168912;8569.80022796809;8578.09929957358;8579;6810.795676129724;6839.213490448563;6945.16658001033;6968.581885086911;7002.75490357835;6773.7129945310235;6791.185057793096;6824.829379265359;6831.487638427038;6834.931650683429;7753.457257991887;8087.110417854149;8117.350611951148;8132.1461246570625;8136.837263254583;8068.596570171585;8211.58942052883;8226;8397.790055248423;8412.369072319723;6366.331535188739;6392.552521323462;6475.773347932988;6681.9642955342;6775.4240889524945;6918.584884906922;7061.187963384276;7072.9646351767915;7122.112640150261;7135.108111486064;5855.268091488564;6657.73369065232;6724.125863637892;6799.898001529882;6819.318068193339;6316.273628532777;6665.700043497957;6670.866582668416;6769.729210831709;6775;6554.868902622016;6564.081028655896;6570.605763654196;6603.306652801387;6629.834254143685;6114.113453549299;6173.104899789595;6178.845528861814;6183.783567575113;6191.349908259748;6013.098035294566;6213;6283.96858015707;6299.464545513682;6400 20:18:19 INFO - PROCESS | 11618 | |4;prototype.html;342.30512060517145;349.18291198595284;352.56810407251123;353.57041194948135;356.80732404501555;5884.999550076486;5917.792877249297;5928.347881733006;5951.166836642863;5959.642421454705;5675.6878371689545;5727.140928860663;5824.504917082053;5836.15375770514;5919.467247947684;4596.402467679197;4618.607418369443;4624.283236098393;4625.791839367236;4643.558861908114;4611.239145540982;4620.907581848361;4629.467611224702;4636.6058884994645;4643.88390290242;4362.280223763075;4445.488768791582;4446.733196008234;4449.911001779962;4464.73211607303;4453.910921781562;4506.59440650343;4521.208788462006;4523.344115103325;4545.340925565791;4006.338954072604;4008.318585840414;4010.0776821331256;4015.959840401588;4044.1911617676287;5655.236543066674;5683.886322273573;5685.829425117253;5688.317401911756;5692.089265717506;5101.438841727407;5246.685198888079;5271.65734227274;5287.788488460457;5298.09932311508;6278.183836101278;6278.4035516625845;6278.780242691484;6286.402791734778;6291.339409362043;4407.801648925806;4411.42651455312;4413;4414.514403415622;4419.447569053868;6454.709538070798;6504.1869766279215;6572.967135164294;6576.473882089469;6588.275289718127;4502.144592527409;4508.07584445188;4511.571400716926;4514.232580461329;4515.841945531891;4557.339185818038;4562.110388474282;4568.977155114269;4569.223232050559;4572.862814115582;5250.474952504719;5253.947460525423;5261.657992230493;5285.709285989231;5311.760970756325;6220.377962203834;6338.049292606146;6344;6357.904631430532;6358.427741503287;1591.7214487464648;1616.2807550640086;1616.9353225871068;1617;1617.8220395756457;1079.7894410589859;1087.505185140759;1088.50473034769;1103.773726386089;1108.0858291909208;6001.2498437695285;6004.579679422399;6012.338642749294;6018.488428483628;6018.638881667114;6519.7392104315295;6524.869502609921;6525.11910892033;6525.151730275129;6532.183477065367;5803.767849286066;5836.649801011953;5958.374370691102;6018.067199584071;6022.397760223943;3494.5631796025496;3516.841742121611;3517.050396393011;3525.7531972761662;3527.5590551181103;6730.8653826924165;6733.293004234582;6739.797806065826;6743.932560674429;6754.5947243165565;6544.051112588648;6759.662016899136;6769.255381907986;6791.966040169867;6792.42264407521;6737.69680364375;6740.292269311652;6746.561473504206;6747.05541224229;6748.291429400038;6507.511936604679;6509.056186852785;6541.149650545589;6541.34586541342;6578.868422631424;6320.778772742932;6481.287058423664;6491.902621460777;6499.057636642755;6502.934970650422;6781.152355955505;6786.3892249697765;6790.7623233186605;6794.660266986532;6799.252082271045;4536.183486972377;4536.614387776944;4537.795799188978;4540.409746732904;4541.704789188692;6429.646369449725;6581.276059633341;6592.70332835014;6603.702833372414;6609.636469994197;6356.459700925288;6383.553151279366;6389.169407976933;6391.968040159955;6408.1349017881985;6354.951433013686;6364.427201551883;6365.904511432424;6371.203599550056;6375.5218358624215;6149.569530132848;6209.937900621117;6245.875082498415;6251.593646412968;6255.093011513396;6384.457321127757;6389.4888408926245;6391.520635952415;6396.776112836028;6412.743490260337;6258.530610204344;6262.185915830913;6267.905981410374;6268.279147897868;6278 20:18:19 INFO - PROCESS | 11618 | |5;yui.html;790.2532107158736;808.6482380164629;814.2346194577101;817.7873752824265;837.644001299448;13321.666958326046;13424.328783560819;13478.393472293747;13502.12236204646;13505.527306544273;12316.63050108496;12548.247105173696;12571.748565028694;12592.93703531481;12613;670.8557660103077;682.4881338995754;801.7835184500196;809.1988930958368;811.3630799822112;808.3815880851154;813.1055838577577;819.6434550970317;820.4216027700456;820.6143112737004;847.4957400346784;856.1267507142711;858.2704701004159;859.5358506406565;864.2092485375905;689.7447944260606;694.4375056204465;839.6221700234858;855.5978690015683;861.9396642235046;627.4196368359295;627.6171535363425;627.8555932135635;629.2197674883158;630.0391902348908;12961.898238649726;13062.542811001664;13068.215907045607;13071.54249601269;13110.672233194151;11887.583934562335;12260.203086799329;12402.814142665797;12411.503539858395;12497.250164990039;10361.119304859096;10416.947915260374;10602.204834637432;10706;10904.400257985808;3632.346177688015;3690.15126520899;3711.870084547055;3792.810359482015;3802.8098595070137;44445.111097777866;46516;46701.5329846704;46991.29513057307;47058.76470617625;9153.81692366149;9512.38169518993;9645.324827262024;9749.707508774749;9864.753381165385;17403.825961740222;17613.119344033003;17632.911835441;17658.823411765974;17746.911265443847;7110.786676399716;7197.388222001084;7249.637518124073;7250.927490725026;7330.340269375782;4360.040791025969;4372.781360931941;4381.539938306496;4392.407025051577;4437.800298986554;3012.0361484325244;3034.5903303054247;3035.9241018974703;3038.8176709397067;3043.208765720884;561.2479277767811;562.4853259267805;568.5707290995272;569.5898952754011;580.9331926828385;584.6638183044766;634.3592971099223;646.2083947164685;654.5810681163964;708.3270892652001;8169.428140030141;8243.505389676639;8276.875846862302;8414.621342039623;8474.74575762728;548.9149181876816;577.890200861835;612.2805703298607;655.5935320101568;686.0909295183901;3603.801790901473;3692.464592634107;3807.71392894986;3813.923721525554;3899.200663863901;53310;56489.90238390397;56706.43293567094;58031.419685802604;58339.708301458224;47391.52608473871;47957.76021119872;49937.250941235914;50086.499135008184;50278;44968.55031449709;45057.549424505334;45116.77441612836;45117.32324015077;46073.30890036652;7666.655000524878;8147.144549822184;8183.468074575134;8269.2971097455;8456.746297611082;31565.526517101804;33094.33811323808;33120.337593248485;33178.33643327168;33766.15584610404;43871.56128438675;44045.33931990959;44048.55951440445;44353.55646443494;44882.77558612316;11125.221234513507;11128.276662016942;11151.107911367233;11251.887481125084;11565.94217028943;11845.466953987263;12165.33090680021;12170.14808963364;12215.511379545074;12252.877471225174;11133.888661113286;11480.196386252883;11506.194566380273;11591.304521728724;11972.820407693718;11223.49494272776;11517.308961462339;11652.592159274385;11914.285142891455;11949.386168461402;10849.566017359217;10941.124710023338;11022.779544408906;11408.372539510407;11727.354995474989;9210.401323913924;9588.76028099303;9705.12653861156;9826.312158148861;9835.950820246138;8981.685641002534;9034.819303614022;9063.501507417155;9279.62881484733;9768.85346719814 20:18:19 INFO - PROCESS | 11618 | __end_tp_report 20:18:19 INFO - PROCESS | 11618 | __start_cc_report 20:18:19 INFO - PROCESS | 11618 | _x_x_mozilla_cycle_collect,943 20:18:19 INFO - PROCESS | 11618 | __end_cc_report 20:18:19 INFO - PROCESS | 11618 | __startTimestamp1452485899048__endTimestamp 20:18:19 INFO - PROCESS | 11618 | 20:18:19 INFO - PROCESS | 11618 | ------- Summary: start ------- 20:18:19 INFO - PROCESS | 11618 | Number of tests: 6 20:18:19 INFO - PROCESS | 11618 | 20:18:19 INFO - PROCESS | 11618 | [#0] dojo.html Cycles:165 Average:5055.12 Median:5227.79 stddev:538.15 (10.3%) stddev-sans-first:517.16 20:18:19 INFO - PROCESS | 11618 | Values: 3086.1 3114.6 3147.0 3155.2 3163.6 4964.3 5024.6 5040.3 5054.1 5071.2 5011.4 5054.4 5107.1 5108.9 5140.7 4442.6 4560.1 4598.8 4634.6 4716.6 4514.9 4642.5 4675.9 4688.5 4781.6 4545.2 4627.9 4644.5 4649.6 4657.9 4583.4 4612.6 4612.6 4637.7 4669.5 4554.5 4629.4 4643.2 4649.9 4686.2 4954.4 4955.8 4960.0 4963.4 4971.2 5414.0 5442.8 5443.9 5444.9 5454.6 5327.3 5457.0 5518.4 5518.9 5535.2 5080.4 5081.8 5082.1 5093.4 5100.9 5394.2 5473.5 5530.7 5533.1 5537.7 5217.9 5262.9 5358.0 5372.2 5379.2 5394.6 5397.2 5402.6 5410.9 5410.9 5287.5 5358.3 5391.4 5397.4 5442.6 5356.7 5404.0 5420.9 5422.7 5444.0 4255.1 4262.1 4267.1 4284.4 4295.2 3750.5 3829.0 3832.5 3861.1 3871.8 5042.4 5042.4 5144.8 5162.4 5168.8 5475.8 5498.7 5504.2 5508.4 5508.4 4959.8 5053.5 5105.5 5108.2 5138.7 4635.2 4665.8 4699.0 4724.9 4768.5 5593.7 5600.4 5605.6 5611.4 5645.2 5273.8 5398.2 5442.2 5451.7 5458.2 5572.0 5628.9 5682.9 5725.0 5739.4 5441.5 5459.9 5461.2 5461.6 5469.3 5462.0 5522.2 5535.9 5538.7 5577.9 5152.7 5204.5 5249.5 5310.0 5316.5 5254.5 5289.3 5299.0 5301.9 5309.7 5171.2 5180.9 5185.7 5188.8 5227.8 5235.5 5326.1 5363.3 5371.9 5394.4 5230.2 5252.4 5254.8 5254.8 5279.7 20:18:19 INFO - PROCESS | 11618 | 20:18:19 INFO - PROCESS | 11618 | [#1] ext.html Cycles:180 Average:46726.79 Median:166093.74 stddev:79817.01 (48.1%) stddev-sans-first:79965.54 20:18:19 INFO - PROCESS | 11618 | Values: 526.8 533.7 544.7 550.0 568.0 28261.4 28824.6 36382.6 36592.5 36803.1 39663.0 40018.4 40093.6 40145.4 40260.8 7312.5 7482.8 8265.6 8451.6 8464.3 9987.0 10257.4 10259.1 10263.2 10269.1 9986.7 10108.1 10112.1 10115.8 10121.6 7604.8 7783.9 9850.1 10003.2 10259.1 9793.8 9932.9 9938.1 9941.9 9943.0 36572.8 36766.1 36968.1 37020.6 37037.6 3280.5 3417.3 3494.6 4002.0 4054.2 27609.4 27838.3 27852.6 30821.8 30921.2 3952.7 3988.7 3992.8 4036.7 4122.1 266352.0 270174.0 271061.0 272311.0 273644.6 53499.9 54444.5 58581.0 59039.4 59379.1 64207.0 65622.0 65652.7 65706.0 65739.3 15776.8 16150.4 16153.0 16160.7 16164.0 11321.5 11335.2 11358.1 11359.0 11360.1 19210.0 19539.9 19546.7 19572.4 19629.1 7318.7 7427.9 7526.1 7556.4 7580.3 957.6 965.2 971.1 979.7 1134.3 27755.3 28204.7 28411.4 28487.4 28494.4 1041.1 1053.8 1055.2 1109.1 1126.7 14456.2 14644.8 14718.9 14984.3 15069.9 323445.0 328907.0 329766.0 329934.0 330389.0 51184.5 51358.2 51617.0 51620.5 51651.5 1311.5 1323.9 1328.9 1330.3 1337.3 27623.6 28149.2 28570.4 28620.3 28620.7 45672.3 46021.8 46029.0 46085.5 46089.0 310560.6 312188.0 312290.2 313217.0 313933.0 26749.9 29097.0 31761.5 31922.0 31939.8 38702.0 39240.0 40360.4 40387.8 40423.2 34826.0 34875.8 35178.8 35219.5 35246.5 30061.7 34092.5 34989.8 35274.0 36791.8 31903.2 32045.8 32071.8 32075.8 32098.7 26930.7 31897.8 31992.5 32195.7 32303.0 23714.8 23962.0 24122.8 24406.3 24678.4 20:18:19 INFO - PROCESS | 11618 | 20:18:19 INFO - PROCESS | 11618 | [#2] jquery.html Cycles:180 Average:27257.07 Median:472.53 stddev:85768.82 (18150.9%) stddev-sans-first:85985.64 20:18:19 INFO - PROCESS | 11618 | Values: 357.2 358.5 360.9 363.9 367.1 13544.8 13994.5 16165.9 16174.5 16925.5 13293.2 13712.2 15058.2 15846.4 15855.1 4672.9 5090.6 5462.9 5464.9 5472.8 3674.1 3833.8 5339.5 6365.4 6858.6 6563.4 6724.0 6842.2 6852.1 6857.1 6451.9 6761.7 6778.2 6804.3 6813.0 6505.3 6509.1 6511.6 6513.7 6519.3 21228.3 21730.8 21747.0 22049.9 22261.4 2160.6 2252.9 2431.8 2436.8 2473.6 13362.9 13707.5 13916.7 13970.5 14212.8 1920.0 2024.5 2036.7 2037.0 2056.7 62389.7 63767.0 63867.7 63962.0 64055.0 14537.0 14706.4 14780.9 14821.8 14834.6 22626.2 23042.8 23065.4 23150.1 23174.5 7245.0 7452.7 7686.4 7723.7 8947.8 7470.4 7486.3 7555.7 7595.8 7603.8 4158.6 4292.8 4392.1 4478.8 4517.9 1757.1 1776.9 1793.7 1861.3 1862.4 464.3 810.5 990.3 1001.6 1009.4 9875.0 9983.0 10312.7 10356.7 10819.4 404.0 415.3 429.2 436.7 461.3 5531.9 5547.7 5590.2 5695.7 5719.2 504469.0 522973.0 523382.0 527729.0 544272.0 69121.7 70524.3 70611.6 72277.6 75682.2 460.7 469.7 471.7 472.5 472.6 9268.7 9548.4 9586.0 9798.8 9842.5 29601.7 30139.7 30192.1 30771.0 31181.4 37867.4 39812.0 40696.6 41509.8 42643.8 7109.3 7210.9 7258.4 7496.4 7553.4 8385.0 10153.7 10641.4 10969.6 11405.8 9385.8 9402.7 9421.5 9586.4 9767.0 7857.0 9940.5 9949.9 10158.8 10420.1 7876.5 9121.5 9632.5 10074.4 10144.6 7153.5 7311.5 7400.9 7510.1 7513.8 8721.2 9553.8 9686.9 9802.2 9913.9 20:18:19 INFO - PROCESS | 11618 | 20:18:19 INFO - PROCESS | 11618 | [#3] mootools.html Cycles:180 Average:5211.86 Median:6181.31 stddev:2614.98 (42.3%) stddev-sans-first:2606.28 20:18:19 INFO - PROCESS | 11618 | Values: 1360.0 1416.7 1444.2 1589.6 1796.3 6660.1 7088.4 7190.7 7226.3 7228.3 7110.7 7306.1 7308.9 7318.8 7326.0 2273.6 2303.8 2304.7 2306.7 2307.0 2249.6 2278.5 2286.6 2287.9 2294.7 2233.9 2238.1 2251.4 2259.7 2261.0 2249.3 2285.6 2289.0 2291.3 2292.4 2239.3 2243.5 2244.6 2245.3 2245.8 7203.5 7261.9 7262.0 7269.5 7310.7 4597.8 4739.8 4742.4 4771.7 4773.4 2971.2 3009.5 3082.0 3105.7 3126.1 919.0 956.1 971.3 1001.4 1005.0 10142.5 10149.5 10164.1 10175.2 10189.7 4282.9 4314.2 4353.5 4363.2 4383.0 8813.1 8820.1 8827.0 8833.2 8837.4 4755.6 4786.4 4787.2 4790.6 4795.2 3683.9 3779.6 4136.6 4222.4 4307.4 3682.8 3709.4 3710.9 3743.2 3751.5 1121.0 1212.1 1231.1 1231.9 1239.9 895.7 1033.4 1074.1 1114.8 1274.1 6849.6 6860.7 6870.4 6909.4 6931.3 1097.9 1110.6 1118.2 1127.0 1147.5 5238.6 5330.7 5334.6 5345.3 5349.8 8475.3 8499.4 8500.0 8502.8 8646.8 8468.7 8563.4 8569.8 8578.1 8579.0 6810.8 6839.2 6945.2 6968.6 7002.8 6773.7 6791.2 6824.8 6831.5 6834.9 7753.5 8087.1 8117.4 8132.1 8136.8 8068.6 8211.6 8226.0 8397.8 8412.4 6366.3 6392.6 6475.8 6682.0 6775.4 6918.6 7061.2 7073.0 7122.1 7135.1 5855.3 6657.7 6724.1 6799.9 6819.3 6316.3 6665.7 6670.9 6769.7 6775.0 6554.9 6564.1 6570.6 6603.3 6629.8 6114.1 6173.1 6178.8 6183.8 6191.3 6013.1 6213.0 6284.0 6299.5 6400.0 20:18:19 INFO - PROCESS | 11618 | 20:18:19 INFO - PROCESS | 11618 | [#4] prototype.html Cycles:180 Average:5292.87 Median:5954.77 stddev:1589.26 (26.7%) stddev-sans-first:1549.67 20:18:19 INFO - PROCESS | 11618 | Values: 342.3 349.2 352.6 353.6 356.8 5885.0 5917.8 5928.3 5951.2 5959.6 5675.7 5727.1 5824.5 5836.2 5919.5 4596.4 4618.6 4624.3 4625.8 4643.6 4611.2 4620.9 4629.5 4636.6 4643.9 4362.3 4445.5 4446.7 4449.9 4464.7 4453.9 4506.6 4521.2 4523.3 4545.3 4006.3 4008.3 4010.1 4016.0 4044.2 5655.2 5683.9 5685.8 5688.3 5692.1 5101.4 5246.7 5271.7 5287.8 5298.1 6278.2 6278.4 6278.8 6286.4 6291.3 4407.8 4411.4 4413.0 4414.5 4419.4 6454.7 6504.2 6573.0 6576.5 6588.3 4502.1 4508.1 4511.6 4514.2 4515.8 4557.3 4562.1 4569.0 4569.2 4572.9 5250.5 5253.9 5261.7 5285.7 5311.8 6220.4 6338.0 6344.0 6357.9 6358.4 1591.7 1616.3 1616.9 1617.0 1617.8 1079.8 1087.5 1088.5 1103.8 1108.1 6001.2 6004.6 6012.3 6018.5 6018.6 6519.7 6524.9 6525.1 6525.2 6532.2 5803.8 5836.6 5958.4 6018.1 6022.4 3494.6 3516.8 3517.1 3525.8 3527.6 6730.9 6733.3 6739.8 6743.9 6754.6 6544.1 6759.7 6769.3 6792.0 6792.4 6737.7 6740.3 6746.6 6747.1 6748.3 6507.5 6509.1 6541.1 6541.3 6578.9 6320.8 6481.3 6491.9 6499.1 6502.9 6781.2 6786.4 6790.8 6794.7 6799.3 4536.2 4536.6 4537.8 4540.4 4541.7 6429.6 6581.3 6592.7 6603.7 6609.6 6356.5 6383.6 6389.2 6392.0 6408.1 6355.0 6364.4 6365.9 6371.2 6375.5 6149.6 6209.9 6245.9 6251.6 6255.1 6384.5 6389.5 6391.5 6396.8 6412.7 6258.5 6262.2 6267.9 6268.3 6278.0 20:18:19 INFO - PROCESS | 11618 | 20:18:19 INFO - PROCESS | 11618 | [#5] yui.html Cycles:180 Average:13481.03 Median:46294.65 stddev:15487.08 (33.5%) stddev-sans-first:15501.20 20:18:19 INFO - PROCESS | 11618 | Values: 790.3 808.6 814.2 817.8 837.6 13321.7 13424.3 13478.4 13502.1 13505.5 12316.6 12548.2 12571.7 12592.9 12613.0 670.9 682.5 801.8 809.2 811.4 808.4 813.1 819.6 820.4 820.6 847.5 856.1 858.3 859.5 864.2 689.7 694.4 839.6 855.6 861.9 627.4 627.6 627.9 629.2 630.0 12961.9 13062.5 13068.2 13071.5 13110.7 11887.6 12260.2 12402.8 12411.5 12497.3 10361.1 10416.9 10602.2 10706.0 10904.4 3632.3 3690.2 3711.9 3792.8 3802.8 44445.1 46516.0 46701.5 46991.3 47058.8 9153.8 9512.4 9645.3 9749.7 9864.8 17403.8 17613.1 17632.9 17658.8 17746.9 7110.8 7197.4 7249.6 7250.9 7330.3 4360.0 4372.8 4381.5 4392.4 4437.8 3012.0 3034.6 3035.9 3038.8 3043.2 561.2 562.5 568.6 569.6 580.9 584.7 634.4 646.2 654.6 708.3 8169.4 8243.5 8276.9 8414.6 8474.7 548.9 577.9 612.3 655.6 686.1 3603.8 3692.5 3807.7 3813.9 3899.2 53310.0 56489.9 56706.4 58031.4 58339.7 47391.5 47957.8 49937.3 50086.5 50278.0 44968.6 45057.5 45116.8 45117.3 46073.3 7666.7 8147.1 8183.5 8269.3 8456.7 31565.5 33094.3 33120.3 33178.3 33766.2 43871.6 44045.3 44048.6 44353.6 44882.8 11125.2 11128.3 11151.1 11251.9 11565.9 11845.5 12165.3 12170.1 12215.5 12252.9 11133.9 11480.2 11506.2 11591.3 11972.8 11223.5 11517.3 11652.6 11914.3 11949.4 10849.6 10941.1 11022.8 11408.4 11727.4 9210.4 9588.8 9705.1 9826.3 9836.0 8981.7 9034.8 9063.5 9279.6 9768.9 20:18:19 INFO - PROCESS | 11618 | -------- Summary: end -------- 20:18:19 INFO - PROCESS | 11618 | 20:18:19 INFO - TEST-INFO | 11618: exit 0 20:18:19 INFO - TEST-OK | dromaeo_css | took 1114182ms 20:18:19 INFO - TEST-START | kraken 20:18:19 INFO - operating with platform_type : linux_ 20:18:19 INFO - Initialising browser for kraken test... 20:18:19 INFO - TEST-INFO | started process 11808 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKn62La/profile http://localhost:39440/getInfo.html) 20:18:23 INFO - PROCESS | 11808 | __metrics Screen width/height:1600/1200 20:18:23 INFO - PROCESS | 11808 | colorDepth:24 20:18:23 INFO - PROCESS | 11808 | Browser inner width/height: 1024/697 20:18:23 INFO - PROCESS | 11808 | __metrics 20:18:24 INFO - PROCESS | 11808 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:18:24 INFO - PROCESS | 11808 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:18:25 INFO - TEST-INFO | 11808: exit 0 20:18:25 INFO - Browser initialized. 20:18:25 INFO - Running cycle 1/1 for kraken test... 20:18:25 INFO - TEST-INFO | started process 11892 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKn62La/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:37 INFO - PROCESS | 11892 | RSS: Main: 149073920 20:18:37 INFO - PROCESS | 11892 | 20:18:39 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39440/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:40 INFO - PROCESS | 11892 | RSS: Main: 187506688 20:18:40 INFO - PROCESS | 11892 | 20:18:42 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39440/tests/kraken/driver.html?testName=audio-dft) 20:18:43 INFO - PROCESS | 11892 | RSS: Main: 177143808 20:18:43 INFO - PROCESS | 11892 | 20:18:46 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39440/tests/kraken/driver.html?testName=audio-fft) 20:18:46 INFO - PROCESS | 11892 | RSS: Main: 161316864 20:18:46 INFO - PROCESS | 11892 | 20:18:48 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39440/tests/kraken/driver.html?testName=audio-oscillator) 20:18:49 INFO - PROCESS | 11892 | RSS: Main: 162226176 20:18:49 INFO - PROCESS | 11892 | 20:18:51 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39440/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:52 INFO - PROCESS | 11892 | RSS: Main: 165830656 20:18:52 INFO - PROCESS | 11892 | 20:18:55 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39440/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:55 INFO - PROCESS | 11892 | RSS: Main: 165203968 20:18:55 INFO - PROCESS | 11892 | 20:18:59 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39440/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:59 INFO - PROCESS | 11892 | RSS: Main: 165736448 20:18:59 INFO - PROCESS | 11892 | 20:19:02 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39440/tests/kraken/driver.html?testName=json-parse-financial) 20:19:02 INFO - PROCESS | 11892 | RSS: Main: 164888576 20:19:02 INFO - PROCESS | 11892 | 20:19:04 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39440/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:05 INFO - PROCESS | 11892 | RSS: Main: 174833664 20:19:05 INFO - PROCESS | 11892 | 20:19:06 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39440/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:19:07 INFO - PROCESS | 11892 | RSS: Main: 172601344 20:19:07 INFO - PROCESS | 11892 | 20:19:09 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39440/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:10 INFO - PROCESS | 11892 | RSS: Main: 183320576 20:19:10 INFO - PROCESS | 11892 | 20:19:12 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:13 INFO - PROCESS | 11892 | RSS: Main: 189661184 20:19:13 INFO - PROCESS | 11892 | 20:19:15 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:16 INFO - PROCESS | 11892 | RSS: Main: 190205952 20:19:16 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | Cycle 1(1): loaded http://localhost:39440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39440/tests/kraken/driver.html?testName=ai-astar) 20:19:18 INFO - PROCESS | 11892 | RSS: Main: 246980608 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | __start_tp_report 20:19:18 INFO - PROCESS | 11892 | _x_x_mozilla_page_load 20:19:18 INFO - PROCESS | 11892 | _x_x_mozilla_page_load_details 20:19:18 INFO - PROCESS | 11892 | |i|pagename|runs| 20:19:18 INFO - PROCESS | 11892 | |0;ai-astar;113;115;107;112;114;114;102;110;112;114 20:19:18 INFO - PROCESS | 11892 | |1;audio-beat-detection;156;131;154;169;129;154;159;131;176;127 20:19:18 INFO - PROCESS | 11892 | |2;audio-dft;165;161;161;163;160;161;159;162;160;160 20:19:18 INFO - PROCESS | 11892 | |3;audio-fft;71;72;87;99;72;71;75;100;93;71 20:19:18 INFO - PROCESS | 11892 | |4;audio-oscillator;96;96;152;95;97;96;139;97;97;140 20:19:18 INFO - PROCESS | 11892 | |5;imaging-gaussian-blur;109;109;110;110;109;109;109;109;111;111 20:19:18 INFO - PROCESS | 11892 | |6;imaging-darkroom;148;145;145;145;146;146;145;145;145;145 20:19:18 INFO - PROCESS | 11892 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 20:19:18 INFO - PROCESS | 11892 | |8;json-parse-financial;58;56;57;55;58;57;62;65;53;54 20:19:18 INFO - PROCESS | 11892 | |9;json-stringify-tinderbox;67;67;68;68;68;68;67;69;68;68 20:19:18 INFO - PROCESS | 11892 | |10;stanford-crypto-aes;84;86;84;85;86;92;84;85;85;85 20:19:18 INFO - PROCESS | 11892 | |11;stanford-crypto-ccm;117;120;122;116;115;121;121;116;124;124 20:19:18 INFO - PROCESS | 11892 | |12;stanford-crypto-pbkdf2;152;141;158;153;146;142;143;152;153;142 20:19:18 INFO - PROCESS | 11892 | |13;stanford-crypto-sha256-iterative;77;69;68;69;68;69;70;69;70;70 20:19:18 INFO - PROCESS | 11892 | __end_tp_report 20:19:18 INFO - PROCESS | 11892 | __start_cc_report 20:19:18 INFO - PROCESS | 11892 | _x_x_mozilla_cycle_collect,965 20:19:18 INFO - PROCESS | 11892 | __end_cc_report 20:19:18 INFO - PROCESS | 11892 | __startTimestamp1452485958271__endTimestamp 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | ------- Summary: start ------- 20:19:18 INFO - PROCESS | 11892 | Number of tests: 14 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.50 stddev:4.03 (3.5%) stddev-sans-first:4.23 20:19:18 INFO - PROCESS | 11892 | Values: 113.0 115.0 107.0 112.0 114.0 114.0 102.0 110.0 112.0 114.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:155.00 stddev:17.82 (11.5%) stddev-sans-first:18.70 20:19:18 INFO - PROCESS | 11892 | Values: 156.0 131.0 154.0 169.0 129.0 154.0 159.0 131.0 176.0 127.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.75 (1.1%) stddev-sans-first:1.20 20:19:18 INFO - PROCESS | 11892 | Values: 165.0 161.0 161.0 163.0 160.0 161.0 159.0 162.0 160.0 160.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#3] audio-fft Cycles:10 Average:81.10 Median:73.50 stddev:12.31 (16.7%) stddev-sans-first:12.50 20:19:18 INFO - PROCESS | 11892 | Values: 71.0 72.0 87.0 99.0 72.0 71.0 75.0 100.0 93.0 71.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.00 stddev:23.15 (24.1%) stddev-sans-first:23.95 20:19:18 INFO - PROCESS | 11892 | Values: 96.0 96.0 152.0 95.0 97.0 96.0 139.0 97.0 97.0 140.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:109.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 20:19:18 INFO - PROCESS | 11892 | Values: 109.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 111.0 111.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.00 stddev:0.97 (0.7%) stddev-sans-first:0.44 20:19:18 INFO - PROCESS | 11892 | Values: 148.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:19:18 INFO - PROCESS | 11892 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.50 stddev:3.63 (6.3%) stddev-sans-first:3.84 20:19:18 INFO - PROCESS | 11892 | Values: 58.0 56.0 57.0 55.0 58.0 57.0 62.0 65.0 53.0 54.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 20:19:18 INFO - PROCESS | 11892 | Values: 67.0 67.0 68.0 68.0 68.0 68.0 67.0 69.0 68.0 68.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:2.37 (2.8%) stddev-sans-first:2.44 20:19:18 INFO - PROCESS | 11892 | Values: 84.0 86.0 84.0 85.0 86.0 92.0 84.0 85.0 85.0 85.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:121.00 stddev:3.37 (2.8%) stddev-sans-first:3.44 20:19:18 INFO - PROCESS | 11892 | Values: 117.0 120.0 122.0 116.0 115.0 121.0 121.0 116.0 124.0 124.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:152.00 stddev:6.07 (4.0%) stddev-sans-first:6.28 20:19:18 INFO - PROCESS | 11892 | Values: 152.0 141.0 158.0 153.0 146.0 142.0 143.0 152.0 153.0 142.0 20:19:18 INFO - PROCESS | 11892 | 20:19:18 INFO - PROCESS | 11892 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.50 stddev:2.60 (3.7%) stddev-sans-first:0.78 20:19:18 INFO - PROCESS | 11892 | Values: 77.0 69.0 68.0 69.0 68.0 69.0 70.0 69.0 70.0 70.0 20:19:18 INFO - PROCESS | 11892 | -------- Summary: end -------- 20:19:18 INFO - PROCESS | 11892 | 20:19:19 INFO - TEST-INFO | 11892: exit 0 20:19:19 INFO - TEST-OK | kraken | took 59289ms 20:19:19 INFO - TEST-START | v8_7 20:19:19 INFO - operating with platform_type : linux_ 20:19:19 INFO - Initialising browser for v8_7 test... 20:19:19 INFO - TEST-INFO | started process 12143 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxmhq6W/profile http://localhost:39440/getInfo.html) 20:19:23 INFO - PROCESS | 12143 | __metrics Screen width/height:1600/1200 20:19:23 INFO - PROCESS | 12143 | colorDepth:24 20:19:23 INFO - PROCESS | 12143 | Browser inner width/height: 1024/697 20:19:23 INFO - PROCESS | 12143 | __metrics 20:19:23 INFO - PROCESS | 12143 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:19:23 INFO - PROCESS | 12143 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:19:24 INFO - TEST-INFO | 12143: exit 0 20:19:24 INFO - Browser initialized. 20:19:24 INFO - Running cycle 1/1 for v8_7 test... 20:19:24 INFO - TEST-INFO | started process 12227 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxmhq6W/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:36 INFO - PROCESS | 12227 | RSS: Main: 148656128 20:19:36 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | Cycle 1(1): loaded http://localhost:39440/tests/v8_7/run.html (next: http://localhost:39440/tests/v8_7/run.html) 20:19:59 INFO - PROCESS | 12227 | RSS: Main: 537993216 20:19:59 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | __start_tp_report 20:19:59 INFO - PROCESS | 12227 | _x_x_mozilla_page_load 20:19:59 INFO - PROCESS | 12227 | _x_x_mozilla_page_load_details 20:19:59 INFO - PROCESS | 12227 | |i|pagename|runs| 20:19:59 INFO - PROCESS | 12227 | |0;Richards;166.19577862722286 20:19:59 INFO - PROCESS | 12227 | |1;DeltaBlue;190.00570017100512 20:19:59 INFO - PROCESS | 12227 | |2;Encrypt;280.58361391694723 20:19:59 INFO - PROCESS | 12227 | |3;Decrypt;5181.347150259067 20:19:59 INFO - PROCESS | 12227 | |4;RayTrace;1962.7450980392157 20:19:59 INFO - PROCESS | 12227 | |5;Earley;803.8585209003215 20:19:59 INFO - PROCESS | 12227 | |6;Boyer;12219.512195121952 20:19:59 INFO - PROCESS | 12227 | |7;RegExp;42437.5 20:19:59 INFO - PROCESS | 12227 | |8;Splay;570.7814269535673 20:19:59 INFO - PROCESS | 12227 | |9;NavierStokes;4830.917874396136 20:19:59 INFO - PROCESS | 12227 | __end_tp_report 20:19:59 INFO - PROCESS | 12227 | __startTimestamp1452485999265__endTimestamp 20:19:59 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | ------- Summary: start ------- 20:19:59 INFO - PROCESS | 12227 | Number of tests: 10 20:19:59 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | [#0] Richards Cycles:1 Average:166.20 Median:166.20 stddev:0.00 (0.0%) 20:19:59 INFO - PROCESS | 12227 | Values: 166.2 20:19:59 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | [#1] DeltaBlue Cycles:1 Average:190.01 Median:190.01 stddev:0.00 (0.0%) 20:19:59 INFO - PROCESS | 12227 | Values: 190.0 20:19:59 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 20:19:59 INFO - PROCESS | 12227 | Values: 280.6 20:19:59 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 20:19:59 INFO - PROCESS | 12227 | Values: 5181.3 20:19:59 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | [#4] RayTrace Cycles:1 Average:1962.75 Median:1962.75 stddev:0.00 (0.0%) 20:19:59 INFO - PROCESS | 12227 | Values: 1962.7 20:19:59 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | [#5] Earley Cycles:1 Average:803.86 Median:803.86 stddev:0.00 (0.0%) 20:19:59 INFO - PROCESS | 12227 | Values: 803.9 20:19:59 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 20:19:59 INFO - PROCESS | 12227 | Values: 12219.5 20:19:59 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | [#7] RegExp Cycles:1 Average:42437.50 Median:42437.50 stddev:0.00 (0.0%) 20:19:59 INFO - PROCESS | 12227 | Values: 42437.5 20:19:59 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | [#8] Splay Cycles:1 Average:570.78 Median:570.78 stddev:0.00 (0.0%) 20:19:59 INFO - PROCESS | 12227 | Values: 570.8 20:19:59 INFO - PROCESS | 12227 | 20:19:59 INFO - PROCESS | 12227 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 20:19:59 INFO - PROCESS | 12227 | Values: 4830.9 20:19:59 INFO - PROCESS | 12227 | -------- Summary: end -------- 20:19:59 INFO - PROCESS | 12227 | 20:20:00 INFO - TEST-INFO | 12227: exit 0 20:20:00 INFO - TEST-OK | v8_7 | took 41003ms 20:20:00 INFO - SUITE-END | took 1214s 20:20:00 INFO - Completed test suite (00:20:14) 20:20:00 INFO - Working with test: dromaeo_css 20:20:00 INFO - Generating results file: dromaeo_css 20:20:00 INFO - Working with test: kraken 20:20:00 INFO - Generating results file: kraken 20:20:00 INFO - javascript benchmark 20:20:00 INFO - Working with test: v8_7 20:20:00 INFO - Generating results file: v8_7 20:20:00 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:00 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:20:00 INFO - process_Request line: dromaeo_css 6737.15 graph.html#tests=[[72,64,35]] 20:20:00 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:00 INFO - process_Request line: kraken 1512.30 graph.html#tests=[[232,64,35]] 20:20:00 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:00 INFO - process_Request line: v8_7 18989.58 graph.html#tests=[[230,64,35]] 20:20:00 INFO - RETURN: dromaeo_css: 6737.15 20:20:00 INFO - RETURN: kraken: 1512.30 20:20:00 INFO - RETURN: v8_7: 18989.58 20:20:00 INFO - javascript benchmark 20:20:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3086.1050295414325, 3114.6106736657916, 3146.968530314696, 3155.2427417419826, 3163.5729176561163, 4964.304997300381, 5024.598032157423, 5040.294358789773, 5054.115529782287, 5071.16325806242, 5011.373578302712, 5054.444011158779, 5107.080725469414, 5108.948910510894, 5140.691558506493, 4442.577955094261, 4560.133574620828, 4598.816047358102, 4634.629229661636, 4716.646251531131, 4514.932276015862, 4642.489326174118, 4675.906481870361, 4688.531146885318, 4781.6413768967295, 4545.204589196877, 4627.930581041287, 4644.4658864230705, 4649.5815376616265, 4657.906841863144, 4583.427071616048, 4612.58486736192, 4612.630989520831, 4637.698549594265, 4669.486356500782, 4554.453465584118, 4629.398178236807, 4643.233866412038, 4649.860504184846, 4686.2267725825195, 4954.355933728628, 4955.776990035457, 4960.032793605248, 4963.354763880709, 4971.1549036663855, 5414.025475414423, 5442.809501667462, 5443.945560544384, 5444.863878403072, 5454.59090568209, 5327.280817089682, 5457.045017121988, 5518.392976772552, 5518.944810551883, 5535.169724541351, 5080.415752188509, 5081.771320290596, 5082.085224659597, 5093.414257360414, 5100.897982040338, 5394.244805727123, 5473.507384335429, 5530.723463826873, 5533.114701647717, 5537.723113844291, 5217.947820521822, 5262.894742105136, 5358.008768377863, 5372.167314066326, 5379.246905433242, 5394.595405344615, 5397.190421436816, 5402.648827826258, 5410.864728381822, 5410.8917821643345, 5287.4976877196605, 5358.33020872391, 5391.406945236021, 5397.4062853086125, 5442.591805614595, 5356.651817631841, 5404.0, 5420.945790542044, 5422.728863556807, 5443.972780136153, 4255.106427650167, 4262.147570485915, 4267.061246525759, 4284.421603083606, 4295.183915056129, 3750.512433383697, 3829.0, 3832.4826148470156, 3861.092643228839, 3871.787051712183, 5042.369703787027, 5042.445331013586, 5144.845654630367, 5162.354705661793, 5168.8449346519665, 5475.753591088411, 5498.670079795225, 5504.174373843955, 5508.421615730371, 5508.44915508446, 4959.82640607577, 5053.545180933734, 5105.463926287686, 5108.157154069611, 5138.743062846843, 4635.1656701794, 4665.813367465264, 4699.036697477009, 4724.881877953078, 4768.451628062817, 5593.664380137205, 5600.383957764561, 5605.635633683797, 5611.410801865745, 5645.153227015899, 5273.762680679302, 5398.217258497574, 5442.183672449164, 5451.727413629382, 5458.235846981505, 5572.0, 5628.915566266591, 5682.9431705684065, 5725.0, 5739.426057394394, 5441.5102640762525, 5459.945400546103, 5461.208124821799, 5461.617686761889, 5469.343678758574, 5462.0, 5522.22688823557, 5535.861603459945, 5538.723063846711, 5577.860553486195, 5152.742362881916, 5204.531592156724, 5249.527542521191, 5310.044192045469, 5316.548093412103, 5254.527092561688, 5289.338832645919, 5299.046171688979, 5301.867453313698, 5309.707966061904, 5171.198464238049, 5180.922286165635, 5185.714785686823, 5188.766505507337, 5227.790888364423, 5235.476452354734, 5326.147816349366, 5363.302770639948, 5371.865703357447, 5394.406615272395, 5230.189320655304, 5252.44849290819, 5254.816081437131, 5254.842354729364, 5279.736013199402], "unit": "score", "name": "dojo.html", "value": 5022.127148598871}, {"lowerIsBetter": false, "replicates": [526.7682219823278, 533.7384681506061, 544.7031367904492, 549.9862503437414, 567.9858003549913, 28261.43477130456, 28824.56763148552, 36382.63617363832, 36592.45111323329, 36803.07992300194, 39663.0, 40018.399724004164, 40093.59906400935, 40145.39781903267, 40260.79869600648, 7312.488125831194, 7482.802751559751, 8265.586720663972, 8451.57742112895, 8464.280536154403, 9986.950065249664, 10257.38455692657, 10259.127974122208, 10263.230257730662, 10269.075783179513, 9986.700398988041, 10108.09027187553, 10112.140468060186, 10115.848262276035, 10121.595136194543, 7604.847903041936, 7783.883241751379, 9850.064243896853, 10003.249756268237, 10259.127974122208, 9793.755156121155, 9932.90067099327, 9938.105570498617, 9941.850872236922, 9943.0, 36572.81713591442, 36766.080847978745, 36968.07579810499, 37020.629793701984, 37037.62962370396, 3280.475123980176, 3417.2994536120036, 3494.5981212160673, 4001.9599804001878, 4054.2499637567144, 27609.447811043665, 27838.3040423989, 27852.582211266847, 30821.845890770626, 30921.226969325722, 3952.7035472339403, 3988.700847436454, 3992.8003599819895, 4036.6972477064046, 4122.134351786129, 266352.0, 270174.0, 271061.0, 272311.0, 273644.6317768418, 53499.930001399756, 54444.45555544473, 58581.0, 59039.40960590425, 59379.109313360335, 64207.0, 65622.0, 65652.67173664196, 65706.0, 65739.34260657428, 15776.76334854978, 16150.434734784227, 16153.0, 16160.67678646444, 16164.0, 11321.547138114547, 11335.206535542433, 11358.148138889615, 11359.0, 11360.091192704564, 19210.00566696158, 19539.873620220696, 19546.70679939802, 19572.412827615193, 19629.116689748997, 7318.707251709979, 7427.925720742724, 7526.09686837572, 7556.395488360918, 7580.279873412017, 957.6025949230991, 965.2278177458005, 971.1405406215409, 979.6718099436627, 1134.2513940799033, 27755.306117346823, 28204.71795282021, 28411.431771364456, 28487.430251394857, 28494.43011139807, 1041.1150522056191, 1053.8313869780798, 1055.1875056206677, 1109.1237922041496, 1126.6507382711386, 14456.20490873012, 14644.780328295084, 14718.926405367905, 14984.250787460584, 15069.924650376677, 323445.0, 328907.0, 329766.0, 329934.0, 330389.0, 51184.48815511871, 51358.22962655563, 51617.0, 51620.48379516232, 51651.483485165416, 1311.4754098360731, 1323.8676132386684, 1328.8804007639164, 1330.3082397153619, 1337.2979185927272, 27623.585646215724, 28149.155525334274, 28570.42859142847, 28620.284492887844, 28620.713792861803, 45672.31491527696, 46021.76989115167, 46029.0, 46085.53914460813, 46089.0, 310560.6023488029, 312188.0, 312290.1927451741, 313217.0, 313933.0, 26749.866250668623, 29097.0, 31761.523577146825, 31922.0, 31939.840300798347, 38702.0, 39240.0, 40360.3945940817, 40387.798061009504, 40423.191536168524, 34826.0, 34875.825620871736, 35178.82410587931, 35219.47170792389, 35246.471302930986, 30061.699383006766, 34092.488612671325, 34989.825050874584, 35274.0, 36791.81604091962, 31903.202419939687, 32045.83977080193, 32071.839640801645, 32075.839620801748, 32098.6790132105, 26930.730692693607, 31897.840510797298, 31992.520112198803, 32195.678043219268, 32303.0, 23714.762852371256, 23962.0, 24122.75877241205, 24406.26781196567, 24678.383040424134], "unit": "score", "name": "ext.html", "value": 18378.983839886307}, {"lowerIsBetter": false, "replicates": [357.18027127741846, 358.51242310457775, 360.89173248025594, 363.90720366306596, 367.0603255665498, 13544.796828047587, 13994.510192143278, 16165.919170404146, 16174.514764557052, 16925.49223523293, 13293.202407855535, 13712.17726936382, 15058.247087645628, 15846.3661453542, 15855.127967961758, 4672.929906051412, 5090.592752579803, 5462.863428414302, 5464.9453505465035, 5472.753726082316, 3674.1365779041903, 3833.7508061976023, 5339.519443250107, 6365.395287447685, 6858.588484690909, 6563.4247780532805, 6723.966380168093, 6842.213145488258, 6852.143482064742, 6857.108575885128, 6451.870962580722, 6761.729530818761, 6778.186617605869, 6804.319568043181, 6812.965935170318, 6505.349465053457, 6509.088727578142, 6511.576747511396, 6513.706883190268, 6519.282878883319, 21228.257011004695, 21730.8067200847, 21747.0, 22049.889750551305, 22261.44346391337, 2160.5570857974076, 2252.887355632212, 2431.8176136789634, 2436.817238707104, 2473.579491486452, 13362.933185334108, 13707.520236791665, 13916.652083697887, 13970.511032113827, 14212.818545131908, 1919.9520011999673, 2024.4533975826444, 2036.7352244208307, 2036.9694454583193, 2056.7429071366078, 62389.68805156036, 63767.0, 63867.680661596394, 63962.0, 64055.0, 14537.0, 14706.426375384479, 14780.852191478163, 14821.77767333491, 14834.554963351116, 22626.208082717025, 23042.769572304398, 23065.423364416023, 23150.07399703993, 23174.53650926972, 7244.963775181196, 7452.703039983961, 7686.385089192851, 7723.729669461542, 8947.792048073557, 7470.402367810562, 7486.288802563748, 7555.659995300225, 7595.772126836093, 7603.847923041619, 4158.563350848178, 4292.849750258726, 4392.099619577979, 4478.753668548261, 4517.864464066083, 1757.1302205408404, 1776.8845025073329, 1793.704038833578, 1861.26480040386, 1862.422648978821, 464.34991012582657, 810.4772421787914, 990.2869933647762, 1001.6344034427527, 1009.4195837393381, 9875.0, 9982.950085249673, 10312.690619281433, 10356.741081473023, 10819.404932728617, 403.98586049488125, 415.27119904567894, 429.1695569073852, 436.6921320469062, 461.3356766256647, 5531.944680553223, 5547.694876781735, 5590.2453168821685, 5695.743691533891, 5719.170720245625, 504469.0, 522973.0, 523382.0, 527729.0, 544272.0, 69121.65439172772, 70524.2947570528, 70611.64694176496, 72277.63861180766, 75682.24317756863, 460.7143570985943, 469.69235150976164, 471.7429001194289, 472.45431526586844, 472.6077355794682, 9268.72193834186, 9548.37935534188, 9585.952070239604, 9798.75503112428, 9842.507874606097, 29601.703982959894, 30139.69860301369, 30192.09423717292, 30771.0, 31181.376372472878, 37867.431988520744, 39812.0, 40696.59303406928, 41509.79245103755, 42643.78678106589, 7109.253528379652, 7210.9278907210255, 7258.383037441877, 7496.4002879768395, 7553.357964572853, 8385.0, 10153.695389138338, 10641.414722190353, 10969.561217551527, 11405.828912566483, 9385.765355866159, 9402.670906518239, 9421.481818500048, 9586.424814511152, 9767.0, 7857.0, 9940.502974851373, 9949.875813955963, 10158.847617285599, 10420.11429028541, 7876.488028278143, 9121.498317592595, 9632.47021413829, 10074.44590547527, 10144.64493742745, 7153.463490238357, 7311.524750891175, 7400.925990740024, 7510.098788145458, 7513.812154696177, 8721.21509064162, 9553.761155970878, 9686.897254729476, 9802.215822734022, 9913.900860991298], "unit": "score", "name": "jquery.html", "value": 7886.356974723661}, {"lowerIsBetter": false, "replicates": [1360.0207850347758, 1416.7308211439827, 1444.1768192130482, 1589.6170331811327, 1796.2635319519, 6660.100886380344, 7088.3620474157315, 7190.748323808668, 7226.349628533438, 7228.349448549629, 7110.715571377139, 7306.123265208183, 7308.890366644505, 7318.780436586911, 7325.963370183142, 2273.5793878132517, 2303.8387312888103, 2304.72343318802, 2306.7116610423695, 2307.0310469602723, 2249.6063188941953, 2278.4759505313787, 2286.554121946221, 2287.931362059141, 2294.724633044037, 2233.910643574255, 2238.0600147937907, 2251.4258863989658, 2259.7401298850596, 2261.027758064032, 2249.325202439262, 2285.5771682238837, 2289.0386037864137, 2291.324059402472, 2292.4498120451053, 2239.328201539548, 2243.450354663118, 2244.5510897820336, 2245.315178870444, 2245.8427910046303, 7203.495755297131, 7261.854762904765, 7262.019627350346, 7269.491135620508, 7310.671019804122, 4597.793099310539, 4739.810407583693, 4742.359781429497, 4771.6898401603785, 4773.403324584427, 2971.1532213319315, 3009.4733421651345, 3082.029160814336, 3105.673904240045, 3126.0778070469037, 918.967836125739, 956.1346980982222, 971.2958105373618, 1001.4191768774093, 1004.9648262310784, 10142.543585538668, 10149.543270552844, 10164.085232329126, 10175.185985121172, 10189.694309170736, 4282.850100246476, 4314.158739045919, 4353.521112677603, 4363.2364336241035, 4383.035732138925, 8813.118688131135, 8820.073892241351, 8827.0, 8833.205011548991, 8837.381383303236, 4755.643326750507, 4786.44955830077, 4787.2101103318255, 4790.568848803624, 4795.184818580849, 3683.9447408288897, 3779.640934111255, 4136.586341365839, 4222.387753775685, 4307.375430562551, 3682.779033258013, 3709.387950988111, 3710.870119545803, 3743.232637309345, 3751.493548370935, 1120.994395028036, 1212.1393660730737, 1231.1074471008626, 1231.9322437266037, 1239.876012398753, 895.7312806158127, 1033.4419413516766, 1074.0977578833817, 1114.765899161169, 1274.1272228523492, 6849.554778939353, 6860.6912688929115, 6870.416014638712, 6909.447244220451, 6931.272216417305, 1097.9231453798318, 1110.6168371911679, 1118.2284223885656, 1126.971825704364, 1147.4549588945351, 5238.60710446718, 5330.653507521999, 5334.5732341412595, 5345.278387417727, 5349.839504814861, 8475.27960123384, 8499.36254780894, 8500.0, 8502.787430314167, 8646.827063458695, 8468.745937621881, 8563.357748168912, 8569.80022796809, 8578.09929957358, 8579.0, 6810.795676129724, 6839.213490448563, 6945.16658001033, 6968.581885086911, 7002.75490357835, 6773.7129945310235, 6791.185057793096, 6824.829379265359, 6831.487638427038, 6834.931650683429, 7753.457257991887, 8087.110417854149, 8117.350611951148, 8132.1461246570625, 8136.837263254583, 8068.596570171585, 8211.58942052883, 8226.0, 8397.790055248423, 8412.369072319723, 6366.331535188739, 6392.552521323462, 6475.773347932988, 6681.9642955342, 6775.4240889524945, 6918.584884906922, 7061.187963384276, 7072.9646351767915, 7122.112640150261, 7135.108111486064, 5855.268091488564, 6657.73369065232, 6724.125863637892, 6799.898001529882, 6819.318068193339, 6316.273628532777, 6665.700043497957, 6670.866582668416, 6769.729210831709, 6775.0, 6554.868902622016, 6564.081028655896, 6570.605763654196, 6603.306652801387, 6629.834254143685, 6114.113453549299, 6173.104899789595, 6178.845528861814, 6183.783567575113, 6191.349908259748, 6013.098035294566, 6213.0, 6283.96858015707, 6299.464545513682, 6400.0], "unit": "score", "name": "mootools.html", "value": 4332.656132645396}, {"lowerIsBetter": false, "replicates": [342.30512060517145, 349.18291198595284, 352.56810407251123, 353.57041194948135, 356.80732404501555, 5884.999550076486, 5917.792877249297, 5928.347881733006, 5951.166836642863, 5959.642421454705, 5675.6878371689545, 5727.140928860663, 5824.504917082053, 5836.15375770514, 5919.467247947684, 4596.402467679197, 4618.607418369443, 4624.283236098393, 4625.791839367236, 4643.558861908114, 4611.239145540982, 4620.907581848361, 4629.467611224702, 4636.6058884994645, 4643.88390290242, 4362.280223763075, 4445.488768791582, 4446.733196008234, 4449.911001779962, 4464.73211607303, 4453.910921781562, 4506.59440650343, 4521.208788462006, 4523.344115103325, 4545.340925565791, 4006.338954072604, 4008.318585840414, 4010.0776821331256, 4015.959840401588, 4044.1911617676287, 5655.236543066674, 5683.886322273573, 5685.829425117253, 5688.317401911756, 5692.089265717506, 5101.438841727407, 5246.685198888079, 5271.65734227274, 5287.788488460457, 5298.09932311508, 6278.183836101278, 6278.4035516625845, 6278.780242691484, 6286.402791734778, 6291.339409362043, 4407.801648925806, 4411.42651455312, 4413.0, 4414.514403415622, 4419.447569053868, 6454.709538070798, 6504.1869766279215, 6572.967135164294, 6576.473882089469, 6588.275289718127, 4502.144592527409, 4508.07584445188, 4511.571400716926, 4514.232580461329, 4515.841945531891, 4557.339185818038, 4562.110388474282, 4568.977155114269, 4569.223232050559, 4572.862814115582, 5250.474952504719, 5253.947460525423, 5261.657992230493, 5285.709285989231, 5311.760970756325, 6220.377962203834, 6338.049292606146, 6344.0, 6357.904631430532, 6358.427741503287, 1591.7214487464648, 1616.2807550640086, 1616.9353225871068, 1617.0, 1617.8220395756457, 1079.7894410589859, 1087.505185140759, 1088.50473034769, 1103.773726386089, 1108.0858291909208, 6001.2498437695285, 6004.579679422399, 6012.338642749294, 6018.488428483628, 6018.638881667114, 6519.7392104315295, 6524.869502609921, 6525.11910892033, 6525.151730275129, 6532.183477065367, 5803.767849286066, 5836.649801011953, 5958.374370691102, 6018.067199584071, 6022.397760223943, 3494.5631796025496, 3516.841742121611, 3517.050396393011, 3525.7531972761662, 3527.5590551181103, 6730.8653826924165, 6733.293004234582, 6739.797806065826, 6743.932560674429, 6754.5947243165565, 6544.051112588648, 6759.662016899136, 6769.255381907986, 6791.966040169867, 6792.42264407521, 6737.69680364375, 6740.292269311652, 6746.561473504206, 6747.05541224229, 6748.291429400038, 6507.511936604679, 6509.056186852785, 6541.149650545589, 6541.34586541342, 6578.868422631424, 6320.778772742932, 6481.287058423664, 6491.902621460777, 6499.057636642755, 6502.934970650422, 6781.152355955505, 6786.3892249697765, 6790.7623233186605, 6794.660266986532, 6799.252082271045, 4536.183486972377, 4536.614387776944, 4537.795799188978, 4540.409746732904, 4541.704789188692, 6429.646369449725, 6581.276059633341, 6592.70332835014, 6603.702833372414, 6609.636469994197, 6356.459700925288, 6383.553151279366, 6389.169407976933, 6391.968040159955, 6408.1349017881985, 6354.951433013686, 6364.427201551883, 6365.904511432424, 6371.203599550056, 6375.5218358624215, 6149.569530132848, 6209.937900621117, 6245.875082498415, 6251.593646412968, 6255.093011513396, 6384.457321127757, 6389.4888408926245, 6391.520635952415, 6396.776112836028, 6412.743490260337, 6258.530610204344, 6262.185915830913, 6267.905981410374, 6268.279147897868, 6278.0], "unit": "score", "name": "prototype.html", "value": 4782.780344617274}, {"lowerIsBetter": false, "replicates": [790.2532107158736, 808.6482380164629, 814.2346194577101, 817.7873752824265, 837.644001299448, 13321.666958326046, 13424.328783560819, 13478.393472293747, 13502.12236204646, 13505.527306544273, 12316.63050108496, 12548.247105173696, 12571.748565028694, 12592.93703531481, 12613.0, 670.8557660103077, 682.4881338995754, 801.7835184500196, 809.1988930958368, 811.3630799822112, 808.3815880851154, 813.1055838577577, 819.6434550970317, 820.4216027700456, 820.6143112737004, 847.4957400346784, 856.1267507142711, 858.2704701004159, 859.5358506406565, 864.2092485375905, 689.7447944260606, 694.4375056204465, 839.6221700234858, 855.5978690015683, 861.9396642235046, 627.4196368359295, 627.6171535363425, 627.8555932135635, 629.2197674883158, 630.0391902348908, 12961.898238649726, 13062.542811001664, 13068.215907045607, 13071.54249601269, 13110.672233194151, 11887.583934562335, 12260.203086799329, 12402.814142665797, 12411.503539858395, 12497.250164990039, 10361.119304859096, 10416.947915260374, 10602.204834637432, 10706.0, 10904.400257985808, 3632.346177688015, 3690.15126520899, 3711.870084547055, 3792.810359482015, 3802.8098595070137, 44445.111097777866, 46516.0, 46701.5329846704, 46991.29513057307, 47058.76470617625, 9153.81692366149, 9512.38169518993, 9645.324827262024, 9749.707508774749, 9864.753381165385, 17403.825961740222, 17613.119344033003, 17632.911835441, 17658.823411765974, 17746.911265443847, 7110.786676399716, 7197.388222001084, 7249.637518124073, 7250.927490725026, 7330.340269375782, 4360.040791025969, 4372.781360931941, 4381.539938306496, 4392.407025051577, 4437.800298986554, 3012.0361484325244, 3034.5903303054247, 3035.9241018974703, 3038.8176709397067, 3043.208765720884, 561.2479277767811, 562.4853259267805, 568.5707290995272, 569.5898952754011, 580.9331926828385, 584.6638183044766, 634.3592971099223, 646.2083947164685, 654.5810681163964, 708.3270892652001, 8169.428140030141, 8243.505389676639, 8276.875846862302, 8414.621342039623, 8474.74575762728, 548.9149181876816, 577.890200861835, 612.2805703298607, 655.5935320101568, 686.0909295183901, 3603.801790901473, 3692.464592634107, 3807.71392894986, 3813.923721525554, 3899.200663863901, 53310.0, 56489.90238390397, 56706.43293567094, 58031.419685802604, 58339.708301458224, 47391.52608473871, 47957.76021119872, 49937.250941235914, 50086.499135008184, 50278.0, 44968.55031449709, 45057.549424505334, 45116.77441612836, 45117.32324015077, 46073.30890036652, 7666.655000524878, 8147.144549822184, 8183.468074575134, 8269.2971097455, 8456.746297611082, 31565.526517101804, 33094.33811323808, 33120.337593248485, 33178.33643327168, 33766.15584610404, 43871.56128438675, 44045.33931990959, 44048.55951440445, 44353.55646443494, 44882.77558612316, 11125.221234513507, 11128.276662016942, 11151.107911367233, 11251.887481125084, 11565.94217028943, 11845.466953987263, 12165.33090680021, 12170.14808963364, 12215.511379545074, 12252.877471225174, 11133.888661113286, 11480.196386252883, 11506.194566380273, 11591.304521728724, 11972.820407693718, 11223.49494272776, 11517.308961462339, 11652.592159274385, 11914.285142891455, 11949.386168461402, 10849.566017359217, 10941.124710023338, 11022.779544408906, 11408.372539510407, 11727.354995474989, 9210.401323913924, 9588.76028099303, 9705.12653861156, 9826.312158148861, 9835.950820246138, 8981.685641002534, 9034.819303614022, 9063.501507417155, 9279.62881484733, 9768.85346719814], "unit": "score", "name": "yui.html", "value": 6198.622683430577}], "name": "dromaeo_css", "value": 6737.144006000496}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 115.0, 107.0, 112.0, 114.0, 114.0, 102.0, 110.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 154.0, 169.0, 129.0, 154.0, 159.0, 131.0, 176.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [165.0, 161.0, 161.0, 163.0, 160.0, 161.0, 159.0, 162.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 87.0, 99.0, 72.0, 71.0, 75.0, 100.0, 93.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 152.0, 95.0, 97.0, 96.0, 139.0, 97.0, 97.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 57.0, 55.0, 58.0, 57.0, 62.0, 65.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 84.0, 85.0, 86.0, 92.0, 84.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [117.0, 120.0, 122.0, 116.0, 115.0, 121.0, 121.0, 116.0, 124.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [152.0, 141.0, 158.0, 153.0, 146.0, 142.0, 143.0, 152.0, 153.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.2}, {"lowerIsBetter": true, "replicates": [77.0, 69.0, 68.0, 69.0, 68.0, 69.0, 70.0, 69.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1512.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.19577862722286], "unit": "score", "name": "Richards", "value": 212.41213400000004}, {"lowerIsBetter": false, "replicates": [190.00570017100512], "unit": "score", "name": "DeltaBlue", "value": 347.979034}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1962.7450980392157], "unit": "score", "name": "RayTrace", "value": 377.0173726273725}, {"lowerIsBetter": false, "replicates": [803.8585209003215], "unit": "score", "name": "Earley", "value": 829.0799720000001}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [42437.5], "unit": "score", "name": "RegExp", "value": 21.466509572901316}, {"lowerIsBetter": false, "replicates": [570.7814269535673], "unit": "score", "name": "Splay", "value": 142.77093849206346}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18989.583642493206}]} 20:20:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18989.58"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1512.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6737.15"}}} 20:20:00 INFO - Return code: 0 20:20:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:20:00 INFO - # TBPL SUCCESS # 20:20:00 INFO - Running post-action listener: _resource_record_post_action 20:20:00 INFO - Running post-run listener: _resource_record_post_run 20:20:01 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 562466816; Read time: 0; Write time: 521300 20:20:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239603712; Read time: 0; Write time: 274056 20:20:01 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 0; Write bytes: 322863104; Read time: 0; Write time: 247244 20:20:01 INFO - Running post-run listener: _upload_blobber_files 20:20:01 INFO - Blob upload gear active. 20:20:01 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:20:01 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 20:20:01 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'] 20:20:01 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 20:20:01 INFO - (blobuploader) - INFO - Open directory for files ... 20:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:03 INFO - (blobuploader) - INFO - Done attempting. 20:20:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:20:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:20:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:04 INFO - (blobuploader) - INFO - Done attempting. 20:20:04 INFO - (blobuploader) - INFO - Iteration through files over. 20:20:04 INFO - Return code: 0 20:20:04 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:20:04 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:20:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4932424d5b0c3d2de84405995b6d424eb50a7dad7c40151ea7f4c7f6d00d84de0bebc6cc6a8018ad497175a0c5c781bc1f952a9ceba59b67dba92045d8bd63d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b87948083f8e3b4331eb3552ff0a697c2973e6cd8cf895dfacb1cfb4ba6ae4c290f9625d4b0d059ae11f9d9751647c9a262e59708106dbfa61044b0fae74ee7d"} 20:20:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:20:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:20:04 INFO - Contents: 20:20:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4932424d5b0c3d2de84405995b6d424eb50a7dad7c40151ea7f4c7f6d00d84de0bebc6cc6a8018ad497175a0c5c781bc1f952a9ceba59b67dba92045d8bd63d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b87948083f8e3b4331eb3552ff0a697c2973e6cd8cf895dfacb1cfb4ba6ae4c290f9625d4b0d059ae11f9d9751647c9a262e59708106dbfa61044b0fae74ee7d"} 20:20:04 INFO - Copying logs to upload dir... 20:20:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1291.965424 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-10 20:20:03.171820) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 20:20:03.174985) ========= 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-1452481266.889989-2004671528 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/4932424d5b0c3d2de84405995b6d424eb50a7dad7c40151ea7f4c7f6d00d84de0bebc6cc6a8018ad497175a0c5c781bc1f952a9ceba59b67dba92045d8bd63d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b87948083f8e3b4331eb3552ff0a697c2973e6cd8cf895dfacb1cfb4ba6ae4c290f9625d4b0d059ae11f9d9751647c9a262e59708106dbfa61044b0fae74ee7d"} build_url:https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-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/4932424d5b0c3d2de84405995b6d424eb50a7dad7c40151ea7f4c7f6d00d84de0bebc6cc6a8018ad497175a0c5c781bc1f952a9ceba59b67dba92045d8bd63d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b87948083f8e3b4331eb3552ff0a697c2973e6cd8cf895dfacb1cfb4ba6ae4c290f9625d4b0d059ae11f9d9751647c9a262e59708106dbfa61044b0fae74ee7d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 20:20:03.201034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:20:03.201430) ========= 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-1452481266.889989-2004671528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:20:03.284092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 20:20:03.284450) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 20:20:03.284819) ========= ========= Total master_lag: 0.22 =========