builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1452626070.22 results: success (0) buildid: 20160112083253 builduid: 46f5211979b14d738bf800baa0ddd7b6 revision: 98687c28986cb707736bd06d99366332b794b777 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.224637) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.225104) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.225396) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004295 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.242264) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.242569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.259918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.260266) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.037819 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.308920) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.309232) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.309583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.309852) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 11:14:30-- 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% 207M=0s 2016-01-12 11:14:30 (207 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175789 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.497879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.498226) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.175385 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.684222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:30.684568) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98687c28986cb707736bd06d99366332b794b777 --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 98687c28986cb707736bd06d99366332b794b777 --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=6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 11:14:30,748 truncating revision to first 12 chars 2016-01-12 11:14:30,748 Setting DEBUG logging. 2016-01-12 11:14:30,748 attempt 1/10 2016-01-12 11:14:30,748 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98687c28986c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 11:14:31,023 unpacking tar archive at: fx-team-98687c28986c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583771 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:31.280211) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:31.280530) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:31.287938) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:31.288212) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 11:14:31.288592) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-12 11:14:31.288871) ========= /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=6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:14:31 INFO - MultiFileLogger online at 20160112 11:14:31 in /builds/slave/test-pgo 11:14:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:14:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:14:31 INFO - {'append_to_log': False, 11:14:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:14:31 INFO - 'blob_upload_branch': 'Fx-Team', 11:14:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:14:31 INFO - 'branch': 'Fx-Team', 11:14:31 INFO - 'buildbot_json_path': 'buildprops.json', 11:14:31 INFO - 'config_files': ('talos/linux_config.py',), 11:14:31 INFO - 'default_actions': ('clobber', 11:14:31 INFO - 'read-buildbot-config', 11:14:31 INFO - 'download-and-extract', 11:14:31 INFO - 'populate-webroot', 11:14:31 INFO - 'create-virtualenv', 11:14:31 INFO - 'install', 11:14:31 INFO - 'run-tests'), 11:14:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:14:31 INFO - 'download_minidump_stackwalk': True, 11:14:31 INFO - 'download_symbols': 'ondemand', 11:14:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:14:31 INFO - 'tooltool.py': '/tools/tooltool.py', 11:14:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:14:31 INFO - '/tools/misc-python/virtualenv.py')}, 11:14:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:14:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:14:31 INFO - 'installer_path': 'installer.exe', 11:14:31 INFO - 'log_level': 'info', 11:14:31 INFO - 'log_name': 'talos', 11:14:31 INFO - 'log_to_console': True, 11:14:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:14:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:14:31 INFO - 'opt_config_files': (), 11:14:31 INFO - 'pip_index': False, 11:14:31 INFO - 'sps_profile': False, 11:14:31 INFO - 'sps_profile_interval': 0, 11:14:31 INFO - 'suite': 'dromaeojs', 11:14:31 INFO - 'system_bits': '32', 11:14:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:14:31 INFO - 'title': 'talos-linux64-ix-023', 11:14:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:14:31 INFO - 'use_talos_json': True, 11:14:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:14:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:14:31 INFO - 'work_dir': 'build'} 11:14:31 INFO - ##### 11:14:31 INFO - ##### Running clobber step. 11:14:31 INFO - ##### 11:14:31 INFO - Running pre-action listener: _resource_record_pre_action 11:14:31 INFO - Running main action method: clobber 11:14:31 INFO - rmtree: /builds/slave/test-pgo/build 11:14:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:14:32 INFO - Running post-action listener: _resource_record_post_action 11:14:32 INFO - ##### 11:14:32 INFO - ##### Running read-buildbot-config step. 11:14:32 INFO - ##### 11:14:32 INFO - Running pre-action listener: _resource_record_pre_action 11:14:32 INFO - Running main action method: read_buildbot_config 11:14:32 INFO - Using buildbot properties: 11:14:32 INFO - { 11:14:32 INFO - "project": "", 11:14:32 INFO - "product": "firefox", 11:14:32 INFO - "script_repo_revision": "production", 11:14:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:14:32 INFO - "repository": "", 11:14:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:14:32 INFO - "buildid": "20160112083253", 11:14:32 INFO - "pgo_build": "True", 11:14:32 INFO - "basedir": "/builds/slave/test-pgo", 11:14:32 INFO - "buildnumber": 891, 11:14:32 INFO - "slavename": "talos-linux64-ix-023", 11:14:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:14:32 INFO - "platform": "ubuntu64_hw", 11:14:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:14:32 INFO - "branch": "fx-team", 11:14:32 INFO - "repo_path": "integration/fx-team", 11:14:32 INFO - "revision": "98687c28986cb707736bd06d99366332b794b777", 11:14:32 INFO - "stage_platform": "linux64-pgo", 11:14:32 INFO - "builduid": "46f5211979b14d738bf800baa0ddd7b6", 11:14:32 INFO - "slavebuilddir": "test" 11:14:32 INFO - } 11:14:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:14:32 INFO - Running post-action listener: _resource_record_post_action 11:14:32 INFO - ##### 11:14:32 INFO - ##### Running download-and-extract step. 11:14:32 INFO - ##### 11:14:32 INFO - Running pre-action listener: _resource_record_pre_action 11:14:32 INFO - Running main action method: download_and_extract 11:14:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:14:32 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')]} 11:14:32 INFO - https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:14:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/test_packages.json 11:14:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/test_packages.json 11:14:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:14:33 INFO - Downloaded 1302 bytes. 11:14:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:14:33 INFO - Using the following test package requirements: 11:14:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:14:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:33 INFO - u'jsshell-linux-x86_64.zip'], 11:14:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:14:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:14:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:14:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:14:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:14:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:14: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')]} 11:14:33 INFO - https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:14:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:14:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:14:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/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 11:14:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/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 11:14:35 INFO - Downloaded 24027009 bytes. 11:14:35 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 11:14:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:14:35 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 11:14:36 INFO - Return code: 0 11:14:36 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 11:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:36 INFO - https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:14:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:14:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:14:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/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 11:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/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 11:14:39 INFO - Downloaded 24027009 bytes. 11:14:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:14:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:14:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:14:40 INFO - Return code: 0 11:14: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')]} 11:14:40 INFO - https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/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 11:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/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 11:14:42 INFO - Downloaded 11132285 bytes. 11:14:42 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 11:14:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:42 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 11:14:42 INFO - Return code: 0 11:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:42 INFO - https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:14:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:14:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:14:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/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 11:14:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/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 11:14:45 INFO - Downloaded 55746196 bytes. 11:14:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:14:45 INFO - mkdir: /builds/slave/test-pgo/properties 11:14:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:14:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:14:45 INFO - Contents: 11:14:45 INFO - build_url:https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:14:45 INFO - Running post-action listener: _resource_record_post_action 11:14:45 INFO - Running post-action listener: set_extra_try_arguments 11:14:45 INFO - ##### 11:14:45 INFO - ##### Running populate-webroot step. 11:14:45 INFO - ##### 11:14:45 INFO - Running pre-action listener: _resource_record_pre_action 11:14:45 INFO - Running main action method: populate_webroot 11:14:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:14:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:14:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:14:45 INFO - '--tppagecycles', 11:14:45 INFO - '7'], 11:14:45 INFO - 'tests': ['tsvgm']}}, 11:14:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:14:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:14:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:14:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:14:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:14:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:14:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:45 INFO - 'talos_options': ['--e10s'], 11:14:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:45 INFO - 'tests': ['damp', 'tps']}, 11:14:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:45 INFO - 'talos_options': ['--e10s'], 11:14:45 INFO - 'tests': ['damp', 'tps']}, 11:14:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:14:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:14:45 INFO - 'other': {'tests': ['a11yr', 11:14:45 INFO - 'ts_paint', 11:14:45 INFO - 'tpaint', 11:14:45 INFO - 'sessionrestore', 11:14:45 INFO - 'sessionrestore_no_auto_restore']}, 11:14:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:14:45 INFO - 'tests': ['a11yr', 11:14:45 INFO - 'ts_paint', 11:14:45 INFO - 'tpaint', 11:14:45 INFO - 'sessionrestore', 11:14:45 INFO - 'sessionrestore_no_auto_restore']}, 11:14:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:14:45 INFO - 'tests': ['a11yr', 11:14:45 INFO - 'ts_paint', 11:14:45 INFO - 'tpaint', 11:14:45 INFO - 'sessionrestore', 11:14:45 INFO - 'sessionrestore_no_auto_restore']}, 11:14:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:14:45 INFO - 'tests': ['a11yr', 11:14:45 INFO - 'ts_paint', 11:14:45 INFO - 'tpaint', 11:14:45 INFO - 'sessionrestore', 11:14:45 INFO - 'sessionrestore_no_auto_restore']}, 11:14:45 INFO - 'other_l64': {'tests': ['a11yr', 11:14:45 INFO - 'ts_paint', 11:14:45 INFO - 'tpaint', 11:14:45 INFO - 'sessionrestore', 11:14:45 INFO - 'sessionrestore_no_auto_restore']}, 11:14:45 INFO - 'other_nol64': {'tests': ['a11yr', 11:14:45 INFO - 'ts_paint', 11:14:45 INFO - 'tpaint', 11:14:45 INFO - 'sessionrestore', 11:14:45 INFO - 'sessionrestore_no_auto_restore']}, 11:14:45 INFO - 'svgr': {'tests': ['tsvgx', 11:14:45 INFO - 'tsvgr_opacity', 11:14:45 INFO - 'tart', 11:14:45 INFO - 'tscrollx', 11:14:45 INFO - 'cart']}, 11:14:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:14:45 INFO - 'tests': ['tsvgx', 11:14:45 INFO - 'tsvgr_opacity', 11:14:45 INFO - 'tart', 11:14:45 INFO - 'tscrollx', 11:14:45 INFO - 'cart']}, 11:14:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:45 INFO - 'tests': ['tp5o']}, 11:14:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:45 INFO - 'talos_options': ['--e10s'], 11:14:45 INFO - 'tests': ['tp5o']}, 11:14:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:45 INFO - 'talos_options': ['--xperf_path', 11:14:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:45 INFO - 'tests': ['tp5n']}, 11:14:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:45 INFO - 'talos_options': ['--e10s', 11:14:45 INFO - '--xperf_path', 11:14:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:45 INFO - 'tests': ['tp5n']}}, 11:14:45 INFO - 'talos.zip': {'path': '', 11:14:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:14:45 INFO - Running post-action listener: _resource_record_post_action 11:14:45 INFO - ##### 11:14:45 INFO - ##### Running create-virtualenv step. 11:14:45 INFO - ##### 11:14:45 INFO - Running pre-action listener: _resource_record_pre_action 11:14:45 INFO - Running main action method: create_virtualenv 11:14:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:14:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 11:14:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:14:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:14:45 INFO - Using real prefix '/usr' 11:14:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:14:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:14:47 INFO - Installing pip.................done. 11:14:47 INFO - Return code: 0 11:14:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74b68f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9660>, '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 0x22aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aaa10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', '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 11:14:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:14:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:14:47 INFO - Using env: {'DISPLAY': ':0', 11:14:47 INFO - 'HOME': '/home/cltbld', 11:14:47 INFO - 'LANG': 'en_US.UTF-8', 11:14:47 INFO - 'LANGUAGE': 'en_US:en', 11:14:47 INFO - 'LOGNAME': 'cltbld', 11:14:47 INFO - 'MAIL': '/var/mail/cltbld', 11:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:47 INFO - 'MOZ_NO_REMOTE': '1', 11:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:47 INFO - 'NO_EM_RESTART': '1', 11:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:47 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:47 INFO - 'SHELL': '/bin/bash', 11:14:47 INFO - 'SHLVL': '1', 11:14:47 INFO - 'TERM': 'linux', 11:14:47 INFO - 'TMOUT': '86400', 11:14:47 INFO - 'USER': 'cltbld', 11:14:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', 11:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:47 INFO - '_': '/tools/buildbot/bin/python'} 11:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:14:48 INFO - Cleaning up... 11:14:48 INFO - Return code: 0 11:14:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74b68f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9660>, '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 0x22aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aaa10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', '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 11:14:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:14:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:14:48 INFO - Using env: {'DISPLAY': ':0', 11:14:48 INFO - 'HOME': '/home/cltbld', 11:14:48 INFO - 'LANG': 'en_US.UTF-8', 11:14:48 INFO - 'LANGUAGE': 'en_US:en', 11:14:48 INFO - 'LOGNAME': 'cltbld', 11:14:48 INFO - 'MAIL': '/var/mail/cltbld', 11:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:48 INFO - 'MOZ_NO_REMOTE': '1', 11:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:48 INFO - 'NO_EM_RESTART': '1', 11:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:48 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:48 INFO - 'SHELL': '/bin/bash', 11:14:48 INFO - 'SHLVL': '1', 11:14:48 INFO - 'TERM': 'linux', 11:14:48 INFO - 'TMOUT': '86400', 11:14:48 INFO - 'USER': 'cltbld', 11:14:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', 11:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:48 INFO - '_': '/tools/buildbot/bin/python'} 11:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:48 INFO - Downloading/unpacking psutil>=0.7.1 11:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:14:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:14:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:14:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:50 INFO - Installing collected packages: psutil 11:14:50 INFO - Running setup.py install for psutil 11:14:50 INFO - building 'psutil._psutil_linux' extension 11:14:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:14:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:14:50 INFO - building 'psutil._psutil_posix' extension 11:14:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:14:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:14:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:50 INFO - Successfully installed psutil 11:14:50 INFO - Cleaning up... 11:14:50 INFO - Return code: 0 11:14:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74b68f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9660>, '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 0x22aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aaa10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', '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 11:14:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:14:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:14:50 INFO - Using env: {'DISPLAY': ':0', 11:14:50 INFO - 'HOME': '/home/cltbld', 11:14:50 INFO - 'LANG': 'en_US.UTF-8', 11:14:50 INFO - 'LANGUAGE': 'en_US:en', 11:14:50 INFO - 'LOGNAME': 'cltbld', 11:14:50 INFO - 'MAIL': '/var/mail/cltbld', 11:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:50 INFO - 'MOZ_NO_REMOTE': '1', 11:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:50 INFO - 'NO_EM_RESTART': '1', 11:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:50 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:50 INFO - 'SHELL': '/bin/bash', 11:14:50 INFO - 'SHLVL': '1', 11:14:50 INFO - 'TERM': 'linux', 11:14:50 INFO - 'TMOUT': '86400', 11:14:50 INFO - 'USER': 'cltbld', 11:14:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', 11:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:50 INFO - '_': '/tools/buildbot/bin/python'} 11:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:14:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:14:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:14:52 INFO - Installing collected packages: mozsystemmonitor 11:14:52 INFO - Running setup.py install for mozsystemmonitor 11:14:52 INFO - Successfully installed mozsystemmonitor 11:14:52 INFO - Cleaning up... 11:14:52 INFO - Return code: 0 11:14:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74b68f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9660>, '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 0x22aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aaa10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', '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 11:14:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:14:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:14:52 INFO - Using env: {'DISPLAY': ':0', 11:14:52 INFO - 'HOME': '/home/cltbld', 11:14:52 INFO - 'LANG': 'en_US.UTF-8', 11:14:52 INFO - 'LANGUAGE': 'en_US:en', 11:14:52 INFO - 'LOGNAME': 'cltbld', 11:14:52 INFO - 'MAIL': '/var/mail/cltbld', 11:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:52 INFO - 'MOZ_NO_REMOTE': '1', 11:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:52 INFO - 'NO_EM_RESTART': '1', 11:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:52 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:52 INFO - 'SHELL': '/bin/bash', 11:14:52 INFO - 'SHLVL': '1', 11:14:52 INFO - 'TERM': 'linux', 11:14:52 INFO - 'TMOUT': '86400', 11:14:52 INFO - 'USER': 'cltbld', 11:14:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', 11:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:52 INFO - '_': '/tools/buildbot/bin/python'} 11:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:14:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:14:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:14:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:14:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:14:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:55 INFO - Downloading docopt-0.6.1.tar.gz 11:14:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:14:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:14:55 INFO - Installing collected packages: blobuploader, requests, docopt 11:14:55 INFO - Running setup.py install for blobuploader 11:14:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:14:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:14:55 INFO - Running setup.py install for requests 11:14:55 INFO - Running setup.py install for docopt 11:14:55 INFO - Successfully installed blobuploader requests docopt 11:14:55 INFO - Cleaning up... 11:14:55 INFO - Return code: 0 11:14:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:14: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')]} 11:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74b68f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9660>, '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 0x22aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aaa10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', '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 11:14:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:14:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:14:55 INFO - Using env: {'DISPLAY': ':0', 11:14:55 INFO - 'HOME': '/home/cltbld', 11:14:55 INFO - 'LANG': 'en_US.UTF-8', 11:14:55 INFO - 'LANGUAGE': 'en_US:en', 11:14:55 INFO - 'LOGNAME': 'cltbld', 11:14:55 INFO - 'MAIL': '/var/mail/cltbld', 11:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:55 INFO - 'MOZ_NO_REMOTE': '1', 11:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:55 INFO - 'NO_EM_RESTART': '1', 11:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:55 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:55 INFO - 'SHELL': '/bin/bash', 11:14:55 INFO - 'SHLVL': '1', 11:14:55 INFO - 'TERM': 'linux', 11:14:55 INFO - 'TMOUT': '86400', 11:14:55 INFO - 'USER': 'cltbld', 11:14:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', 11:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:55 INFO - '_': '/tools/buildbot/bin/python'} 11:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:14:56 INFO - Running setup.py (path:/tmp/pip-EmZ7mN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:14:56 INFO - Running setup.py (path:/tmp/pip-gMRbmt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:14:56 INFO - Running setup.py (path:/tmp/pip-ooRPCd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:14:56 INFO - Running setup.py (path:/tmp/pip-XwyOox-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:14:56 INFO - Running setup.py (path:/tmp/pip-SJlHDP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:14:56 INFO - Running setup.py (path:/tmp/pip-F2jgtb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:14:56 INFO - Running setup.py (path:/tmp/pip-d_oTSW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:14:56 INFO - Running setup.py (path:/tmp/pip-R4HDU1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:14:56 INFO - Running setup.py (path:/tmp/pip-hjedRz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:14:56 INFO - Running setup.py (path:/tmp/pip-dqNGDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:14:56 INFO - Running setup.py (path:/tmp/pip-kiw7T9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:14:56 INFO - Running setup.py (path:/tmp/pip-TTfAis-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:14:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:14:57 INFO - Running setup.py (path:/tmp/pip-ERXTgk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:14:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:14:57 INFO - Running setup.py (path:/tmp/pip-noBaOJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:14:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:14:57 INFO - Running setup.py (path:/tmp/pip-VD9Syk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:14:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:14:57 INFO - Running setup.py (path:/tmp/pip-gCWJcZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:14:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:14:57 INFO - Running setup.py (path:/tmp/pip-T88kXf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:14:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:57 INFO - Running setup.py install for manifestparser 11:14:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:14:57 INFO - Running setup.py install for mozcrash 11:14:57 INFO - Running setup.py install for mozdebug 11:14:57 INFO - Running setup.py install for mozdevice 11:14:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:14:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:14:57 INFO - Running setup.py install for mozfile 11:14:57 INFO - Running setup.py install for mozhttpd 11:14:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:14:58 INFO - Running setup.py install for mozinfo 11:14:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:14:58 INFO - Running setup.py install for mozInstall 11:14:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:14:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:14:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:14:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:14:58 INFO - Running setup.py install for mozleak 11:14:58 INFO - Running setup.py install for mozlog 11:14:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:14:58 INFO - Running setup.py install for moznetwork 11:14:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:14:58 INFO - Running setup.py install for mozprocess 11:14:58 INFO - Running setup.py install for mozprofile 11:14:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:14:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:14:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:14:58 INFO - Running setup.py install for mozrunner 11:14:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:14:58 INFO - Running setup.py install for mozscreenshot 11:14:58 INFO - Running setup.py install for moztest 11:14:59 INFO - Running setup.py install for mozversion 11:14:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:14:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:14:59 INFO - Cleaning up... 11:14:59 INFO - Return code: 0 11:14:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:14: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')]} 11:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74b68f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9660>, '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 0x22aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aaa10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', '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 11:14:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:14:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:14:59 INFO - Using env: {'DISPLAY': ':0', 11:14:59 INFO - 'HOME': '/home/cltbld', 11:14:59 INFO - 'LANG': 'en_US.UTF-8', 11:14:59 INFO - 'LANGUAGE': 'en_US:en', 11:14:59 INFO - 'LOGNAME': 'cltbld', 11:14:59 INFO - 'MAIL': '/var/mail/cltbld', 11:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:59 INFO - 'MOZ_NO_REMOTE': '1', 11:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:59 INFO - 'NO_EM_RESTART': '1', 11:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:59 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:59 INFO - 'SHELL': '/bin/bash', 11:14:59 INFO - 'SHLVL': '1', 11:14:59 INFO - 'TERM': 'linux', 11:14:59 INFO - 'TMOUT': '86400', 11:14:59 INFO - 'USER': 'cltbld', 11:14:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', 11:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:59 INFO - '_': '/tools/buildbot/bin/python'} 11:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:14:59 INFO - Running setup.py (path:/tmp/pip-ItYFfW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:14:59 INFO - Running setup.py (path:/tmp/pip-XO_1yY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:14:59 INFO - Running setup.py (path:/tmp/pip-B4DwcT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:14:59 INFO - Running setup.py (path:/tmp/pip-J5sjLf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:14:59 INFO - Running setup.py (path:/tmp/pip-da4anh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:14:59 INFO - Running setup.py (path:/tmp/pip-j6u_op-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:14:59 INFO - Running setup.py (path:/tmp/pip-951Wl8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:14:59 INFO - Running setup.py (path:/tmp/pip-NRGxj1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:14:59 INFO - Running setup.py (path:/tmp/pip-F7pyb4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 11:15:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:15:00 INFO - Running setup.py (path:/tmp/pip-sOAbrj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:15:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:15:00 INFO - Running setup.py (path:/tmp/pip-wQKxUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 11:15:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:15:00 INFO - Running setup.py (path:/tmp/pip-qrjhW7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 11:15:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:15:00 INFO - Running setup.py (path:/tmp/pip-xO3rl0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 11:15:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:15:00 INFO - Running setup.py (path:/tmp/pip-JAcPYd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 11:15:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:15:00 INFO - Running setup.py (path:/tmp/pip-yzubR1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 11:15:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:15:00 INFO - Running setup.py (path:/tmp/pip-Jl6vRt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 11:15:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:15:00 INFO - Running setup.py (path:/tmp/pip-Q5A5X9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:15:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:02 INFO - Downloading blessings-1.5.1.tar.gz 11:15:02 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 11:15:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:15:02 INFO - Installing collected packages: blessings 11:15:02 INFO - Running setup.py install for blessings 11:15:02 INFO - Successfully installed blessings 11:15:02 INFO - Cleaning up... 11:15:02 INFO - Return code: 0 11:15:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:15:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:15:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:15:02 INFO - Reading from file tmpfile_stdout 11:15:02 INFO - Current package versions: 11:15:02 INFO - argparse == 1.2.1 11:15:02 INFO - blessings == 1.5.1 11:15:02 INFO - blobuploader == 1.2.4 11:15:02 INFO - docopt == 0.6.1 11:15:02 INFO - manifestparser == 1.1 11:15:02 INFO - mozInstall == 1.12 11:15:02 INFO - mozcrash == 0.16 11:15:02 INFO - mozdebug == 0.1 11:15:02 INFO - mozdevice == 0.47 11:15:02 INFO - mozfile == 1.2 11:15:02 INFO - mozhttpd == 0.7 11:15:02 INFO - mozinfo == 0.9 11:15:02 INFO - mozleak == 0.1 11:15:02 INFO - mozlog == 3.1 11:15:02 INFO - moznetwork == 0.27 11:15:02 INFO - mozprocess == 0.22 11:15:02 INFO - mozprofile == 0.28 11:15:02 INFO - mozrunner == 6.11 11:15:02 INFO - mozscreenshot == 0.1 11:15:02 INFO - mozsystemmonitor == 0.0 11:15:02 INFO - moztest == 0.7 11:15:02 INFO - mozversion == 1.4 11:15:02 INFO - psutil == 3.1.1 11:15:02 INFO - requests == 1.2.3 11:15:02 INFO - wsgiref == 0.1.2 11:15:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74b68f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9660>, '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 0x22aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aaa10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', '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 11:15:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 11:15:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:15:02 INFO - Using env: {'DISPLAY': ':0', 11:15:02 INFO - 'HOME': '/home/cltbld', 11:15:02 INFO - 'LANG': 'en_US.UTF-8', 11:15:02 INFO - 'LANGUAGE': 'en_US:en', 11:15:02 INFO - 'LOGNAME': 'cltbld', 11:15:02 INFO - 'MAIL': '/var/mail/cltbld', 11:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:02 INFO - 'MOZ_NO_REMOTE': '1', 11:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:02 INFO - 'NO_EM_RESTART': '1', 11:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:15:02 INFO - 'PWD': '/builds/slave/test-pgo', 11:15:02 INFO - 'SHELL': '/bin/bash', 11:15:02 INFO - 'SHLVL': '1', 11:15:02 INFO - 'TERM': 'linux', 11:15:02 INFO - 'TMOUT': '86400', 11:15:02 INFO - 'USER': 'cltbld', 11:15:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', 11:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:02 INFO - '_': '/tools/buildbot/bin/python'} 11:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 11:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 11:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 11:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 11:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 11:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 11:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 11:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:15:02 INFO - Cleaning up... 11:15:02 INFO - Return code: 0 11:15:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f74b68f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9660>, '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 0x22aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aaa10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', '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 11:15:02 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 11:15:02 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 11:15:02 INFO - Using env: {'DISPLAY': ':0', 11:15:02 INFO - 'HOME': '/home/cltbld', 11:15:02 INFO - 'LANG': 'en_US.UTF-8', 11:15:02 INFO - 'LANGUAGE': 'en_US:en', 11:15:02 INFO - 'LOGNAME': 'cltbld', 11:15:02 INFO - 'MAIL': '/var/mail/cltbld', 11:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:02 INFO - 'MOZ_NO_REMOTE': '1', 11:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:02 INFO - 'NO_EM_RESTART': '1', 11:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:15:02 INFO - 'PWD': '/builds/slave/test-pgo', 11:15:02 INFO - 'SHELL': '/bin/bash', 11:15:02 INFO - 'SHLVL': '1', 11:15:02 INFO - 'TERM': 'linux', 11:15:02 INFO - 'TMOUT': '86400', 11:15:02 INFO - 'USER': 'cltbld', 11:15:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', 11:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:02 INFO - '_': '/tools/buildbot/bin/python'} 11:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:03 INFO - Downloading/unpacking jsonschema 11:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:15:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 11:15:04 INFO - Downloading/unpacking functools32 (from jsonschema) 11:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:05 INFO - Downloading functools32-3.2.3-2.tar.gz 11:15:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:15:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:15:05 INFO - warning: no files found matching '*.txt' 11:15:05 INFO - no previously-included directories found matching 'build' 11:15:05 INFO - no previously-included directories found matching 'dist' 11:15:05 INFO - no previously-included directories found matching '.git*' 11:15:05 INFO - Installing collected packages: jsonschema, functools32 11:15:05 INFO - Running setup.py install for functools32 11:15:05 INFO - warning: no files found matching '*.txt' 11:15:05 INFO - no previously-included directories found matching 'build' 11:15:05 INFO - no previously-included directories found matching 'dist' 11:15:05 INFO - no previously-included directories found matching '.git*' 11:15:05 INFO - Successfully installed jsonschema functools32 11:15:05 INFO - Cleaning up... 11:15:05 INFO - Return code: 0 11:15:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74b68f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9660>, '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 0x22aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aaa10>, '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': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', '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 11:15:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:15:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:15:05 INFO - Using env: {'DISPLAY': ':0', 11:15:05 INFO - 'HOME': '/home/cltbld', 11:15:05 INFO - 'LANG': 'en_US.UTF-8', 11:15:05 INFO - 'LANGUAGE': 'en_US:en', 11:15:05 INFO - 'LOGNAME': 'cltbld', 11:15:05 INFO - 'MAIL': '/var/mail/cltbld', 11:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:05 INFO - 'MOZ_NO_REMOTE': '1', 11:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:05 INFO - 'NO_EM_RESTART': '1', 11:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:15:05 INFO - 'PWD': '/builds/slave/test-pgo', 11:15:05 INFO - 'SHELL': '/bin/bash', 11:15:05 INFO - 'SHLVL': '1', 11:15:05 INFO - 'TERM': 'linux', 11:15:05 INFO - 'TMOUT': '86400', 11:15:05 INFO - 'USER': 'cltbld', 11:15:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', 11:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:05 INFO - '_': '/tools/buildbot/bin/python'} 11:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:05 INFO - Downloading/unpacking flake8 11:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:15:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 11:15:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:15:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 11:15:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 11:15:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:15:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:15:07 INFO - no previously-included directories found matching 'docs/_build' 11:15:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:15:08 INFO - Running setup.py install for pep8 11:15:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:15:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:15:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:15:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:15:08 INFO - no previously-included directories found matching 'docs/_build' 11:15:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:15:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:15:08 INFO - Cleaning up... 11:15:08 INFO - Return code: 0 11:15:08 INFO - Running post-action listener: _resource_record_post_action 11:15:08 INFO - Running post-action listener: _start_resource_monitoring 11:15:08 INFO - Starting resource monitoring. 11:15:08 INFO - ##### 11:15:08 INFO - ##### Running install step. 11:15:08 INFO - ##### 11:15:08 INFO - Running pre-action listener: _resource_record_pre_action 11:15:08 INFO - Running main action method: install 11:15:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:15:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:15:08 INFO - Reading from file tmpfile_stdout 11:15:08 INFO - Detecting whether we're running mozinstall >=1.0... 11:15:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:15:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:15:08 INFO - Reading from file tmpfile_stdout 11:15:08 INFO - Output received: 11:15:08 INFO - Usage: mozinstall [options] installer 11:15:08 INFO - Options: 11:15:08 INFO - -h, --help show this help message and exit 11:15:08 INFO - -d DEST, --destination=DEST 11:15:08 INFO - Directory to install application into. [default: 11:15:08 INFO - "/builds/slave/test-pgo"] 11:15:08 INFO - --app=APP Application being installed. [default: firefox] 11:15:08 INFO - mkdir: /builds/slave/test-pgo/build/application 11:15:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:15:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:15:24 INFO - Reading from file tmpfile_stdout 11:15:24 INFO - Output received: 11:15:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:15:24 INFO - Running post-action listener: _resource_record_post_action 11:15:24 INFO - ##### 11:15:24 INFO - ##### Running run-tests step. 11:15:24 INFO - ##### 11:15:24 INFO - Running pre-action listener: _resource_record_pre_action 11:15:24 INFO - Running main action method: run_tests 11:15:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:15:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:15:24 INFO - Python 2.7.3 11:15:24 INFO - Return code: 0 11:15:24 INFO - grabbing minidump binary from tooltool 11:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9660>, '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 0x22aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aaa10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:15:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 11:15:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:15:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:15:24 INFO - Return code: 0 11:15:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:15:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:15:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:15:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:15:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:15:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:15:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:15:25 INFO - Return code: 0 11:15:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 11:15:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 11:15:25 INFO - Using env: {'DISPLAY': ':0', 11:15:25 INFO - 'HOME': '/home/cltbld', 11:15:25 INFO - 'LANG': 'en_US.UTF-8', 11:15:25 INFO - 'LANGUAGE': 'en_US:en', 11:15:25 INFO - 'LOGNAME': 'cltbld', 11:15:25 INFO - 'MAIL': '/var/mail/cltbld', 11:15:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:15:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:25 INFO - 'MOZ_NO_REMOTE': '1', 11:15:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:25 INFO - 'NO_EM_RESTART': '1', 11:15:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:15:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:15:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:15:25 INFO - 'SHELL': '/bin/bash', 11:15:25 INFO - 'SHLVL': '1', 11:15:25 INFO - 'TERM': 'linux', 11:15:25 INFO - 'TMOUT': '86400', 11:15:25 INFO - 'USER': 'cltbld', 11:15:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061', 11:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:25 INFO - '_': '/tools/buildbot/bin/python'} 11:15:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 11:15:25 INFO - mozversion application_buildid: 20160112083253 11:15:25 INFO - mozversion application_changeset: 98687c28986cb707736bd06d99366332b794b777 11:15:25 INFO - mozversion application_display_name: Nightly 11:15:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:15:25 INFO - mozversion application_name: Firefox 11:15:25 INFO - mozversion application_remotingname: firefox 11:15:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:15:25 INFO - mozversion application_vendor: Mozilla 11:15:25 INFO - mozversion application_version: 46.0a1 11:15:25 INFO - mozversion platform_buildid: 20160112083253 11:15:25 INFO - mozversion platform_changeset: 98687c28986cb707736bd06d99366332b794b777 11:15:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:15:25 INFO - mozversion platform_version: 46.0a1 11:15:25 INFO - using testdate: 1452626125 11:15:25 INFO - actual date: 1452626125 11:15:25 INFO - starting webserver on 'localhost:54167' 11:15:25 INFO - SUITE-START | Running 3 tests 11:15:25 INFO - TEST-START | dromaeo_css 11:15:25 INFO - operating with platform_type : linux_ 11:15:25 INFO - Initialising browser for dromaeo_css test... 11:15:25 INFO - TEST-INFO | started process 9151 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTa5rUR/profile http://localhost:54167/getInfo.html) 11:15:29 INFO - PROCESS | 9151 | __metrics Screen width/height:1600/1200 11:15:29 INFO - PROCESS | 9151 | colorDepth:24 11:15:29 INFO - PROCESS | 9151 | Browser inner width/height: 1024/697 11:15:29 INFO - PROCESS | 9151 | __metrics 11:15:29 INFO - PROCESS | 9151 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:15:29 INFO - PROCESS | 9151 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:15:30 INFO - TEST-INFO | 9151: exit 0 11:15:30 INFO - Browser initialized. 11:15:30 INFO - Running cycle 1/1 for dromaeo_css test... 11:15:30 INFO - TEST-INFO | started process 9249 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTa5rUR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:15:42 INFO - PROCESS | 9249 | RSS: Main: 147845120 11:15:42 INFO - PROCESS | 9249 | 11:16:33 INFO - PROCESS | 9249 | 1452626193968 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] 11:18:41 INFO - PROCESS | 9249 | Cycle 1(1): loaded http://localhost:54167/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54167/tests/dromaeo/cssquery-ext.html) 11:18:43 INFO - PROCESS | 9249 | RSS: Main: 271257600 11:18:43 INFO - PROCESS | 9249 | 11:21:45 INFO - PROCESS | 9249 | Cycle 1(1): loaded http://localhost:54167/tests/dromaeo/cssquery-ext.html (next: http://localhost:54167/tests/dromaeo/cssquery-jquery.html) 11:21:46 INFO - PROCESS | 9249 | RSS: Main: 230744064 11:21:46 INFO - PROCESS | 9249 | 11:24:48 INFO - PROCESS | 9249 | Cycle 1(1): loaded http://localhost:54167/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54167/tests/dromaeo/cssquery-mootools.html) 11:24:48 INFO - PROCESS | 9249 | RSS: Main: 225701888 11:24:48 INFO - PROCESS | 9249 | 11:27:50 INFO - PROCESS | 9249 | Cycle 1(1): loaded http://localhost:54167/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54167/tests/dromaeo/cssquery-prototype.html) 11:27:51 INFO - PROCESS | 9249 | RSS: Main: 210944000 11:27:51 INFO - PROCESS | 9249 | 11:30:53 INFO - PROCESS | 9249 | Cycle 1(1): loaded http://localhost:54167/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54167/tests/dromaeo/cssquery-yui.html) 11:30:54 INFO - PROCESS | 9249 | RSS: Main: 216891392 11:30:54 INFO - PROCESS | 9249 | 11:33:57 INFO - PROCESS | 9249 | Cycle 1(1): loaded http://localhost:54167/tests/dromaeo/cssquery-yui.html (next: http://localhost:54167/tests/dromaeo/cssquery-dojo.html) 11:33:57 INFO - PROCESS | 9249 | RSS: Main: 267218944 11:33:57 INFO - PROCESS | 9249 | 11:33:57 INFO - PROCESS | 9249 | __start_tp_report 11:33:57 INFO - PROCESS | 9249 | _x_x_mozilla_page_load 11:33:57 INFO - PROCESS | 9249 | _x_x_mozilla_page_load_details 11:33:57 INFO - PROCESS | 9249 | |i|pagename|runs| 11:33:57 INFO - PROCESS | 9249 | |0;dojo.html;3098.333858220483;3099.907002789917;3142.0573827851654;3142.71715545601;3167.1765341011337;4927.6797008194535;4995.525425084616;5023.874403139924;5050.217216331474;5061.063703214908;4953.257011448284;5016.7742451589675;5046.873828154298;5048.1165795985735;5056.266841308008;4366.454193225847;4545.4545454545505;4566.383538222339;4620.838270660528;4739.14695354836;4512.751798651073;4596.862094137181;4641.791119399635;4693.272542755878;4757.690750101249;4634.258518637019;4663.60359369454;4672.602828759559;4676.696014759047;4701.388819453483;4588.977055114737;4607.746573938432;4611.492735799059;4638.976805115986;4646.605038571725;4572.0627271409285;4594.540545945412;4601.7699115044115;4624.838130665411;4669.369635099286;4850.369451971256;4871.050145221683;4876.122297986361;4899.338589290436;4969.875753106165;5308.70802105884;5309.203619457112;5312.442193569696;5312.946870531284;5359.866003349947;5332.253484512172;5335.546478549328;5340.385855626614;5408.783648654049;5480.890382192374;5058.696478211319;5080.060188865072;5093.337866077423;5136.126858434075;5140.485951404867;5351.3043304370185;5356.946430535645;5385.78456861729;5392.5416339611575;5392.703401312965;5198.2202669599865;5199.48005199477;5217.478252174752;5245.0558899398475;5308.150695888639;5307.946920530745;5308.256844041837;5326.280952071421;5343.599230057684;5388.649737767033;5315.229291752674;5327.094393953037;5345.35855697311;5347.919781203285;5368.489993450616;5229.686218826882;5346.812861549827;5353.304070470892;5353.973230133903;5361.651492652965;4184.916301673949;4205.053862880827;4209.1792100540715;4228;4237.385579091015;3751.6998640108727;3774.4338349247832;3775.9433608495897;3813.2564149990485;3817.7518461300483;4965.503449655078;4990.575801056951;5008.474110218447;5015.974920125376;5074.771635276347;5377.085895397713;5403.432639572867;5427.267318911975;5428.212909128154;5474.260974768435;5040.722760248148;5062.215356619729;5067.290579318898;5070.391553013588;5110.437851836295;4567.931481027787;4603.631709463302;4627.1439783640135;4653.744044077541;4676.275177347517;5523.309586301712;5545.168224766237;5554.250176226158;5556.111022236423;5576.358718747315;5317.1226747586215;5317.308749862493;5322.361316642027;5323.3878104016985;5363.222332761806;5507.118860982224;5543.9168412474655;5567.498925096761;5583.385827559046;5586.77652893896;5358.892822143457;5364.168553874156;5367.3827509836865;5368.2752828367675;5370.03339398912;5424.457554244544;5445.53712934405;5447.455254474521;5452.7546260417585;5500.80747173847;5189.584833213258;5289.656172348785;5290.973545132404;5328.227407026037;5369.060414427538;5318.946810531846;5319.281896944018;5321.042212401805;5324.068288049499;5327.440618734977;5223.555997740083;5249.317588713443;5251.921221181609;5251.973740131275;5292.761825717775;5130.563902068366;5212.629605063002;5256.947430525645;5305.363356397257;5313.282706834528;5110.463401342806;5131.461196574455;5135.563477104488;5139.897202056013;5176.275321454924 11:33:57 INFO - PROCESS | 9249 | |1;ext.html;519.4260342321737;533.5464854873358;540.6485784240243;553.4686700767263;558.3885645218487;27909.860450697743;28404.715952840466;28466.857665711694;28519.144425667237;35334.293314133705;38315.425268620995;38735.61264387355;38773.41839872404;38848.611513884855;38878.222435551346;8271.875921861161;8525.701600443987;8546.700865469678;8550.358723095762;8554.828903421927;8317.293030092449;8424.283935865427;8463.534505602189;8469;8476.364272679542;8416.873746893802;8498.660053597849;8506.44708093975;8512.106228845974;8657.22085012352;8504.829903401927;8613;8617.095205003447;8630.309575233998;8630.352723545697;8314.625841837133;8502.937132858393;8541.444806087646;8555.401121921468;8555.828883422359;38325.80837095824;38615.227695446214;38776.22447551033;38800.417993730116;38844.22311553781;2994.7753918455987;3287.621923478807;3292.242784159657;3327.681431021996;3539.734519911017;28992.565111523345;29459.852700736574;29821.552676709867;29918.102456926328;30429.23926901823;3278.360719659667;3295.555100061485;3323.418401779679;3402.0984439123654;3487.546618939547;252207;252747;252858;253432;253455;49650;50614.24078638823;56497.43502565004;57672.71163644155;57705.71147144322;51642;51692.74153629208;51956;51991;52008;12829.807552886714;13131.737365252642;14616.342264598119;14852.62868428298;14852.777208341884;11366.545338186545;11576.76846463066;11580.76838463226;11587.362695051854;11598.594049208237;18389.448316550526;18411;18541.16564754589;18574.907125464288;18582;7184.461165412615;7392.667329970164;7450.627468626547;7466.85066298671;7472.252774722593;888.7422647432302;1002.9598816047422;1010.6008126789877;1020.7039958411978;1057.6509751781894;27740.306492337448;27874.860625696743;28079.71920280771;28160.71839281622;28351.71648283532;1005.9446730429751;1088.4394536813547;1107.7507560798756;1145.9541618335172;1150.344303746873;14393;14403.855961440251;14511.346989385293;14564;14689.632759180893;307285;310000;311232;311314;313396;49288;49630.50369496259;49660.751696241285;49669.75165124224;49696.751516242184;1285.7685616589104;1300.8959283257316;1306.235852026575;1306.5502183406113;1314.6450458376185;26750.464990700468;27022.32444188911;27223.86388068047;27376.726232738216;27514.862425687745;43877;44115;44238.778806105765;44284.55715442805;44318;288484;291535;291928;292472;292581;26002.479950401263;26232.475350493263;31419;32065.358692825546;32765;37249.81375093107;37806.43290350592;38051.23897522089;38301.808490957366;39102.4134637975;32958.50562241616;33405.49891751674;33473.66526334705;33488.49767253542;33652.831735841166;28862.278443039093;33070.83464582662;33860.15349616181;34045.48931765976;35410.46884296789;31266.37467250597;31534.369312613162;33431.66568334286;34969.47545786866;34991;27324.316892077855;29151.854240728662;30080.548791767702;31608.525872111477;32444;22409.66385504186;23275.301740947798;23610.645840312067;24516.87741561281;24726.896812222327 11:33:57 INFO - PROCESS | 9249 | |2;jquery.html;351.77662184512826;352.2567382822246;354.2189472213769;356.1843378662861;357.9463080537919;14081.507147249848;14561.199134047623;16027.919860400696;16375.83624163758;17632.38286659967;15005.09969401834;15129;15188.772168417483;15223.847761522382;15244.618884527892;5064.72144032079;5411.918821217685;5435.402105768362;5441.673499590018;5442.863928401782;3915.7454765440157;4066.837326506951;5317.8936421271555;5659.773609055654;5887.8233652990475;5644.520215781664;5820.243368362128;5850.327212370568;5859.150423188635;5954.940450595482;5923.733431995571;5928;5935.792247271324;5958.851028724295;5962.612430192024;4633.675642705012;4799.592034677056;4803.327534145223;4826.300186472942;5246.31797866275;12155.574554890625;12427.875721242763;18860;19261.80738192614;19304.1313140909;2092.8221101206263;2101.2225476573767;2202.0090959068484;2358.7641235876445;2445.608702607592;9263.861042084374;9393.953030234805;12165.330906800122;12243.387830608523;12453.75092498154;1754.2719771294896;1761.6124452620404;1765.6468706258672;1794.4168145352683;1805.9909700451544;48687.26969095502;52471.73764131193;52761;53402.19896701552;55122.72438637781;9136.725898223063;9320.254379649747;9347.485888276211;9390.85913711295;9395.906040939502;12242.265464072185;12258.754824903452;12261.080418968613;12266.386680665932;12322.938385308196;7008.299170082951;7202.603856787822;7210;7242.094738157731;7267;7038.296170383023;7071.964640176766;7087.0432491614;7089.468289878279;7117.466190035768;3904.941425878614;4142.523609784913;4218.451601291812;4243.257429949808;4248.277792775236;1529.3194528434963;1675.8240384759667;1710.8203638618015;1771.1055916761952;1771.2826305346355;835.6490274084899;872.8777971084053;877.7322916510398;882.3779235638859;972.1882228339274;13158.539451119357;14987.250637468083;15252.694946101015;16157.919210404109;16375.42686005984;859.9140085991351;871.6295574380989;904.3217586809892;904.633623382518;957.090763774417;9036.231920286718;9084.046175151647;9547.42715437076;9552.713418597454;9816.705498835046;372492;487978;488652;524813;537092;64199;66721.66639166774;69743.65128174327;70000.2999970004;70154.87986561816;1043.2488608202082;1078.417654466595;1081.7674200047027;1110.0730889707186;1148.465963327057;14374.928125359307;14385.424583016562;14549.490767823076;14911.25443727831;14925.776113358526;30618.540721888745;30874.69125308718;31232.531512026882;31357.686423135478;31716.524252136696;41236;41425.585744143376;41790;41824.16351673011;43048;6676.465882729273;6732.562383445061;6732.831679208059;6761.391474767294;6825.726970921108;9902.702918912444;9927.503624818875;10165.593376265162;10456.947715261374;10560.735981600521;9163.312751543528;9228.584713687766;9345.813083738423;9481.857772133286;9701.9029809701;9141.497217652826;9304.906950930404;9479.810403792024;9770.85343719859;9803.656872009446;9080.954595226982;9206.447613143233;9267.165955064076;9434;9567.904320956979;6629.105070815378;6635.867282654416;6724.596524208563;6749.392554670103;6877.724891004304;8068.515889046676;9100;9188.448693078437;9467;9714 11:33:57 INFO - PROCESS | 9249 | |3;mootools.html;1123.2305870478717;1390.6106290238733;1395.107131435881;1484.1614487814384;1655.9254833532498;6859.622720750357;6978.546394484361;7215.278472152782;7343.66953487093;7438.888416673741;7532.284432978872;7549.962250188742;7569.697212111509;7603.353714934237;7609.505382150171;2240.798328150462;2265.422317309084;2266.3880752196897;2267.0025188916907;2268.6937263469385;2217.7227846519186;2218.2125345502277;2248.1457046322375;2265.0713207584895;2269.704938358011;2234.6089434349005;2235.2958817972367;2239.1603148819195;2248.9654758810966;2266.9773302267013;2165.6101901657694;2175.7389113306344;2180.716506854115;2184.421128400983;2186.5736181444627;2270.2735124760084;2273.488465095357;2275.5562665280277;2275.670027845953;2276;7604.581748003858;7633.465657403984;7639.197884222188;7644.732434364826;7652.234776522303;4517.119161763458;4678.181318269323;4680.9297860532115;4681.625469962395;4687.250039993619;2777.597248398991;2881.207667891326;2883.783716221292;2886.163012726307;2900.390917907242;857.3698331726176;861.5950503263456;875.0549406640813;884.4162852517372;911.1207684584408;10492.265541412104;10503.894961050368;10508.947455262674;10510.737231569196;10515.894841051644;4028.738132021409;4072.3280658690983;4098.549159592442;4240.406343111967;4264.552222016706;8315;8336.66653333872;8350.33197344211;8353.749387518385;8355;4569.81720731167;4571.657125715585;4614.561616646413;4619.630429565626;4620.399348084795;3727.142757165867;3784.564775050849;4125.401816736557;4168.791560421967;4228.175505776344;3384.983075084609;3433;3442.1738782691973;3461.671141241578;3488.1628409181612;1015.7968406318765;1026.4252018869456;1031.9845202321972;1033.6485594897772;1056.3239526702916;1195.1693572966878;1209.2623499665197;1225.2709637765515;1240.8262843201958;1250.2810883741886;7033.859322813515;7092.397146242524;7191.568505889663;7248.565086094851;7249.782506524813;1072.6192201768415;1076.494047797534;1103.542030057533;1110.3337997201616;1120.0871289898707;5554.72226388679;5605.887882242414;5625.071863142535;5633.380328163898;5635.830925072254;8778.473291602524;9370.250379969586;9375.484348360906;9378.062193780568;9389.436633801857;9262.305327100494;9392.34253602255;9475.099865512766;9499.050094990584;9512.857307140399;7164.641767911584;7442.292982166794;7449.143348514882;7462.365698915544;7469.663865125974;6989.30106989297;6995.930040699528;7042.683079261548;7048.0485134508235;7061;8002.5598592077995;8136.511809291462;8415.70545030921;8416.87374689368;8418.200270974248;8273.83452330962;8428.241458268785;8451.112633173429;8475.788105297417;8491.660333586835;5967.76128954837;6133.6319820810895;6537.640429776217;6750.122484077038;6909.516333856582;7298.4526160539235;7313.378362839218;7325.853482930418;7353.338199562065;7355.742549010973;6528.640924748995;6847.383735463832;6881.724731010703;6969.7909062728195;7058.71765129389;6749.190097188369;6778.966105169443;6827.317268273133;6928.861422771415;7005.22942476317;6771.93228067713;6803.93196068033;6822.795316140524;6832.248452670103;6913.170419549686;6235.314115447207;6269.811905642656;6273.717682704198;6280.7487700491465;6283.057541368648;6457.515686323451;6475.449586785176;6482.962725964012;6492.513061520311;6510.18622672166 11:33:57 INFO - PROCESS | 9249 | |4;prototype.html;317.3795230324715;327.6706909555896;331.8423748719357;335.9983200083999;335.9983200084;5684.602077854542;5788.218590490283;5792.3917988611165;5792.68140252286;5827.300723913137;5573.136163894593;5728.570357223204;5731.254936858202;5754.913676294859;5768.336641286242;4470.150671372445;4472.865814025585;4473.798679059442;4479.417675702154;4482.97758511207;4222.936655950163;4309.504406993189;4314.546972567882;4315.352697095445;4468.463784345883;4290.249206388885;4378.452693413324;4383.693141480082;4388.736675799446;4401.60385565299;4347.326164444532;4362.978185109086;4366.345048242789;4372.103718737651;4380.904773806548;3887.688984881231;3889.2610404023144;3891.7859517726515;3894.1432884765304;3894.7273690841653;5405.594580406485;5499.312585926759;5509.614326997112;5510.283663123809;5514.172874068881;5111.514406131411;5119.948800511985;5127.846164615067;5128.2564028216075;5128.640995130342;6061.636301821904;6063.818085457399;6069.726862291208;6072.726727297282;6073.787417440412;4102.589741025903;4192.895177620553;4224.704270701052;4306.117245964601;4306.3755755415605;6375.075614035985;6388.1695379600815;6390.3609639036185;6391.712372943229;6408.436625349851;4338.262495375794;4374.650027997753;4377.0808130293;4379.233634114017;4394.560543945644;4368.257396242647;4428.114377124588;4430.889227769331;4438.7114837535455;4441.511433742286;5129.256257842592;5145.871353216125;5146.433892271922;5151.25306830515;5154.974225128851;6154.1999540059505;6154.969225153935;6163.19878415812;6163.260408750979;6164.845878853064;1570.4895908829676;1585.58774718574;1586.3654538184587;1589.078334565972;1589.6105454163803;1064.2816099133054;1070.8072546941469;1083.6532309660834;1086.5870969031876;1093.5297821936485;5823.505002074787;5847.473727364472;5854.18041474194;5856.619319744203;5859.853503662443;6315.305316415191;6322;6324.9051264231075;6327.905081423783;6329.556931014785;5831.037878750044;5844.620099693507;5850.707464626837;5851.707414629337;5854.326752423526;3295.555100061461;3390.6100798408497;3399;3399.6090449598614;3409.0454672691685;6602.933970660328;6627.541940773022;6628.801135965929;6630.071789949411;6635.369639884203;6469.385408386196;6472.352764723584;6476.4495017924;6481.902771458432;6483.643399612973;6482.708278127496;6602;6641.900371494431;6667.733290668416;6677.732890684319;6368.808935731936;6381.1704478417505;6388.744450221939;6391.296957334783;6391.424771770563;6025.698715064142;6123.2652081750475;6171.166892469639;6267.185265915402;6267.185265915402;6632.535722499379;6635.402813746593;6636.634985075867;6645.734170633121;6688;4418.050119224382;4425.557444255549;4437.977810111058;4441.045175287329;4458.108378324413;6252.562320637512;6368.108464814837;6386.16979792624;6387.201599800025;6400.359964003563;6217.191765070512;6227.688615569294;6234.251889773256;6236.688165591793;6238.719257633326;6210.844728881814;6218.502519798496;6220.502359811295;6221.502279817694;6224.564280500322;5969;6095.817125486243;6103.664298463627;6112.510999119971;6120.785772497941;6216.906746398898;6222.471089957405;6224.782132625336;6228.252609686867;6231.844203894939;6103.08453731926;6103.816885493442;6107.541934354852;6112.28855920343;6113.816585502442 11:33:57 INFO - PROCESS | 9249 | |5;yui.html;667.5160508631243;677.4411110833563;705.7953193573863;739.9630018499074;804.5574933786417;12657.493700251991;13057.347132643365;13081.476740930364;13109;13111.409986550605;13062.673433164176;13077.607671769862;13101.868981310185;13107.54123605674;13131.868681313184;645.7158850105939;646.8253571535682;759.0132827324497;769.4114002787871;769.9730509432171;776.8329809091044;783.3145997252404;783.75703531905;783.8549868274359;784.0982869699834;809.0695699945052;809.5911564659868;809.7975506123469;809.8987626546682;809.9190080991883;664.9958562570529;665.7669815564562;793.936485081195;803.1687203744096;811.3428123220151;592.594073059951;593.2613895699882;594;595.2618752746606;595.624756403463;13094.14888032275;13124.343782810822;13143.737125257538;13153.671158221025;13175.86824131756;11539.903709147618;11898.702532436671;11990.340531270776;12060.577879774253;12265.509379624804;9487.762805929839;9502.952485237598;9506.47714375716;9538.189253913426;9807.656732014346;3301.4222511060707;3340.048086295394;3442.431998720208;3485.6165821759587;3687.9815600922093;44572.108557828986;44588;44772;45068.323975140396;46338.53661463376;9001.18989290967;9363.157315841607;9487.193588545051;9521.640542226502;9874.753131171634;17300.913495432444;17515.73726394105;17517.82482175162;17546.034968076878;17558.736618950727;7167.677454514559;7458.589777562286;7660.348870345972;7783.104942931635;7920.881186782203;3884.9223015540097;3935.822887969991;3985.6412922837085;4017.83928642851;4036.6367026967714;2787.874545645451;2808.255812209766;2812.2688101093863;2815.591739197846;2822.111035023961;484.6268373352499;493.1690102177842;496.5406998526349;499.3757802746567;521.5202014146994;514.3519165851054;560.4899541417291;578.308920839601;597.7877853362081;629.3486241739869;8287;8419.536925469036;8496.447730897471;8524.14758524155;8565.443246188977;561.5563704673262;571.8999175144334;586.571802584116;612.4702132655221;624.4161708802285;3629.419292913174;3726.720495962814;3744.5693745219105;3853.8265778040054;3944.9605503945168;50838.491615083374;52549;52953.2057019145;53376.73311633417;53500;49681;50301.496985029684;50430.74784626127;50719.74640126776;51023.74488127536;43150.999999999374;43184;43757.34363984543;44430.77784611056;44458.777706111265;7498.250174982458;7608.581528015791;7663.616819158909;7788.532688038736;8277.875831862648;33388;33496.66503335033;34676.47985280273;34938.30123397467;35421.64578354287;42635.360469592364;42878.78560607177;42924;43175.784121079196;43855.561444386425;9090.590923408594;9604.75988100303;9652.806943861224;9821.410715357102;10008.299419040597;10742.892571074502;10856;10897.509612067635;11334.206605537533;11476.196666233618;9758.707238782848;9948.35335703177;10144.391336519833;10330.328528645614;10478.109360704426;10238.078572928473;10326.173906087344;10548.578056877946;10623;11112.833307500232;10282.485875706334;10791.406472643766;10809.945950270197;10831.566737330733;10856.620018299322;8801;8916.885389326335;8995;9012.083847102343;9103.681371151977;8448.746537603882;8691.391602587759;8756.695743437915;8818.91181088181;9021.639134434812 11:33:57 INFO - PROCESS | 9249 | __end_tp_report 11:33:57 INFO - PROCESS | 9249 | __start_cc_report 11:33:57 INFO - PROCESS | 9249 | _x_x_mozilla_cycle_collect,1075 11:33:57 INFO - PROCESS | 9249 | __end_cc_report 11:33:57 INFO - PROCESS | 9249 | __startTimestamp1452627237265__endTimestamp 11:33:57 INFO - PROCESS | 9249 | 11:33:57 INFO - PROCESS | 9249 | ------- Summary: start ------- 11:33:57 INFO - PROCESS | 9249 | Number of tests: 6 11:33:57 INFO - PROCESS | 9249 | 11:33:57 INFO - PROCESS | 9249 | [#0] dojo.html Cycles:165 Average:5006.75 Median:5198.22 stddev:520.48 (10.0%) stddev-sans-first:500.08 11:33:57 INFO - PROCESS | 9249 | Values: 3098.3 3099.9 3142.1 3142.7 3167.2 4927.7 4995.5 5023.9 5050.2 5061.1 4953.3 5016.8 5046.9 5048.1 5056.3 4366.5 4545.5 4566.4 4620.8 4739.1 4512.8 4596.9 4641.8 4693.3 4757.7 4634.3 4663.6 4672.6 4676.7 4701.4 4589.0 4607.7 4611.5 4639.0 4646.6 4572.1 4594.5 4601.8 4624.8 4669.4 4850.4 4871.1 4876.1 4899.3 4969.9 5308.7 5309.2 5312.4 5312.9 5359.9 5332.3 5335.5 5340.4 5408.8 5480.9 5058.7 5080.1 5093.3 5136.1 5140.5 5351.3 5356.9 5385.8 5392.5 5392.7 5198.2 5199.5 5217.5 5245.1 5308.2 5307.9 5308.3 5326.3 5343.6 5388.6 5315.2 5327.1 5345.4 5347.9 5368.5 5229.7 5346.8 5353.3 5354.0 5361.7 4184.9 4205.1 4209.2 4228.0 4237.4 3751.7 3774.4 3775.9 3813.3 3817.8 4965.5 4990.6 5008.5 5016.0 5074.8 5377.1 5403.4 5427.3 5428.2 5474.3 5040.7 5062.2 5067.3 5070.4 5110.4 4567.9 4603.6 4627.1 4653.7 4676.3 5523.3 5545.2 5554.3 5556.1 5576.4 5317.1 5317.3 5322.4 5323.4 5363.2 5507.1 5543.9 5567.5 5583.4 5586.8 5358.9 5364.2 5367.4 5368.3 5370.0 5424.5 5445.5 5447.5 5452.8 5500.8 5189.6 5289.7 5291.0 5328.2 5369.1 5318.9 5319.3 5321.0 5324.1 5327.4 5223.6 5249.3 5251.9 5252.0 5292.8 5130.6 5212.6 5256.9 5305.4 5313.3 5110.5 5131.5 5135.6 5139.9 5176.3 11:33:57 INFO - PROCESS | 9249 | 11:33:57 INFO - PROCESS | 9249 | [#1] ext.html Cycles:180 Average:44097.62 Median:18127.03 stddev:74785.73 (412.6%) stddev-sans-first:74923.95 11:33:57 INFO - PROCESS | 9249 | Values: 519.4 533.5 540.6 553.5 558.4 27909.9 28404.7 28466.9 28519.1 35334.3 38315.4 38735.6 38773.4 38848.6 38878.2 8271.9 8525.7 8546.7 8550.4 8554.8 8317.3 8424.3 8463.5 8469.0 8476.4 8416.9 8498.7 8506.4 8512.1 8657.2 8504.8 8613.0 8617.1 8630.3 8630.4 8314.6 8502.9 8541.4 8555.4 8555.8 38325.8 38615.2 38776.2 38800.4 38844.2 2994.8 3287.6 3292.2 3327.7 3539.7 28992.6 29459.9 29821.6 29918.1 30429.2 3278.4 3295.6 3323.4 3402.1 3487.5 252207.0 252747.0 252858.0 253432.0 253455.0 49650.0 50614.2 56497.4 57672.7 57705.7 51642.0 51692.7 51956.0 51991.0 52008.0 12829.8 13131.7 14616.3 14852.6 14852.8 11366.5 11576.8 11580.8 11587.4 11598.6 18389.4 18411.0 18541.2 18574.9 18582.0 7184.5 7392.7 7450.6 7466.9 7472.3 888.7 1003.0 1010.6 1020.7 1057.7 27740.3 27874.9 28079.7 28160.7 28351.7 1005.9 1088.4 1107.8 1146.0 1150.3 14393.0 14403.9 14511.3 14564.0 14689.6 307285.0 310000.0 311232.0 311314.0 313396.0 49288.0 49630.5 49660.8 49669.8 49696.8 1285.8 1300.9 1306.2 1306.6 1314.6 26750.5 27022.3 27223.9 27376.7 27514.9 43877.0 44115.0 44238.8 44284.6 44318.0 288484.0 291535.0 291928.0 292472.0 292581.0 26002.5 26232.5 31419.0 32065.4 32765.0 37249.8 37806.4 38051.2 38301.8 39102.4 32958.5 33405.5 33473.7 33488.5 33652.8 28862.3 33070.8 33860.2 34045.5 35410.5 31266.4 31534.4 33431.7 34969.5 34991.0 27324.3 29151.9 30080.5 31608.5 32444.0 22409.7 23275.3 23610.6 24516.9 24726.9 11:33:57 INFO - PROCESS | 9249 | 11:33:57 INFO - PROCESS | 9249 | [#2] jquery.html Cycles:180 Average:25288.59 Median:29039.45 stddev:79366.07 (273.3%) stddev-sans-first:79566.62 11:33:57 INFO - PROCESS | 9249 | Values: 351.8 352.3 354.2 356.2 357.9 14081.5 14561.2 16027.9 16375.8 17632.4 15005.1 15129.0 15188.8 15223.8 15244.6 5064.7 5411.9 5435.4 5441.7 5442.9 3915.7 4066.8 5317.9 5659.8 5887.8 5644.5 5820.2 5850.3 5859.2 5954.9 5923.7 5928.0 5935.8 5958.9 5962.6 4633.7 4799.6 4803.3 4826.3 5246.3 12155.6 12427.9 18860.0 19261.8 19304.1 2092.8 2101.2 2202.0 2358.8 2445.6 9263.9 9394.0 12165.3 12243.4 12453.8 1754.3 1761.6 1765.6 1794.4 1806.0 48687.3 52471.7 52761.0 53402.2 55122.7 9136.7 9320.3 9347.5 9390.9 9395.9 12242.3 12258.8 12261.1 12266.4 12322.9 7008.3 7202.6 7210.0 7242.1 7267.0 7038.3 7072.0 7087.0 7089.5 7117.5 3904.9 4142.5 4218.5 4243.3 4248.3 1529.3 1675.8 1710.8 1771.1 1771.3 835.6 872.9 877.7 882.4 972.2 13158.5 14987.3 15252.7 16157.9 16375.4 859.9 871.6 904.3 904.6 957.1 9036.2 9084.0 9547.4 9552.7 9816.7 372492.0 487978.0 488652.0 524813.0 537092.0 64199.0 66721.7 69743.7 70000.3 70154.9 1043.2 1078.4 1081.8 1110.1 1148.5 14374.9 14385.4 14549.5 14911.3 14925.8 30618.5 30874.7 31232.5 31357.7 31716.5 41236.0 41425.6 41790.0 41824.2 43048.0 6676.5 6732.6 6732.8 6761.4 6825.7 9902.7 9927.5 10165.6 10456.9 10560.7 9163.3 9228.6 9345.8 9481.9 9701.9 9141.5 9304.9 9479.8 9770.9 9803.7 9081.0 9206.4 9267.2 9434.0 9567.9 6629.1 6635.9 6724.6 6749.4 6877.7 8068.5 9100.0 9188.4 9467.0 9714.0 11:33:57 INFO - PROCESS | 9249 | 11:33:57 INFO - PROCESS | 9249 | [#3] mootools.html Cycles:180 Average:5317.92 Median:6281.90 stddev:2773.92 (44.2%) stddev-sans-first:2763.77 11:33:57 INFO - PROCESS | 9249 | Values: 1123.2 1390.6 1395.1 1484.2 1655.9 6859.6 6978.5 7215.3 7343.7 7438.9 7532.3 7550.0 7569.7 7603.4 7609.5 2240.8 2265.4 2266.4 2267.0 2268.7 2217.7 2218.2 2248.1 2265.1 2269.7 2234.6 2235.3 2239.2 2249.0 2267.0 2165.6 2175.7 2180.7 2184.4 2186.6 2270.3 2273.5 2275.6 2275.7 2276.0 7604.6 7633.5 7639.2 7644.7 7652.2 4517.1 4678.2 4680.9 4681.6 4687.3 2777.6 2881.2 2883.8 2886.2 2900.4 857.4 861.6 875.1 884.4 911.1 10492.3 10503.9 10508.9 10510.7 10515.9 4028.7 4072.3 4098.5 4240.4 4264.6 8315.0 8336.7 8350.3 8353.7 8355.0 4569.8 4571.7 4614.6 4619.6 4620.4 3727.1 3784.6 4125.4 4168.8 4228.2 3385.0 3433.0 3442.2 3461.7 3488.2 1015.8 1026.4 1032.0 1033.6 1056.3 1195.2 1209.3 1225.3 1240.8 1250.3 7033.9 7092.4 7191.6 7248.6 7249.8 1072.6 1076.5 1103.5 1110.3 1120.1 5554.7 5605.9 5625.1 5633.4 5635.8 8778.5 9370.3 9375.5 9378.1 9389.4 9262.3 9392.3 9475.1 9499.1 9512.9 7164.6 7442.3 7449.1 7462.4 7469.7 6989.3 6995.9 7042.7 7048.0 7061.0 8002.6 8136.5 8415.7 8416.9 8418.2 8273.8 8428.2 8451.1 8475.8 8491.7 5967.8 6133.6 6537.6 6750.1 6909.5 7298.5 7313.4 7325.9 7353.3 7355.7 6528.6 6847.4 6881.7 6969.8 7058.7 6749.2 6779.0 6827.3 6928.9 7005.2 6771.9 6803.9 6822.8 6832.2 6913.2 6235.3 6269.8 6273.7 6280.7 6283.1 6457.5 6475.4 6483.0 6492.5 6510.2 11:33:57 INFO - PROCESS | 9249 | 11:33:57 INFO - PROCESS | 9249 | [#4] prototype.html Cycles:180 Average:5146.71 Median:5829.17 stddev:1552.77 (26.6%) stddev-sans-first:1514.23 11:33:57 INFO - PROCESS | 9249 | Values: 317.4 327.7 331.8 336.0 336.0 5684.6 5788.2 5792.4 5792.7 5827.3 5573.1 5728.6 5731.3 5754.9 5768.3 4470.2 4472.9 4473.8 4479.4 4483.0 4222.9 4309.5 4314.5 4315.4 4468.5 4290.2 4378.5 4383.7 4388.7 4401.6 4347.3 4363.0 4366.3 4372.1 4380.9 3887.7 3889.3 3891.8 3894.1 3894.7 5405.6 5499.3 5509.6 5510.3 5514.2 5111.5 5119.9 5127.8 5128.3 5128.6 6061.6 6063.8 6069.7 6072.7 6073.8 4102.6 4192.9 4224.7 4306.1 4306.4 6375.1 6388.2 6390.4 6391.7 6408.4 4338.3 4374.7 4377.1 4379.2 4394.6 4368.3 4428.1 4430.9 4438.7 4441.5 5129.3 5145.9 5146.4 5151.3 5155.0 6154.2 6155.0 6163.2 6163.3 6164.8 1570.5 1585.6 1586.4 1589.1 1589.6 1064.3 1070.8 1083.7 1086.6 1093.5 5823.5 5847.5 5854.2 5856.6 5859.9 6315.3 6322.0 6324.9 6327.9 6329.6 5831.0 5844.6 5850.7 5851.7 5854.3 3295.6 3390.6 3399.0 3399.6 3409.0 6602.9 6627.5 6628.8 6630.1 6635.4 6469.4 6472.4 6476.4 6481.9 6483.6 6482.7 6602.0 6641.9 6667.7 6677.7 6368.8 6381.2 6388.7 6391.3 6391.4 6025.7 6123.3 6171.2 6267.2 6267.2 6632.5 6635.4 6636.6 6645.7 6688.0 4418.1 4425.6 4438.0 4441.0 4458.1 6252.6 6368.1 6386.2 6387.2 6400.4 6217.2 6227.7 6234.3 6236.7 6238.7 6210.8 6218.5 6220.5 6221.5 6224.6 5969.0 6095.8 6103.7 6112.5 6120.8 6216.9 6222.5 6224.8 6228.3 6231.8 6103.1 6103.8 6107.5 6112.3 6113.8 11:33:57 INFO - PROCESS | 9249 | 11:33:57 INFO - PROCESS | 9249 | [#5] yui.html Cycles:180 Average:13078.14 Median:50575.25 stddev:15168.55 (30.0%) stddev-sans-first:15182.47 11:33:57 INFO - PROCESS | 9249 | Values: 667.5 677.4 705.8 740.0 804.6 12657.5 13057.3 13081.5 13109.0 13111.4 13062.7 13077.6 13101.9 13107.5 13131.9 645.7 646.8 759.0 769.4 770.0 776.8 783.3 783.8 783.9 784.1 809.1 809.6 809.8 809.9 809.9 665.0 665.8 793.9 803.2 811.3 592.6 593.3 594.0 595.3 595.6 13094.1 13124.3 13143.7 13153.7 13175.9 11539.9 11898.7 11990.3 12060.6 12265.5 9487.8 9503.0 9506.5 9538.2 9807.7 3301.4 3340.0 3442.4 3485.6 3688.0 44572.1 44588.0 44772.0 45068.3 46338.5 9001.2 9363.2 9487.2 9521.6 9874.8 17300.9 17515.7 17517.8 17546.0 17558.7 7167.7 7458.6 7660.3 7783.1 7920.9 3884.9 3935.8 3985.6 4017.8 4036.6 2787.9 2808.3 2812.3 2815.6 2822.1 484.6 493.2 496.5 499.4 521.5 514.4 560.5 578.3 597.8 629.3 8287.0 8419.5 8496.4 8524.1 8565.4 561.6 571.9 586.6 612.5 624.4 3629.4 3726.7 3744.6 3853.8 3945.0 50838.5 52549.0 52953.2 53376.7 53500.0 49681.0 50301.5 50430.7 50719.7 51023.7 43151.0 43184.0 43757.3 44430.8 44458.8 7498.3 7608.6 7663.6 7788.5 8277.9 33388.0 33496.7 34676.5 34938.3 35421.6 42635.4 42878.8 42924.0 43175.8 43855.6 9090.6 9604.8 9652.8 9821.4 10008.3 10742.9 10856.0 10897.5 11334.2 11476.2 9758.7 9948.4 10144.4 10330.3 10478.1 10238.1 10326.2 10548.6 10623.0 11112.8 10282.5 10791.4 10809.9 10831.6 10856.6 8801.0 8916.9 8995.0 9012.1 9103.7 8448.7 8691.4 8756.7 8818.9 9021.6 11:33:57 INFO - PROCESS | 9249 | -------- Summary: end -------- 11:33:57 INFO - PROCESS | 9249 | 11:33:57 INFO - TEST-INFO | 9249: exit 0 11:33:57 INFO - TEST-OK | dromaeo_css | took 1112169ms 11:33:57 INFO - TEST-START | kraken 11:33:57 INFO - operating with platform_type : linux_ 11:33:57 INFO - Initialising browser for kraken test... 11:33:57 INFO - TEST-INFO | started process 9443 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnRN1HK/profile http://localhost:54167/getInfo.html) 11:34:01 INFO - PROCESS | 9443 | __metrics Screen width/height:1600/1200 11:34:01 INFO - PROCESS | 9443 | colorDepth:24 11:34:01 INFO - PROCESS | 9443 | Browser inner width/height: 1024/697 11:34:01 INFO - PROCESS | 9443 | __metrics 11:34:01 INFO - PROCESS | 9443 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:34:01 INFO - PROCESS | 9443 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:34:02 INFO - TEST-INFO | 9443: exit 0 11:34:02 INFO - Browser initialized. 11:34:02 INFO - Running cycle 1/1 for kraken test... 11:34:02 INFO - TEST-INFO | started process 9526 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnRN1HK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:14 INFO - PROCESS | 9526 | RSS: Main: 148647936 11:34:14 INFO - PROCESS | 9526 | 11:34:17 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54167/tests/kraken/driver.html?testName=audio-beat-detection) 11:34:17 INFO - PROCESS | 9526 | RSS: Main: 187985920 11:34:17 INFO - PROCESS | 9526 | 11:34:20 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54167/tests/kraken/driver.html?testName=audio-dft) 11:34:20 INFO - PROCESS | 9526 | RSS: Main: 176017408 11:34:20 INFO - PROCESS | 9526 | 11:34:23 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54167/tests/kraken/driver.html?testName=audio-fft) 11:34:24 INFO - PROCESS | 9526 | RSS: Main: 160886784 11:34:24 INFO - PROCESS | 9526 | 11:34:26 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54167/tests/kraken/driver.html?testName=audio-oscillator) 11:34:26 INFO - PROCESS | 9526 | RSS: Main: 162168832 11:34:26 INFO - PROCESS | 9526 | 11:34:29 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54167/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:34:29 INFO - PROCESS | 9526 | RSS: Main: 165519360 11:34:29 INFO - PROCESS | 9526 | 11:34:32 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54167/tests/kraken/driver.html?testName=imaging-darkroom) 11:34:33 INFO - PROCESS | 9526 | RSS: Main: 164814848 11:34:33 INFO - PROCESS | 9526 | 11:34:36 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54167/tests/kraken/driver.html?testName=imaging-desaturate) 11:34:37 INFO - PROCESS | 9526 | RSS: Main: 166531072 11:34:37 INFO - PROCESS | 9526 | 11:34:39 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54167/tests/kraken/driver.html?testName=json-parse-financial) 11:34:40 INFO - PROCESS | 9526 | RSS: Main: 166158336 11:34:40 INFO - PROCESS | 9526 | 11:34:41 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54167/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:34:42 INFO - PROCESS | 9526 | RSS: Main: 176238592 11:34:42 INFO - PROCESS | 9526 | 11:34:44 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54167/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:34:44 INFO - PROCESS | 9526 | RSS: Main: 175915008 11:34:44 INFO - PROCESS | 9526 | 11:34:46 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54167/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:34:47 INFO - PROCESS | 9526 | RSS: Main: 188383232 11:34:47 INFO - PROCESS | 9526 | 11:34:49 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54167/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:34:50 INFO - PROCESS | 9526 | RSS: Main: 195866624 11:34:50 INFO - PROCESS | 9526 | 11:34:53 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54167/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:34:53 INFO - PROCESS | 9526 | RSS: Main: 194314240 11:34:53 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:54167/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54167/tests/kraken/driver.html?testName=ai-astar) 11:34:55 INFO - PROCESS | 9526 | RSS: Main: 253108224 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | __start_tp_report 11:34:55 INFO - PROCESS | 9526 | _x_x_mozilla_page_load 11:34:55 INFO - PROCESS | 9526 | _x_x_mozilla_page_load_details 11:34:55 INFO - PROCESS | 9526 | |i|pagename|runs| 11:34:55 INFO - PROCESS | 9526 | |0;ai-astar;109;112;106;111;111;112;101;110;110;121 11:34:55 INFO - PROCESS | 9526 | |1;audio-beat-detection;151;127;156;165;126;149;152;127;171;125 11:34:55 INFO - PROCESS | 9526 | |2;audio-dft;161;159;159;160;161;161;161;163;160;161 11:34:55 INFO - PROCESS | 9526 | |3;audio-fft;72;74;85;101;81;71;73;109;93;75 11:34:55 INFO - PROCESS | 9526 | |4;audio-oscillator;97;96;143;97;98;97;142;96;96;138 11:34:55 INFO - PROCESS | 9526 | |5;imaging-gaussian-blur;109;109;109;109;109;108;109;109;110;109 11:34:55 INFO - PROCESS | 9526 | |6;imaging-darkroom;145;145;145;145;146;146;145;146;146;145 11:34:55 INFO - PROCESS | 9526 | |7;imaging-desaturate;96;96;95;95;96;95;95;95;95;96 11:34:55 INFO - PROCESS | 9526 | |8;json-parse-financial;53;54;55;54;55;58;57;63;52;51 11:34:55 INFO - PROCESS | 9526 | |9;json-stringify-tinderbox;67;67;67;67;68;67;67;67;68;68 11:34:55 INFO - PROCESS | 9526 | |10;stanford-crypto-aes;85;85;85;90;85;93;94;94;86;86 11:34:55 INFO - PROCESS | 9526 | |11;stanford-crypto-ccm;132;123;116;123;124;121;115;118;120;118 11:34:55 INFO - PROCESS | 9526 | |12;stanford-crypto-pbkdf2;140;151;143;150;150;142;150;150;162;142 11:34:55 INFO - PROCESS | 9526 | |13;stanford-crypto-sha256-iterative;68;68;69;68;66;66;69;69;67;67 11:34:55 INFO - PROCESS | 9526 | __end_tp_report 11:34:55 INFO - PROCESS | 9526 | __start_cc_report 11:34:55 INFO - PROCESS | 9526 | _x_x_mozilla_cycle_collect,924 11:34:55 INFO - PROCESS | 9526 | __end_cc_report 11:34:55 INFO - PROCESS | 9526 | __startTimestamp1452627295615__endTimestamp 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | ------- Summary: start ------- 11:34:55 INFO - PROCESS | 9526 | Number of tests: 14 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:5.03 (4.5%) stddev-sans-first:5.32 11:34:55 INFO - PROCESS | 9526 | Values: 109.0 112.0 106.0 111.0 111.0 112.0 101.0 110.0 110.0 121.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:151.50 stddev:17.34 (11.4%) stddev-sans-first:18.25 11:34:55 INFO - PROCESS | 9526 | Values: 151.0 127.0 156.0 165.0 126.0 149.0 152.0 127.0 171.0 125.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 11:34:55 INFO - PROCESS | 9526 | Values: 161.0 159.0 159.0 160.0 161.0 161.0 161.0 163.0 160.0 161.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#3] audio-fft Cycles:10 Average:83.40 Median:74.50 stddev:13.40 (18.0%) stddev-sans-first:13.56 11:34:55 INFO - PROCESS | 9526 | Values: 72.0 74.0 85.0 101.0 81.0 71.0 73.0 109.0 93.0 75.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.50 stddev:21.44 (22.2%) stddev-sans-first:22.22 11:34:55 INFO - PROCESS | 9526 | Values: 97.0 96.0 143.0 97.0 98.0 97.0 142.0 96.0 96.0 138.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 11:34:55 INFO - PROCESS | 9526 | Values: 109.0 109.0 109.0 109.0 109.0 108.0 109.0 109.0 110.0 109.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:34:55 INFO - PROCESS | 9526 | Values: 145.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 145.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:34:55 INFO - PROCESS | 9526 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:3.46 (6.3%) stddev-sans-first:3.57 11:34:55 INFO - PROCESS | 9526 | Values: 53.0 54.0 55.0 54.0 55.0 58.0 57.0 63.0 52.0 51.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 11:34:55 INFO - PROCESS | 9526 | Values: 67.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 68.0 68.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:88.00 stddev:4.00 (4.5%) stddev-sans-first:4.06 11:34:55 INFO - PROCESS | 9526 | Values: 85.0 85.0 85.0 90.0 85.0 93.0 94.0 94.0 86.0 86.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:122.00 stddev:4.92 (4.0%) stddev-sans-first:3.23 11:34:55 INFO - PROCESS | 9526 | Values: 132.0 123.0 116.0 123.0 124.0 121.0 115.0 118.0 120.0 118.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:150.00 stddev:6.51 (4.3%) stddev-sans-first:6.23 11:34:55 INFO - PROCESS | 9526 | Values: 140.0 151.0 143.0 150.0 150.0 142.0 150.0 150.0 162.0 142.0 11:34:55 INFO - PROCESS | 9526 | 11:34:55 INFO - PROCESS | 9526 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 11:34:55 INFO - PROCESS | 9526 | Values: 68.0 68.0 69.0 68.0 66.0 66.0 69.0 69.0 67.0 67.0 11:34:55 INFO - PROCESS | 9526 | -------- Summary: end -------- 11:34:55 INFO - PROCESS | 9526 | 11:34:56 INFO - TEST-INFO | 9526: exit 0 11:34:56 INFO - TEST-OK | kraken | took 58544ms 11:34:56 INFO - TEST-START | v8_7 11:34:56 INFO - operating with platform_type : linux_ 11:34:56 INFO - Initialising browser for v8_7 test... 11:34:56 INFO - TEST-INFO | started process 9778 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQwiMCb/profile http://localhost:54167/getInfo.html) 11:35:00 INFO - PROCESS | 9778 | __metrics Screen width/height:1600/1200 11:35:00 INFO - PROCESS | 9778 | colorDepth:24 11:35:00 INFO - PROCESS | 9778 | Browser inner width/height: 1024/697 11:35:00 INFO - PROCESS | 9778 | __metrics 11:35:00 INFO - PROCESS | 9778 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:35:00 INFO - PROCESS | 9778 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:35:01 INFO - TEST-INFO | 9778: exit 0 11:35:01 INFO - Browser initialized. 11:35:01 INFO - Running cycle 1/1 for v8_7 test... 11:35:01 INFO - TEST-INFO | started process 9861 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQwiMCb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:13 INFO - PROCESS | 9861 | RSS: Main: 148078592 11:35:13 INFO - PROCESS | 9861 | 11:35:35 INFO - PROCESS | 9861 | Cycle 1(1): loaded http://localhost:54167/tests/v8_7/run.html (next: http://localhost:54167/tests/v8_7/run.html) 11:35:36 INFO - PROCESS | 9861 | RSS: Main: 531873792 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - PROCESS | 9861 | __start_tp_report 11:35:36 INFO - PROCESS | 9861 | _x_x_mozilla_page_load 11:35:36 INFO - PROCESS | 9861 | _x_x_mozilla_page_load_details 11:35:36 INFO - PROCESS | 9861 | |i|pagename|runs| 11:35:36 INFO - PROCESS | 9861 | |0;Richards;166.44474034620507 11:35:36 INFO - PROCESS | 9861 | |1;DeltaBlue;190.8761213972132 11:35:36 INFO - PROCESS | 9861 | |2;Encrypt;280.0336040324839 11:35:36 INFO - PROCESS | 9861 | |3;Decrypt;5261.780104712042 11:35:36 INFO - PROCESS | 9861 | |4;RayTrace;1996.007984031936 11:35:36 INFO - PROCESS | 9861 | |5;Earley;860.5851979345955 11:35:36 INFO - PROCESS | 9861 | |6;Boyer;12481.481481481482 11:35:36 INFO - PROCESS | 9861 | |7;RegExp;43638.29787234042 11:35:36 INFO - PROCESS | 9861 | |8;Splay;563.063063063063 11:35:36 INFO - PROCESS | 9861 | |9;NavierStokes;4826.923076923077 11:35:36 INFO - PROCESS | 9861 | __end_tp_report 11:35:36 INFO - PROCESS | 9861 | __startTimestamp1452627336033__endTimestamp 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - PROCESS | 9861 | ------- Summary: start ------- 11:35:36 INFO - PROCESS | 9861 | Number of tests: 10 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - PROCESS | 9861 | [#0] Richards Cycles:1 Average:166.44 Median:166.44 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 9861 | Values: 166.4 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - PROCESS | 9861 | [#1] DeltaBlue Cycles:1 Average:190.88 Median:190.88 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 9861 | Values: 190.9 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - PROCESS | 9861 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 9861 | Values: 280.0 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - PROCESS | 9861 | [#3] Decrypt Cycles:1 Average:5261.78 Median:5261.78 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 9861 | Values: 5261.8 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - PROCESS | 9861 | [#4] RayTrace Cycles:1 Average:1996.01 Median:1996.01 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 9861 | Values: 1996.0 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - PROCESS | 9861 | [#5] Earley Cycles:1 Average:860.59 Median:860.59 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 9861 | Values: 860.6 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - PROCESS | 9861 | [#6] Boyer Cycles:1 Average:12481.48 Median:12481.48 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 9861 | Values: 12481.5 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - PROCESS | 9861 | [#7] RegExp Cycles:1 Average:43638.30 Median:43638.30 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 9861 | Values: 43638.3 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - PROCESS | 9861 | [#8] Splay Cycles:1 Average:563.06 Median:563.06 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 9861 | Values: 563.1 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - PROCESS | 9861 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:35:36 INFO - PROCESS | 9861 | Values: 4826.9 11:35:36 INFO - PROCESS | 9861 | -------- Summary: end -------- 11:35:36 INFO - PROCESS | 9861 | 11:35:36 INFO - TEST-INFO | 9861: exit 0 11:35:36 INFO - TEST-OK | v8_7 | took 40378ms 11:35:36 INFO - SUITE-END | took 1211s 11:35:37 INFO - Completed test suite (00:20:11) 11:35:37 INFO - Working with test: dromaeo_css 11:35:37 INFO - Generating results file: dromaeo_css 11:35:37 INFO - Working with test: kraken 11:35:37 INFO - Generating results file: kraken 11:35:37 INFO - javascript benchmark 11:35:37 INFO - Working with test: v8_7 11:35:37 INFO - Generating results file: v8_7 11:35:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:35:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:35:37 INFO - process_Request line: dromaeo_css 6582.61 graph.html#tests=[[72,64,35]] 11:35:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:35:37 INFO - process_Request line: kraken 1506.50 graph.html#tests=[[232,64,35]] 11:35:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:35:37 INFO - process_Request line: v8_7 18729.49 graph.html#tests=[[230,64,35]] 11:35:37 INFO - RETURN: dromaeo_css: 6582.61 11:35:37 INFO - RETURN: kraken: 1506.50 11:35:37 INFO - RETURN: v8_7: 18729.49 11:35:37 INFO - javascript benchmark 11:35:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3098.333858220483, 3099.907002789917, 3142.0573827851654, 3142.71715545601, 3167.1765341011337, 4927.6797008194535, 4995.525425084616, 5023.874403139924, 5050.217216331474, 5061.063703214908, 4953.257011448284, 5016.7742451589675, 5046.873828154298, 5048.1165795985735, 5056.266841308008, 4366.454193225847, 4545.4545454545505, 4566.383538222339, 4620.838270660528, 4739.14695354836, 4512.751798651073, 4596.862094137181, 4641.791119399635, 4693.272542755878, 4757.690750101249, 4634.258518637019, 4663.60359369454, 4672.602828759559, 4676.696014759047, 4701.388819453483, 4588.977055114737, 4607.746573938432, 4611.492735799059, 4638.976805115986, 4646.605038571725, 4572.0627271409285, 4594.540545945412, 4601.7699115044115, 4624.838130665411, 4669.369635099286, 4850.369451971256, 4871.050145221683, 4876.122297986361, 4899.338589290436, 4969.875753106165, 5308.70802105884, 5309.203619457112, 5312.442193569696, 5312.946870531284, 5359.866003349947, 5332.253484512172, 5335.546478549328, 5340.385855626614, 5408.783648654049, 5480.890382192374, 5058.696478211319, 5080.060188865072, 5093.337866077423, 5136.126858434075, 5140.485951404867, 5351.3043304370185, 5356.946430535645, 5385.78456861729, 5392.5416339611575, 5392.703401312965, 5198.2202669599865, 5199.48005199477, 5217.478252174752, 5245.0558899398475, 5308.150695888639, 5307.946920530745, 5308.256844041837, 5326.280952071421, 5343.599230057684, 5388.649737767033, 5315.229291752674, 5327.094393953037, 5345.35855697311, 5347.919781203285, 5368.489993450616, 5229.686218826882, 5346.812861549827, 5353.304070470892, 5353.973230133903, 5361.651492652965, 4184.916301673949, 4205.053862880827, 4209.1792100540715, 4228.0, 4237.385579091015, 3751.6998640108727, 3774.4338349247832, 3775.9433608495897, 3813.2564149990485, 3817.7518461300483, 4965.503449655078, 4990.575801056951, 5008.474110218447, 5015.974920125376, 5074.771635276347, 5377.085895397713, 5403.432639572867, 5427.267318911975, 5428.212909128154, 5474.260974768435, 5040.722760248148, 5062.215356619729, 5067.290579318898, 5070.391553013588, 5110.437851836295, 4567.931481027787, 4603.631709463302, 4627.1439783640135, 4653.744044077541, 4676.275177347517, 5523.309586301712, 5545.168224766237, 5554.250176226158, 5556.111022236423, 5576.358718747315, 5317.1226747586215, 5317.308749862493, 5322.361316642027, 5323.3878104016985, 5363.222332761806, 5507.118860982224, 5543.9168412474655, 5567.498925096761, 5583.385827559046, 5586.77652893896, 5358.892822143457, 5364.168553874156, 5367.3827509836865, 5368.2752828367675, 5370.03339398912, 5424.457554244544, 5445.53712934405, 5447.455254474521, 5452.7546260417585, 5500.80747173847, 5189.584833213258, 5289.656172348785, 5290.973545132404, 5328.227407026037, 5369.060414427538, 5318.946810531846, 5319.281896944018, 5321.042212401805, 5324.068288049499, 5327.440618734977, 5223.555997740083, 5249.317588713443, 5251.921221181609, 5251.973740131275, 5292.761825717775, 5130.563902068366, 5212.629605063002, 5256.947430525645, 5305.363356397257, 5313.282706834528, 5110.463401342806, 5131.461196574455, 5135.563477104488, 5139.897202056013, 5176.275321454924], "unit": "score", "name": "dojo.html", "value": 4975.466413657296}, {"lowerIsBetter": false, "replicates": [519.4260342321737, 533.5464854873358, 540.6485784240243, 553.4686700767263, 558.3885645218487, 27909.860450697743, 28404.715952840466, 28466.857665711694, 28519.144425667237, 35334.293314133705, 38315.425268620995, 38735.61264387355, 38773.41839872404, 38848.611513884855, 38878.222435551346, 8271.875921861161, 8525.701600443987, 8546.700865469678, 8550.358723095762, 8554.828903421927, 8317.293030092449, 8424.283935865427, 8463.534505602189, 8469.0, 8476.364272679542, 8416.873746893802, 8498.660053597849, 8506.44708093975, 8512.106228845974, 8657.22085012352, 8504.829903401927, 8613.0, 8617.095205003447, 8630.309575233998, 8630.352723545697, 8314.625841837133, 8502.937132858393, 8541.444806087646, 8555.401121921468, 8555.828883422359, 38325.80837095824, 38615.227695446214, 38776.22447551033, 38800.417993730116, 38844.22311553781, 2994.7753918455987, 3287.621923478807, 3292.242784159657, 3327.681431021996, 3539.734519911017, 28992.565111523345, 29459.852700736574, 29821.552676709867, 29918.102456926328, 30429.23926901823, 3278.360719659667, 3295.555100061485, 3323.418401779679, 3402.0984439123654, 3487.546618939547, 252207.0, 252747.0, 252858.0, 253432.0, 253455.0, 49650.0, 50614.24078638823, 56497.43502565004, 57672.71163644155, 57705.71147144322, 51642.0, 51692.74153629208, 51956.0, 51991.0, 52008.0, 12829.807552886714, 13131.737365252642, 14616.342264598119, 14852.62868428298, 14852.777208341884, 11366.545338186545, 11576.76846463066, 11580.76838463226, 11587.362695051854, 11598.594049208237, 18389.448316550526, 18411.0, 18541.16564754589, 18574.907125464288, 18582.0, 7184.461165412615, 7392.667329970164, 7450.627468626547, 7466.85066298671, 7472.252774722593, 888.7422647432302, 1002.9598816047422, 1010.6008126789877, 1020.7039958411978, 1057.6509751781894, 27740.306492337448, 27874.860625696743, 28079.71920280771, 28160.71839281622, 28351.71648283532, 1005.9446730429751, 1088.4394536813547, 1107.7507560798756, 1145.9541618335172, 1150.344303746873, 14393.0, 14403.855961440251, 14511.346989385293, 14564.0, 14689.632759180893, 307285.0, 310000.0, 311232.0, 311314.0, 313396.0, 49288.0, 49630.50369496259, 49660.751696241285, 49669.75165124224, 49696.751516242184, 1285.7685616589104, 1300.8959283257316, 1306.235852026575, 1306.5502183406113, 1314.6450458376185, 26750.464990700468, 27022.32444188911, 27223.86388068047, 27376.726232738216, 27514.862425687745, 43877.0, 44115.0, 44238.778806105765, 44284.55715442805, 44318.0, 288484.0, 291535.0, 291928.0, 292472.0, 292581.0, 26002.479950401263, 26232.475350493263, 31419.0, 32065.358692825546, 32765.0, 37249.81375093107, 37806.43290350592, 38051.23897522089, 38301.808490957366, 39102.4134637975, 32958.50562241616, 33405.49891751674, 33473.66526334705, 33488.49767253542, 33652.831735841166, 28862.278443039093, 33070.83464582662, 33860.15349616181, 34045.48931765976, 35410.46884296789, 31266.37467250597, 31534.369312613162, 33431.66568334286, 34969.47545786866, 34991.0, 27324.316892077855, 29151.854240728662, 30080.548791767702, 31608.525872111477, 32444.0, 22409.66385504186, 23275.301740947798, 23610.645840312067, 24516.87741561281, 24726.896812222327], "unit": "score", "name": "ext.html", "value": 17462.260293080148}, {"lowerIsBetter": false, "replicates": [351.77662184512826, 352.2567382822246, 354.2189472213769, 356.1843378662861, 357.9463080537919, 14081.507147249848, 14561.199134047623, 16027.919860400696, 16375.83624163758, 17632.38286659967, 15005.09969401834, 15129.0, 15188.772168417483, 15223.847761522382, 15244.618884527892, 5064.72144032079, 5411.918821217685, 5435.402105768362, 5441.673499590018, 5442.863928401782, 3915.7454765440157, 4066.837326506951, 5317.8936421271555, 5659.773609055654, 5887.8233652990475, 5644.520215781664, 5820.243368362128, 5850.327212370568, 5859.150423188635, 5954.940450595482, 5923.733431995571, 5928.0, 5935.792247271324, 5958.851028724295, 5962.612430192024, 4633.675642705012, 4799.592034677056, 4803.327534145223, 4826.300186472942, 5246.31797866275, 12155.574554890625, 12427.875721242763, 18860.0, 19261.80738192614, 19304.1313140909, 2092.8221101206263, 2101.2225476573767, 2202.0090959068484, 2358.7641235876445, 2445.608702607592, 9263.861042084374, 9393.953030234805, 12165.330906800122, 12243.387830608523, 12453.75092498154, 1754.2719771294896, 1761.6124452620404, 1765.6468706258672, 1794.4168145352683, 1805.9909700451544, 48687.26969095502, 52471.73764131193, 52761.0, 53402.19896701552, 55122.72438637781, 9136.725898223063, 9320.254379649747, 9347.485888276211, 9390.85913711295, 9395.906040939502, 12242.265464072185, 12258.754824903452, 12261.080418968613, 12266.386680665932, 12322.938385308196, 7008.299170082951, 7202.603856787822, 7210.0, 7242.094738157731, 7267.0, 7038.296170383023, 7071.964640176766, 7087.0432491614, 7089.468289878279, 7117.466190035768, 3904.941425878614, 4142.523609784913, 4218.451601291812, 4243.257429949808, 4248.277792775236, 1529.3194528434963, 1675.8240384759667, 1710.8203638618015, 1771.1055916761952, 1771.2826305346355, 835.6490274084899, 872.8777971084053, 877.7322916510398, 882.3779235638859, 972.1882228339274, 13158.539451119357, 14987.250637468083, 15252.694946101015, 16157.919210404109, 16375.42686005984, 859.9140085991351, 871.6295574380989, 904.3217586809892, 904.633623382518, 957.090763774417, 9036.231920286718, 9084.046175151647, 9547.42715437076, 9552.713418597454, 9816.705498835046, 372492.0, 487978.0, 488652.0, 524813.0, 537092.0, 64199.0, 66721.66639166774, 69743.65128174327, 70000.2999970004, 70154.87986561816, 1043.2488608202082, 1078.417654466595, 1081.7674200047027, 1110.0730889707186, 1148.465963327057, 14374.928125359307, 14385.424583016562, 14549.490767823076, 14911.25443727831, 14925.776113358526, 30618.540721888745, 30874.69125308718, 31232.531512026882, 31357.686423135478, 31716.524252136696, 41236.0, 41425.585744143376, 41790.0, 41824.16351673011, 43048.0, 6676.465882729273, 6732.562383445061, 6732.831679208059, 6761.391474767294, 6825.726970921108, 9902.702918912444, 9927.503624818875, 10165.593376265162, 10456.947715261374, 10560.735981600521, 9163.312751543528, 9228.584713687766, 9345.813083738423, 9481.857772133286, 9701.9029809701, 9141.497217652826, 9304.906950930404, 9479.810403792024, 9770.85343719859, 9803.656872009446, 9080.954595226982, 9206.447613143233, 9267.165955064076, 9434.0, 9567.904320956979, 6629.105070815378, 6635.867282654416, 6724.596524208563, 6749.392554670103, 6877.724891004304, 8068.515889046676, 9100.0, 9188.448693078437, 9467.0, 9714.0], "unit": "score", "name": "jquery.html", "value": 7847.304363443515}, {"lowerIsBetter": false, "replicates": [1123.2305870478717, 1390.6106290238733, 1395.107131435881, 1484.1614487814384, 1655.9254833532498, 6859.622720750357, 6978.546394484361, 7215.278472152782, 7343.66953487093, 7438.888416673741, 7532.284432978872, 7549.962250188742, 7569.697212111509, 7603.353714934237, 7609.505382150171, 2240.798328150462, 2265.422317309084, 2266.3880752196897, 2267.0025188916907, 2268.6937263469385, 2217.7227846519186, 2218.2125345502277, 2248.1457046322375, 2265.0713207584895, 2269.704938358011, 2234.6089434349005, 2235.2958817972367, 2239.1603148819195, 2248.9654758810966, 2266.9773302267013, 2165.6101901657694, 2175.7389113306344, 2180.716506854115, 2184.421128400983, 2186.5736181444627, 2270.2735124760084, 2273.488465095357, 2275.5562665280277, 2275.670027845953, 2276.0, 7604.581748003858, 7633.465657403984, 7639.197884222188, 7644.732434364826, 7652.234776522303, 4517.119161763458, 4678.181318269323, 4680.9297860532115, 4681.625469962395, 4687.250039993619, 2777.597248398991, 2881.207667891326, 2883.783716221292, 2886.163012726307, 2900.390917907242, 857.3698331726176, 861.5950503263456, 875.0549406640813, 884.4162852517372, 911.1207684584408, 10492.265541412104, 10503.894961050368, 10508.947455262674, 10510.737231569196, 10515.894841051644, 4028.738132021409, 4072.3280658690983, 4098.549159592442, 4240.406343111967, 4264.552222016706, 8315.0, 8336.66653333872, 8350.33197344211, 8353.749387518385, 8355.0, 4569.81720731167, 4571.657125715585, 4614.561616646413, 4619.630429565626, 4620.399348084795, 3727.142757165867, 3784.564775050849, 4125.401816736557, 4168.791560421967, 4228.175505776344, 3384.983075084609, 3433.0, 3442.1738782691973, 3461.671141241578, 3488.1628409181612, 1015.7968406318765, 1026.4252018869456, 1031.9845202321972, 1033.6485594897772, 1056.3239526702916, 1195.1693572966878, 1209.2623499665197, 1225.2709637765515, 1240.8262843201958, 1250.2810883741886, 7033.859322813515, 7092.397146242524, 7191.568505889663, 7248.565086094851, 7249.782506524813, 1072.6192201768415, 1076.494047797534, 1103.542030057533, 1110.3337997201616, 1120.0871289898707, 5554.72226388679, 5605.887882242414, 5625.071863142535, 5633.380328163898, 5635.830925072254, 8778.473291602524, 9370.250379969586, 9375.484348360906, 9378.062193780568, 9389.436633801857, 9262.305327100494, 9392.34253602255, 9475.099865512766, 9499.050094990584, 9512.857307140399, 7164.641767911584, 7442.292982166794, 7449.143348514882, 7462.365698915544, 7469.663865125974, 6989.30106989297, 6995.930040699528, 7042.683079261548, 7048.0485134508235, 7061.0, 8002.5598592077995, 8136.511809291462, 8415.70545030921, 8416.87374689368, 8418.200270974248, 8273.83452330962, 8428.241458268785, 8451.112633173429, 8475.788105297417, 8491.660333586835, 5967.76128954837, 6133.6319820810895, 6537.640429776217, 6750.122484077038, 6909.516333856582, 7298.4526160539235, 7313.378362839218, 7325.853482930418, 7353.338199562065, 7355.742549010973, 6528.640924748995, 6847.383735463832, 6881.724731010703, 6969.7909062728195, 7058.71765129389, 6749.190097188369, 6778.966105169443, 6827.317268273133, 6928.861422771415, 7005.22942476317, 6771.93228067713, 6803.93196068033, 6822.795316140524, 6832.248452670103, 6913.170419549686, 6235.314115447207, 6269.811905642656, 6273.717682704198, 6280.7487700491465, 6283.057541368648, 6457.515686323451, 6475.449586785176, 6482.962725964012, 6492.513061520311, 6510.18622672166], "unit": "score", "name": "mootools.html", "value": 4350.365130209657}, {"lowerIsBetter": false, "replicates": [317.3795230324715, 327.6706909555896, 331.8423748719357, 335.9983200083999, 335.9983200084, 5684.602077854542, 5788.218590490283, 5792.3917988611165, 5792.68140252286, 5827.300723913137, 5573.136163894593, 5728.570357223204, 5731.254936858202, 5754.913676294859, 5768.336641286242, 4470.150671372445, 4472.865814025585, 4473.798679059442, 4479.417675702154, 4482.97758511207, 4222.936655950163, 4309.504406993189, 4314.546972567882, 4315.352697095445, 4468.463784345883, 4290.249206388885, 4378.452693413324, 4383.693141480082, 4388.736675799446, 4401.60385565299, 4347.326164444532, 4362.978185109086, 4366.345048242789, 4372.103718737651, 4380.904773806548, 3887.688984881231, 3889.2610404023144, 3891.7859517726515, 3894.1432884765304, 3894.7273690841653, 5405.594580406485, 5499.312585926759, 5509.614326997112, 5510.283663123809, 5514.172874068881, 5111.514406131411, 5119.948800511985, 5127.846164615067, 5128.2564028216075, 5128.640995130342, 6061.636301821904, 6063.818085457399, 6069.726862291208, 6072.726727297282, 6073.787417440412, 4102.589741025903, 4192.895177620553, 4224.704270701052, 4306.117245964601, 4306.3755755415605, 6375.075614035985, 6388.1695379600815, 6390.3609639036185, 6391.712372943229, 6408.436625349851, 4338.262495375794, 4374.650027997753, 4377.0808130293, 4379.233634114017, 4394.560543945644, 4368.257396242647, 4428.114377124588, 4430.889227769331, 4438.7114837535455, 4441.511433742286, 5129.256257842592, 5145.871353216125, 5146.433892271922, 5151.25306830515, 5154.974225128851, 6154.1999540059505, 6154.969225153935, 6163.19878415812, 6163.260408750979, 6164.845878853064, 1570.4895908829676, 1585.58774718574, 1586.3654538184587, 1589.078334565972, 1589.6105454163803, 1064.2816099133054, 1070.8072546941469, 1083.6532309660834, 1086.5870969031876, 1093.5297821936485, 5823.505002074787, 5847.473727364472, 5854.18041474194, 5856.619319744203, 5859.853503662443, 6315.305316415191, 6322.0, 6324.9051264231075, 6327.905081423783, 6329.556931014785, 5831.037878750044, 5844.620099693507, 5850.707464626837, 5851.707414629337, 5854.326752423526, 3295.555100061461, 3390.6100798408497, 3399.0, 3399.6090449598614, 3409.0454672691685, 6602.933970660328, 6627.541940773022, 6628.801135965929, 6630.071789949411, 6635.369639884203, 6469.385408386196, 6472.352764723584, 6476.4495017924, 6481.902771458432, 6483.643399612973, 6482.708278127496, 6602.0, 6641.900371494431, 6667.733290668416, 6677.732890684319, 6368.808935731936, 6381.1704478417505, 6388.744450221939, 6391.296957334783, 6391.424771770563, 6025.698715064142, 6123.2652081750475, 6171.166892469639, 6267.185265915402, 6267.185265915402, 6632.535722499379, 6635.402813746593, 6636.634985075867, 6645.734170633121, 6688.0, 4418.050119224382, 4425.557444255549, 4437.977810111058, 4441.045175287329, 4458.108378324413, 6252.562320637512, 6368.108464814837, 6386.16979792624, 6387.201599800025, 6400.359964003563, 6217.191765070512, 6227.688615569294, 6234.251889773256, 6236.688165591793, 6238.719257633326, 6210.844728881814, 6218.502519798496, 6220.502359811295, 6221.502279817694, 6224.564280500322, 5969.0, 6095.817125486243, 6103.664298463627, 6112.510999119971, 6120.785772497941, 6216.906746398898, 6222.471089957405, 6224.782132625336, 6228.252609686867, 6231.844203894939, 6103.08453731926, 6103.816885493442, 6107.541934354852, 6112.28855920343, 6113.816585502442], "unit": "score", "name": "prototype.html", "value": 4646.635223548249}, {"lowerIsBetter": false, "replicates": [667.5160508631243, 677.4411110833563, 705.7953193573863, 739.9630018499074, 804.5574933786417, 12657.493700251991, 13057.347132643365, 13081.476740930364, 13109.0, 13111.409986550605, 13062.673433164176, 13077.607671769862, 13101.868981310185, 13107.54123605674, 13131.868681313184, 645.7158850105939, 646.8253571535682, 759.0132827324497, 769.4114002787871, 769.9730509432171, 776.8329809091044, 783.3145997252404, 783.75703531905, 783.8549868274359, 784.0982869699834, 809.0695699945052, 809.5911564659868, 809.7975506123469, 809.8987626546682, 809.9190080991883, 664.9958562570529, 665.7669815564562, 793.936485081195, 803.1687203744096, 811.3428123220151, 592.594073059951, 593.2613895699882, 594.0, 595.2618752746606, 595.624756403463, 13094.14888032275, 13124.343782810822, 13143.737125257538, 13153.671158221025, 13175.86824131756, 11539.903709147618, 11898.702532436671, 11990.340531270776, 12060.577879774253, 12265.509379624804, 9487.762805929839, 9502.952485237598, 9506.47714375716, 9538.189253913426, 9807.656732014346, 3301.4222511060707, 3340.048086295394, 3442.431998720208, 3485.6165821759587, 3687.9815600922093, 44572.108557828986, 44588.0, 44772.0, 45068.323975140396, 46338.53661463376, 9001.18989290967, 9363.157315841607, 9487.193588545051, 9521.640542226502, 9874.753131171634, 17300.913495432444, 17515.73726394105, 17517.82482175162, 17546.034968076878, 17558.736618950727, 7167.677454514559, 7458.589777562286, 7660.348870345972, 7783.104942931635, 7920.881186782203, 3884.9223015540097, 3935.822887969991, 3985.6412922837085, 4017.83928642851, 4036.6367026967714, 2787.874545645451, 2808.255812209766, 2812.2688101093863, 2815.591739197846, 2822.111035023961, 484.6268373352499, 493.1690102177842, 496.5406998526349, 499.3757802746567, 521.5202014146994, 514.3519165851054, 560.4899541417291, 578.308920839601, 597.7877853362081, 629.3486241739869, 8287.0, 8419.536925469036, 8496.447730897471, 8524.14758524155, 8565.443246188977, 561.5563704673262, 571.8999175144334, 586.571802584116, 612.4702132655221, 624.4161708802285, 3629.419292913174, 3726.720495962814, 3744.5693745219105, 3853.8265778040054, 3944.9605503945168, 50838.491615083374, 52549.0, 52953.2057019145, 53376.73311633417, 53500.0, 49681.0, 50301.496985029684, 50430.74784626127, 50719.74640126776, 51023.74488127536, 43150.999999999374, 43184.0, 43757.34363984543, 44430.77784611056, 44458.777706111265, 7498.250174982458, 7608.581528015791, 7663.616819158909, 7788.532688038736, 8277.875831862648, 33388.0, 33496.66503335033, 34676.47985280273, 34938.30123397467, 35421.64578354287, 42635.360469592364, 42878.78560607177, 42924.0, 43175.784121079196, 43855.561444386425, 9090.590923408594, 9604.75988100303, 9652.806943861224, 9821.410715357102, 10008.299419040597, 10742.892571074502, 10856.0, 10897.509612067635, 11334.206605537533, 11476.196666233618, 9758.707238782848, 9948.35335703177, 10144.391336519833, 10330.328528645614, 10478.109360704426, 10238.078572928473, 10326.173906087344, 10548.578056877946, 10623.0, 11112.833307500232, 10282.485875706334, 10791.406472643766, 10809.945950270197, 10831.566737330733, 10856.620018299322, 8801.0, 8916.885389326335, 8995.0, 9012.083847102343, 9103.681371151977, 8448.746537603882, 8691.391602587759, 8756.695743437915, 8818.91181088181, 9021.639134434812], "unit": "score", "name": "yui.html", "value": 5902.39860267094}], "name": "dromaeo_css", "value": 6582.603264491926}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 106.0, 111.0, 111.0, 112.0, 101.0, 110.0, 110.0, 121.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 156.0, 165.0, 126.0, 149.0, 152.0, 127.0, 171.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 159.0, 160.0, 161.0, 161.0, 161.0, 163.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 85.0, 101.0, 81.0, 71.0, 73.0, 109.0, 93.0, 75.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 143.0, 97.0, 98.0, 97.0, 142.0, 96.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 55.0, 54.0, 55.0, 58.0, 57.0, 63.0, 52.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 90.0, 85.0, 93.0, 94.0, 94.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.3}, {"lowerIsBetter": true, "replicates": [132.0, 123.0, 116.0, 123.0, 124.0, 121.0, 115.0, 118.0, 120.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [140.0, 151.0, 143.0, 150.0, 150.0, 142.0, 150.0, 150.0, 162.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 66.0, 66.0, 69.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1506.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.44474034620507], "unit": "score", "name": "Richards", "value": 212.09441600000005}, {"lowerIsBetter": false, "replicates": [190.8761213972132], "unit": "score", "name": "DeltaBlue", "value": 346.39220200000005}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5261.780104712042], "unit": "score", "name": "Decrypt", "value": 50.58763283582091}, {"lowerIsBetter": false, "replicates": [1996.007984031936], "unit": "score", "name": "RayTrace", "value": 370.73448899999994}, {"lowerIsBetter": false, "replicates": [860.5851979345955], "unit": "score", "name": "Earley", "value": 774.4300060000002}, {"lowerIsBetter": false, "replicates": [12481.481481481482], "unit": "score", "name": "Boyer", "value": 53.39614540059344}, {"lowerIsBetter": false, "replicates": [43638.29787234042], "unit": "score", "name": "RegExp", "value": 20.875814236957574}, {"lowerIsBetter": false, "replicates": [563.063063063063], "unit": "score", "name": "Splay", "value": 144.728016}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 18729.491824227465}]} 11:35:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18729.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1506.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6582.61"}}} 11:35:37 INFO - Return code: 0 11:35:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:35:37 INFO - # TBPL SUCCESS # 11:35:37 INFO - Running post-action listener: _resource_record_post_action 11:35:37 INFO - Running post-run listener: _resource_record_post_run 11:35:38 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 86016; Write bytes: 542351360; Read time: 48; Write time: 499512 11:35:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 238977024; Read time: 0; Write time: 235360 11:35:38 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 86016; Write bytes: 303374336; Read time: 48; Write time: 264152 11:35:38 INFO - Running post-run listener: _upload_blobber_files 11:35:38 INFO - Blob upload gear active. 11:35:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:35:38 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 11:35:38 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'] 11:35:38 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 11:35:38 INFO - (blobuploader) - INFO - Open directory for files ... 11:35:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:35:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:35:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:40 INFO - (blobuploader) - INFO - Done attempting. 11:35:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:35:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:35:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:40 INFO - (blobuploader) - INFO - Done attempting. 11:35:40 INFO - (blobuploader) - INFO - Iteration through files over. 11:35:40 INFO - Return code: 0 11:35:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:35:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:35:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6be4059cdadf5c4dc372103cc9ca9f44e1d1d5f9609d0f09df6a3a3c16ea23ff695c361207fed4efa25403e5466c995b3783e942bc01af9192d780f99a894a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bafb1b01b0fc46b34aebfaeb3bc75f63881855634173b000f086a93171e60b289294616f551609778bf1efe06d032da7402ed1d7cf3b93035bc38dc793c83c36"} 11:35:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:35:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:35:40 INFO - Contents: 11:35:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6be4059cdadf5c4dc372103cc9ca9f44e1d1d5f9609d0f09df6a3a3c16ea23ff695c361207fed4efa25403e5466c995b3783e942bc01af9192d780f99a894a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bafb1b01b0fc46b34aebfaeb3bc75f63881855634173b000f086a93171e60b289294616f551609778bf1efe06d032da7402ed1d7cf3b93035bc38dc793c83c36"} 11:35:40 INFO - Copying logs to upload dir... 11:35:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.646116 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-12 11:35:40.940271) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 11:35:40.943565) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061 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/c6be4059cdadf5c4dc372103cc9ca9f44e1d1d5f9609d0f09df6a3a3c16ea23ff695c361207fed4efa25403e5466c995b3783e942bc01af9192d780f99a894a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bafb1b01b0fc46b34aebfaeb3bc75f63881855634173b000f086a93171e60b289294616f551609778bf1efe06d032da7402ed1d7cf3b93035bc38dc793c83c36"} build_url:https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/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/c6be4059cdadf5c4dc372103cc9ca9f44e1d1d5f9609d0f09df6a3a3c16ea23ff695c361207fed4efa25403e5466c995b3783e942bc01af9192d780f99a894a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bafb1b01b0fc46b34aebfaeb3bc75f63881855634173b000f086a93171e60b289294616f551609778bf1efe06d032da7402ed1d7cf3b93035bc38dc793c83c36"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 11:35:40.967502) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:35:40.967819) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452626069.547515-780857061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:35:41.049875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 11:35:41.050201) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 11:35:41.050485) ========= ========= Total master_lag: 0.15 =========