builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1452183509.39 results: success (0) buildid: 20160107053022 builduid: ee2c27757ca5458890fba04ef963c304 revision: e2f7ab5a03709a2a1a5eeba4e02b5961b530be4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.392208) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.392639) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.392931) ========= 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=32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006460 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.422216) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.422493) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.439138) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.439393) ========= 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=32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004737 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.490261) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.490522) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.490866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.491149) ========= 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=32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 08:18:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 224M=0s 2016-01-07 08:18:29 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162683 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.665709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.666038) ========= 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=32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014988 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.715319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:29.715635) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e2f7ab5a03709a2a1a5eeba4e02b5961b530be4c --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 e2f7ab5a03709a2a1a5eeba4e02b5961b530be4c --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=32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 08:18:29,952 truncating revision to first 12 chars 2016-01-07 08:18:29,952 Setting DEBUG logging. 2016-01-07 08:18:29,952 attempt 1/10 2016-01-07 08:18:29,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e2f7ab5a0370?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 08:18:30,181 unpacking tar archive at: fx-team-e2f7ab5a0370/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550365 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:30.279911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:30.280427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:30.295215) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:30.295660) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:30.296331) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-07 08:18:30.296666) ========= /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=32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:18:30 INFO - MultiFileLogger online at 20160107 08:18:30 in /builds/slave/test-pgo 08:18:30 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 08:18:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:18:30 INFO - {'append_to_log': False, 08:18:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:18:30 INFO - 'blob_upload_branch': 'Fx-Team', 08:18:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:18:30 INFO - 'branch': 'Fx-Team', 08:18:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:30 INFO - 'config_files': ('talos/linux_config.py',), 08:18:30 INFO - 'default_actions': ('clobber', 08:18:30 INFO - 'read-buildbot-config', 08:18:30 INFO - 'download-and-extract', 08:18:30 INFO - 'populate-webroot', 08:18:30 INFO - 'create-virtualenv', 08:18:30 INFO - 'install', 08:18:30 INFO - 'run-tests'), 08:18:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:30 INFO - 'download_minidump_stackwalk': True, 08:18:30 INFO - 'download_symbols': 'ondemand', 08:18:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:30 INFO - 'installer_path': 'installer.exe', 08:18:30 INFO - 'log_level': 'info', 08:18:30 INFO - 'log_name': 'talos', 08:18:30 INFO - 'log_to_console': True, 08:18:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:18:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:18:30 INFO - 'opt_config_files': (), 08:18:30 INFO - 'pip_index': False, 08:18:30 INFO - 'sps_profile': False, 08:18:30 INFO - 'sps_profile_interval': 0, 08:18:30 INFO - 'suite': 'dromaeojs', 08:18:30 INFO - 'system_bits': '32', 08:18:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:30 INFO - 'title': 'talos-linux64-ix-008', 08:18:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:30 INFO - 'use_talos_json': True, 08:18:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:18:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:30 INFO - 'work_dir': 'build'} 08:18:30 INFO - ##### 08:18:30 INFO - ##### Running clobber step. 08:18:30 INFO - ##### 08:18:30 INFO - Running pre-action listener: _resource_record_pre_action 08:18:30 INFO - Running main action method: clobber 08:18:30 INFO - rmtree: /builds/slave/test-pgo/build 08:18:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:18:31 INFO - Running post-action listener: _resource_record_post_action 08:18:31 INFO - ##### 08:18:31 INFO - ##### Running read-buildbot-config step. 08:18:31 INFO - ##### 08:18:31 INFO - Running pre-action listener: _resource_record_pre_action 08:18:31 INFO - Running main action method: read_buildbot_config 08:18:31 INFO - Using buildbot properties: 08:18:31 INFO - { 08:18:31 INFO - "project": "", 08:18:31 INFO - "product": "firefox", 08:18:31 INFO - "script_repo_revision": "production", 08:18:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:18:31 INFO - "repository": "", 08:18:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:18:31 INFO - "buildid": "20160107053022", 08:18:31 INFO - "pgo_build": "True", 08:18:31 INFO - "basedir": "/builds/slave/test-pgo", 08:18:31 INFO - "buildnumber": 404, 08:18:31 INFO - "slavename": "talos-linux64-ix-008", 08:18:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:18:31 INFO - "platform": "ubuntu64_hw", 08:18:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:18:31 INFO - "branch": "fx-team", 08:18:31 INFO - "repo_path": "integration/fx-team", 08:18:31 INFO - "revision": "e2f7ab5a03709a2a1a5eeba4e02b5961b530be4c", 08:18:31 INFO - "stage_platform": "linux64-pgo", 08:18:31 INFO - "builduid": "ee2c27757ca5458890fba04ef963c304", 08:18:31 INFO - "slavebuilddir": "test" 08:18:31 INFO - } 08:18:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:18:31 INFO - Running post-action listener: _resource_record_post_action 08:18:31 INFO - ##### 08:18:31 INFO - ##### Running download-and-extract step. 08:18:31 INFO - ##### 08:18:31 INFO - Running pre-action listener: _resource_record_pre_action 08:18:31 INFO - Running main action method: download_and_extract 08:18:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:31 INFO - https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:18:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/test_packages.json 08:18:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/test_packages.json 08:18:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:18:35 INFO - Downloaded 1302 bytes. 08:18:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:18:35 INFO - Using the following test package requirements: 08:18:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:18:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:35 INFO - u'jsshell-linux-x86_64.zip'], 08:18:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:18:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:18:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:18:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:18:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:18:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:35 INFO - https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:18:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:41 INFO - Downloaded 24056384 bytes. 08:18:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 08:18:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:18:42 INFO - Return code: 0 08:18:42 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 08:18: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')]} 08:18:42 INFO - https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:18:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:48 INFO - Downloaded 24056384 bytes. 08:18:48 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 08:18:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:48 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 08:18:49 INFO - Return code: 0 08:18:49 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')]} 08:18:49 INFO - https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:18:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:18:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:18:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:51 INFO - Downloaded 11132285 bytes. 08:18:51 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 08:18:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:18:51 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 08:18:51 INFO - Return code: 0 08:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:51 INFO - https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:18:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:18:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:18:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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 08:18:52 INFO - Downloaded 55912600 bytes. 08:18:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:18:52 INFO - mkdir: /builds/slave/test-pgo/properties 08:18:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:18:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:18:52 INFO - Contents: 08:18:52 INFO - build_url:https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:18:52 INFO - Running post-action listener: _resource_record_post_action 08:18:52 INFO - Running post-action listener: set_extra_try_arguments 08:18:52 INFO - ##### 08:18:52 INFO - ##### Running populate-webroot step. 08:18:52 INFO - ##### 08:18:52 INFO - Running pre-action listener: _resource_record_pre_action 08:18:52 INFO - Running main action method: populate_webroot 08:18:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:18:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:18:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:18:52 INFO - '--tppagecycles', 08:18:52 INFO - '7'], 08:18:52 INFO - 'tests': ['tsvgm']}}, 08:18:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:18:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:18:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:18:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:18:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:18:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:18:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:52 INFO - 'talos_options': ['--e10s'], 08:18:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:52 INFO - 'tests': ['damp', 'tps']}, 08:18:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:52 INFO - 'talos_options': ['--e10s'], 08:18:52 INFO - 'tests': ['damp', 'tps']}, 08:18:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:18:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:18:52 INFO - 'other': {'tests': ['a11yr', 08:18:52 INFO - 'ts_paint', 08:18:52 INFO - 'tpaint', 08:18:52 INFO - 'sessionrestore', 08:18:52 INFO - 'sessionrestore_no_auto_restore']}, 08:18:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:18:52 INFO - 'tests': ['a11yr', 08:18:52 INFO - 'ts_paint', 08:18:52 INFO - 'tpaint', 08:18:52 INFO - 'sessionrestore', 08:18:52 INFO - 'sessionrestore_no_auto_restore']}, 08:18:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:18:52 INFO - 'tests': ['a11yr', 08:18:52 INFO - 'ts_paint', 08:18:52 INFO - 'tpaint', 08:18:52 INFO - 'sessionrestore', 08:18:52 INFO - 'sessionrestore_no_auto_restore']}, 08:18:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:18:52 INFO - 'tests': ['a11yr', 08:18:52 INFO - 'ts_paint', 08:18:52 INFO - 'tpaint', 08:18:52 INFO - 'sessionrestore', 08:18:52 INFO - 'sessionrestore_no_auto_restore']}, 08:18:52 INFO - 'other_l64': {'tests': ['a11yr', 08:18:52 INFO - 'ts_paint', 08:18:52 INFO - 'tpaint', 08:18:52 INFO - 'sessionrestore', 08:18:52 INFO - 'sessionrestore_no_auto_restore']}, 08:18:52 INFO - 'other_nol64': {'tests': ['a11yr', 08:18:52 INFO - 'ts_paint', 08:18:52 INFO - 'tpaint', 08:18:52 INFO - 'sessionrestore', 08:18:52 INFO - 'sessionrestore_no_auto_restore']}, 08:18:52 INFO - 'svgr': {'tests': ['tsvgx', 08:18:52 INFO - 'tsvgr_opacity', 08:18:52 INFO - 'tart', 08:18:52 INFO - 'tscrollx', 08:18:52 INFO - 'cart']}, 08:18:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:18:52 INFO - 'tests': ['tsvgx', 08:18:52 INFO - 'tsvgr_opacity', 08:18:52 INFO - 'tart', 08:18:52 INFO - 'tscrollx', 08:18:52 INFO - 'cart']}, 08:18:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:52 INFO - 'tests': ['tp5o']}, 08:18:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:52 INFO - 'talos_options': ['--e10s'], 08:18:52 INFO - 'tests': ['tp5o']}, 08:18:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:52 INFO - 'talos_options': ['--xperf_path', 08:18:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:52 INFO - 'tests': ['tp5n']}, 08:18:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:52 INFO - 'talos_options': ['--e10s', 08:18:52 INFO - '--xperf_path', 08:18:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:52 INFO - 'tests': ['tp5n']}}, 08:18:52 INFO - 'talos.zip': {'path': '', 08:18:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:18:52 INFO - Running post-action listener: _resource_record_post_action 08:18:52 INFO - ##### 08:18:52 INFO - ##### Running create-virtualenv step. 08:18:52 INFO - ##### 08:18:52 INFO - Running pre-action listener: _resource_record_pre_action 08:18:52 INFO - Running main action method: create_virtualenv 08:18:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:18:52 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 08:18:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:18:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:18:52 INFO - Using real prefix '/usr' 08:18:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:18:53 INFO - Installing distribute.............................................................................................................................................................................................done. 08:18:55 INFO - Installing pip.................done. 08:18:55 INFO - Return code: 0 08:18:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:18: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')]} 08:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18: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')]} 08:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:55 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 0x7f58ccfd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a840>, '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 0xd976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97b60>, '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': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', '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 08:18:55 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 08:18:55 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 08:18:55 INFO - Using env: {'DISPLAY': ':0', 08:18:55 INFO - 'HOME': '/home/cltbld', 08:18:55 INFO - 'LANG': 'en_US.UTF-8', 08:18:55 INFO - 'LANGUAGE': 'en_US:en', 08:18:55 INFO - 'LOGNAME': 'cltbld', 08:18:55 INFO - 'MAIL': '/var/mail/cltbld', 08:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:55 INFO - 'MOZ_NO_REMOTE': '1', 08:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:55 INFO - 'NO_EM_RESTART': '1', 08:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:18:55 INFO - 'PWD': '/builds/slave/test-pgo', 08:18:55 INFO - 'SHELL': '/bin/bash', 08:18:55 INFO - 'SHLVL': '1', 08:18:55 INFO - 'TERM': 'linux', 08:18:55 INFO - 'TMOUT': '86400', 08:18:55 INFO - 'USER': 'cltbld', 08:18:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', 08:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:55 INFO - '_': '/tools/buildbot/bin/python'} 08:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:55 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 08:18:55 INFO - Cleaning up... 08:18:55 INFO - Return code: 0 08:18:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:18: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')]} 08:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18: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')]} 08:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:55 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 0x7f58ccfd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a840>, '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 0xd976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97b60>, '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': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', '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 08:18:55 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 08:18:55 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 08:18:55 INFO - Using env: {'DISPLAY': ':0', 08:18:55 INFO - 'HOME': '/home/cltbld', 08:18:55 INFO - 'LANG': 'en_US.UTF-8', 08:18:55 INFO - 'LANGUAGE': 'en_US:en', 08:18:55 INFO - 'LOGNAME': 'cltbld', 08:18:55 INFO - 'MAIL': '/var/mail/cltbld', 08:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:55 INFO - 'MOZ_NO_REMOTE': '1', 08:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:55 INFO - 'NO_EM_RESTART': '1', 08:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:18:55 INFO - 'PWD': '/builds/slave/test-pgo', 08:18:55 INFO - 'SHELL': '/bin/bash', 08:18:55 INFO - 'SHLVL': '1', 08:18:55 INFO - 'TERM': 'linux', 08:18:55 INFO - 'TMOUT': '86400', 08:18:55 INFO - 'USER': 'cltbld', 08:18:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', 08:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:55 INFO - '_': '/tools/buildbot/bin/python'} 08:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:55 INFO - Downloading/unpacking psutil>=0.7.1 08:18: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 08:18: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 08:18: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 08:18: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 08:18: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 08:18: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 08:18:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:18:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:18:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:18:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:57 INFO - Installing collected packages: psutil 08:18:57 INFO - Running setup.py install for psutil 08:18:57 INFO - building 'psutil._psutil_linux' extension 08:18:57 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 08:18:57 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 08:18:57 INFO - building 'psutil._psutil_posix' extension 08:18:57 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 08:18:57 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 08:18:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:57 INFO - Successfully installed psutil 08:18:57 INFO - Cleaning up... 08:18:58 INFO - Return code: 0 08:18:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f58ccfd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a840>, '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 0xd976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97b60>, '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': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', '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 08:18:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:18:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:18:58 INFO - Using env: {'DISPLAY': ':0', 08:18:58 INFO - 'HOME': '/home/cltbld', 08:18:58 INFO - 'LANG': 'en_US.UTF-8', 08:18:58 INFO - 'LANGUAGE': 'en_US:en', 08:18:58 INFO - 'LOGNAME': 'cltbld', 08:18:58 INFO - 'MAIL': '/var/mail/cltbld', 08:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:58 INFO - 'MOZ_NO_REMOTE': '1', 08:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:58 INFO - 'NO_EM_RESTART': '1', 08:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:18:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:18:58 INFO - 'SHELL': '/bin/bash', 08:18:58 INFO - 'SHLVL': '1', 08:18:58 INFO - 'TERM': 'linux', 08:18:58 INFO - 'TMOUT': '86400', 08:18:58 INFO - 'USER': 'cltbld', 08:18:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', 08:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:58 INFO - '_': '/tools/buildbot/bin/python'} 08:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:18:58 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 08:18:58 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 08:18:58 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 08:18:58 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 08:18:58 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 08:18:58 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 08:18:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:18:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:18:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:19:00 INFO - Installing collected packages: mozsystemmonitor 08:19:00 INFO - Running setup.py install for mozsystemmonitor 08:19:00 INFO - Successfully installed mozsystemmonitor 08:19:00 INFO - Cleaning up... 08:19:00 INFO - Return code: 0 08:19:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:00 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 0x7f58ccfd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a840>, '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 0xd976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97b60>, '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': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', '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 08:19:00 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 08:19:00 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 08:19:00 INFO - Using env: {'DISPLAY': ':0', 08:19:00 INFO - 'HOME': '/home/cltbld', 08:19:00 INFO - 'LANG': 'en_US.UTF-8', 08:19:00 INFO - 'LANGUAGE': 'en_US:en', 08:19:00 INFO - 'LOGNAME': 'cltbld', 08:19:00 INFO - 'MAIL': '/var/mail/cltbld', 08:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:00 INFO - 'MOZ_NO_REMOTE': '1', 08:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:00 INFO - 'NO_EM_RESTART': '1', 08:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:00 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:00 INFO - 'SHELL': '/bin/bash', 08:19:00 INFO - 'SHLVL': '1', 08:19:00 INFO - 'TERM': 'linux', 08:19:00 INFO - 'TMOUT': '86400', 08:19:00 INFO - 'USER': 'cltbld', 08:19:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', 08:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:00 INFO - '_': '/tools/buildbot/bin/python'} 08:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:00 INFO - Downloading/unpacking blobuploader==1.2.4 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19:02 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:19:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:02 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 08:19:02 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 08:19:02 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 08:19:02 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 08:19:02 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 08:19:02 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 08:19:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:19:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:19:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:02 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 08:19:02 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 08:19:02 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 08:19:02 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 08:19:02 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 08:19:02 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 08:19:02 INFO - Downloading docopt-0.6.1.tar.gz 08:19:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:19:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:02 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:02 INFO - Running setup.py install for blobuploader 08:19:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:19:02 INFO - Running setup.py install for requests 08:19:03 INFO - Running setup.py install for docopt 08:19:03 INFO - Successfully installed blobuploader requests docopt 08:19:03 INFO - Cleaning up... 08:19:03 INFO - Return code: 0 08:19:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:03 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 0x7f58ccfd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a840>, '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 0xd976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97b60>, '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': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', '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 08:19:03 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 08:19:03 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 08:19:03 INFO - Using env: {'DISPLAY': ':0', 08:19:03 INFO - 'HOME': '/home/cltbld', 08:19:03 INFO - 'LANG': 'en_US.UTF-8', 08:19:03 INFO - 'LANGUAGE': 'en_US:en', 08:19:03 INFO - 'LOGNAME': 'cltbld', 08:19:03 INFO - 'MAIL': '/var/mail/cltbld', 08:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:03 INFO - 'MOZ_NO_REMOTE': '1', 08:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:03 INFO - 'NO_EM_RESTART': '1', 08:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:03 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:03 INFO - 'SHELL': '/bin/bash', 08:19:03 INFO - 'SHLVL': '1', 08:19:03 INFO - 'TERM': 'linux', 08:19:03 INFO - 'TMOUT': '86400', 08:19:03 INFO - 'USER': 'cltbld', 08:19:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', 08:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:03 INFO - '_': '/tools/buildbot/bin/python'} 08:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:03 INFO - Running setup.py (path:/tmp/pip-WtOz1J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:03 INFO - Running setup.py (path:/tmp/pip-lQZZyP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:03 INFO - Running setup.py (path:/tmp/pip-nIoden-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:03 INFO - Running setup.py (path:/tmp/pip-oSrZm5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:03 INFO - Running setup.py (path:/tmp/pip-nqjtFk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:03 INFO - Running setup.py (path:/tmp/pip-3TY2t4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:04 INFO - Running setup.py (path:/tmp/pip-G1_1y8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:04 INFO - Running setup.py (path:/tmp/pip-6ee_dm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:04 INFO - Running setup.py (path:/tmp/pip-70Nole-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:04 INFO - Running setup.py (path:/tmp/pip-B7kSc0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:04 INFO - Running setup.py (path:/tmp/pip-06Q7WE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:04 INFO - Running setup.py (path:/tmp/pip-0PW0iO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:04 INFO - Running setup.py (path:/tmp/pip-WSJQ5x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:04 INFO - Running setup.py (path:/tmp/pip-wbtxXI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:04 INFO - Running setup.py (path:/tmp/pip-jk7IAL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:04 INFO - Running setup.py (path:/tmp/pip-DDLWLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:04 INFO - Running setup.py (path:/tmp/pip-SwrArC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:04 INFO - Running setup.py install for manifestparser 08:19:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:19:04 INFO - Running setup.py install for mozcrash 08:19:05 INFO - Running setup.py install for mozdebug 08:19:05 INFO - Running setup.py install for mozdevice 08:19:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:19:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:19:05 INFO - Running setup.py install for mozfile 08:19:05 INFO - Running setup.py install for mozhttpd 08:19:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:19:05 INFO - Running setup.py install for mozinfo 08:19:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:19:05 INFO - Running setup.py install for mozInstall 08:19:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:19:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:19:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:19:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:19:05 INFO - Running setup.py install for mozleak 08:19:05 INFO - Running setup.py install for mozlog 08:19:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:19:05 INFO - Running setup.py install for moznetwork 08:19:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:19:05 INFO - Running setup.py install for mozprocess 08:19:06 INFO - Running setup.py install for mozprofile 08:19:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:19:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:19:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:19:06 INFO - Running setup.py install for mozrunner 08:19:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:19:06 INFO - Running setup.py install for mozscreenshot 08:19:06 INFO - Running setup.py install for moztest 08:19:06 INFO - Running setup.py install for mozversion 08:19:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:19:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:06 INFO - Cleaning up... 08:19:06 INFO - Return code: 0 08:19:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:19:06 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')]} 08:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:06 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')]} 08:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:06 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 0x7f58ccfd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a840>, '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 0xd976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97b60>, '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': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', '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 08:19:06 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 08:19:06 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 08:19:06 INFO - Using env: {'DISPLAY': ':0', 08:19:06 INFO - 'HOME': '/home/cltbld', 08:19:06 INFO - 'LANG': 'en_US.UTF-8', 08:19:06 INFO - 'LANGUAGE': 'en_US:en', 08:19:06 INFO - 'LOGNAME': 'cltbld', 08:19:06 INFO - 'MAIL': '/var/mail/cltbld', 08:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:06 INFO - 'MOZ_NO_REMOTE': '1', 08:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:06 INFO - 'NO_EM_RESTART': '1', 08:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:06 INFO - 'SHELL': '/bin/bash', 08:19:06 INFO - 'SHLVL': '1', 08:19:06 INFO - 'TERM': 'linux', 08:19:06 INFO - 'TMOUT': '86400', 08:19:06 INFO - 'USER': 'cltbld', 08:19:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', 08:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:06 INFO - '_': '/tools/buildbot/bin/python'} 08:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:06 INFO - Running setup.py (path:/tmp/pip-Y8QNuv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:06 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)) 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:06 INFO - Running setup.py (path:/tmp/pip-llrvDs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:06 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)) 08:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:06 INFO - Running setup.py (path:/tmp/pip-joy7_X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:07 INFO - Running setup.py (path:/tmp/pip-fvhJzH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:07 INFO - Running setup.py (path:/tmp/pip-6VXknh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:07 INFO - Running setup.py (path:/tmp/pip-HNhcUI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:07 INFO - Running setup.py (path:/tmp/pip-avTVyU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:07 INFO - Running setup.py (path:/tmp/pip-n4bLAS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:07 INFO - Running setup.py (path:/tmp/pip-xmYd38-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:07 INFO - Running setup.py (path:/tmp/pip-UDp70w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:07 INFO - Running setup.py (path:/tmp/pip-d8t_A4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:07 INFO - Running setup.py (path:/tmp/pip-QIKuJZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:07 INFO - Running setup.py (path:/tmp/pip-hnUWGE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:07 INFO - Running setup.py (path:/tmp/pip-HORUfn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:07 INFO - Running setup.py (path:/tmp/pip-BEpfmO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:07 INFO - Running setup.py (path:/tmp/pip-1F7PfL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:07 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)) 08:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:07 INFO - Running setup.py (path:/tmp/pip-6OEDfH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:08 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)) 08:19:08 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)) 08:19:08 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)) 08:19:08 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)) 08:19:08 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)) 08:19:08 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)) 08:19:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:08 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 08:19:08 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 08:19:08 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 08:19:08 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 08:19:08 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 08:19:08 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 08:19:09 INFO - Downloading blessings-1.5.1.tar.gz 08:19:09 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 08:19:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:09 INFO - Installing collected packages: blessings 08:19:09 INFO - Running setup.py install for blessings 08:19:09 INFO - Successfully installed blessings 08:19:09 INFO - Cleaning up... 08:19:10 INFO - Return code: 0 08:19:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:19:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:19:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:19:10 INFO - Reading from file tmpfile_stdout 08:19:10 INFO - Current package versions: 08:19:10 INFO - argparse == 1.2.1 08:19:10 INFO - blessings == 1.5.1 08:19:10 INFO - blobuploader == 1.2.4 08:19:10 INFO - docopt == 0.6.1 08:19:10 INFO - manifestparser == 1.1 08:19:10 INFO - mozInstall == 1.12 08:19:10 INFO - mozcrash == 0.16 08:19:10 INFO - mozdebug == 0.1 08:19:10 INFO - mozdevice == 0.47 08:19:10 INFO - mozfile == 1.2 08:19:10 INFO - mozhttpd == 0.7 08:19:10 INFO - mozinfo == 0.9 08:19:10 INFO - mozleak == 0.1 08:19:10 INFO - mozlog == 3.1 08:19:10 INFO - moznetwork == 0.27 08:19:10 INFO - mozprocess == 0.22 08:19:10 INFO - mozprofile == 0.28 08:19:10 INFO - mozrunner == 6.11 08:19:10 INFO - mozscreenshot == 0.1 08:19:10 INFO - mozsystemmonitor == 0.0 08:19:10 INFO - moztest == 0.7 08:19:10 INFO - mozversion == 1.4 08:19:10 INFO - psutil == 3.1.1 08:19:10 INFO - requests == 1.2.3 08:19:10 INFO - wsgiref == 0.1.2 08:19:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f58ccfd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a840>, '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 0xd976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97b60>, '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': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', '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 08:19:10 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 08:19:10 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 08:19:10 INFO - Using env: {'DISPLAY': ':0', 08:19:10 INFO - 'HOME': '/home/cltbld', 08:19:10 INFO - 'LANG': 'en_US.UTF-8', 08:19:10 INFO - 'LANGUAGE': 'en_US:en', 08:19:10 INFO - 'LOGNAME': 'cltbld', 08:19:10 INFO - 'MAIL': '/var/mail/cltbld', 08:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:10 INFO - 'MOZ_NO_REMOTE': '1', 08:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:10 INFO - 'NO_EM_RESTART': '1', 08:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:10 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:10 INFO - 'SHELL': '/bin/bash', 08:19:10 INFO - 'SHLVL': '1', 08:19:10 INFO - 'TERM': 'linux', 08:19:10 INFO - 'TMOUT': '86400', 08:19:10 INFO - 'USER': 'cltbld', 08:19:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', 08:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:10 INFO - '_': '/tools/buildbot/bin/python'} 08:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 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)) 08:19:10 INFO - Cleaning up... 08:19:10 INFO - Return code: 0 08:19:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58ccfd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a840>, '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 0xd976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97b60>, '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': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', '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 08:19:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:19:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:19:10 INFO - Using env: {'DISPLAY': ':0', 08:19:10 INFO - 'HOME': '/home/cltbld', 08:19:10 INFO - 'LANG': 'en_US.UTF-8', 08:19:10 INFO - 'LANGUAGE': 'en_US:en', 08:19:10 INFO - 'LOGNAME': 'cltbld', 08:19:10 INFO - 'MAIL': '/var/mail/cltbld', 08:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:10 INFO - 'MOZ_NO_REMOTE': '1', 08:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:10 INFO - 'NO_EM_RESTART': '1', 08:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:10 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:10 INFO - 'SHELL': '/bin/bash', 08:19:10 INFO - 'SHLVL': '1', 08:19:10 INFO - 'TERM': 'linux', 08:19:10 INFO - 'TMOUT': '86400', 08:19:10 INFO - 'USER': 'cltbld', 08:19:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', 08:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:10 INFO - '_': '/tools/buildbot/bin/python'} 08:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:10 INFO - Downloading/unpacking jsonschema 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:19:12 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 08:19:12 INFO - Downloading/unpacking functools32 (from jsonschema) 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:12 INFO - Downloading functools32-3.2.3-2.tar.gz 08:19:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:19:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:19:12 INFO - warning: no files found matching '*.txt' 08:19:12 INFO - no previously-included directories found matching 'build' 08:19:12 INFO - no previously-included directories found matching 'dist' 08:19:12 INFO - no previously-included directories found matching '.git*' 08:19:12 INFO - Installing collected packages: jsonschema, functools32 08:19:12 INFO - Running setup.py install for functools32 08:19:12 INFO - warning: no files found matching '*.txt' 08:19:12 INFO - no previously-included directories found matching 'build' 08:19:12 INFO - no previously-included directories found matching 'dist' 08:19:12 INFO - no previously-included directories found matching '.git*' 08:19:12 INFO - Successfully installed jsonschema functools32 08:19:12 INFO - Cleaning up... 08:19:12 INFO - Return code: 0 08:19:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58ccfd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2a840>, '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 0xd976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97b60>, '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': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', '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 08:19:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:19:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:19:12 INFO - Using env: {'DISPLAY': ':0', 08:19:12 INFO - 'HOME': '/home/cltbld', 08:19:12 INFO - 'LANG': 'en_US.UTF-8', 08:19:12 INFO - 'LANGUAGE': 'en_US:en', 08:19:12 INFO - 'LOGNAME': 'cltbld', 08:19:12 INFO - 'MAIL': '/var/mail/cltbld', 08:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:12 INFO - 'MOZ_NO_REMOTE': '1', 08:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:12 INFO - 'NO_EM_RESTART': '1', 08:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:12 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:12 INFO - 'SHELL': '/bin/bash', 08:19:12 INFO - 'SHLVL': '1', 08:19:12 INFO - 'TERM': 'linux', 08:19:12 INFO - 'TMOUT': '86400', 08:19:12 INFO - 'USER': 'cltbld', 08:19:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', 08:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:12 INFO - '_': '/tools/buildbot/bin/python'} 08:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:13 INFO - Downloading/unpacking flake8 08:19:13 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 08:19:13 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 08:19:13 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 08:19:13 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 08:19:13 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 08:19:13 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 08:19:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:19:14 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 08:19:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:19:14 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 08:19:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:15 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 08:19:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:19:15 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 08:19:15 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 08:19:15 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 08:19:15 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 08:19:15 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 08:19:15 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 08:19:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:19:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:19:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:15 INFO - no previously-included directories found matching 'docs/_build' 08:19:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:19:15 INFO - Running setup.py install for pep8 08:19:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:15 INFO - no previously-included directories found matching 'docs/_build' 08:19:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:19:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:19:15 INFO - Cleaning up... 08:19:15 INFO - Return code: 0 08:19:15 INFO - Running post-action listener: _resource_record_post_action 08:19:15 INFO - Running post-action listener: _start_resource_monitoring 08:19:15 INFO - Starting resource monitoring. 08:19:15 INFO - ##### 08:19:15 INFO - ##### Running install step. 08:19:15 INFO - ##### 08:19:15 INFO - Running pre-action listener: _resource_record_pre_action 08:19:15 INFO - Running main action method: install 08:19:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:19:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:19:15 INFO - Reading from file tmpfile_stdout 08:19:15 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:19:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:19:15 INFO - Reading from file tmpfile_stdout 08:19:15 INFO - Output received: 08:19:15 INFO - Usage: mozinstall [options] installer 08:19:15 INFO - Options: 08:19:15 INFO - -h, --help show this help message and exit 08:19:15 INFO - -d DEST, --destination=DEST 08:19:15 INFO - Directory to install application into. [default: 08:19:15 INFO - "/builds/slave/test-pgo"] 08:19:15 INFO - --app=APP Application being installed. [default: firefox] 08:19:15 INFO - mkdir: /builds/slave/test-pgo/build/application 08:19:15 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'] 08:19:15 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 08:19:32 INFO - Reading from file tmpfile_stdout 08:19:32 INFO - Output received: 08:19:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:19:32 INFO - Running post-action listener: _resource_record_post_action 08:19:32 INFO - ##### 08:19:32 INFO - ##### Running run-tests step. 08:19:32 INFO - ##### 08:19:32 INFO - Running pre-action listener: _resource_record_pre_action 08:19:32 INFO - Running main action method: run_tests 08:19:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:19:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:19:32 INFO - Python 2.7.3 08:19:32 INFO - Return code: 0 08:19:32 INFO - grabbing minidump binary from tooltool 08:19: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')]} 08:19:32 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 0xe2a840>, '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 0xd976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:19:32 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 08:19:32 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 08:19:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:19:32 INFO - Return code: 0 08:19:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:19:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:19:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:19:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:19:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:19:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:19:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:19:33 INFO - Return code: 0 08:19:33 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/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 08:19:33 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/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 08:19:33 INFO - Using env: {'DISPLAY': ':0', 08:19:33 INFO - 'HOME': '/home/cltbld', 08:19:33 INFO - 'LANG': 'en_US.UTF-8', 08:19:33 INFO - 'LANGUAGE': 'en_US:en', 08:19:33 INFO - 'LOGNAME': 'cltbld', 08:19:33 INFO - 'MAIL': '/var/mail/cltbld', 08:19:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:19:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:33 INFO - 'MOZ_NO_REMOTE': '1', 08:19:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:33 INFO - 'NO_EM_RESTART': '1', 08:19:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:33 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:19:33 INFO - 'SHELL': '/bin/bash', 08:19:33 INFO - 'SHLVL': '1', 08:19:33 INFO - 'TERM': 'linux', 08:19:33 INFO - 'TMOUT': '86400', 08:19:33 INFO - 'USER': 'cltbld', 08:19:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467', 08:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:33 INFO - '_': '/tools/buildbot/bin/python'} 08:19:33 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/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 08:19:33 INFO - mozversion application_buildid: 20160107053022 08:19:33 INFO - mozversion application_changeset: e2f7ab5a03709a2a1a5eeba4e02b5961b530be4c 08:19:33 INFO - mozversion application_display_name: Nightly 08:19:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:19:33 INFO - mozversion application_name: Firefox 08:19:33 INFO - mozversion application_remotingname: firefox 08:19:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:19:33 INFO - mozversion application_vendor: Mozilla 08:19:33 INFO - mozversion application_version: 46.0a1 08:19:33 INFO - mozversion platform_buildid: 20160107053022 08:19:33 INFO - mozversion platform_changeset: e2f7ab5a03709a2a1a5eeba4e02b5961b530be4c 08:19:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:19:33 INFO - mozversion platform_version: 46.0a1 08:19:33 INFO - using testdate: 1452183573 08:19:33 INFO - actual date: 1452183573 08:19:33 INFO - starting webserver on 'localhost:51111' 08:19:33 INFO - SUITE-START | Running 3 tests 08:19:33 INFO - TEST-START | dromaeo_css 08:19:33 INFO - operating with platform_type : linux_ 08:19:33 INFO - Initialising browser for dromaeo_css test... 08:19:33 INFO - TEST-INFO | started process 17994 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVPnmE7/profile http://localhost:51111/getInfo.html) 08:19:37 INFO - PROCESS | 17994 | __metrics Screen width/height:1600/1200 08:19:37 INFO - PROCESS | 17994 | colorDepth:24 08:19:37 INFO - PROCESS | 17994 | Browser inner width/height: 1024/697 08:19:37 INFO - PROCESS | 17994 | __metrics 08:19:37 INFO - PROCESS | 17994 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:19:37 INFO - PROCESS | 17994 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:38 INFO - TEST-INFO | 17994: exit 0 08:19:38 INFO - Browser initialized. 08:19:38 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:38 INFO - TEST-INFO | started process 18087 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVPnmE7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:50 INFO - PROCESS | 18087 | RSS: Main: 150302720 08:19:50 INFO - PROCESS | 18087 | 08:20:42 INFO - PROCESS | 18087 | 1452183642012 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] 08:22:50 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:51111/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51111/tests/dromaeo/cssquery-ext.html) 08:22:51 INFO - PROCESS | 18087 | RSS: Main: 266469376 08:22:51 INFO - PROCESS | 18087 | 08:25:54 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:51111/tests/dromaeo/cssquery-ext.html (next: http://localhost:51111/tests/dromaeo/cssquery-jquery.html) 08:25:54 INFO - PROCESS | 18087 | RSS: Main: 237805568 08:25:54 INFO - PROCESS | 18087 | 08:28:56 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:51111/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51111/tests/dromaeo/cssquery-mootools.html) 08:28:57 INFO - PROCESS | 18087 | RSS: Main: 239689728 08:28:57 INFO - PROCESS | 18087 | 08:31:59 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:51111/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51111/tests/dromaeo/cssquery-prototype.html) 08:31:59 INFO - PROCESS | 18087 | RSS: Main: 217776128 08:31:59 INFO - PROCESS | 18087 | 08:35:02 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:51111/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51111/tests/dromaeo/cssquery-yui.html) 08:35:02 INFO - PROCESS | 18087 | RSS: Main: 218038272 08:35:02 INFO - PROCESS | 18087 | 08:38:05 INFO - PROCESS | 18087 | Cycle 1(1): loaded http://localhost:51111/tests/dromaeo/cssquery-yui.html (next: http://localhost:51111/tests/dromaeo/cssquery-dojo.html) 08:38:06 INFO - PROCESS | 18087 | RSS: Main: 249212928 08:38:06 INFO - PROCESS | 18087 | 08:38:06 INFO - PROCESS | 18087 | __start_tp_report 08:38:06 INFO - PROCESS | 18087 | _x_x_mozilla_page_load 08:38:06 INFO - PROCESS | 18087 | _x_x_mozilla_page_load_details 08:38:06 INFO - PROCESS | 18087 | |i|pagename|runs| 08:38:06 INFO - PROCESS | 18087 | |0;dojo.html;3120.1731541141594;3150.054983504951;3195.4727469967456;3199.7120259176654;3227.0802821195957;5014.373203349582;5070.594352451795;5134.845954621363;5157.071727089118;5190.71451070191;5146.871328216787;5216.921746173811;5254.6847189168675;5256.763445644946;5260.894782104356;4674.953250467486;4689.953100468994;4705.482396936334;4746.193147164973;4752.90494190116;4667.649926255527;4763.118823017736;4792.6405519586;4801.615870730333;4862.2220444728855;4697.812087516478;4709.222978208609;4795.328653988445;4800.879978000543;4815.855524334275;4761.285807128924;4789.353437285991;4792.880177995543;4796.25658023007;4836.10532051568;4667.906641867177;4749.762511874427;4770.928436073462;4785;4837.879053023703;5010.073136469765;5029.522195391469;5105.259737338102;5106.693598384109;5145.897082058375;5580.693061881595;5582.413846546095;5591.440855914417;5591.916121258185;5593.161025846115;5398.676079435247;5614.522765564891;5614.803481878155;5620.634658747168;5627;5166.044281807877;5172.767225474862;5194.844154675366;5200.6619569727845;5281.023010743025;5660.264165658438;5684.658920464785;5688.402717714663;5691.288588926384;5722.54219662426;5364.356277246756;5453.345598528202;5455.972720136374;5456.699881506555;5479.397266300703;5440.156775699773;5492.395836457987;5496.258005169251;5528.585356098309;5632.352279487911;5555.2222688822785;5594.916076258859;5600.271964644651;5627.493525582717;5645.858853528613;5546.278983732089;5548.944510554924;5549.694766787785;5560.4161563036105;5566.554675626021;4255.446791917031;4326.437563116775;4337.566243375701;4342.109867477159;4365.869023929287;3849.9807500962875;3864.806759662006;3878.5151856017997;3893.591172926802;3924.3132451820816;5076.82231121909;5097.745112744348;5101.20931255656;5101.948980510221;5147.948520514747;5434.427285064708;5454.181872719045;5493.670379777226;5555.111182210908;5555.611107222537;5095.388553373545;5142.640015198975;5172.870678233075;5204.0372531081875;5220.243064755589;4735.479097299294;4740.881477963009;4742.928856067162;4745.857624271277;4791.257355109963;5528.032594295983;5644.717764111861;5740.655560666373;5750.424957504216;5752.424757524298;5444.918326225189;5489;5577.330720313588;5583.609147359646;5609.1305847593685;5745.597808153389;5760.33756118035;5765.279340082489;5770.942290577208;5781.075027995501;5343.572514198777;5425.674459532441;5578.330600327824;5584.553235741049;5595.748191331319;5504.422035686195;5527.834164975057;5588.888222235451;5590.049691552527;5638.182463542681;5383.838484845461;5406.891862162814;5456.290682211287;5458.181272809111;5461.453854614507;5348.064088784369;5436.374816896107;5446.727663616883;5453.345598528202;5461.972690136524;5312.681239125664;5364.785408583769;5367.543758780391;5371.4897084776885;5416.674999500043;5465.59008074388;5502.862428439161;5508.091164957737;5511.338639363302;5569.248151499496;5203.843884683465;5309.787608495617;5319.627626066138;5390.62265641417;5393.892122157614 08:38:06 INFO - PROCESS | 18087 | |1;ext.html;532.2468706779906;539.3473896585134;542.2462776740332;548.0956421903859;561.4021067563048;28116.85941570292;28809.711902880965;38446.23107537848;39634.40548391776;39699.80150099253;42260;42748;43014.35478467825;43037.569624303746;43087;8548.529830859316;8728.127187281285;8730.476171429735;8734.432261902955;8736.51949142797;8485.575721213945;8603.655853765842;8629.05080441151;8630.697925572606;8630.741077767678;8561.657533698675;8703.17319854616;8710.433821801562;8723.694670686527;8732.781680458007;8545.31637469001;8552.358573107042;8592.312614990786;8607.827843443096;8625.094365091669;8432.241098301121;8556.144385561456;8583.141685831368;8586.398952073358;8594.570271486464;39492.210155796725;39558;39964.60035399638;40067.19865602672;40090.398644020366;3423.7089847363004;3469.705075068597;3493.7205023598053;3742.3450896093345;4152.792360381999;29577.120019982514;30450.019635232034;30549;30582.388352233054;30704.078877633707;3399.1502124468884;3445.707114895237;3452.205992621686;3460.1349662584353;3593.586737525166;244321;246505.7674711633;246661;246701;247324;56714.432855670915;56826.7158664204;56947;57050.714746426835;57083;55458.445415546135;56421.71789141028;62368.68815655893;64308.67845660835;64410.355896441375;13963.860361396459;14501.492447764278;14621.92689036548;14655.193964331851;14800.407983680747;9944.403335799876;10176.847347289797;10495.947520262349;10515.211359147941;10576.36541807494;19921.501962450766;20795.37613871556;20819;20856.79143208579;20869.37391878246;7345.3021962913435;7396.741114060982;7503.598848368579;7538.962305188439;7557.6221188940335;845.5138295480124;926.9536523173814;933.9626414943463;947.2469386837481;990.7275499237767;26977.19068427911;27898.860505697747;27913.109861891746;28142.43715125727;28779.28051798722;1041.4740556019312;1047.701405099543;1078.5308390850005;1090.095220966596;1108.9168312376444;13494.122882012638;15153.621159471102;15276.541703748906;15302.770458443132;15374.231288435534;375307.1234643864;382267;382999;385144;385325;53558.464415356124;54090.5909409056;54246.45753542493;54316;54343.18485222725;1284.2872205925614;1286.5497076023505;1319.3205499167937;1357.3213393303545;1377.455904917572;28956.42087158287;30243.395132097674;31671.52492712565;32168;32962.931546356696;39655.60344396519;40339.193216134925;48561;49378;49472.75263623659;239556;244732;245479;245700;247843;42208.57791422169;42765.35851962161;43134;43289;43940.560594393646;42752.5724742761;43121;43134.56865431431;43410.78294608507;43458.56541434672;36179.095522612144;36685.81657091698;37121.25757484889;38843.80578097091;40402.59597404106;35452.64547354494;37221;37222.813885930394;37226.6277337234;39253.41119883261;35908.64091359053;36311.45532816957;36434;37071.258574827814;37074.07314817151;31412.842935786088;32884.177895552806;33735.15662108467;33822.83088584541;35127.82436087803;24731.876340618903;24925.87537062303;25046.49907001886;25149.371265718502;25296.494070118864 08:38:06 INFO - PROCESS | 18087 | |2;jquery.html;353.0608581174074;354.1094148217234;355.2876482652282;357.90336609115536;359.7697473616886;13748.58754237372;13787.999205245376;16581.17094145294;17392.56518587036;18531.16609752561;15164.84835151648;16103.436379726712;16115.83884161158;16227.918860405682;17431.651366972652;5264.578833693305;5381.730913454331;5388.299521062276;5390.056740070472;5394.05604019297;4020.115574573589;4119.032027473556;5359.517643412092;5396.055690254209;5702.429757024306;5815.069588865782;5823.767049318022;5855.326637436707;5861.296644402656;5864.501517371007;5659.4340565943485;5796.07262837946;5813.767449302023;5817.941820581782;5834.708264586754;5115.769790359443;5129.563987061104;5171;5173.793048278064;5179.067767801795;19469.707954380694;20211.797882021285;20609;21131.78868211329;21383.465413364636;2230.520438105799;2288.1533832482087;2382.24959137871;2566.781823545001;2600.9739902600923;12771.93614031924;12954.417051232716;13012.739745205043;13155.144915580553;13266.53567125146;1819.9818001819945;1834.2937968881943;1836.2471386731509;1883.6896397069843;1939.3890924358782;57242;59960.700196498736;60329.396706032814;63491.682541587;63497;9923.156531694887;10054.447005414773;10064.043915827984;10397.636082737068;10477;13594.184348939096;13607.795883061763;13614.18314901109;13627.454901804014;13637.113587616774;7382.520136191238;7496.58768767723;7535;7556.962215188889;7644.197359277307;6868.62222577753;6879.449644028466;7016.333448322402;7127.2160062393095;7164.319389657974;4340.30555111187;4403.229434848889;4411.117776444724;4475.977620111878;4511.481179664315;1721.5007647782254;1759.7184450488116;1759.9560010999828;1772.6011647379237;1836.3480964257496;886.2378354615026;895.8253140637513;918.5223683684446;978.3396207559869;1029.2846471702244;12416.75166496665;13974.021818472813;16136.919315403582;17105.657886842193;17131.314747409964;843.6709683223547;879.7492714576315;924.1682485762867;942.8632848236967;1012.6455740490917;9306.674266400643;9498.145166934872;9676.516174191403;9717.31978761494;9815.558299876522;399824;402702;402941;403904;407113;79243;80674;81885.59057204676;82374;83267;1095.1129585035987;1137.5847815547431;1147.0937959012454;1149.2759561476216;1149.4080548517352;14737.705245894807;14857.257137142884;14902.77645835335;15212.619684507534;15506.689866202838;32407.675923241408;32526.674733252363;32803.507947380334;33258;33272.66727332793;39070.804645977725;40247.19505609813;40700.796496017334;40753.1849363017;43522;8427.452215605967;9408.247340212904;9609.711708648752;9692.660756873476;9752.9024709752;16845.91577042107;17338.91330543339;17388.47834564965;17742.556436089202;17750.644987100444;13804.309784510935;13978.161310321413;14051.086679365808;14145;14779.92610036943;14082.929585352007;14221.644458888197;14442.350094245574;14505.347259373564;15249.23753812327;13057.934710326388;13088.476460941456;13997.930010349883;14240.430382784572;14494.927525362305;9512.85730714026;9623.326367154232;9694.224462043161;9701.563429645825;9715.562799674173;13335.933320333335;13579.253141077335;13745.862541374458;14770.48303309379;15096.622584435478 08:38:06 INFO - PROCESS | 18087 | |3;mootools.html;1292.5476083370827;1445.6964037552116;1452.230317931496;1593.4502596604168;1784.4914199453167;6754.425873800727;7285.41716662667;7315.926840731591;7335.889961650566;7340.926590734091;7234.674439650228;7398.704051837934;7415.332620064193;7418.109826820789;7419.369353604937;1981.28673677476;2011.6278488479677;2159.3090211132444;2191.5945550073207;2204.1073365287084;2189.4745261137373;2197.2090047582856;2197.439652888519;2197.9340619781433;2199.9010044547954;2121.543868068365;2222.9777702223014;2223.6998005269324;2224.810891074261;2226.3209721035078;2197.8901054947187;2221.4557433428754;2224.4327696437304;2226.0984301357976;2253.763354847742;2194.594000109985;2206.5035367042447;2222.388843068169;2225.00987060758;2249.910003599854;7511.173770885198;7587.658555364967;7588.2791134842655;7590.468667193299;7591.3926885849;4432.290833466662;4510.729356238636;4540.137373898981;4544.977275113636;4545.250033744428;2845.573164025392;2939.7942144049925;2947.1158652404406;2953.4831404504125;2972.929745291715;925.9444433333954;936.1434287626813;951.5813042261452;962.6678795815433;965.7826988927505;10599.788004239948;10600.734981625445;10613.310134841287;10614.363138211733;10627.893721062768;4107.958920410817;4110.23960567296;4188.748675079505;4194.3289073748665;4201.243776120266;9040;9053.049429809907;9067.229285510806;9071.501067441222;9081.137291957386;4590.288505281686;4593.793279302439;4613.446386433649;4629.953700462952;4637.7449240291435;4213.389058586487;4216.746995180299;4219.029623186684;4219.6202341789385;4221.472315960505;3313.122022663996;3358.8488518016748;3483.773554718935;3561.893143205708;3606.891793246207;1125.671707385277;1150.2983180260035;1153.988460115405;1162.5001249462812;1169.9941500292443;1033.3541536539663;1041.2971244409994;1081.9721264798472;1169.8771628979005;1293.4050336844969;6857.211420686585;6865.691043903036;6946.756863509854;6947.895781563179;6952.652367381611;1087.4019289390803;1093.8523299354645;1108.1024370260116;1110.5335758981087;1116.6705821782593;5524.723763811793;5672.347680016851;5697.088465845445;5699.116636921284;5700.401457846866;8810.118988101138;9088.772780680536;9126.17864392208;9166.81666366669;9345.252379809599;9182.265418766483;9201.217896478875;9204.217641500414;9211.032841551674;9212.35513514061;7023.122109736283;7047.224805271416;7173.103362079844;7185.389241914496;7259.6007219603425;6883.27725588806;6884.173899132136;6884.449244060363;6903.689333979883;6919.342662447059;7924.20757924203;8004.679812807422;8182.590870456573;8189.918100819154;8199.754007379788;8114.959425202836;8281.83436331282;8292.17078292166;8474.1949514796;8485.872711909204;6758.256591774999;6822.795316140524;6850.623215723183;6913.481488888253;6919.827004324731;6388.584741991755;6487.286398496068;7221.819454513679;7395.741149059757;7396.112466504054;6866.450683945172;6873.5875847449315;6978.8833786593905;7088.822779430556;7093.255208203064;6522.34776522363;6556.967215163893;6615.470762339098;6642.667866606554;6735.49483788708;6837.179538455417;6876.724931002704;6883.27725588826;6891.552049116792;6892.104026476526;6102.7253773579405;6148.600340977822;6174.289956655042;6188.721507532262;6196.318404975539;6140.416660417253;6178.382161783786;6183.443490085914;6184.752609895734;6190.597611155261 08:38:06 INFO - PROCESS | 18087 | |4;prototype.html;313.9497680371141;319.431412086486;333.11723931581304;337.44321868916285;341.5713279833809;5775.56683248756;5780.017397042502;5784.392638772932;5801.622894511859;5854.619449735775;5714.914276285848;5719.571032172583;5723.399043100477;5745.339285982102;5750.827475175741;4478.731276123435;4481.305397663367;4483.551644835523;4484.260097083978;4484.618807401359;4390.67069969752;4402.537733537981;4443.977780111111;4456.06422651242;4488.798004089824;4393.187260356828;4397.714148580348;4399.846005389812;4419.138268037734;4420.359047938047;4258.148370325947;4394.912101757979;4400.295952647577;4403.911921761579;4415.735055896656;3859.07382228266;3860.517435320585;3924.4701965234613;3939.4090886367276;3955.6835453163676;5460.699661518614;5506.669599823983;5508.531774799147;5509.531689806371;5571.275734154575;4939.851804445872;5027.824026159067;5071.695698258116;5165.896682066337;5181.404138524081;6002.729877155539;6057.939420605826;6063.242094738158;6082.60463069899;6091.573589848713;4355.956440435587;4357;4357.651387888961;4358.171947329997;4360.367746676746;6221.191245138149;6382.329855365167;6386.457151142158;6387.2654644715985;6393.648349340784;4479.238529450001;4486.013077123028;4486.237339652267;4487.035287413222;4496.213162696515;4521.095780843779;4544.159330523864;4548.840790572381;4549;4552.044070745114;5129.153689641242;5137.101007323703;5139.640225184201;5140;5183.481651834786;6005.39946005396;6142.815715528452;6150.231221097363;6151.9384806151365;6168.568200225941;1600.927958241882;1618.8704903607918;1619.9389399943057;1621.1813034417544;1623.5291765387906;1103.5034234594464;1117.3184357541893;1118.2395970739974;1122.528538014036;1140.190464770006;5783.94216057834;5812.331581868139;5813.447722466359;5813.79651712188;5818.185454036438;6306.085617585424;6307.369263073656;6308.495320374359;6312.715927783261;6319.778807741707;5813.215215945793;5813.59304848665;5818.33089194748;5826.096954971986;5827.7668893244645;3304.9173770655925;3410.505476705913;3411.710004649583;3415.55597772293;3421.349943510725;6530.249021362509;6533.738650454024;6538.084668146464;6543.149390579194;6547;6239.064140378889;6418.711157997901;6433.839154021093;6434.163558737334;6438.774642887476;6483.3516648335735;6484.092227088211;6631.370019848203;6635.303293154246;6646.900296495556;6336.619802811846;6377.043443483514;6399.744010239725;6424.646644434414;6425.293217745951;6070.3019152798;6279.748810047547;6287.182666253358;6294.779682711083;6303.275123360872;6631.734730610914;6631.933680663132;6634.369734875179;6635.469162466895;6638.800835974928;4412.514623391488;4453.220686379936;4455.26488129455;4463.866084017484;4463.888402789957;6407.391297826699;6409.3270206629495;6414.61512309263;6419.261784894797;6421.71102300407;6007.90988135187;6180.752769889334;6222.066689996536;6235.688215589112;6245.750169993149;6204.945159322836;6224.315325314303;6276.309605943251;6279.654618995816;6288.905666415099;6121.938780612315;6127.571070025056;6130.049842274455;6131.877362452815;6134.171886795226;6089.725962331794;6273.65494897785;6281.403266689657;6281.874362512815;6285.49716022708;6107.450329470369;6107.847303817262;6111.877762444815;6121.84695382619;6128.754849805958 08:38:06 INFO - PROCESS | 18087 | |5;yui.html;778.544551437409;830.3523251863545;853.7140058080547;856.6915910272301;892.3931726426027;13385.464581416743;13627.863721362783;13691.383887725051;13701.794473082888;13702.931485342584;12472.625821225378;12568.685782855433;12584.874151258484;12605.36973151341;13312;801.2748462641305;808.3250485844327;808.7048227396987;809.7813590330608;810.1250649298772;808.6482380164647;808.8665370213907;810.7203014959858;810.8621534339147;811.5536454949784;847.2628812932758;847.5338563789921;848.0544193224541;848.245061894914;848.4357901995165;837.8408102460513;843.1315744782853;843.2284459719349;844.877492763549;845.9703910363138;618.2519151826295;618.761776715963;619.0064945762077;621.5773274173561;624.6470744029654;12681.365931703378;12853.742925141538;12856.292903890282;12875.227486350848;12940.870591294155;10943.45282735868;11295.887041129567;11365.147613928906;11398.373089480076;11538.250013749079;10057.89942100577;10149.086582207638;10171.338862973884;10359.585616575403;11035.117190624731;3634.6915110560176;3704.666580007812;3719.702423806089;3744.588095309514;3815.332316844569;43905.56094439047;44579.55420445786;46356;47258;49019.01961960777;9816.361936474106;9953.751156221153;9985.101340879355;10000.399976001463;10028.197744180448;17369.65260694779;17370.3051877926;17397.47807565775;17407.3037078518;17419.73870391945;7721.729739459092;7777.766666999999;7843;7938.04743430792;8068.7175948841505;4387.627051700578;4405.557597004682;4443.466783985878;4507.414036175276;4534.59188673021;2915.5918171456015;2920.196945839911;2923.4883895318235;2924.1227631710403;2928.443595716807;530.7452422836983;546.0880329849082;549.2996429552353;550.6668465578267;553.3553410277062;533.871870751017;592.502298069615;599.0235915457775;601.7502736364447;614.1524695919692;8118.261842670569;8232.17678232172;8236.752897413087;8496.49021058726;8643.308535317285;567.1606023085856;604.8826924221052;624.950003999679;667.6361383046251;685.2428066986008;3710.7216958728204;4071.3485842265095;4098.631123198927;4118.258713431611;4173.520045194841;50019.24971125436;50800.491995080316;51035.23447148296;51723.48276517262;51756.48243517517;47096.406503089594;48051;48078;48935.5106448931;49122.75438622855;40177.99555011148;42283.36574951378;45044.77477612591;48379;48643.5135648639;8942.68700595476;9034.909650903406;9126.361154719372;9162.26701863836;9196.908030919873;33715.494267586495;33834;34428.82785586056;34464.48303275503;35734.28531429409;37495.81252093722;39864.402033970095;41457.79271103625;42749;44956.77521612371;11171;11317.830232546354;11431.199816013132;11619.477123529292;11660.825087623523;11383.260088094248;11979.28124312544;12238.632841014427;12968.416421261254;13032.674183145496;11843.644690659294;12173.391330433265;12223.205491643015;12506.312152831682;12628.242305461701;11308.7738245233;11321.264117832314;11850.466728997388;11919.582814601446;12248.75502489963;11071.446427678422;11136.777264454504;11379.374134422686;11442.141839361915;11625.302481851117;10128.251525682506;10266.632694354077;10373.17014638812;10536.683899483029;10610.946945265225;9073.637054517745;9769.413835169913;10008.723062587906;10027.29808913369;10091.243156763125 08:38:06 INFO - PROCESS | 18087 | __end_tp_report 08:38:06 INFO - PROCESS | 18087 | __start_cc_report 08:38:06 INFO - PROCESS | 18087 | _x_x_mozilla_cycle_collect,911 08:38:06 INFO - PROCESS | 18087 | __end_cc_report 08:38:06 INFO - PROCESS | 18087 | __startTimestamp1452184686003__endTimestamp 08:38:06 INFO - PROCESS | 18087 | 08:38:06 INFO - PROCESS | 18087 | ------- Summary: start ------- 08:38:06 INFO - PROCESS | 18087 | Number of tests: 6 08:38:06 INFO - PROCESS | 18087 | 08:38:06 INFO - PROCESS | 18087 | [#0] dojo.html Cycles:165 Average:5164.97 Median:5364.79 stddev:553.15 (10.3%) stddev-sans-first:531.08 08:38:06 INFO - PROCESS | 18087 | Values: 3120.2 3150.1 3195.5 3199.7 3227.1 5014.4 5070.6 5134.8 5157.1 5190.7 5146.9 5216.9 5254.7 5256.8 5260.9 4675.0 4690.0 4705.5 4746.2 4752.9 4667.6 4763.1 4792.6 4801.6 4862.2 4697.8 4709.2 4795.3 4800.9 4815.9 4761.3 4789.4 4792.9 4796.3 4836.1 4667.9 4749.8 4770.9 4785.0 4837.9 5010.1 5029.5 5105.3 5106.7 5145.9 5580.7 5582.4 5591.4 5591.9 5593.2 5398.7 5614.5 5614.8 5620.6 5627.0 5166.0 5172.8 5194.8 5200.7 5281.0 5660.3 5684.7 5688.4 5691.3 5722.5 5364.4 5453.3 5456.0 5456.7 5479.4 5440.2 5492.4 5496.3 5528.6 5632.4 5555.2 5594.9 5600.3 5627.5 5645.9 5546.3 5548.9 5549.7 5560.4 5566.6 4255.4 4326.4 4337.6 4342.1 4365.9 3850.0 3864.8 3878.5 3893.6 3924.3 5076.8 5097.7 5101.2 5101.9 5147.9 5434.4 5454.2 5493.7 5555.1 5555.6 5095.4 5142.6 5172.9 5204.0 5220.2 4735.5 4740.9 4742.9 4745.9 4791.3 5528.0 5644.7 5740.7 5750.4 5752.4 5444.9 5489.0 5577.3 5583.6 5609.1 5745.6 5760.3 5765.3 5770.9 5781.1 5343.6 5425.7 5578.3 5584.6 5595.7 5504.4 5527.8 5588.9 5590.0 5638.2 5383.8 5406.9 5456.3 5458.2 5461.5 5348.1 5436.4 5446.7 5453.3 5462.0 5312.7 5364.8 5367.5 5371.5 5416.7 5465.6 5502.9 5508.1 5511.3 5569.2 5203.8 5309.8 5319.6 5390.6 5393.9 08:38:06 INFO - PROCESS | 18087 | 08:38:06 INFO - PROCESS | 18087 | [#1] ext.html Cycles:180 Average:46548.83 Median:211795.12 stddev:78207.65 (36.9%) stddev-sans-first:78350.72 08:38:06 INFO - PROCESS | 18087 | Values: 532.2 539.3 542.2 548.1 561.4 28116.9 28809.7 38446.2 39634.4 39699.8 42260.0 42748.0 43014.4 43037.6 43087.0 8548.5 8728.1 8730.5 8734.4 8736.5 8485.6 8603.7 8629.1 8630.7 8630.7 8561.7 8703.2 8710.4 8723.7 8732.8 8545.3 8552.4 8592.3 8607.8 8625.1 8432.2 8556.1 8583.1 8586.4 8594.6 39492.2 39558.0 39964.6 40067.2 40090.4 3423.7 3469.7 3493.7 3742.3 4152.8 29577.1 30450.0 30549.0 30582.4 30704.1 3399.2 3445.7 3452.2 3460.1 3593.6 244321.0 246505.8 246661.0 246701.0 247324.0 56714.4 56826.7 56947.0 57050.7 57083.0 55458.4 56421.7 62368.7 64308.7 64410.4 13963.9 14501.5 14621.9 14655.2 14800.4 9944.4 10176.8 10495.9 10515.2 10576.4 19921.5 20795.4 20819.0 20856.8 20869.4 7345.3 7396.7 7503.6 7539.0 7557.6 845.5 927.0 934.0 947.2 990.7 26977.2 27898.9 27913.1 28142.4 28779.3 1041.5 1047.7 1078.5 1090.1 1108.9 13494.1 15153.6 15276.5 15302.8 15374.2 375307.1 382267.0 382999.0 385144.0 385325.0 53558.5 54090.6 54246.5 54316.0 54343.2 1284.3 1286.5 1319.3 1357.3 1377.5 28956.4 30243.4 31671.5 32168.0 32962.9 39655.6 40339.2 48561.0 49378.0 49472.8 239556.0 244732.0 245479.0 245700.0 247843.0 42208.6 42765.4 43134.0 43289.0 43940.6 42752.6 43121.0 43134.6 43410.8 43458.6 36179.1 36685.8 37121.3 38843.8 40402.6 35452.6 37221.0 37222.8 37226.6 39253.4 35908.6 36311.5 36434.0 37071.3 37074.1 31412.8 32884.2 33735.2 33822.8 35127.8 24731.9 24925.9 25046.5 25149.4 25296.5 08:38:06 INFO - PROCESS | 18087 | 08:38:06 INFO - PROCESS | 18087 | [#2] jquery.html Cycles:180 Average:24928.17 Median:16812.86 stddev:66207.78 (393.8%) stddev-sans-first:66367.80 08:38:06 INFO - PROCESS | 18087 | Values: 353.1 354.1 355.3 357.9 359.8 13748.6 13788.0 16581.2 17392.6 18531.2 15164.8 16103.4 16115.8 16227.9 17431.7 5264.6 5381.7 5388.3 5390.1 5394.1 4020.1 4119.0 5359.5 5396.1 5702.4 5815.1 5823.8 5855.3 5861.3 5864.5 5659.4 5796.1 5813.8 5817.9 5834.7 5115.8 5129.6 5171.0 5173.8 5179.1 19469.7 20211.8 20609.0 21131.8 21383.5 2230.5 2288.2 2382.2 2566.8 2601.0 12771.9 12954.4 13012.7 13155.1 13266.5 1820.0 1834.3 1836.2 1883.7 1939.4 57242.0 59960.7 60329.4 63491.7 63497.0 9923.2 10054.4 10064.0 10397.6 10477.0 13594.2 13607.8 13614.2 13627.5 13637.1 7382.5 7496.6 7535.0 7557.0 7644.2 6868.6 6879.4 7016.3 7127.2 7164.3 4340.3 4403.2 4411.1 4476.0 4511.5 1721.5 1759.7 1760.0 1772.6 1836.3 886.2 895.8 918.5 978.3 1029.3 12416.8 13974.0 16136.9 17105.7 17131.3 843.7 879.7 924.2 942.9 1012.6 9306.7 9498.1 9676.5 9717.3 9815.6 399824.0 402702.0 402941.0 403904.0 407113.0 79243.0 80674.0 81885.6 82374.0 83267.0 1095.1 1137.6 1147.1 1149.3 1149.4 14737.7 14857.3 14902.8 15212.6 15506.7 32407.7 32526.7 32803.5 33258.0 33272.7 39070.8 40247.2 40700.8 40753.2 43522.0 8427.5 9408.2 9609.7 9692.7 9752.9 16845.9 17338.9 17388.5 17742.6 17750.6 13804.3 13978.2 14051.1 14145.0 14779.9 14082.9 14221.6 14442.4 14505.3 15249.2 13057.9 13088.5 13997.9 14240.4 14494.9 9512.9 9623.3 9694.2 9701.6 9715.6 13335.9 13579.3 13745.9 14770.5 15096.6 08:38:06 INFO - PROCESS | 18087 | 08:38:06 INFO - PROCESS | 18087 | [#3] mootools.html Cycles:180 Average:5292.09 Median:6184.10 stddev:2753.77 (44.5%) stddev-sans-first:2745.08 08:38:06 INFO - PROCESS | 18087 | Values: 1292.5 1445.7 1452.2 1593.5 1784.5 6754.4 7285.4 7315.9 7335.9 7340.9 7234.7 7398.7 7415.3 7418.1 7419.4 1981.3 2011.6 2159.3 2191.6 2204.1 2189.5 2197.2 2197.4 2197.9 2199.9 2121.5 2223.0 2223.7 2224.8 2226.3 2197.9 2221.5 2224.4 2226.1 2253.8 2194.6 2206.5 2222.4 2225.0 2249.9 7511.2 7587.7 7588.3 7590.5 7591.4 4432.3 4510.7 4540.1 4545.0 4545.3 2845.6 2939.8 2947.1 2953.5 2972.9 925.9 936.1 951.6 962.7 965.8 10599.8 10600.7 10613.3 10614.4 10627.9 4108.0 4110.2 4188.7 4194.3 4201.2 9040.0 9053.0 9067.2 9071.5 9081.1 4590.3 4593.8 4613.4 4630.0 4637.7 4213.4 4216.7 4219.0 4219.6 4221.5 3313.1 3358.8 3483.8 3561.9 3606.9 1125.7 1150.3 1154.0 1162.5 1170.0 1033.4 1041.3 1082.0 1169.9 1293.4 6857.2 6865.7 6946.8 6947.9 6952.7 1087.4 1093.9 1108.1 1110.5 1116.7 5524.7 5672.3 5697.1 5699.1 5700.4 8810.1 9088.8 9126.2 9166.8 9345.3 9182.3 9201.2 9204.2 9211.0 9212.4 7023.1 7047.2 7173.1 7185.4 7259.6 6883.3 6884.2 6884.4 6903.7 6919.3 7924.2 8004.7 8182.6 8189.9 8199.8 8115.0 8281.8 8292.2 8474.2 8485.9 6758.3 6822.8 6850.6 6913.5 6919.8 6388.6 6487.3 7221.8 7395.7 7396.1 6866.5 6873.6 6978.9 7088.8 7093.3 6522.3 6557.0 6615.5 6642.7 6735.5 6837.2 6876.7 6883.3 6891.6 6892.1 6102.7 6148.6 6174.3 6188.7 6196.3 6140.4 6178.4 6183.4 6184.8 6190.6 08:38:06 INFO - PROCESS | 18087 | 08:38:06 INFO - PROCESS | 18087 | [#4] prototype.html Cycles:180 Average:5160.05 Median:5812.77 stddev:1535.96 (26.4%) stddev-sans-first:1496.59 08:38:06 INFO - PROCESS | 18087 | Values: 313.9 319.4 333.1 337.4 341.6 5775.6 5780.0 5784.4 5801.6 5854.6 5714.9 5719.6 5723.4 5745.3 5750.8 4478.7 4481.3 4483.6 4484.3 4484.6 4390.7 4402.5 4444.0 4456.1 4488.8 4393.2 4397.7 4399.8 4419.1 4420.4 4258.1 4394.9 4400.3 4403.9 4415.7 3859.1 3860.5 3924.5 3939.4 3955.7 5460.7 5506.7 5508.5 5509.5 5571.3 4939.9 5027.8 5071.7 5165.9 5181.4 6002.7 6057.9 6063.2 6082.6 6091.6 4356.0 4357.0 4357.7 4358.2 4360.4 6221.2 6382.3 6386.5 6387.3 6393.6 4479.2 4486.0 4486.2 4487.0 4496.2 4521.1 4544.2 4548.8 4549.0 4552.0 5129.2 5137.1 5139.6 5140.0 5183.5 6005.4 6142.8 6150.2 6151.9 6168.6 1600.9 1618.9 1619.9 1621.2 1623.5 1103.5 1117.3 1118.2 1122.5 1140.2 5783.9 5812.3 5813.4 5813.8 5818.2 6306.1 6307.4 6308.5 6312.7 6319.8 5813.2 5813.6 5818.3 5826.1 5827.8 3304.9 3410.5 3411.7 3415.6 3421.3 6530.2 6533.7 6538.1 6543.1 6547.0 6239.1 6418.7 6433.8 6434.2 6438.8 6483.4 6484.1 6631.4 6635.3 6646.9 6336.6 6377.0 6399.7 6424.6 6425.3 6070.3 6279.7 6287.2 6294.8 6303.3 6631.7 6631.9 6634.4 6635.5 6638.8 4412.5 4453.2 4455.3 4463.9 4463.9 6407.4 6409.3 6414.6 6419.3 6421.7 6007.9 6180.8 6222.1 6235.7 6245.8 6204.9 6224.3 6276.3 6279.7 6288.9 6121.9 6127.6 6130.0 6131.9 6134.2 6089.7 6273.7 6281.4 6281.9 6285.5 6107.5 6107.8 6111.9 6121.8 6128.8 08:38:06 INFO - PROCESS | 18087 | 08:38:06 INFO - PROCESS | 18087 | [#5] yui.html Cycles:180 Average:13350.87 Median:23568.31 stddev:14871.62 (63.1%) stddev-sans-first:14883.37 08:38:06 INFO - PROCESS | 18087 | Values: 778.5 830.4 853.7 856.7 892.4 13385.5 13627.9 13691.4 13701.8 13702.9 12472.6 12568.7 12584.9 12605.4 13312.0 801.3 808.3 808.7 809.8 810.1 808.6 808.9 810.7 810.9 811.6 847.3 847.5 848.1 848.2 848.4 837.8 843.1 843.2 844.9 846.0 618.3 618.8 619.0 621.6 624.6 12681.4 12853.7 12856.3 12875.2 12940.9 10943.5 11295.9 11365.1 11398.4 11538.3 10057.9 10149.1 10171.3 10359.6 11035.1 3634.7 3704.7 3719.7 3744.6 3815.3 43905.6 44579.6 46356.0 47258.0 49019.0 9816.4 9953.8 9985.1 10000.4 10028.2 17369.7 17370.3 17397.5 17407.3 17419.7 7721.7 7777.8 7843.0 7938.0 8068.7 4387.6 4405.6 4443.5 4507.4 4534.6 2915.6 2920.2 2923.5 2924.1 2928.4 530.7 546.1 549.3 550.7 553.4 533.9 592.5 599.0 601.8 614.2 8118.3 8232.2 8236.8 8496.5 8643.3 567.2 604.9 625.0 667.6 685.2 3710.7 4071.3 4098.6 4118.3 4173.5 50019.2 50800.5 51035.2 51723.5 51756.5 47096.4 48051.0 48078.0 48935.5 49122.8 40178.0 42283.4 45044.8 48379.0 48643.5 8942.7 9034.9 9126.4 9162.3 9196.9 33715.5 33834.0 34428.8 34464.5 35734.3 37495.8 39864.4 41457.8 42749.0 44956.8 11171.0 11317.8 11431.2 11619.5 11660.8 11383.3 11979.3 12238.6 12968.4 13032.7 11843.6 12173.4 12223.2 12506.3 12628.2 11308.8 11321.3 11850.5 11919.6 12248.8 11071.4 11136.8 11379.4 11442.1 11625.3 10128.3 10266.6 10373.2 10536.7 10610.9 9073.6 9769.4 10008.7 10027.3 10091.2 08:38:06 INFO - PROCESS | 18087 | -------- Summary: end -------- 08:38:06 INFO - PROCESS | 18087 | 08:38:06 INFO - TEST-INFO | 18087: exit 0 08:38:06 INFO - TEST-OK | dromaeo_css | took 1113216ms 08:38:06 INFO - TEST-START | kraken 08:38:06 INFO - operating with platform_type : linux_ 08:38:06 INFO - Initialising browser for kraken test... 08:38:06 INFO - TEST-INFO | started process 18278 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqsIjMs/profile http://localhost:51111/getInfo.html) 08:38:10 INFO - PROCESS | 18278 | __metrics Screen width/height:1600/1200 08:38:10 INFO - PROCESS | 18278 | colorDepth:24 08:38:10 INFO - PROCESS | 18278 | Browser inner width/height: 1024/697 08:38:10 INFO - PROCESS | 18278 | __metrics 08:38:10 INFO - PROCESS | 18278 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:38:10 INFO - PROCESS | 18278 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:38:11 INFO - TEST-INFO | 18278: exit 0 08:38:11 INFO - Browser initialized. 08:38:11 INFO - Running cycle 1/1 for kraken test... 08:38:11 INFO - TEST-INFO | started process 18359 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqsIjMs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:23 INFO - PROCESS | 18359 | RSS: Main: 150294528 08:38:23 INFO - PROCESS | 18359 | 08:38:25 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51111/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:26 INFO - PROCESS | 18359 | RSS: Main: 187199488 08:38:26 INFO - PROCESS | 18359 | 08:38:29 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51111/tests/kraken/driver.html?testName=audio-dft) 08:38:29 INFO - PROCESS | 18359 | RSS: Main: 176668672 08:38:29 INFO - PROCESS | 18359 | 08:38:32 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51111/tests/kraken/driver.html?testName=audio-fft) 08:38:33 INFO - PROCESS | 18359 | RSS: Main: 161882112 08:38:33 INFO - PROCESS | 18359 | 08:38:35 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51111/tests/kraken/driver.html?testName=audio-oscillator) 08:38:35 INFO - PROCESS | 18359 | RSS: Main: 165019648 08:38:35 INFO - PROCESS | 18359 | 08:38:37 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51111/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:38 INFO - PROCESS | 18359 | RSS: Main: 166551552 08:38:38 INFO - PROCESS | 18359 | 08:38:41 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51111/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:41 INFO - PROCESS | 18359 | RSS: Main: 166502400 08:38:41 INFO - PROCESS | 18359 | 08:38:45 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51111/tests/kraken/driver.html?testName=imaging-desaturate) 08:38:45 INFO - PROCESS | 18359 | RSS: Main: 166858752 08:38:45 INFO - PROCESS | 18359 | 08:38:48 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51111/tests/kraken/driver.html?testName=json-parse-financial) 08:38:49 INFO - PROCESS | 18359 | RSS: Main: 165158912 08:38:49 INFO - PROCESS | 18359 | 08:38:50 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51111/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:38:51 INFO - PROCESS | 18359 | RSS: Main: 177520640 08:38:51 INFO - PROCESS | 18359 | 08:38:53 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51111/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:38:53 INFO - PROCESS | 18359 | RSS: Main: 175243264 08:38:53 INFO - PROCESS | 18359 | 08:38:55 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51111/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:38:56 INFO - PROCESS | 18359 | RSS: Main: 181002240 08:38:56 INFO - PROCESS | 18359 | 08:38:58 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:38:59 INFO - PROCESS | 18359 | RSS: Main: 188854272 08:38:59 INFO - PROCESS | 18359 | 08:39:01 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:02 INFO - PROCESS | 18359 | RSS: Main: 187195392 08:39:02 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | Cycle 1(1): loaded http://localhost:51111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51111/tests/kraken/driver.html?testName=ai-astar) 08:39:04 INFO - PROCESS | 18359 | RSS: Main: 246083584 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | __start_tp_report 08:39:04 INFO - PROCESS | 18359 | _x_x_mozilla_page_load 08:39:04 INFO - PROCESS | 18359 | _x_x_mozilla_page_load_details 08:39:04 INFO - PROCESS | 18359 | |i|pagename|runs| 08:39:04 INFO - PROCESS | 18359 | |0;ai-astar;108;110;105;110;110;110;99;110;109;109 08:39:04 INFO - PROCESS | 18359 | |1;audio-beat-detection;150;126;155;164;126;153;156;126;168;126 08:39:04 INFO - PROCESS | 18359 | |2;audio-dft;160;161;160;159;158;160;161;161;162;161 08:39:04 INFO - PROCESS | 18359 | |3;audio-fft;74;71;86;95;73;72;75;109;97;73 08:39:04 INFO - PROCESS | 18359 | |4;audio-oscillator;95;97;148;95;97;96;148;95;97;137 08:39:04 INFO - PROCESS | 18359 | |5;imaging-gaussian-blur;109;109;110;110;109;109;110;110;110;110 08:39:04 INFO - PROCESS | 18359 | |6;imaging-darkroom;146;145;145;145;145;145;145;147;145;145 08:39:04 INFO - PROCESS | 18359 | |7;imaging-desaturate;95;95;95;95;96;96;95;96;96;96 08:39:04 INFO - PROCESS | 18359 | |8;json-parse-financial;57;54;56;57;55;55;55;64;52;55 08:39:04 INFO - PROCESS | 18359 | |9;json-stringify-tinderbox;67;68;68;68;68;68;69;68;68;68 08:39:04 INFO - PROCESS | 18359 | |10;stanford-crypto-aes;91;84;88;84;83;84;85;85;84;84 08:39:04 INFO - PROCESS | 18359 | |11;stanford-crypto-ccm;127;122;127;114;124;119;125;121;122;116 08:39:04 INFO - PROCESS | 18359 | |12;stanford-crypto-pbkdf2;143;145;156;150;153;142;150;150;161;139 08:39:04 INFO - PROCESS | 18359 | |13;stanford-crypto-sha256-iterative;70;68;69;70;68;72;68;70;68;67 08:39:04 INFO - PROCESS | 18359 | __end_tp_report 08:39:04 INFO - PROCESS | 18359 | __start_cc_report 08:39:04 INFO - PROCESS | 18359 | _x_x_mozilla_cycle_collect,945 08:39:04 INFO - PROCESS | 18359 | __end_cc_report 08:39:04 INFO - PROCESS | 18359 | __startTimestamp1452184744451__endTimestamp 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | ------- Summary: start ------- 08:39:04 INFO - PROCESS | 18359 | Number of tests: 14 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.53 (3.2%) stddev-sans-first:3.74 08:39:04 INFO - PROCESS | 18359 | Values: 108.0 110.0 105.0 110.0 110.0 110.0 99.0 110.0 109.0 109.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:154.00 stddev:17.14 (11.1%) stddev-sans-first:18.08 08:39:04 INFO - PROCESS | 18359 | Values: 150.0 126.0 155.0 164.0 126.0 153.0 156.0 126.0 168.0 126.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 08:39:04 INFO - PROCESS | 18359 | Values: 160.0 161.0 160.0 159.0 158.0 160.0 161.0 161.0 162.0 161.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#3] audio-fft Cycles:10 Average:82.50 Median:74.50 stddev:13.47 (18.1%) stddev-sans-first:13.93 08:39:04 INFO - PROCESS | 18359 | Values: 74.0 71.0 86.0 95.0 73.0 72.0 75.0 109.0 97.0 73.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:95.50 stddev:23.55 (24.7%) stddev-sans-first:24.30 08:39:04 INFO - PROCESS | 18359 | Values: 95.0 97.0 148.0 95.0 97.0 96.0 148.0 95.0 97.0 137.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:39:04 INFO - PROCESS | 18359 | Values: 109.0 109.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 110.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 08:39:04 INFO - PROCESS | 18359 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 147.0 145.0 145.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:39:04 INFO - PROCESS | 18359 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.50 stddev:3.16 (5.7%) stddev-sans-first:3.33 08:39:04 INFO - PROCESS | 18359 | Values: 57.0 54.0 56.0 57.0 55.0 55.0 55.0 64.0 52.0 55.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 08:39:04 INFO - PROCESS | 18359 | Values: 67.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.50 stddev:2.44 (2.9%) stddev-sans-first:1.42 08:39:04 INFO - PROCESS | 18359 | Values: 91.0 84.0 88.0 84.0 83.0 84.0 85.0 85.0 84.0 84.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:123.00 stddev:4.37 (3.6%) stddev-sans-first:4.20 08:39:04 INFO - PROCESS | 18359 | Values: 127.0 122.0 127.0 114.0 124.0 119.0 125.0 121.0 122.0 116.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:150.00 stddev:6.77 (4.5%) stddev-sans-first:6.84 08:39:04 INFO - PROCESS | 18359 | Values: 143.0 145.0 156.0 150.0 153.0 142.0 150.0 150.0 161.0 139.0 08:39:04 INFO - PROCESS | 18359 | 08:39:04 INFO - PROCESS | 18359 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.49 (2.1%) stddev-sans-first:1.54 08:39:04 INFO - PROCESS | 18359 | Values: 70.0 68.0 69.0 70.0 68.0 72.0 68.0 70.0 68.0 67.0 08:39:04 INFO - PROCESS | 18359 | -------- Summary: end -------- 08:39:04 INFO - PROCESS | 18359 | 08:39:05 INFO - TEST-INFO | 18359: exit 0 08:39:05 INFO - TEST-OK | kraken | took 58685ms 08:39:05 INFO - TEST-START | v8_7 08:39:05 INFO - operating with platform_type : linux_ 08:39:05 INFO - Initialising browser for v8_7 test... 08:39:05 INFO - TEST-INFO | started process 18611 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiOFtuM/profile http://localhost:51111/getInfo.html) 08:39:09 INFO - PROCESS | 18611 | __metrics Screen width/height:1600/1200 08:39:09 INFO - PROCESS | 18611 | colorDepth:24 08:39:09 INFO - PROCESS | 18611 | Browser inner width/height: 1024/697 08:39:09 INFO - PROCESS | 18611 | __metrics 08:39:09 INFO - PROCESS | 18611 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:39:09 INFO - PROCESS | 18611 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:39:10 INFO - TEST-INFO | 18611: exit 0 08:39:10 INFO - Browser initialized. 08:39:10 INFO - Running cycle 1/1 for v8_7 test... 08:39:10 INFO - TEST-INFO | started process 18692 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiOFtuM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:22 INFO - PROCESS | 18692 | RSS: Main: 150089728 08:39:22 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | Cycle 1(1): loaded http://localhost:51111/tests/v8_7/run.html (next: http://localhost:51111/tests/v8_7/run.html) 08:39:43 INFO - PROCESS | 18692 | RSS: Main: 548700160 08:39:43 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | __start_tp_report 08:39:43 INFO - PROCESS | 18692 | _x_x_mozilla_page_load 08:39:43 INFO - PROCESS | 18692 | _x_x_mozilla_page_load_details 08:39:43 INFO - PROCESS | 18692 | |i|pagename|runs| 08:39:43 INFO - PROCESS | 18692 | |0;Richards;166.9727834362999 08:39:43 INFO - PROCESS | 18692 | |1;DeltaBlue;190.11406844106463 08:39:43 INFO - PROCESS | 18692 | |2;Encrypt;280.42624789680315 08:39:43 INFO - PROCESS | 18692 | |3;Decrypt;5256.544502617801 08:39:43 INFO - PROCESS | 18692 | |4;RayTrace;1103.638368246968 08:39:43 INFO - PROCESS | 18692 | |5;Earley;790.5138339920949 08:39:43 INFO - PROCESS | 18692 | |6;Boyer;11940.47619047619 08:39:43 INFO - PROCESS | 18692 | |7;RegExp;26256.410256410258 08:39:43 INFO - PROCESS | 18692 | |8;Splay;582.7505827505828 08:39:43 INFO - PROCESS | 18692 | |9;NavierStokes;4835.748792270531 08:39:43 INFO - PROCESS | 18692 | __end_tp_report 08:39:43 INFO - PROCESS | 18692 | __startTimestamp1452184783680__endTimestamp 08:39:43 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | ------- Summary: start ------- 08:39:43 INFO - PROCESS | 18692 | Number of tests: 10 08:39:43 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | [#0] Richards Cycles:1 Average:166.97 Median:166.97 stddev:0.00 (0.0%) 08:39:43 INFO - PROCESS | 18692 | Values: 167.0 08:39:43 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | [#1] DeltaBlue Cycles:1 Average:190.11 Median:190.11 stddev:0.00 (0.0%) 08:39:43 INFO - PROCESS | 18692 | Values: 190.1 08:39:43 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 08:39:43 INFO - PROCESS | 18692 | Values: 280.4 08:39:43 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 08:39:43 INFO - PROCESS | 18692 | Values: 5256.5 08:39:43 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | [#4] RayTrace Cycles:1 Average:1103.64 Median:1103.64 stddev:0.00 (0.0%) 08:39:43 INFO - PROCESS | 18692 | Values: 1103.6 08:39:43 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 08:39:43 INFO - PROCESS | 18692 | Values: 790.5 08:39:43 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | [#6] Boyer Cycles:1 Average:11940.48 Median:11940.48 stddev:0.00 (0.0%) 08:39:43 INFO - PROCESS | 18692 | Values: 11940.5 08:39:43 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 08:39:43 INFO - PROCESS | 18692 | Values: 26256.4 08:39:43 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | [#8] Splay Cycles:1 Average:582.75 Median:582.75 stddev:0.00 (0.0%) 08:39:43 INFO - PROCESS | 18692 | Values: 582.8 08:39:43 INFO - PROCESS | 18692 | 08:39:43 INFO - PROCESS | 18692 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 08:39:43 INFO - PROCESS | 18692 | Values: 4835.7 08:39:43 INFO - PROCESS | 18692 | -------- Summary: end -------- 08:39:43 INFO - PROCESS | 18692 | 08:39:44 INFO - TEST-INFO | 18692: exit 0 08:39:44 INFO - TEST-OK | v8_7 | took 39172ms 08:39:44 INFO - SUITE-END | took 1211s 08:39:44 INFO - Completed test suite (00:20:11) 08:39:44 INFO - Working with test: dromaeo_css 08:39:44 INFO - Generating results file: dromaeo_css 08:39:44 INFO - Working with test: kraken 08:39:44 INFO - Generating results file: kraken 08:39:44 INFO - javascript benchmark 08:39:44 INFO - Working with test: v8_7 08:39:44 INFO - Generating results file: v8_7 08:39:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:39:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:39:44 INFO - process_Request line: dromaeo_css 6877.61 graph.html#tests=[[72,64,35]] 08:39:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:39:44 INFO - process_Request line: kraken 1505.50 graph.html#tests=[[232,64,35]] 08:39:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:39:44 INFO - process_Request line: v8_7 21074.61 graph.html#tests=[[230,64,35]] 08:39:44 INFO - RETURN: dromaeo_css: 6877.61 08:39:44 INFO - RETURN: kraken: 1505.50 08:39:44 INFO - RETURN: v8_7: 21074.61 08:39:44 INFO - javascript benchmark 08:39:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3120.1731541141594, 3150.054983504951, 3195.4727469967456, 3199.7120259176654, 3227.0802821195957, 5014.373203349582, 5070.594352451795, 5134.845954621363, 5157.071727089118, 5190.71451070191, 5146.871328216787, 5216.921746173811, 5254.6847189168675, 5256.763445644946, 5260.894782104356, 4674.953250467486, 4689.953100468994, 4705.482396936334, 4746.193147164973, 4752.90494190116, 4667.649926255527, 4763.118823017736, 4792.6405519586, 4801.615870730333, 4862.2220444728855, 4697.812087516478, 4709.222978208609, 4795.328653988445, 4800.879978000543, 4815.855524334275, 4761.285807128924, 4789.353437285991, 4792.880177995543, 4796.25658023007, 4836.10532051568, 4667.906641867177, 4749.762511874427, 4770.928436073462, 4785.0, 4837.879053023703, 5010.073136469765, 5029.522195391469, 5105.259737338102, 5106.693598384109, 5145.897082058375, 5580.693061881595, 5582.413846546095, 5591.440855914417, 5591.916121258185, 5593.161025846115, 5398.676079435247, 5614.522765564891, 5614.803481878155, 5620.634658747168, 5627.0, 5166.044281807877, 5172.767225474862, 5194.844154675366, 5200.6619569727845, 5281.023010743025, 5660.264165658438, 5684.658920464785, 5688.402717714663, 5691.288588926384, 5722.54219662426, 5364.356277246756, 5453.345598528202, 5455.972720136374, 5456.699881506555, 5479.397266300703, 5440.156775699773, 5492.395836457987, 5496.258005169251, 5528.585356098309, 5632.352279487911, 5555.2222688822785, 5594.916076258859, 5600.271964644651, 5627.493525582717, 5645.858853528613, 5546.278983732089, 5548.944510554924, 5549.694766787785, 5560.4161563036105, 5566.554675626021, 4255.446791917031, 4326.437563116775, 4337.566243375701, 4342.109867477159, 4365.869023929287, 3849.9807500962875, 3864.806759662006, 3878.5151856017997, 3893.591172926802, 3924.3132451820816, 5076.82231121909, 5097.745112744348, 5101.20931255656, 5101.948980510221, 5147.948520514747, 5434.427285064708, 5454.181872719045, 5493.670379777226, 5555.111182210908, 5555.611107222537, 5095.388553373545, 5142.640015198975, 5172.870678233075, 5204.0372531081875, 5220.243064755589, 4735.479097299294, 4740.881477963009, 4742.928856067162, 4745.857624271277, 4791.257355109963, 5528.032594295983, 5644.717764111861, 5740.655560666373, 5750.424957504216, 5752.424757524298, 5444.918326225189, 5489.0, 5577.330720313588, 5583.609147359646, 5609.1305847593685, 5745.597808153389, 5760.33756118035, 5765.279340082489, 5770.942290577208, 5781.075027995501, 5343.572514198777, 5425.674459532441, 5578.330600327824, 5584.553235741049, 5595.748191331319, 5504.422035686195, 5527.834164975057, 5588.888222235451, 5590.049691552527, 5638.182463542681, 5383.838484845461, 5406.891862162814, 5456.290682211287, 5458.181272809111, 5461.453854614507, 5348.064088784369, 5436.374816896107, 5446.727663616883, 5453.345598528202, 5461.972690136524, 5312.681239125664, 5364.785408583769, 5367.543758780391, 5371.4897084776885, 5416.674999500043, 5465.59008074388, 5502.862428439161, 5508.091164957737, 5511.338639363302, 5569.248151499496, 5203.843884683465, 5309.787608495617, 5319.627626066138, 5390.62265641417, 5393.892122157614], "unit": "score", "name": "dojo.html", "value": 5130.676559973631}, {"lowerIsBetter": false, "replicates": [532.2468706779906, 539.3473896585134, 542.2462776740332, 548.0956421903859, 561.4021067563048, 28116.85941570292, 28809.711902880965, 38446.23107537848, 39634.40548391776, 39699.80150099253, 42260.0, 42748.0, 43014.35478467825, 43037.569624303746, 43087.0, 8548.529830859316, 8728.127187281285, 8730.476171429735, 8734.432261902955, 8736.51949142797, 8485.575721213945, 8603.655853765842, 8629.05080441151, 8630.697925572606, 8630.741077767678, 8561.657533698675, 8703.17319854616, 8710.433821801562, 8723.694670686527, 8732.781680458007, 8545.31637469001, 8552.358573107042, 8592.312614990786, 8607.827843443096, 8625.094365091669, 8432.241098301121, 8556.144385561456, 8583.141685831368, 8586.398952073358, 8594.570271486464, 39492.210155796725, 39558.0, 39964.60035399638, 40067.19865602672, 40090.398644020366, 3423.7089847363004, 3469.705075068597, 3493.7205023598053, 3742.3450896093345, 4152.792360381999, 29577.120019982514, 30450.019635232034, 30549.0, 30582.388352233054, 30704.078877633707, 3399.1502124468884, 3445.707114895237, 3452.205992621686, 3460.1349662584353, 3593.586737525166, 244321.0, 246505.7674711633, 246661.0, 246701.0, 247324.0, 56714.432855670915, 56826.7158664204, 56947.0, 57050.714746426835, 57083.0, 55458.445415546135, 56421.71789141028, 62368.68815655893, 64308.67845660835, 64410.355896441375, 13963.860361396459, 14501.492447764278, 14621.92689036548, 14655.193964331851, 14800.407983680747, 9944.403335799876, 10176.847347289797, 10495.947520262349, 10515.211359147941, 10576.36541807494, 19921.501962450766, 20795.37613871556, 20819.0, 20856.79143208579, 20869.37391878246, 7345.3021962913435, 7396.741114060982, 7503.598848368579, 7538.962305188439, 7557.6221188940335, 845.5138295480124, 926.9536523173814, 933.9626414943463, 947.2469386837481, 990.7275499237767, 26977.19068427911, 27898.860505697747, 27913.109861891746, 28142.43715125727, 28779.28051798722, 1041.4740556019312, 1047.701405099543, 1078.5308390850005, 1090.095220966596, 1108.9168312376444, 13494.122882012638, 15153.621159471102, 15276.541703748906, 15302.770458443132, 15374.231288435534, 375307.1234643864, 382267.0, 382999.0, 385144.0, 385325.0, 53558.464415356124, 54090.5909409056, 54246.45753542493, 54316.0, 54343.18485222725, 1284.2872205925614, 1286.5497076023505, 1319.3205499167937, 1357.3213393303545, 1377.455904917572, 28956.42087158287, 30243.395132097674, 31671.52492712565, 32168.0, 32962.931546356696, 39655.60344396519, 40339.193216134925, 48561.0, 49378.0, 49472.75263623659, 239556.0, 244732.0, 245479.0, 245700.0, 247843.0, 42208.57791422169, 42765.35851962161, 43134.0, 43289.0, 43940.560594393646, 42752.5724742761, 43121.0, 43134.56865431431, 43410.78294608507, 43458.56541434672, 36179.095522612144, 36685.81657091698, 37121.25757484889, 38843.80578097091, 40402.59597404106, 35452.64547354494, 37221.0, 37222.813885930394, 37226.6277337234, 39253.41119883261, 35908.64091359053, 36311.45532816957, 36434.0, 37071.258574827814, 37074.07314817151, 31412.842935786088, 32884.177895552806, 33735.15662108467, 33822.83088584541, 35127.82436087803, 24731.876340618903, 24925.87537062303, 25046.49907001886, 25149.371265718502, 25296.494070118864], "unit": "score", "name": "ext.html", "value": 18445.714554779093}, {"lowerIsBetter": false, "replicates": [353.0608581174074, 354.1094148217234, 355.2876482652282, 357.90336609115536, 359.7697473616886, 13748.58754237372, 13787.999205245376, 16581.17094145294, 17392.56518587036, 18531.16609752561, 15164.84835151648, 16103.436379726712, 16115.83884161158, 16227.918860405682, 17431.651366972652, 5264.578833693305, 5381.730913454331, 5388.299521062276, 5390.056740070472, 5394.05604019297, 4020.115574573589, 4119.032027473556, 5359.517643412092, 5396.055690254209, 5702.429757024306, 5815.069588865782, 5823.767049318022, 5855.326637436707, 5861.296644402656, 5864.501517371007, 5659.4340565943485, 5796.07262837946, 5813.767449302023, 5817.941820581782, 5834.708264586754, 5115.769790359443, 5129.563987061104, 5171.0, 5173.793048278064, 5179.067767801795, 19469.707954380694, 20211.797882021285, 20609.0, 21131.78868211329, 21383.465413364636, 2230.520438105799, 2288.1533832482087, 2382.24959137871, 2566.781823545001, 2600.9739902600923, 12771.93614031924, 12954.417051232716, 13012.739745205043, 13155.144915580553, 13266.53567125146, 1819.9818001819945, 1834.2937968881943, 1836.2471386731509, 1883.6896397069843, 1939.3890924358782, 57242.0, 59960.700196498736, 60329.396706032814, 63491.682541587, 63497.0, 9923.156531694887, 10054.447005414773, 10064.043915827984, 10397.636082737068, 10477.0, 13594.184348939096, 13607.795883061763, 13614.18314901109, 13627.454901804014, 13637.113587616774, 7382.520136191238, 7496.58768767723, 7535.0, 7556.962215188889, 7644.197359277307, 6868.62222577753, 6879.449644028466, 7016.333448322402, 7127.2160062393095, 7164.319389657974, 4340.30555111187, 4403.229434848889, 4411.117776444724, 4475.977620111878, 4511.481179664315, 1721.5007647782254, 1759.7184450488116, 1759.9560010999828, 1772.6011647379237, 1836.3480964257496, 886.2378354615026, 895.8253140637513, 918.5223683684446, 978.3396207559869, 1029.2846471702244, 12416.75166496665, 13974.021818472813, 16136.919315403582, 17105.657886842193, 17131.314747409964, 843.6709683223547, 879.7492714576315, 924.1682485762867, 942.8632848236967, 1012.6455740490917, 9306.674266400643, 9498.145166934872, 9676.516174191403, 9717.31978761494, 9815.558299876522, 399824.0, 402702.0, 402941.0, 403904.0, 407113.0, 79243.0, 80674.0, 81885.59057204676, 82374.0, 83267.0, 1095.1129585035987, 1137.5847815547431, 1147.0937959012454, 1149.2759561476216, 1149.4080548517352, 14737.705245894807, 14857.257137142884, 14902.77645835335, 15212.619684507534, 15506.689866202838, 32407.675923241408, 32526.674733252363, 32803.507947380334, 33258.0, 33272.66727332793, 39070.804645977725, 40247.19505609813, 40700.796496017334, 40753.1849363017, 43522.0, 8427.452215605967, 9408.247340212904, 9609.711708648752, 9692.660756873476, 9752.9024709752, 16845.91577042107, 17338.91330543339, 17388.47834564965, 17742.556436089202, 17750.644987100444, 13804.309784510935, 13978.161310321413, 14051.086679365808, 14145.0, 14779.92610036943, 14082.929585352007, 14221.644458888197, 14442.350094245574, 14505.347259373564, 15249.23753812327, 13057.934710326388, 13088.476460941456, 13997.930010349883, 14240.430382784572, 14494.927525362305, 9512.85730714026, 9623.326367154232, 9694.224462043161, 9701.563429645825, 9715.562799674173, 13335.933320333335, 13579.253141077335, 13745.862541374458, 14770.48303309379, 15096.622584435478], "unit": "score", "name": "jquery.html", "value": 8819.804819200157}, {"lowerIsBetter": false, "replicates": [1292.5476083370827, 1445.6964037552116, 1452.230317931496, 1593.4502596604168, 1784.4914199453167, 6754.425873800727, 7285.41716662667, 7315.926840731591, 7335.889961650566, 7340.926590734091, 7234.674439650228, 7398.704051837934, 7415.332620064193, 7418.109826820789, 7419.369353604937, 1981.28673677476, 2011.6278488479677, 2159.3090211132444, 2191.5945550073207, 2204.1073365287084, 2189.4745261137373, 2197.2090047582856, 2197.439652888519, 2197.9340619781433, 2199.9010044547954, 2121.543868068365, 2222.9777702223014, 2223.6998005269324, 2224.810891074261, 2226.3209721035078, 2197.8901054947187, 2221.4557433428754, 2224.4327696437304, 2226.0984301357976, 2253.763354847742, 2194.594000109985, 2206.5035367042447, 2222.388843068169, 2225.00987060758, 2249.910003599854, 7511.173770885198, 7587.658555364967, 7588.2791134842655, 7590.468667193299, 7591.3926885849, 4432.290833466662, 4510.729356238636, 4540.137373898981, 4544.977275113636, 4545.250033744428, 2845.573164025392, 2939.7942144049925, 2947.1158652404406, 2953.4831404504125, 2972.929745291715, 925.9444433333954, 936.1434287626813, 951.5813042261452, 962.6678795815433, 965.7826988927505, 10599.788004239948, 10600.734981625445, 10613.310134841287, 10614.363138211733, 10627.893721062768, 4107.958920410817, 4110.23960567296, 4188.748675079505, 4194.3289073748665, 4201.243776120266, 9040.0, 9053.049429809907, 9067.229285510806, 9071.501067441222, 9081.137291957386, 4590.288505281686, 4593.793279302439, 4613.446386433649, 4629.953700462952, 4637.7449240291435, 4213.389058586487, 4216.746995180299, 4219.029623186684, 4219.6202341789385, 4221.472315960505, 3313.122022663996, 3358.8488518016748, 3483.773554718935, 3561.893143205708, 3606.891793246207, 1125.671707385277, 1150.2983180260035, 1153.988460115405, 1162.5001249462812, 1169.9941500292443, 1033.3541536539663, 1041.2971244409994, 1081.9721264798472, 1169.8771628979005, 1293.4050336844969, 6857.211420686585, 6865.691043903036, 6946.756863509854, 6947.895781563179, 6952.652367381611, 1087.4019289390803, 1093.8523299354645, 1108.1024370260116, 1110.5335758981087, 1116.6705821782593, 5524.723763811793, 5672.347680016851, 5697.088465845445, 5699.116636921284, 5700.401457846866, 8810.118988101138, 9088.772780680536, 9126.17864392208, 9166.81666366669, 9345.252379809599, 9182.265418766483, 9201.217896478875, 9204.217641500414, 9211.032841551674, 9212.35513514061, 7023.122109736283, 7047.224805271416, 7173.103362079844, 7185.389241914496, 7259.6007219603425, 6883.27725588806, 6884.173899132136, 6884.449244060363, 6903.689333979883, 6919.342662447059, 7924.20757924203, 8004.679812807422, 8182.590870456573, 8189.918100819154, 8199.754007379788, 8114.959425202836, 8281.83436331282, 8292.17078292166, 8474.1949514796, 8485.872711909204, 6758.256591774999, 6822.795316140524, 6850.623215723183, 6913.481488888253, 6919.827004324731, 6388.584741991755, 6487.286398496068, 7221.819454513679, 7395.741149059757, 7396.112466504054, 6866.450683945172, 6873.5875847449315, 6978.8833786593905, 7088.822779430556, 7093.255208203064, 6522.34776522363, 6556.967215163893, 6615.470762339098, 6642.667866606554, 6735.49483788708, 6837.179538455417, 6876.724931002704, 6883.27725588826, 6891.552049116792, 6892.104026476526, 6102.7253773579405, 6148.600340977822, 6174.289956655042, 6188.721507532262, 6196.318404975539, 6140.416660417253, 6178.382161783786, 6183.443490085914, 6184.752609895734, 6190.597611155261], "unit": "score", "name": "mootools.html", "value": 4346.292195694623}, {"lowerIsBetter": false, "replicates": [313.9497680371141, 319.431412086486, 333.11723931581304, 337.44321868916285, 341.5713279833809, 5775.56683248756, 5780.017397042502, 5784.392638772932, 5801.622894511859, 5854.619449735775, 5714.914276285848, 5719.571032172583, 5723.399043100477, 5745.339285982102, 5750.827475175741, 4478.731276123435, 4481.305397663367, 4483.551644835523, 4484.260097083978, 4484.618807401359, 4390.67069969752, 4402.537733537981, 4443.977780111111, 4456.06422651242, 4488.798004089824, 4393.187260356828, 4397.714148580348, 4399.846005389812, 4419.138268037734, 4420.359047938047, 4258.148370325947, 4394.912101757979, 4400.295952647577, 4403.911921761579, 4415.735055896656, 3859.07382228266, 3860.517435320585, 3924.4701965234613, 3939.4090886367276, 3955.6835453163676, 5460.699661518614, 5506.669599823983, 5508.531774799147, 5509.531689806371, 5571.275734154575, 4939.851804445872, 5027.824026159067, 5071.695698258116, 5165.896682066337, 5181.404138524081, 6002.729877155539, 6057.939420605826, 6063.242094738158, 6082.60463069899, 6091.573589848713, 4355.956440435587, 4357.0, 4357.651387888961, 4358.171947329997, 4360.367746676746, 6221.191245138149, 6382.329855365167, 6386.457151142158, 6387.2654644715985, 6393.648349340784, 4479.238529450001, 4486.013077123028, 4486.237339652267, 4487.035287413222, 4496.213162696515, 4521.095780843779, 4544.159330523864, 4548.840790572381, 4549.0, 4552.044070745114, 5129.153689641242, 5137.101007323703, 5139.640225184201, 5140.0, 5183.481651834786, 6005.39946005396, 6142.815715528452, 6150.231221097363, 6151.9384806151365, 6168.568200225941, 1600.927958241882, 1618.8704903607918, 1619.9389399943057, 1621.1813034417544, 1623.5291765387906, 1103.5034234594464, 1117.3184357541893, 1118.2395970739974, 1122.528538014036, 1140.190464770006, 5783.94216057834, 5812.331581868139, 5813.447722466359, 5813.79651712188, 5818.185454036438, 6306.085617585424, 6307.369263073656, 6308.495320374359, 6312.715927783261, 6319.778807741707, 5813.215215945793, 5813.59304848665, 5818.33089194748, 5826.096954971986, 5827.7668893244645, 3304.9173770655925, 3410.505476705913, 3411.710004649583, 3415.55597772293, 3421.349943510725, 6530.249021362509, 6533.738650454024, 6538.084668146464, 6543.149390579194, 6547.0, 6239.064140378889, 6418.711157997901, 6433.839154021093, 6434.163558737334, 6438.774642887476, 6483.3516648335735, 6484.092227088211, 6631.370019848203, 6635.303293154246, 6646.900296495556, 6336.619802811846, 6377.043443483514, 6399.744010239725, 6424.646644434414, 6425.293217745951, 6070.3019152798, 6279.748810047547, 6287.182666253358, 6294.779682711083, 6303.275123360872, 6631.734730610914, 6631.933680663132, 6634.369734875179, 6635.469162466895, 6638.800835974928, 4412.514623391488, 4453.220686379936, 4455.26488129455, 4463.866084017484, 4463.888402789957, 6407.391297826699, 6409.3270206629495, 6414.61512309263, 6419.261784894797, 6421.71102300407, 6007.90988135187, 6180.752769889334, 6222.066689996536, 6235.688215589112, 6245.750169993149, 6204.945159322836, 6224.315325314303, 6276.309605943251, 6279.654618995816, 6288.905666415099, 6121.938780612315, 6127.571070025056, 6130.049842274455, 6131.877362452815, 6134.171886795226, 6089.725962331794, 6273.65494897785, 6281.403266689657, 6281.874362512815, 6285.49716022708, 6107.450329470369, 6107.847303817262, 6111.877762444815, 6121.84695382619, 6128.754849805958], "unit": "score", "name": "prototype.html", "value": 4667.450284194767}, {"lowerIsBetter": false, "replicates": [778.544551437409, 830.3523251863545, 853.7140058080547, 856.6915910272301, 892.3931726426027, 13385.464581416743, 13627.863721362783, 13691.383887725051, 13701.794473082888, 13702.931485342584, 12472.625821225378, 12568.685782855433, 12584.874151258484, 12605.36973151341, 13312.0, 801.2748462641305, 808.3250485844327, 808.7048227396987, 809.7813590330608, 810.1250649298772, 808.6482380164647, 808.8665370213907, 810.7203014959858, 810.8621534339147, 811.5536454949784, 847.2628812932758, 847.5338563789921, 848.0544193224541, 848.245061894914, 848.4357901995165, 837.8408102460513, 843.1315744782853, 843.2284459719349, 844.877492763549, 845.9703910363138, 618.2519151826295, 618.761776715963, 619.0064945762077, 621.5773274173561, 624.6470744029654, 12681.365931703378, 12853.742925141538, 12856.292903890282, 12875.227486350848, 12940.870591294155, 10943.45282735868, 11295.887041129567, 11365.147613928906, 11398.373089480076, 11538.250013749079, 10057.89942100577, 10149.086582207638, 10171.338862973884, 10359.585616575403, 11035.117190624731, 3634.6915110560176, 3704.666580007812, 3719.702423806089, 3744.588095309514, 3815.332316844569, 43905.56094439047, 44579.55420445786, 46356.0, 47258.0, 49019.01961960777, 9816.361936474106, 9953.751156221153, 9985.101340879355, 10000.399976001463, 10028.197744180448, 17369.65260694779, 17370.3051877926, 17397.47807565775, 17407.3037078518, 17419.73870391945, 7721.729739459092, 7777.766666999999, 7843.0, 7938.04743430792, 8068.7175948841505, 4387.627051700578, 4405.557597004682, 4443.466783985878, 4507.414036175276, 4534.59188673021, 2915.5918171456015, 2920.196945839911, 2923.4883895318235, 2924.1227631710403, 2928.443595716807, 530.7452422836983, 546.0880329849082, 549.2996429552353, 550.6668465578267, 553.3553410277062, 533.871870751017, 592.502298069615, 599.0235915457775, 601.7502736364447, 614.1524695919692, 8118.261842670569, 8232.17678232172, 8236.752897413087, 8496.49021058726, 8643.308535317285, 567.1606023085856, 604.8826924221052, 624.950003999679, 667.6361383046251, 685.2428066986008, 3710.7216958728204, 4071.3485842265095, 4098.631123198927, 4118.258713431611, 4173.520045194841, 50019.24971125436, 50800.491995080316, 51035.23447148296, 51723.48276517262, 51756.48243517517, 47096.406503089594, 48051.0, 48078.0, 48935.5106448931, 49122.75438622855, 40177.99555011148, 42283.36574951378, 45044.77477612591, 48379.0, 48643.5135648639, 8942.68700595476, 9034.909650903406, 9126.361154719372, 9162.26701863836, 9196.908030919873, 33715.494267586495, 33834.0, 34428.82785586056, 34464.48303275503, 35734.28531429409, 37495.81252093722, 39864.402033970095, 41457.79271103625, 42749.0, 44956.77521612371, 11171.0, 11317.830232546354, 11431.199816013132, 11619.477123529292, 11660.825087623523, 11383.260088094248, 11979.28124312544, 12238.632841014427, 12968.416421261254, 13032.674183145496, 11843.644690659294, 12173.391330433265, 12223.205491643015, 12506.312152831682, 12628.242305461701, 11308.7738245233, 11321.264117832314, 11850.466728997388, 11919.582814601446, 12248.75502489963, 11071.446427678422, 11136.777264454504, 11379.374134422686, 11442.141839361915, 11625.302481851117, 10128.251525682506, 10266.632694354077, 10373.17014638812, 10536.683899483029, 10610.946945265225, 9073.637054517745, 9769.413835169913, 10008.723062587906, 10027.29808913369, 10091.243156763125], "unit": "score", "name": "yui.html", "value": 6249.64554254447}], "name": "dromaeo_css", "value": 6877.606929905254}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 110.0, 110.0, 110.0, 99.0, 110.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 155.0, 164.0, 126.0, 153.0, 156.0, 126.0, 168.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 159.0, 158.0, 160.0, 161.0, 161.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 86.0, 95.0, 73.0, 72.0, 75.0, 109.0, 97.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 148.0, 95.0, 97.0, 96.0, 148.0, 95.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 56.0, 57.0, 55.0, 55.0, 55.0, 64.0, 52.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [91.0, 84.0, 88.0, 84.0, 83.0, 84.0, 85.0, 85.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [127.0, 122.0, 127.0, 114.0, 124.0, 119.0, 125.0, 121.0, 122.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [143.0, 145.0, 156.0, 150.0, 153.0, 142.0, 150.0, 150.0, 161.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 70.0, 68.0, 72.0, 68.0, 70.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1505.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9727834362999], "unit": "score", "name": "Richards", "value": 211.42367800000002}, {"lowerIsBetter": false, "replicates": [190.11406844106463], "unit": "score", "name": "DeltaBlue", "value": 347.7806799999999}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1103.638368246968], "unit": "score", "name": "RayTrace", "value": 670.4995234765233}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [11940.47619047619], "unit": "score", "name": "Boyer", "value": 55.815445663010976}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [582.7505827505828], "unit": "score", "name": "Splay", "value": 139.838556}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21074.613232095886}]} 08:39:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "21074.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1505.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6877.61"}}} 08:39:44 INFO - Return code: 0 08:39:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:39:44 INFO - # TBPL SUCCESS # 08:39:44 INFO - Running post-action listener: _resource_record_post_action 08:39:44 INFO - Running post-run listener: _resource_record_post_run 08:39:46 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 551731200; Read time: 0; Write time: 473608 08:39:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 239300608; Read time: 0; Write time: 241176 08:39:46 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 312430592; Read time: 0; Write time: 232432 08:39:46 INFO - Running post-run listener: _upload_blobber_files 08:39:46 INFO - Blob upload gear active. 08:39:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:39:46 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 08:39:46 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'] 08:39:46 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 08:39:46 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:39:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:39:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:47 INFO - (blobuploader) - INFO - Done attempting. 08:39:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:39:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:39:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:48 INFO - (blobuploader) - INFO - Done attempting. 08:39:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:39:48 INFO - Return code: 0 08:39:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:39:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:39:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78c3c27f0102eee2bb02508b742e2b49ae5550df1854322fb6251222e4e3bb0a5252b5f31b042aff8db664924acc2c8c986a6795d2e03a305f3ddd074930f259", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ff2775eb9ae9fd88f8fbb158bd869d908de54abc7a351434020eaf3538bf1e643da03e7dbbdd6d3c75baab3897319e7a3166922a6e426a7f1c29d4104dd2731"} 08:39:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:39:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:39:48 INFO - Contents: 08:39:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78c3c27f0102eee2bb02508b742e2b49ae5550df1854322fb6251222e4e3bb0a5252b5f31b042aff8db664924acc2c8c986a6795d2e03a305f3ddd074930f259", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ff2775eb9ae9fd88f8fbb158bd869d908de54abc7a351434020eaf3538bf1e643da03e7dbbdd6d3c75baab3897319e7a3166922a6e426a7f1c29d4104dd2731"} 08:39:48 INFO - Copying logs to upload dir... 08:39:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.763976 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-07 08:39:48.072791) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 08:39:48.076476) ========= 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=32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467 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/78c3c27f0102eee2bb02508b742e2b49ae5550df1854322fb6251222e4e3bb0a5252b5f31b042aff8db664924acc2c8c986a6795d2e03a305f3ddd074930f259", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ff2775eb9ae9fd88f8fbb158bd869d908de54abc7a351434020eaf3538bf1e643da03e7dbbdd6d3c75baab3897319e7a3166922a6e426a7f1c29d4104dd2731"} build_url:https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/dxZBSU3PQ6S1c6h4nj4C3g/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/78c3c27f0102eee2bb02508b742e2b49ae5550df1854322fb6251222e4e3bb0a5252b5f31b042aff8db664924acc2c8c986a6795d2e03a305f3ddd074930f259", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ff2775eb9ae9fd88f8fbb158bd869d908de54abc7a351434020eaf3538bf1e643da03e7dbbdd6d3c75baab3897319e7a3166922a6e426a7f1c29d4104dd2731"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 08:39:48.101125) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:39:48.101451) ========= 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=32c5991c409366f7fec8a718000001d2-1452183308.141721-1204267467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:39:48.185930) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 08:39:48.186323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 08:39:48.186691) ========= ========= Total master_lag: 0.23 =========