builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1452892896.38 results: success (0) buildid: 20160115113040 builduid: 786daca23d5f41529eedd2dc021be487 revision: 80e55e78a44c60640f975722caff586da3af65fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.384407) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.384925) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.385222) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004017 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.402426) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.402790) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.415633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.416055) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.466831) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.467301) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.467851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.468253) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 13:21:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-01-15 13:21:36 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116565 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.598686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.599028) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019042 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.649478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:36.649975) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 80e55e78a44c60640f975722caff586da3af65fe --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 80e55e78a44c60640f975722caff586da3af65fe --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=a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 13:21:36,956 truncating revision to first 12 chars 2016-01-15 13:21:36,956 Setting DEBUG logging. 2016-01-15 13:21:36,956 attempt 1/10 2016-01-15 13:21:36,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/80e55e78a44c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 13:21:37,294 unpacking tar archive at: fx-team-80e55e78a44c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:37.298455) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:37.298799) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003432 script_repo_revision: '%(revision)s' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:37.346361) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:37.346715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:37.356866) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:37.357232) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 13:21:37.357705) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-15 13:21:37.357984) ========= /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=a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:21:37 INFO - MultiFileLogger online at 20160115 13:21:37 in /builds/slave/test-pgo 13:21:37 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 13:21:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:21:37 INFO - {'append_to_log': False, 13:21:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:21:37 INFO - 'blob_upload_branch': 'Fx-Team', 13:21:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:21:37 INFO - 'branch': 'Fx-Team', 13:21:37 INFO - 'buildbot_json_path': 'buildprops.json', 13:21:37 INFO - 'config_files': ('talos/linux_config.py',), 13:21:37 INFO - 'default_actions': ('clobber', 13:21:37 INFO - 'read-buildbot-config', 13:21:37 INFO - 'download-and-extract', 13:21:37 INFO - 'populate-webroot', 13:21:37 INFO - 'create-virtualenv', 13:21:37 INFO - 'install', 13:21:37 INFO - 'run-tests'), 13:21:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:21:37 INFO - 'download_minidump_stackwalk': True, 13:21:37 INFO - 'download_symbols': 'ondemand', 13:21:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:21:37 INFO - 'tooltool.py': '/tools/tooltool.py', 13:21:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:21:37 INFO - '/tools/misc-python/virtualenv.py')}, 13:21:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:21:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:21:37 INFO - 'installer_path': 'installer.exe', 13:21:37 INFO - 'log_level': 'info', 13:21:37 INFO - 'log_name': 'talos', 13:21:37 INFO - 'log_to_console': True, 13:21:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:21:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:21:37 INFO - 'opt_config_files': (), 13:21:37 INFO - 'pip_index': False, 13:21:37 INFO - 'sps_profile': False, 13:21:37 INFO - 'sps_profile_interval': 0, 13:21:37 INFO - 'suite': 'dromaeojs', 13:21:37 INFO - 'system_bits': '32', 13:21:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:21:37 INFO - 'title': 'talos-linux64-ix-002', 13:21:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:21:37 INFO - 'use_talos_json': True, 13:21:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:21:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:21:37 INFO - 'work_dir': 'build'} 13:21:37 INFO - ##### 13:21:37 INFO - ##### Running clobber step. 13:21:37 INFO - ##### 13:21:37 INFO - Running pre-action listener: _resource_record_pre_action 13:21:37 INFO - Running main action method: clobber 13:21:37 INFO - rmtree: /builds/slave/test-pgo/build 13:21:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:21:38 INFO - Running post-action listener: _resource_record_post_action 13:21:38 INFO - ##### 13:21:38 INFO - ##### Running read-buildbot-config step. 13:21:38 INFO - ##### 13:21:38 INFO - Running pre-action listener: _resource_record_pre_action 13:21:38 INFO - Running main action method: read_buildbot_config 13:21:38 INFO - Using buildbot properties: 13:21:38 INFO - { 13:21:38 INFO - "project": "", 13:21:38 INFO - "product": "firefox", 13:21:38 INFO - "script_repo_revision": "production", 13:21:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:21:38 INFO - "repository": "", 13:21:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:21:38 INFO - "buildid": "20160115113040", 13:21:38 INFO - "pgo_build": "True", 13:21:38 INFO - "basedir": "/builds/slave/test-pgo", 13:21:38 INFO - "buildnumber": 584, 13:21:38 INFO - "slavename": "talos-linux64-ix-002", 13:21:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:21:38 INFO - "platform": "ubuntu64_hw", 13:21:38 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:21:38 INFO - "branch": "fx-team", 13:21:38 INFO - "repo_path": "integration/fx-team", 13:21:38 INFO - "revision": "80e55e78a44c60640f975722caff586da3af65fe", 13:21:38 INFO - "stage_platform": "linux64-pgo", 13:21:38 INFO - "builduid": "786daca23d5f41529eedd2dc021be487", 13:21:38 INFO - "slavebuilddir": "test" 13:21:38 INFO - } 13:21:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:21:38 INFO - Running post-action listener: _resource_record_post_action 13:21:38 INFO - ##### 13:21:38 INFO - ##### Running download-and-extract step. 13:21:38 INFO - ##### 13:21:38 INFO - Running pre-action listener: _resource_record_pre_action 13:21:38 INFO - Running main action method: download_and_extract 13:21:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:38 INFO - https://queue.taskcluster.net/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:21:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/test_packages.json 13:21:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/test_packages.json 13:21:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:21:38 INFO - Downloaded 1448 bytes. 13:21:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:21:38 INFO - Using the following test package requirements: 13:21:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:21:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:21:38 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:21:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:38 INFO - u'jsshell-linux-x86_64.zip'], 13:21:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:21:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:21:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:21:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:21:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:21:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:21:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:21:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:38 INFO - https://queue.taskcluster.net/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:21:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:21:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:21:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/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 13:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/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 13:21:41 INFO - Downloaded 22441173 bytes. 13:21:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:21:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:21:42 INFO - Return code: 0 13:21: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 13:21: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')]} 13:21:42 INFO - https://queue.taskcluster.net/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:21:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:21:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:21:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/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 13:21:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/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 13:21:45 INFO - Downloaded 22441173 bytes. 13:21:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:21:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:21:46 INFO - Return code: 0 13:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:46 INFO - https://queue.taskcluster.net/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:21:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:21:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:21:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/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 13:21:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/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 13:21:48 INFO - Downloaded 11132144 bytes. 13:21:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:21:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 13:21:48 INFO - Return code: 0 13:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:48 INFO - https://queue.taskcluster.net/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:21:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:21:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:21:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/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 13:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azl4wFdXSSqhF-yLg0srYQ/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 13:21:51 INFO - Downloaded 55890595 bytes. 13:21:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:21:51 INFO - mkdir: /builds/slave/test-pgo/properties 13:21:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:21:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:21:51 INFO - Contents: 13:21:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:21:51 INFO - Running post-action listener: _resource_record_post_action 13:21:51 INFO - Running post-action listener: set_extra_try_arguments 13:21:51 INFO - ##### 13:21:51 INFO - ##### Running populate-webroot step. 13:21:51 INFO - ##### 13:21:51 INFO - Running pre-action listener: _resource_record_pre_action 13:21:51 INFO - Running main action method: populate_webroot 13:21:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:21:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:21:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:21:51 INFO - '--tppagecycles', 13:21:51 INFO - '7'], 13:21:51 INFO - 'tests': ['tsvgm']}}, 13:21:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:21:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:21:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:21:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:21:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:21:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:21:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:51 INFO - 'talos_options': ['--e10s'], 13:21:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:51 INFO - 'tests': ['damp', 'tps']}, 13:21:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:51 INFO - 'talos_options': ['--e10s'], 13:21:51 INFO - 'tests': ['damp', 'tps']}, 13:21:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:21:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:21:51 INFO - 'other': {'tests': ['a11yr', 13:21:51 INFO - 'ts_paint', 13:21:51 INFO - 'tpaint', 13:21:51 INFO - 'sessionrestore', 13:21:51 INFO - 'sessionrestore_no_auto_restore']}, 13:21:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:21:51 INFO - 'tests': ['a11yr', 13:21:51 INFO - 'ts_paint', 13:21:51 INFO - 'tpaint', 13:21:51 INFO - 'sessionrestore', 13:21:51 INFO - 'sessionrestore_no_auto_restore']}, 13:21:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:21:51 INFO - 'tests': ['a11yr', 13:21:51 INFO - 'ts_paint', 13:21:51 INFO - 'tpaint', 13:21:51 INFO - 'sessionrestore', 13:21:51 INFO - 'sessionrestore_no_auto_restore']}, 13:21:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:21:51 INFO - 'tests': ['a11yr', 13:21:51 INFO - 'ts_paint', 13:21:51 INFO - 'tpaint', 13:21:51 INFO - 'sessionrestore', 13:21:51 INFO - 'sessionrestore_no_auto_restore']}, 13:21:51 INFO - 'other_l64': {'tests': ['a11yr', 13:21:51 INFO - 'ts_paint', 13:21:51 INFO - 'tpaint', 13:21:51 INFO - 'sessionrestore', 13:21:51 INFO - 'sessionrestore_no_auto_restore']}, 13:21:51 INFO - 'other_nol64': {'tests': ['a11yr', 13:21:51 INFO - 'ts_paint', 13:21:51 INFO - 'tpaint', 13:21:51 INFO - 'sessionrestore', 13:21:51 INFO - 'sessionrestore_no_auto_restore']}, 13:21:51 INFO - 'svgr': {'tests': ['tsvgx', 13:21:51 INFO - 'tsvgr_opacity', 13:21:51 INFO - 'tart', 13:21:51 INFO - 'tscrollx', 13:21:51 INFO - 'cart']}, 13:21:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:21:51 INFO - 'tests': ['tsvgx', 13:21:51 INFO - 'tsvgr_opacity', 13:21:51 INFO - 'tart', 13:21:51 INFO - 'tscrollx', 13:21:51 INFO - 'cart']}, 13:21:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:51 INFO - 'tests': ['tp5o']}, 13:21:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:51 INFO - 'talos_options': ['--e10s'], 13:21:51 INFO - 'tests': ['tp5o']}, 13:21:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:51 INFO - 'talos_options': ['--xperf_path', 13:21:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:51 INFO - 'tests': ['tp5n']}, 13:21:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:51 INFO - 'talos_options': ['--e10s', 13:21:51 INFO - '--xperf_path', 13:21:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:51 INFO - 'tests': ['tp5n']}}, 13:21:51 INFO - 'talos.zip': {'path': '', 13:21:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:21:51 INFO - Running post-action listener: _resource_record_post_action 13:21:51 INFO - ##### 13:21:51 INFO - ##### Running create-virtualenv step. 13:21:51 INFO - ##### 13:21:51 INFO - Running pre-action listener: _resource_record_pre_action 13:21:51 INFO - Running main action method: create_virtualenv 13:21:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:21:51 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 13:21:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:21:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:21:52 INFO - Using real prefix '/usr' 13:21:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:21:52 INFO - Installing distribute.............................................................................................................................................................................................done. 13:21:54 INFO - Installing pip.................done. 13:21:54 INFO - Return code: 0 13:21:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e4f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7840>, '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 0x26146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2614b60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', '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 13:21:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 13:21:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:21:54 INFO - Using env: {'DISPLAY': ':0', 13:21:54 INFO - 'HOME': '/home/cltbld', 13:21:54 INFO - 'LANG': 'en_US.UTF-8', 13:21:54 INFO - 'LANGUAGE': 'en_US:en', 13:21:54 INFO - 'LOGNAME': 'cltbld', 13:21:54 INFO - 'MAIL': '/var/mail/cltbld', 13:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:54 INFO - 'MOZ_NO_REMOTE': '1', 13:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:54 INFO - 'NO_EM_RESTART': '1', 13:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:54 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:54 INFO - 'SHELL': '/bin/bash', 13:21:54 INFO - 'SHLVL': '1', 13:21:54 INFO - 'TERM': 'linux', 13:21:54 INFO - 'TMOUT': '86400', 13:21:54 INFO - 'USER': 'cltbld', 13:21:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', 13:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:54 INFO - '_': '/tools/buildbot/bin/python'} 13:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:54 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 13:21:54 INFO - Cleaning up... 13:21:54 INFO - Return code: 0 13:21:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f99e4f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7840>, '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 0x26146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2614b60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', '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 13:21:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:21:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:21:54 INFO - Using env: {'DISPLAY': ':0', 13:21:54 INFO - 'HOME': '/home/cltbld', 13:21:54 INFO - 'LANG': 'en_US.UTF-8', 13:21:54 INFO - 'LANGUAGE': 'en_US:en', 13:21:54 INFO - 'LOGNAME': 'cltbld', 13:21:54 INFO - 'MAIL': '/var/mail/cltbld', 13:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:54 INFO - 'MOZ_NO_REMOTE': '1', 13:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:54 INFO - 'NO_EM_RESTART': '1', 13:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:54 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:54 INFO - 'SHELL': '/bin/bash', 13:21:54 INFO - 'SHLVL': '1', 13:21:54 INFO - 'TERM': 'linux', 13:21:54 INFO - 'TMOUT': '86400', 13:21:54 INFO - 'USER': 'cltbld', 13:21:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', 13:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:54 INFO - '_': '/tools/buildbot/bin/python'} 13:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:54 INFO - Downloading/unpacking psutil>=0.7.1 13:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:21:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:21:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:21:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:56 INFO - Installing collected packages: psutil 13:21:56 INFO - Running setup.py install for psutil 13:21:56 INFO - building 'psutil._psutil_linux' extension 13:21:56 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 13:21:56 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 13:21:56 INFO - building 'psutil._psutil_posix' extension 13:21:56 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 13:21: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 13:21:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:57 INFO - Successfully installed psutil 13:21:57 INFO - Cleaning up... 13:21:57 INFO - Return code: 0 13:21:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f99e4f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7840>, '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 0x26146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2614b60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', '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 13:21:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 13:21:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:21:57 INFO - Using env: {'DISPLAY': ':0', 13:21:57 INFO - 'HOME': '/home/cltbld', 13:21:57 INFO - 'LANG': 'en_US.UTF-8', 13:21:57 INFO - 'LANGUAGE': 'en_US:en', 13:21:57 INFO - 'LOGNAME': 'cltbld', 13:21:57 INFO - 'MAIL': '/var/mail/cltbld', 13:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:57 INFO - 'MOZ_NO_REMOTE': '1', 13:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:57 INFO - 'NO_EM_RESTART': '1', 13:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:57 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:57 INFO - 'SHELL': '/bin/bash', 13:21:57 INFO - 'SHLVL': '1', 13:21:57 INFO - 'TERM': 'linux', 13:21:57 INFO - 'TMOUT': '86400', 13:21:57 INFO - 'USER': 'cltbld', 13:21:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', 13:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:57 INFO - '_': '/tools/buildbot/bin/python'} 13:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:21:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:21:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:21:59 INFO - Installing collected packages: mozsystemmonitor 13:21:59 INFO - Running setup.py install for mozsystemmonitor 13:21:59 INFO - Successfully installed mozsystemmonitor 13:21:59 INFO - Cleaning up... 13:21:59 INFO - Return code: 0 13:21:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f99e4f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7840>, '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 0x26146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2614b60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', '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 13:21:59 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 13:21:59 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 13:21:59 INFO - Using env: {'DISPLAY': ':0', 13:21:59 INFO - 'HOME': '/home/cltbld', 13:21:59 INFO - 'LANG': 'en_US.UTF-8', 13:21:59 INFO - 'LANGUAGE': 'en_US:en', 13:21:59 INFO - 'LOGNAME': 'cltbld', 13:21:59 INFO - 'MAIL': '/var/mail/cltbld', 13:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:59 INFO - 'MOZ_NO_REMOTE': '1', 13:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:59 INFO - 'NO_EM_RESTART': '1', 13:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:59 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:59 INFO - 'SHELL': '/bin/bash', 13:21:59 INFO - 'SHLVL': '1', 13:21:59 INFO - 'TERM': 'linux', 13:21:59 INFO - 'TMOUT': '86400', 13:21:59 INFO - 'USER': 'cltbld', 13:21:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', 13:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:59 INFO - '_': '/tools/buildbot/bin/python'} 13:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:59 INFO - Downloading/unpacking blobuploader==1.2.4 13:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:01 INFO - Downloading blobuploader-1.2.4.tar.gz 13:22:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:22:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:22:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:22:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:22:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:01 INFO - Downloading docopt-0.6.1.tar.gz 13:22:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:22:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:22:02 INFO - Installing collected packages: blobuploader, requests, docopt 13:22:02 INFO - Running setup.py install for blobuploader 13:22:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:22:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:22:02 INFO - Running setup.py install for requests 13:22:02 INFO - Running setup.py install for docopt 13:22:02 INFO - Successfully installed blobuploader requests docopt 13:22:02 INFO - Cleaning up... 13:22:02 INFO - Return code: 0 13:22:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:02 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 0x7f99e4f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7840>, '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 0x26146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2614b60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', '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 13:22:02 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 13:22:02 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 13:22:02 INFO - Using env: {'DISPLAY': ':0', 13:22:02 INFO - 'HOME': '/home/cltbld', 13:22:02 INFO - 'LANG': 'en_US.UTF-8', 13:22:02 INFO - 'LANGUAGE': 'en_US:en', 13:22:02 INFO - 'LOGNAME': 'cltbld', 13:22:02 INFO - 'MAIL': '/var/mail/cltbld', 13:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:02 INFO - 'MOZ_NO_REMOTE': '1', 13:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:02 INFO - 'NO_EM_RESTART': '1', 13:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:22:02 INFO - 'PWD': '/builds/slave/test-pgo', 13:22:02 INFO - 'SHELL': '/bin/bash', 13:22:02 INFO - 'SHLVL': '1', 13:22:02 INFO - 'TERM': 'linux', 13:22:02 INFO - 'TMOUT': '86400', 13:22:02 INFO - 'USER': 'cltbld', 13:22:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', 13:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:02 INFO - '_': '/tools/buildbot/bin/python'} 13:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:22:02 INFO - Running setup.py (path:/tmp/pip-eIMlz1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:22:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:22:02 INFO - Running setup.py (path:/tmp/pip-jgJAbe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:22:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:22:02 INFO - Running setup.py (path:/tmp/pip-WGq6fO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:22:03 INFO - Running setup.py (path:/tmp/pip-qqsF1T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:22:03 INFO - Running setup.py (path:/tmp/pip-uA4Eo7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:22:03 INFO - Running setup.py (path:/tmp/pip-KgA2ui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:22:03 INFO - Running setup.py (path:/tmp/pip-CoyXuM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:22:03 INFO - Running setup.py (path:/tmp/pip-4o4__a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:22:03 INFO - Running setup.py (path:/tmp/pip-0Xqc5q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:22:03 INFO - Running setup.py (path:/tmp/pip-sUz45e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:22:03 INFO - Running setup.py (path:/tmp/pip-QyJGQg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:22:03 INFO - Running setup.py (path:/tmp/pip-wEk7Vn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:22:03 INFO - Running setup.py (path:/tmp/pip-C9cvPg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:22:03 INFO - Running setup.py (path:/tmp/pip-ZLtw_3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:22:03 INFO - Running setup.py (path:/tmp/pip-Mqpf7g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:22:03 INFO - Running setup.py (path:/tmp/pip-1Bu_QJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:22:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:22:03 INFO - Running setup.py (path:/tmp/pip-jHGUOd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:22:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:22:04 INFO - Running setup.py install for manifestparser 13:22:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:22:04 INFO - Running setup.py install for mozcrash 13:22:04 INFO - Running setup.py install for mozdebug 13:22:04 INFO - Running setup.py install for mozdevice 13:22:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:22:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:22:04 INFO - Running setup.py install for mozfile 13:22:04 INFO - Running setup.py install for mozhttpd 13:22:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:22:04 INFO - Running setup.py install for mozinfo 13:22:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:22:04 INFO - Running setup.py install for mozInstall 13:22:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:22:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:22:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:22:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:22:04 INFO - Running setup.py install for mozleak 13:22:04 INFO - Running setup.py install for mozlog 13:22:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:22:05 INFO - Running setup.py install for moznetwork 13:22:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:22:05 INFO - Running setup.py install for mozprocess 13:22:05 INFO - Running setup.py install for mozprofile 13:22:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:22:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:22:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:22:05 INFO - Running setup.py install for mozrunner 13:22:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:22:05 INFO - Running setup.py install for mozscreenshot 13:22:05 INFO - Running setup.py install for moztest 13:22:05 INFO - Running setup.py install for mozversion 13:22:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:22:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:22:05 INFO - Cleaning up... 13:22:05 INFO - Return code: 0 13:22:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f99e4f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7840>, '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 0x26146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2614b60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', '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 13:22:05 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 13:22:05 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 13:22:05 INFO - Using env: {'DISPLAY': ':0', 13:22:05 INFO - 'HOME': '/home/cltbld', 13:22:05 INFO - 'LANG': 'en_US.UTF-8', 13:22:05 INFO - 'LANGUAGE': 'en_US:en', 13:22:05 INFO - 'LOGNAME': 'cltbld', 13:22:05 INFO - 'MAIL': '/var/mail/cltbld', 13:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:05 INFO - 'MOZ_NO_REMOTE': '1', 13:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:05 INFO - 'NO_EM_RESTART': '1', 13:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:22:05 INFO - 'PWD': '/builds/slave/test-pgo', 13:22:05 INFO - 'SHELL': '/bin/bash', 13:22:05 INFO - 'SHLVL': '1', 13:22:05 INFO - 'TERM': 'linux', 13:22:05 INFO - 'TMOUT': '86400', 13:22:05 INFO - 'USER': 'cltbld', 13:22:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', 13:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:05 INFO - '_': '/tools/buildbot/bin/python'} 13:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:22:06 INFO - Running setup.py (path:/tmp/pip-vl3VCi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:22: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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:22:06 INFO - Running setup.py (path:/tmp/pip-tYKmQ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:22: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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:22:06 INFO - Running setup.py (path:/tmp/pip-uU5drD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:22:06 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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:22:06 INFO - Running setup.py (path:/tmp/pip-t9Ncuc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:22:06 INFO - Running setup.py (path:/tmp/pip-AJYHRb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:22:06 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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:22:06 INFO - Running setup.py (path:/tmp/pip-RuqZM4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:22:06 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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:22:06 INFO - Running setup.py (path:/tmp/pip-LtrvHg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:22:06 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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:22:06 INFO - Running setup.py (path:/tmp/pip-GUyuoR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:22:06 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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:22:06 INFO - Running setup.py (path:/tmp/pip-PIq9HX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:22:06 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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:22:06 INFO - Running setup.py (path:/tmp/pip-oOri16-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:22:06 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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:22:06 INFO - Running setup.py (path:/tmp/pip-7IEnPC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:22:06 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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:22:06 INFO - Running setup.py (path:/tmp/pip-mlANZp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:22:06 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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:22:06 INFO - Running setup.py (path:/tmp/pip-X8SuhN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:22:06 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)) 13:22:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:22:06 INFO - Running setup.py (path:/tmp/pip-21Q8lb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:22: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)) 13:22:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:22:07 INFO - Running setup.py (path:/tmp/pip-HbRTcV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:22: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)) 13:22:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:22:07 INFO - Running setup.py (path:/tmp/pip-eIkjVt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:22: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)) 13:22:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:22:07 INFO - Running setup.py (path:/tmp/pip-OU7TsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:22:07 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)) 13:22:07 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)) 13:22:07 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)) 13:22:07 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)) 13:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:22:07 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:22:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:08 INFO - Downloading blessings-1.5.1.tar.gz 13:22:08 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 13:22:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:22:09 INFO - Installing collected packages: blessings 13:22:09 INFO - Running setup.py install for blessings 13:22:09 INFO - Successfully installed blessings 13:22:09 INFO - Cleaning up... 13:22:09 INFO - Return code: 0 13:22:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:22:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:22:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:22:09 INFO - Reading from file tmpfile_stdout 13:22:09 INFO - Current package versions: 13:22:09 INFO - argparse == 1.2.1 13:22:09 INFO - blessings == 1.5.1 13:22:09 INFO - blobuploader == 1.2.4 13:22:09 INFO - docopt == 0.6.1 13:22:09 INFO - manifestparser == 1.1 13:22:09 INFO - mozInstall == 1.12 13:22:09 INFO - mozcrash == 0.16 13:22:09 INFO - mozdebug == 0.1 13:22:09 INFO - mozdevice == 0.48 13:22:09 INFO - mozfile == 1.2 13:22:09 INFO - mozhttpd == 0.7 13:22:09 INFO - mozinfo == 0.9 13:22:09 INFO - mozleak == 0.1 13:22:09 INFO - mozlog == 3.1 13:22:09 INFO - moznetwork == 0.27 13:22:09 INFO - mozprocess == 0.22 13:22:09 INFO - mozprofile == 0.28 13:22:09 INFO - mozrunner == 6.11 13:22:09 INFO - mozscreenshot == 0.1 13:22:09 INFO - mozsystemmonitor == 0.0 13:22:09 INFO - moztest == 0.7 13:22:09 INFO - mozversion == 1.4 13:22:09 INFO - psutil == 3.1.1 13:22:09 INFO - requests == 1.2.3 13:22:09 INFO - wsgiref == 0.1.2 13:22:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f99e4f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7840>, '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 0x26146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2614b60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', '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 13:22:09 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 13:22:09 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 13:22:09 INFO - Using env: {'DISPLAY': ':0', 13:22:09 INFO - 'HOME': '/home/cltbld', 13:22:09 INFO - 'LANG': 'en_US.UTF-8', 13:22:09 INFO - 'LANGUAGE': 'en_US:en', 13:22:09 INFO - 'LOGNAME': 'cltbld', 13:22:09 INFO - 'MAIL': '/var/mail/cltbld', 13:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:09 INFO - 'MOZ_NO_REMOTE': '1', 13:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:09 INFO - 'NO_EM_RESTART': '1', 13:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:22:09 INFO - 'PWD': '/builds/slave/test-pgo', 13:22:09 INFO - 'SHELL': '/bin/bash', 13:22:09 INFO - 'SHLVL': '1', 13:22:09 INFO - 'TERM': 'linux', 13:22:09 INFO - 'TMOUT': '86400', 13:22:09 INFO - 'USER': 'cltbld', 13:22:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', 13:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:09 INFO - '_': '/tools/buildbot/bin/python'} 13:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:09 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)) 13:22:09 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)) 13:22:09 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)) 13:22:09 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)) 13:22:09 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)) 13:22:09 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)) 13:22:09 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)) 13:22:09 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)) 13:22:09 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)) 13:22:09 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)) 13:22:09 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)) 13:22:09 INFO - Cleaning up... 13:22:09 INFO - Return code: 0 13:22:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e4f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7840>, '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 0x26146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2614b60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', '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 13:22:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:22:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:22:09 INFO - Using env: {'DISPLAY': ':0', 13:22:09 INFO - 'HOME': '/home/cltbld', 13:22:09 INFO - 'LANG': 'en_US.UTF-8', 13:22:09 INFO - 'LANGUAGE': 'en_US:en', 13:22:09 INFO - 'LOGNAME': 'cltbld', 13:22:09 INFO - 'MAIL': '/var/mail/cltbld', 13:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:09 INFO - 'MOZ_NO_REMOTE': '1', 13:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:09 INFO - 'NO_EM_RESTART': '1', 13:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:22:09 INFO - 'PWD': '/builds/slave/test-pgo', 13:22:09 INFO - 'SHELL': '/bin/bash', 13:22:09 INFO - 'SHLVL': '1', 13:22:09 INFO - 'TERM': 'linux', 13:22:09 INFO - 'TMOUT': '86400', 13:22:09 INFO - 'USER': 'cltbld', 13:22:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', 13:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:09 INFO - '_': '/tools/buildbot/bin/python'} 13:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:09 INFO - Downloading/unpacking jsonschema 13:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:22:11 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 13:22:11 INFO - Downloading/unpacking functools32 (from jsonschema) 13:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:11 INFO - Downloading functools32-3.2.3-2.tar.gz 13:22:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:22:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:22:11 INFO - warning: no files found matching '*.txt' 13:22:11 INFO - no previously-included directories found matching 'build' 13:22:11 INFO - no previously-included directories found matching 'dist' 13:22:11 INFO - no previously-included directories found matching '.git*' 13:22:11 INFO - Installing collected packages: jsonschema, functools32 13:22:11 INFO - Running setup.py install for functools32 13:22:11 INFO - warning: no files found matching '*.txt' 13:22:11 INFO - no previously-included directories found matching 'build' 13:22:11 INFO - no previously-included directories found matching 'dist' 13:22:11 INFO - no previously-included directories found matching '.git*' 13:22:11 INFO - Successfully installed jsonschema functools32 13:22:11 INFO - Cleaning up... 13:22:12 INFO - Return code: 0 13:22:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:22: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')]} 13:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22: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')]} 13:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22: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 0x7f99e4f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7840>, '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 0x26146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2614b60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', '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 13:22: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 13:22: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 13:22:12 INFO - Using env: {'DISPLAY': ':0', 13:22:12 INFO - 'HOME': '/home/cltbld', 13:22:12 INFO - 'LANG': 'en_US.UTF-8', 13:22:12 INFO - 'LANGUAGE': 'en_US:en', 13:22:12 INFO - 'LOGNAME': 'cltbld', 13:22:12 INFO - 'MAIL': '/var/mail/cltbld', 13:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:12 INFO - 'MOZ_NO_REMOTE': '1', 13:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:12 INFO - 'NO_EM_RESTART': '1', 13:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:22:12 INFO - 'PWD': '/builds/slave/test-pgo', 13:22:12 INFO - 'SHELL': '/bin/bash', 13:22:12 INFO - 'SHLVL': '1', 13:22:12 INFO - 'TERM': 'linux', 13:22:12 INFO - 'TMOUT': '86400', 13:22:12 INFO - 'USER': 'cltbld', 13:22:12 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', 13:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:12 INFO - '_': '/tools/buildbot/bin/python'} 13:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:12 INFO - Downloading/unpacking flake8 13:22: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 13:22: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 13:22: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 13:22: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 13:22: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 13:22: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 13:22:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:22:13 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 13:22:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:22: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 13:22: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 13:22: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 13:22: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 13:22: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 13:22: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 13:22:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:22: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 13:22:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:22: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 13:22: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 13:22: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 13:22: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 13:22: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 13:22: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 13:22:14 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 13:22:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:22: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 13:22: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 13:22: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 13:22: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 13:22: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 13:22: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 13:22:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:22:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:22:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:22:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:22:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:22:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:22:14 INFO - no previously-included directories found matching 'docs/_build' 13:22:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:22:14 INFO - Running setup.py install for pep8 13:22:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:22:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:22:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:22:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:22:14 INFO - no previously-included directories found matching 'docs/_build' 13:22:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:22:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:22:14 INFO - Cleaning up... 13:22:14 INFO - Return code: 0 13:22:14 INFO - Running post-action listener: _resource_record_post_action 13:22:14 INFO - Running post-action listener: _start_resource_monitoring 13:22:14 INFO - Starting resource monitoring. 13:22:14 INFO - ##### 13:22:14 INFO - ##### Running install step. 13:22:14 INFO - ##### 13:22:14 INFO - Running pre-action listener: _resource_record_pre_action 13:22:14 INFO - Running main action method: install 13:22:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:22:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:22:15 INFO - Reading from file tmpfile_stdout 13:22:15 INFO - Detecting whether we're running mozinstall >=1.0... 13:22:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:22:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:22:15 INFO - Reading from file tmpfile_stdout 13:22:15 INFO - Output received: 13:22:15 INFO - Usage: mozinstall [options] installer 13:22:15 INFO - Options: 13:22:15 INFO - -h, --help show this help message and exit 13:22:15 INFO - -d DEST, --destination=DEST 13:22:15 INFO - Directory to install application into. [default: 13:22:15 INFO - "/builds/slave/test-pgo"] 13:22:15 INFO - --app=APP Application being installed. [default: firefox] 13:22:15 INFO - mkdir: /builds/slave/test-pgo/build/application 13:22: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'] 13:22: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 13:22:31 INFO - Reading from file tmpfile_stdout 13:22:31 INFO - Output received: 13:22:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:22:31 INFO - Running post-action listener: _resource_record_post_action 13:22:31 INFO - ##### 13:22:31 INFO - ##### Running run-tests step. 13:22:31 INFO - ##### 13:22:31 INFO - Running pre-action listener: _resource_record_pre_action 13:22:31 INFO - Running main action method: run_tests 13:22:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:22:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:22:31 INFO - Python 2.7.3 13:22:31 INFO - Return code: 0 13:22:31 INFO - grabbing minidump binary from tooltool 13:22: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')]} 13:22:31 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 0x26a7840>, '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 0x26146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2614b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:22:31 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 13:22:31 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 13:22:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:22:31 INFO - Return code: 0 13:22:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:22:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:22:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:22:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:22:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:22:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:22:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:22:32 INFO - Return code: 0 13:22:32 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/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 13:22:32 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/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 13:22:32 INFO - Using env: {'DISPLAY': ':0', 13:22:32 INFO - 'HOME': '/home/cltbld', 13:22:32 INFO - 'LANG': 'en_US.UTF-8', 13:22:32 INFO - 'LANGUAGE': 'en_US:en', 13:22:32 INFO - 'LOGNAME': 'cltbld', 13:22:32 INFO - 'MAIL': '/var/mail/cltbld', 13:22:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:22:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:32 INFO - 'MOZ_NO_REMOTE': '1', 13:22:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:32 INFO - 'NO_EM_RESTART': '1', 13:22:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:22:32 INFO - 'PWD': '/builds/slave/test-pgo', 13:22:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:22:32 INFO - 'SHELL': '/bin/bash', 13:22:32 INFO - 'SHLVL': '1', 13:22:32 INFO - 'TERM': 'linux', 13:22:32 INFO - 'TMOUT': '86400', 13:22:32 INFO - 'USER': 'cltbld', 13:22:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434', 13:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:32 INFO - '_': '/tools/buildbot/bin/python'} 13:22:32 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/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 13:22:32 INFO - mozversion application_buildid: 20160115113040 13:22:32 INFO - mozversion application_changeset: 80e55e78a44c60640f975722caff586da3af65fe 13:22:32 INFO - mozversion application_display_name: Nightly 13:22:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:22:32 INFO - mozversion application_name: Firefox 13:22:32 INFO - mozversion application_remotingname: firefox 13:22:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:22:32 INFO - mozversion application_vendor: Mozilla 13:22:32 INFO - mozversion application_version: 46.0a1 13:22:32 INFO - mozversion platform_buildid: 20160115113040 13:22:32 INFO - mozversion platform_changeset: 80e55e78a44c60640f975722caff586da3af65fe 13:22:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:22:32 INFO - mozversion platform_version: 46.0a1 13:22:32 INFO - using testdate: 1452892952 13:22:32 INFO - actual date: 1452892952 13:22:32 INFO - starting webserver on 'localhost:55228' 13:22:32 INFO - SUITE-START | Running 3 tests 13:22:32 INFO - TEST-START | dromaeo_css 13:22:32 INFO - operating with platform_type : linux_ 13:22:32 INFO - Initialising browser for dromaeo_css test... 13:22:32 INFO - TEST-INFO | started process 10826 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxI__ek/profile http://localhost:55228/getInfo.html) 13:22:36 INFO - PROCESS | 10826 | __metrics Screen width/height:1600/1200 13:22:36 INFO - PROCESS | 10826 | colorDepth:24 13:22:36 INFO - PROCESS | 10826 | Browser inner width/height: 1024/697 13:22:36 INFO - PROCESS | 10826 | __metrics 13:22:36 INFO - PROCESS | 10826 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:22:36 INFO - PROCESS | 10826 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:22:37 INFO - TEST-INFO | 10826: exit 0 13:22:37 INFO - Browser initialized. 13:22:37 INFO - Running cycle 1/1 for dromaeo_css test... 13:22:37 INFO - TEST-INFO | started process 10919 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxI__ek/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:22:49 INFO - PROCESS | 10919 | RSS: Main: 150192128 13:22:49 INFO - PROCESS | 10919 | 13:23:41 INFO - PROCESS | 10919 | 1452893021110 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] 13:25:49 INFO - PROCESS | 10919 | Cycle 1(1): loaded http://localhost:55228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55228/tests/dromaeo/cssquery-ext.html) 13:25:50 INFO - PROCESS | 10919 | RSS: Main: 268091392 13:25:50 INFO - PROCESS | 10919 | 13:28:53 INFO - PROCESS | 10919 | Cycle 1(1): loaded http://localhost:55228/tests/dromaeo/cssquery-ext.html (next: http://localhost:55228/tests/dromaeo/cssquery-jquery.html) 13:28:53 INFO - PROCESS | 10919 | RSS: Main: 234151936 13:28:53 INFO - PROCESS | 10919 | 13:31:55 INFO - PROCESS | 10919 | Cycle 1(1): loaded http://localhost:55228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55228/tests/dromaeo/cssquery-mootools.html) 13:31:56 INFO - PROCESS | 10919 | RSS: Main: 227028992 13:31:56 INFO - PROCESS | 10919 | 13:34:58 INFO - PROCESS | 10919 | Cycle 1(1): loaded http://localhost:55228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55228/tests/dromaeo/cssquery-prototype.html) 13:34:58 INFO - PROCESS | 10919 | RSS: Main: 213155840 13:34:58 INFO - PROCESS | 10919 | 13:38:01 INFO - PROCESS | 10919 | Cycle 1(1): loaded http://localhost:55228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55228/tests/dromaeo/cssquery-yui.html) 13:38:01 INFO - PROCESS | 10919 | RSS: Main: 215134208 13:38:01 INFO - PROCESS | 10919 | 13:41:04 INFO - PROCESS | 10919 | Cycle 1(1): loaded http://localhost:55228/tests/dromaeo/cssquery-yui.html (next: http://localhost:55228/tests/dromaeo/cssquery-dojo.html) 13:41:04 INFO - PROCESS | 10919 | RSS: Main: 289034240 13:41:04 INFO - PROCESS | 10919 | 13:41:04 INFO - PROCESS | 10919 | __start_tp_report 13:41:04 INFO - PROCESS | 10919 | _x_x_mozilla_page_load 13:41:04 INFO - PROCESS | 10919 | _x_x_mozilla_page_load_details 13:41:04 INFO - PROCESS | 10919 | |i|pagename|runs| 13:41:04 INFO - PROCESS | 10919 | |0;dojo.html;3095.8297293648848;3103.8292893890825;3137.811731296124;3146.7325277351424;3155.0219431976084;4833.323334733132;4911.9017619647675;4956.182229932061;4969.602431805456;4972.22930445781;4960.082384758822;5067.594592432606;5067.6452648314635;5139.820106296281;5147.0992576299095;4615.861524154281;4620.537946205386;4631.675782695213;4670.065986802636;4720.64595155363;4583.289590113521;4638.628909687234;4718.740469274188;4742.4309082910095;4761.690490118149;4544.227481328182;4586.3579098926175;4587.036722288323;4657;4699.765011749416;4594.908101837945;4595.356650068993;4596.471405788344;4601.332806743037;4636.142313671981;4580.152671755736;4581.518940511231;4589.954100458986;4598.632109431237;4632.3977882875015;4828.73441960692;4887.36464259644;4945.727984960826;4992.101421744084;5023.246513023076;5402.702851343174;5446.101393270105;5448.754806033738;5449.945500545023;5454.4545545445535;5376.758045887906;5470.671759694391;5472.890542189174;5480.616356855022;5537.944620553783;5007.474215207387;5087.109755792721;5100.362454693163;5106.259592359124;5131.640785145079;5539.501444869981;5543.390227075019;5546.112621980464;5549.38956714761;5588.133839254922;5327.547158491494;5332.840014799563;5333.973330133402;5344.251804747339;5396.433374495621;5247.05553000456;5302.125149350314;5354.982553314858;5424.755885985141;5446.128619420953;5367.221752845893;5368.731563421813;5371.409144994048;5374.220737992969;5378.704171270618;5337.706426146521;5385.649932754359;5386.434424385383;5391.757370918318;5436.401995780461;4204.62158405745;4250.23495770758;4273.380359847804;4275.144971005811;4320.697551171451;3824.980875095662;3842.865499707497;3849.2109117630816;3880.7865567394065;3885.7279990400402;4908.116539022939;5072.594192464594;5078.517540833689;5079.796808127708;5128.00003999224;5388.757505912244;5396.487333703292;5444.265024221759;5486.615936884459;5528.834134975958;5043.3443652325695;5064.746762661852;5075.086484432837;5075.187969924795;5111.284420181178;4586.72479651222;4674.953250467452;4676.789544470439;4683.95316046842;4717.033008233304;5530.446955304518;5615.9157612635845;5657.57568182388;5665.12190610456;5715.5427565794635;5400.648957817729;5404.297441332602;5413.648112872651;5414.539764119936;5418.051840927901;5570.944290557205;5623.746931388179;5631.887362252814;5652.293463317085;5668.914966275592;5345;5421.891562168814;5425.972870135624;5428.104362780097;5454.400015998316;5361.731913404392;5392.595555333287;5404.54061404785;5406.432324605859;5450.073487507054;5158.432572416956;5218.817341393033;5274.12976858814;5293.179557168645;5307.150855863043;5382.058139825594;5405.108157154025;5406.486383793534;5408.972955135199;5415.350157981067;5300.469953004668;5306.920396193983;5311.707856067954;5316.946830531645;5357.223202635674;5144.228365745168;5290.841274761763;5333;5341.572674186134;5411.134218525017;5248.265242866079;5290.232916227203;5301.098813201688;5310.787568497217;5311.229871668664 13:41:04 INFO - PROCESS | 10919 | |1;ext.html;518.631771442276;522.1723568144491;529.7218960045975;537.4195868462061;549.4944650921152;28269.293267668294;28944.276393090182;29012.419751605008;29016.709832901666;29033;29435.85282073592;29583.704162958365;36600.81699591505;37384.43923341152;37571.624283757155;8300.958495207531;8454.365922555833;8457.238848503634;8458.238758511732;8470.830583388328;8254.669813207465;8372.413931024801;8383.287420569259;8385.790355241106;8390.622421991025;8386.538740369277;8404.369672274574;8447.070822209553;8457.746267611981;8479;8447.36644751643;8532.31741460688;8535.103814099522;8535.317174626016;8556.058833528306;8421.747347579583;8484.703035393732;8533.786655333604;8551.230389264934;8560.529170895597;39168.21663566741;39447;39545;39570.60429395698;39592;3161.399334126532;3181.729552987999;3205.5512228288057;3215;3534.2224710563637;29793.25516862074;30013.699863001308;30035;30211;31330.686693133233;3258.6252580953255;3274.5415641810164;3313.5692359993045;3428.8971330860113;3472.5485686860798;255877;256143;256268;256601;257262;50612.74693626508;51649;51691;57380.426195737506;57769;45643.315350269775;63163;63183.368166318665;63354.68322658357;63480;12991.350432478339;13073.607791766262;13139.802902956464;13150.342482875818;13154.539591114266;8749;9729.367591106555;9751.024897510193;9792.167665748491;9794.853077203848;16363.345466181458;19406.514837129183;19547.267650578324;19607.803921960596;20521.38435846927;7044.436445084381;7145.8928116078305;7237.407770290528;7265.491415600963;7358.00666909971;967.1295833749682;998.1615443027891;1008.2941940641433;1064.9733756656146;1111.8221084626582;29452;31052.844735776176;31398.055730399963;31484;31726;995.6017592962872;1004.703612434319;1044.749260177567;1064.989350106489;1116.8827273136367;14790.704185916436;15267.847321526864;15313.464028759163;15330.770038449433;15516.689666206612;137862;138625.306873467;141004.29497852444;145604;147552;52360.738196308776;52528;52529;52529.212061819104;52693;1290.490256348737;1297.6042307096427;1306.2097431054265;1307.6469353274563;1311.9409626566828;27339.58990615182;29069.563956540245;29155.7084429153;29536.409271814875;29598.556021660122;45161;46464;46587.76706116583;46595.53404465912;46629.30056049094;313467;313507;315139;315205;315351;28100;28589.28526786764;31521;31894.52158217582;31949.36101278008;37178.07054823651;38004.04989875165;38049.619503804606;38184.236315274095;38359.61640383672;33236.66763332432;35629.109272268404;35852.28295434129;35913.46129808107;35980.4602930951;33175.17062073467;33467.16332091717;33701.32597348088;33781.49327760036;34105.65894341025;30341.848290759288;30595.2351191222;32936.505952410254;36305.092372690895;36440;27043.86478067597;30152.54771178478;30809.383812324075;32483.350332992733;33620.663793362735;22902.885485573133;23251.76748232496;23877.522449550564;24198.75801241965;24593.385165371008 13:41:04 INFO - PROCESS | 10919 | |2;jquery.html;359.89383131976064;362.56130082600055;364.8449409001175;367.9135403180254;368.8616768711735;13484.190948543095;13549;15525.767113493306;16845.578860528494;17995.730064049032;15300.923495382536;15686;16096.1951902405;16124.516264512054;16418.917905410486;5261.2371206175085;5456.7544460499175;5456.945430545703;5458.754356053987;5459.590530710193;3949.7432666876703;4101.364288535282;5309.840704778843;5438.15708565173;5566.526845218141;5696.259486266779;5732;5748.080307150857;5752.367239603661;5755.65466072037;5099.617528685345;5284.4187139414635;5294.391145018334;5308.283381743473;5311.203319502067;4948.7278199699;5097.7196254206;5131.846044618667;5136.383633963911;5140.357455318085;12395.132340736152;14151.858481415156;19414.611707765907;20328.69506957397;20353.694694579593;2049.5695903860205;2072.1504183284783;2091.6653335466253;2136.647453170225;2227.276135256032;8840.778980525474;9434.811303773955;9525.380850244712;11316.321020738782;12720.855123038878;1728.6974779413679;1788.2131861980688;1860.8697391182623;1893.1102381880494;1895.3555791031115;55885.72057139729;57325.426745732846;58501.414985850446;58694;59016.40983590195;9661.903380966241;9974.401535907724;10079.949600251952;10092.293539452316;10200.489975501196;13244.470221191044;13380.264085475197;13388.598342049754;13406.798898016537;13412.329383530785;6749.628770417576;6858.177018757681;6876.828079298058;6930.272321406281;6972.895406568906;6425.903611445832;6468.708908099147;6501.0898474213645;6503.187101612299;6511.804645860631;4372.23485889968;4426.048399594103;4434.689571730012;4453;4495.100979804052;1683.4697070423022;1771.6988112020988;1793.8744287899983;1822.535253510373;1842.6222624361974;858.2275951643571;872.8297981893597;873.7854382408457;913.0413066280512;977.5747549815853;13452.596422107157;14616.342264598119;15168.103987001625;15219.771703424458;15437.536873893801;914.5884352041608;934.0426063285051;943.9103285187896;967.9370840895319;968.4141094637642;7466;8987.236084932854;9059.682911098213;9075.455472671529;9281.72154835356;341296;341890;451633;478184;497023;42068.579314206465;49868.750656246484;53120.734396327774;70706;72009;1116.9553217871357;1118.0496577908875;1125.7748450309807;1153.400231879418;1153.5443499817525;13760.587182384545;14138.22239776822;14289.928550357181;14509.85490145085;14745.1890146043;32249.677503224666;32431.189220269684;32449;32958;33313.669223000856;39606.40590391204;40488.3926741105;40970;42816.57183428126;43084.569154308054;7164.140303163445;7479.364254038468;7617.619119044137;7663.655135518804;7664.271894170045;10703;11347.716307092389;11431.771364572829;11502.82745758831;11528.496762696088;9081.54592270397;9581.185599224144;9581.473018984023;9639.614415423304;9741.707748767549;9583.377080489747;9651.613935442785;9702.805943881223;9721.319507634398;10126.645567405105;9294.163525282756;9680.128788408796;9783.51082445889;9801.460919649488;10087.495625218857;7475;7519.586422746802;7574.621268936421;7641.732539361095;7659.348955338635;8416.3266938646;9769.951150244204;9796.755081123029;9857.383381202508;9987.800243995225 13:41:04 INFO - PROCESS | 10919 | |3;mootools.html;1258.3771033338498;1448.3192899337312;1462.4588902106223;1596.728556145455;1773.8048814630397;6702.1957365116195;7291.963540182298;7436.814079648005;7467.589282589455;7483.588402637853;7268.890966635505;7309.926900730991;7419.183889772121;7456.217097204783;7490.250974902507;2026.8175864172222;2077.740282464692;2326.2555982085696;2351.2123438648073;2353.8116950643907;2288.5194109236995;2339.590571649963;2342.2856028911174;2342.3792694935855;2342.4495243617735;2253.7408198057187;2267.7958983691465;2329.1149363241943;2330.0796185506715;2332.4285550040263;2276.6015947209253;2283.4405570635217;2290.7365652949875;2338.625819868813;2345.073695890114;2319.512902290521;2328.348062542491;2333.218371845434;2333.953320933572;2338.6492026196206;7554.811129721746;7596.354309883666;7603.695852165962;7608.961955190244;7611.695532178762;4734.692245004098;4845.248986407112;4848.22428411456;4858.004109157614;4858.1012512685265;3128.9374212515622;3151.8581663825184;3151.9842400787848;3207.053919093873;3210.357928414303;962.5898059343026;973.3235401395962;987.4272921705393;993.9552720127612;1015.8679371681634;10532.578696852117;10553.52509137083;10555.577776888915;10581.629642962536;10582.629607963685;4302.139572085595;4347.695661303742;4421.38100665907;4423.314386270134;4424.0709451015;9121.407108538056;9143;9143.63425462974;9155.633774648939;9167.724968250963;4703.318018887242;4721.5750582447745;4729;4741.810327586927;4752.453467851172;4194.979025104855;4236.216299984513;4245;4262.381954616625;4290.721103128287;3433.639467855839;3467.9306413872087;3663.670269675742;3674.7243956703355;3734.141147536082;1173.178774857603;1180.698921774942;1188.4295538141741;1190.2441949362044;1201.7536405036947;1288.6005338345144;1292.5476083370934;1301.0827366706449;1320.3398300849576;1346.4614154338342;6928.341807528277;6966.338197871194;7024.683889224997;7032.859342813115;7036.859262814817;1086.6468397770757;1097.8133717268083;1105.7069876482738;1110.5335758981248;1117.4412793603199;5694.800681976111;5782.421757824268;5785.82642520725;5787.710614469344;5788.305403351541;9211.355205135576;9315.441073535609;9529.90470095304;9537.570809313598;9547.809043819085;9411.152996230372;9413.199878010446;9417.529123543796;9418.764530886783;9423.858642120374;6977.6511174441075;7048.400885924651;7154.284571542804;7217.953396757441;7224.891626625605;7094.716211351488;7105.467089968376;7110.786676399716;7122.5726456412785;7130.180029296697;7990.560519171501;8311;8352.290055345364;8516.659333626585;8525.062243153125;8487.448315859448;8514.78713032179;8522.36082293818;8682.91317086821;8693.34799889998;6696.330366963265;6820.249772524919;6835.555688880207;6836.829079272859;6838;6512.120863683342;6613.305602911625;6886.414654754402;7012.7545535906;7022.719091236293;6517.7067031984625;6623.3376662333385;6640.369164929324;6687.395025194016;6700.698468569024;6503.219613646393;6605.966970165118;6656.633885136364;6678.933210668026;6733.764318248838;6585.176852893388;6616.702248398929;6633.303503132294;6642.335766423319;6644.767433139817;6261.279952805486;6272.843178920563;6329.082283069021;6330.3669633036325;6355.078513615592;6181.84545386369;6194.535409844189;6235.469985051322;6253.218347706536;6256.499480041494 13:41:04 INFO - PROCESS | 10919 | |4;prototype.html;332.25408956891783;334.76399138607286;339.1994892054749;342.9522807822104;345.7994363269303;5762.567807414445;5785.797497087603;5791.189233507307;5792.449717276862;5827.35899051104;5504.256925315081;5569.526590239824;5673;5683.687397193163;5750.137479378085;4480;4512.729236245819;4521.480029796583;4541.2733962566;4547.8635640930825;4313.223619748444;4523.027549076948;4526.275795872661;4530.886727831814;4534.909301813962;4367.061081867398;4394.736315821045;4444.17782710198;4451.154280686659;4459.665525085616;4456.086502267028;4461;4462.152191083684;4467.575580319881;4504.2793153095345;3991.401289806552;3995.580464051291;3998.640462242822;3998.8000599969887;4000.7799571023584;5444.455554444564;5509.256250406184;5534.972325138348;5547.362053363874;5548.0845660465975;5254.8686282842855;5256.710880901549;5257.579393648499;5261.894762104736;5262.184361423947;6149.046897730814;6154.353792851731;6155.076738489218;6155.507559395282;6157.384261573851;4425.601695847357;4427.490838553543;4428.734275943454;4432.756198409086;4434.778261086933;6241.375862413768;6410.134631824691;6420.5184611154355;6440.871182576322;6497.382748638872;4541.000979784442;4544.772761361919;4545.886352841206;4550.112728018071;4551.020306166828;4599.678022538457;4601.4248218972625;4603.217453032992;4605.355250264965;4607.2398054320665;5235.554977826928;5238.135707608279;5248.895022099537;5250.448702886219;5258.6581872178185;6044.486218671374;6151.015837465984;6192.318844927055;6199.535034872402;6199.907001394983;1591.3475475055172;1597.1136019509283;1597.9920100399424;1598.7042397156563;1604.5747876812654;1087.3041253597703;1102.8309991409133;1102.9503672334765;1120.1542835159403;1122.0406552397747;5874.265716785402;5876.500497457679;5878.823635290948;5882.088276317178;5883.852903677357;6340.524460665469;6343.460805831463;6346.27017892939;6346.4605508532295;6347.841303967438;5634.99534318487;5650.943490565124;5824.07805424209;5827.155062515912;5829.883402332014;3328.6172090209934;3370.34278315731;3375.8312084395684;3378.138574663494;3425.2806910548566;6631.336866313427;6640.369164929324;6641.435477984329;6645.401913827779;6648.933510664928;6520.054592084121;6598.769043083469;6601.2738598754095;6614.371634694697;6615.801525954229;6541.215054193527;6660.500462465237;6661.233958094785;6668.499862510331;6676.098726671934;6387.968060159669;6394.71223794921;6396.264429590657;6398.392152745481;6404.839879003062;6329.810105696836;6335.461485773761;6337.081123237012;6344.9048264277;6346.428821405911;6528;6655.900161497679;6657.7669781557415;6670.933290667225;6675.766348177791;4590.2426099693175;4591.701539399928;4594.954050459452;4596.448426188878;4600.516945720785;6372.171617689856;6379.96810015947;6417.6470294132405;6422.839429014312;6430.742770289136;6124.5712800103565;6253.78111766086;6259.280182779039;6266.717997690206;6273.905891411724;6243.406876346739;6252.1559589456665;6254.593451425642;6256.249250090018;6258.655773932477;6152.538559607958;6158.076288556752;6159.505400312881;6160.445559899451;6162.599431037148;6148.9692551536955;6278.058291256348;6284.748610055546;6297.1813664223355;6301.149344838572;5861.443162899518;5934.673592952429;5947.256592925884;6003.519718422428;6022.909656355246 13:41:04 INFO - PROCESS | 10919 | |5;yui.html;667.0527850452357;674.2953613473919;720.909886264217;808.2241048593351;809.3039985612372;12572.685682857933;12644.178128421647;12644.747105057904;12750.936245318784;12752.55366062188;12618.116731828753;12673.493060277578;12685.302308373035;12689.555865544708;12689.746205075893;661.956972796769;670.0752960913932;789.0373744032286;792.4492477727981;805.0379796143611;787.0633945604712;797.6011994002998;800.9879851802227;802.891609632698;803.7387848949086;838.9161083891623;844.5101840932244;850.5279569838737;850.8893843800297;852.9829403411928;693.272064332449;700.7512333121745;814.8329592433566;836.9121242269596;846.6824940647257;620.0667994667996;621.5586933277378;622.2905887288495;622.6264241455091;623.2054130982988;12853.293068881208;12870.22778633285;12887.226766394046;12912;12933.547325843645;12299.815502767466;12869.549565765154;12993.480260789556;13364.532241371506;13409.22082763763;10295.485225738757;10411.947940260327;10466.52900619474;10507.474626268733;10520.263581549294;3577.8747743829103;3583.552055993001;3584.7849129052343;3654.8903532894055;3724.9068773280883;48535.75732121352;48747.512524874655;48918;48923.75538122322;48973.51026489725;9911.504424778732;10108.292419530562;10140.391576505433;10182.18542516597;10280.897191027994;17815.73276400855;18300.08499575016;18302.542436439195;18307.176177072062;18331.908340458212;7293.854122917512;7310.488265821447;7386.409087273005;7463.14173870001;7473.626318684044;4222.704410691222;4241.172971270573;4261.403403523509;4349.456317960255;4358.36803663467;3201.071689210103;3247.57781488405;3247.57781488405;3247.626522949891;3248.2691394436065;597.9880402391927;600.6246096189882;605.140700205709;614.744880874441;617.1699064757984;536.3269097282885;572.7107810555726;641.7208514296296;659.3241927024742;676.2730065179951;7949.801254968672;7968.482048666818;8124.634391452399;8133.918660813434;8333.541655209021;516.7287174233558;527.3513578298638;527.3645257464746;597.1669521018156;630.1272737258929;3561.554805649294;3608.404613238786;3655.981720091436;3739.3082279778328;3867.555231148454;54954.72522637441;55619.721901390236;55995.44004559984;59736;59970.40029599648;44860.55139448629;45835.54164458313;45894.541054589026;46250.30624540635;46725.29912051322;41664.58335416668;42122.57877421248;43081.78459107747;46645.99999999932;47496.5250347499;8138.796530086795;8226.341892648694;8337.333013358795;8345.687365059333;8490.957545212234;34133;34580.82709586537;34877.30245395027;35035.29929401448;35173.47239791354;42309;42448.78775606102;45653.77173114113;46309.536904631874;46803;10386.740331491774;10387.169026477712;10491.527881245209;10505.212109092;10541.841872372073;11198.496067676811;11440.370779607201;11458;11521.942390287995;11855.466504007169;10155.187584993035;10349.482525873827;10671.35971841692;10692.091172250135;10829.566817327219;10615.363078215332;10825.458727063458;10973.177011724312;11090.722731931766;11449.974846714369;9668.9033109668;9986.300958932805;10026.348287361297;10049.447280399649;10426.27016108865;9056.954715226382;9196.448213106967;9245.306602004743;9602.183814375856;9692.660756873476;8100.554469504234;8271.462354946909;8300.169983001651;8608.182222688834;8795.824083518422 13:41:04 INFO - PROCESS | 10919 | __end_tp_report 13:41:04 INFO - PROCESS | 10919 | __start_cc_report 13:41:04 INFO - PROCESS | 10919 | _x_x_mozilla_cycle_collect,996 13:41:04 INFO - PROCESS | 10919 | __end_cc_report 13:41:04 INFO - PROCESS | 10919 | __startTimestamp1452894064733__endTimestamp 13:41:04 INFO - PROCESS | 10919 | 13:41:04 INFO - PROCESS | 10919 | ------- Summary: start ------- 13:41:04 INFO - PROCESS | 10919 | Number of tests: 6 13:41:04 INFO - PROCESS | 10919 | 13:41:04 INFO - PROCESS | 10919 | [#0] dojo.html Cycles:165 Average:5050.45 Median:5290.84 stddev:536.12 (10.1%) stddev-sans-first:515.37 13:41:04 INFO - PROCESS | 10919 | Values: 3095.8 3103.8 3137.8 3146.7 3155.0 4833.3 4911.9 4956.2 4969.6 4972.2 4960.1 5067.6 5067.6 5139.8 5147.1 4615.9 4620.5 4631.7 4670.1 4720.6 4583.3 4638.6 4718.7 4742.4 4761.7 4544.2 4586.4 4587.0 4657.0 4699.8 4594.9 4595.4 4596.5 4601.3 4636.1 4580.2 4581.5 4590.0 4598.6 4632.4 4828.7 4887.4 4945.7 4992.1 5023.2 5402.7 5446.1 5448.8 5449.9 5454.5 5376.8 5470.7 5472.9 5480.6 5537.9 5007.5 5087.1 5100.4 5106.3 5131.6 5539.5 5543.4 5546.1 5549.4 5588.1 5327.5 5332.8 5334.0 5344.3 5396.4 5247.1 5302.1 5355.0 5424.8 5446.1 5367.2 5368.7 5371.4 5374.2 5378.7 5337.7 5385.6 5386.4 5391.8 5436.4 4204.6 4250.2 4273.4 4275.1 4320.7 3825.0 3842.9 3849.2 3880.8 3885.7 4908.1 5072.6 5078.5 5079.8 5128.0 5388.8 5396.5 5444.3 5486.6 5528.8 5043.3 5064.7 5075.1 5075.2 5111.3 4586.7 4675.0 4676.8 4684.0 4717.0 5530.4 5615.9 5657.6 5665.1 5715.5 5400.6 5404.3 5413.6 5414.5 5418.1 5570.9 5623.7 5631.9 5652.3 5668.9 5345.0 5421.9 5426.0 5428.1 5454.4 5361.7 5392.6 5404.5 5406.4 5450.1 5158.4 5218.8 5274.1 5293.2 5307.2 5382.1 5405.1 5406.5 5409.0 5415.4 5300.5 5306.9 5311.7 5316.9 5357.2 5144.2 5290.8 5333.0 5341.6 5411.1 5248.3 5290.2 5301.1 5310.8 5311.2 13:41:04 INFO - PROCESS | 10919 | 13:41:04 INFO - PROCESS | 10919 | [#1] ext.html Cycles:180 Average:40566.49 Median:33543.91 stddev:65173.20 (194.3%) stddev-sans-first:65286.66 13:41:04 INFO - PROCESS | 10919 | Values: 518.6 522.2 529.7 537.4 549.5 28269.3 28944.3 29012.4 29016.7 29033.0 29435.9 29583.7 36600.8 37384.4 37571.6 8301.0 8454.4 8457.2 8458.2 8470.8 8254.7 8372.4 8383.3 8385.8 8390.6 8386.5 8404.4 8447.1 8457.7 8479.0 8447.4 8532.3 8535.1 8535.3 8556.1 8421.7 8484.7 8533.8 8551.2 8560.5 39168.2 39447.0 39545.0 39570.6 39592.0 3161.4 3181.7 3205.6 3215.0 3534.2 29793.3 30013.7 30035.0 30211.0 31330.7 3258.6 3274.5 3313.6 3428.9 3472.5 255877.0 256143.0 256268.0 256601.0 257262.0 50612.7 51649.0 51691.0 57380.4 57769.0 45643.3 63163.0 63183.4 63354.7 63480.0 12991.4 13073.6 13139.8 13150.3 13154.5 8749.0 9729.4 9751.0 9792.2 9794.9 16363.3 19406.5 19547.3 19607.8 20521.4 7044.4 7145.9 7237.4 7265.5 7358.0 967.1 998.2 1008.3 1065.0 1111.8 29452.0 31052.8 31398.1 31484.0 31726.0 995.6 1004.7 1044.7 1065.0 1116.9 14790.7 15267.8 15313.5 15330.8 15516.7 137862.0 138625.3 141004.3 145604.0 147552.0 52360.7 52528.0 52529.0 52529.2 52693.0 1290.5 1297.6 1306.2 1307.6 1311.9 27339.6 29069.6 29155.7 29536.4 29598.6 45161.0 46464.0 46587.8 46595.5 46629.3 313467.0 313507.0 315139.0 315205.0 315351.0 28100.0 28589.3 31521.0 31894.5 31949.4 37178.1 38004.0 38049.6 38184.2 38359.6 33236.7 35629.1 35852.3 35913.5 35980.5 33175.2 33467.2 33701.3 33781.5 34105.7 30341.8 30595.2 32936.5 36305.1 36440.0 27043.9 30152.5 30809.4 32483.4 33620.7 22902.9 23251.8 23877.5 24198.8 24593.4 13:41:04 INFO - PROCESS | 10919 | 13:41:04 INFO - PROCESS | 10919 | [#2] jquery.html Cycles:180 Average:23612.54 Median:273445.88 stddev:69855.81 (25.5%) stddev-sans-first:70029.95 13:41:04 INFO - PROCESS | 10919 | Values: 359.9 362.6 364.8 367.9 368.9 13484.2 13549.0 15525.8 16845.6 17995.7 15300.9 15686.0 16096.2 16124.5 16418.9 5261.2 5456.8 5456.9 5458.8 5459.6 3949.7 4101.4 5309.8 5438.2 5566.5 5696.3 5732.0 5748.1 5752.4 5755.7 5099.6 5284.4 5294.4 5308.3 5311.2 4948.7 5097.7 5131.8 5136.4 5140.4 12395.1 14151.9 19414.6 20328.7 20353.7 2049.6 2072.2 2091.7 2136.6 2227.3 8840.8 9434.8 9525.4 11316.3 12720.9 1728.7 1788.2 1860.9 1893.1 1895.4 55885.7 57325.4 58501.4 58694.0 59016.4 9661.9 9974.4 10079.9 10092.3 10200.5 13244.5 13380.3 13388.6 13406.8 13412.3 6749.6 6858.2 6876.8 6930.3 6972.9 6425.9 6468.7 6501.1 6503.2 6511.8 4372.2 4426.0 4434.7 4453.0 4495.1 1683.5 1771.7 1793.9 1822.5 1842.6 858.2 872.8 873.8 913.0 977.6 13452.6 14616.3 15168.1 15219.8 15437.5 914.6 934.0 943.9 967.9 968.4 7466.0 8987.2 9059.7 9075.5 9281.7 341296.0 341890.0 451633.0 478184.0 497023.0 42068.6 49868.8 53120.7 70706.0 72009.0 1117.0 1118.0 1125.8 1153.4 1153.5 13760.6 14138.2 14289.9 14509.9 14745.2 32249.7 32431.2 32449.0 32958.0 33313.7 39606.4 40488.4 40970.0 42816.6 43084.6 7164.1 7479.4 7617.6 7663.7 7664.3 10703.0 11347.7 11431.8 11502.8 11528.5 9081.5 9581.2 9581.5 9639.6 9741.7 9583.4 9651.6 9702.8 9721.3 10126.6 9294.2 9680.1 9783.5 9801.5 10087.5 7475.0 7519.6 7574.6 7641.7 7659.3 8416.3 9770.0 9796.8 9857.4 9987.8 13:41:04 INFO - PROCESS | 10919 | 13:41:04 INFO - PROCESS | 10919 | [#3] mootools.html Cycles:180 Average:5370.13 Median:6258.89 stddev:2746.13 (43.9%) stddev-sans-first:2736.44 13:41:04 INFO - PROCESS | 10919 | Values: 1258.4 1448.3 1462.5 1596.7 1773.8 6702.2 7292.0 7436.8 7467.6 7483.6 7268.9 7309.9 7419.2 7456.2 7490.3 2026.8 2077.7 2326.3 2351.2 2353.8 2288.5 2339.6 2342.3 2342.4 2342.4 2253.7 2267.8 2329.1 2330.1 2332.4 2276.6 2283.4 2290.7 2338.6 2345.1 2319.5 2328.3 2333.2 2334.0 2338.6 7554.8 7596.4 7603.7 7609.0 7611.7 4734.7 4845.2 4848.2 4858.0 4858.1 3128.9 3151.9 3152.0 3207.1 3210.4 962.6 973.3 987.4 994.0 1015.9 10532.6 10553.5 10555.6 10581.6 10582.6 4302.1 4347.7 4421.4 4423.3 4424.1 9121.4 9143.0 9143.6 9155.6 9167.7 4703.3 4721.6 4729.0 4741.8 4752.5 4195.0 4236.2 4245.0 4262.4 4290.7 3433.6 3467.9 3663.7 3674.7 3734.1 1173.2 1180.7 1188.4 1190.2 1201.8 1288.6 1292.5 1301.1 1320.3 1346.5 6928.3 6966.3 7024.7 7032.9 7036.9 1086.6 1097.8 1105.7 1110.5 1117.4 5694.8 5782.4 5785.8 5787.7 5788.3 9211.4 9315.4 9529.9 9537.6 9547.8 9411.2 9413.2 9417.5 9418.8 9423.9 6977.7 7048.4 7154.3 7218.0 7224.9 7094.7 7105.5 7110.8 7122.6 7130.2 7990.6 8311.0 8352.3 8516.7 8525.1 8487.4 8514.8 8522.4 8682.9 8693.3 6696.3 6820.2 6835.6 6836.8 6838.0 6512.1 6613.3 6886.4 7012.8 7022.7 6517.7 6623.3 6640.4 6687.4 6700.7 6503.2 6606.0 6656.6 6678.9 6733.8 6585.2 6616.7 6633.3 6642.3 6644.8 6261.3 6272.8 6329.1 6330.4 6355.1 6181.8 6194.5 6235.5 6253.2 6256.5 13:41:04 INFO - PROCESS | 10919 | 13:41:04 INFO - PROCESS | 10919 | [#4] prototype.html Cycles:180 Average:5198.50 Median:5808.26 stddev:1542.39 (26.6%) stddev-sans-first:1502.84 13:41:04 INFO - PROCESS | 10919 | Values: 332.3 334.8 339.2 343.0 345.8 5762.6 5785.8 5791.2 5792.4 5827.4 5504.3 5569.5 5673.0 5683.7 5750.1 4480.0 4512.7 4521.5 4541.3 4547.9 4313.2 4523.0 4526.3 4530.9 4534.9 4367.1 4394.7 4444.2 4451.2 4459.7 4456.1 4461.0 4462.2 4467.6 4504.3 3991.4 3995.6 3998.6 3998.8 4000.8 5444.5 5509.3 5535.0 5547.4 5548.1 5254.9 5256.7 5257.6 5261.9 5262.2 6149.0 6154.4 6155.1 6155.5 6157.4 4425.6 4427.5 4428.7 4432.8 4434.8 6241.4 6410.1 6420.5 6440.9 6497.4 4541.0 4544.8 4545.9 4550.1 4551.0 4599.7 4601.4 4603.2 4605.4 4607.2 5235.6 5238.1 5248.9 5250.4 5258.7 6044.5 6151.0 6192.3 6199.5 6199.9 1591.3 1597.1 1598.0 1598.7 1604.6 1087.3 1102.8 1103.0 1120.2 1122.0 5874.3 5876.5 5878.8 5882.1 5883.9 6340.5 6343.5 6346.3 6346.5 6347.8 5635.0 5650.9 5824.1 5827.2 5829.9 3328.6 3370.3 3375.8 3378.1 3425.3 6631.3 6640.4 6641.4 6645.4 6648.9 6520.1 6598.8 6601.3 6614.4 6615.8 6541.2 6660.5 6661.2 6668.5 6676.1 6388.0 6394.7 6396.3 6398.4 6404.8 6329.8 6335.5 6337.1 6344.9 6346.4 6528.0 6655.9 6657.8 6670.9 6675.8 4590.2 4591.7 4595.0 4596.4 4600.5 6372.2 6380.0 6417.6 6422.8 6430.7 6124.6 6253.8 6259.3 6266.7 6273.9 6243.4 6252.2 6254.6 6256.2 6258.7 6152.5 6158.1 6159.5 6160.4 6162.6 6149.0 6278.1 6284.7 6297.2 6301.1 5861.4 5934.7 5947.3 6003.5 6022.9 13:41:04 INFO - PROCESS | 10919 | 13:41:04 INFO - PROCESS | 10919 | [#5] yui.html Cycles:180 Average:13385.84 Median:46072.42 stddev:15567.49 (33.8%) stddev-sans-first:15581.86 13:41:04 INFO - PROCESS | 10919 | Values: 667.1 674.3 720.9 808.2 809.3 12572.7 12644.2 12644.7 12750.9 12752.6 12618.1 12673.5 12685.3 12689.6 12689.7 662.0 670.1 789.0 792.4 805.0 787.1 797.6 801.0 802.9 803.7 838.9 844.5 850.5 850.9 853.0 693.3 700.8 814.8 836.9 846.7 620.1 621.6 622.3 622.6 623.2 12853.3 12870.2 12887.2 12912.0 12933.5 12299.8 12869.5 12993.5 13364.5 13409.2 10295.5 10411.9 10466.5 10507.5 10520.3 3577.9 3583.6 3584.8 3654.9 3724.9 48535.8 48747.5 48918.0 48923.8 48973.5 9911.5 10108.3 10140.4 10182.2 10280.9 17815.7 18300.1 18302.5 18307.2 18331.9 7293.9 7310.5 7386.4 7463.1 7473.6 4222.7 4241.2 4261.4 4349.5 4358.4 3201.1 3247.6 3247.6 3247.6 3248.3 598.0 600.6 605.1 614.7 617.2 536.3 572.7 641.7 659.3 676.3 7949.8 7968.5 8124.6 8133.9 8333.5 516.7 527.4 527.4 597.2 630.1 3561.6 3608.4 3656.0 3739.3 3867.6 54954.7 55619.7 55995.4 59736.0 59970.4 44860.6 45835.5 45894.5 46250.3 46725.3 41664.6 42122.6 43081.8 46646.0 47496.5 8138.8 8226.3 8337.3 8345.7 8491.0 34133.0 34580.8 34877.3 35035.3 35173.5 42309.0 42448.8 45653.8 46309.5 46803.0 10386.7 10387.2 10491.5 10505.2 10541.8 11198.5 11440.4 11458.0 11521.9 11855.5 10155.2 10349.5 10671.4 10692.1 10829.6 10615.4 10825.5 10973.2 11090.7 11450.0 9668.9 9986.3 10026.3 10049.4 10426.3 9057.0 9196.4 9245.3 9602.2 9692.7 8100.6 8271.5 8300.2 8608.2 8795.8 13:41:04 INFO - PROCESS | 10919 | -------- Summary: end -------- 13:41:04 INFO - PROCESS | 10919 | 13:41:05 INFO - TEST-INFO | 10919: exit 0 13:41:05 INFO - TEST-OK | dromaeo_css | took 1112997ms 13:41:05 INFO - TEST-START | kraken 13:41:05 INFO - operating with platform_type : linux_ 13:41:05 INFO - Initialising browser for kraken test... 13:41:05 INFO - TEST-INFO | started process 11116 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps3HD5f/profile http://localhost:55228/getInfo.html) 13:41:09 INFO - PROCESS | 11116 | __metrics Screen width/height:1600/1200 13:41:09 INFO - PROCESS | 11116 | colorDepth:24 13:41:09 INFO - PROCESS | 11116 | Browser inner width/height: 1024/697 13:41:09 INFO - PROCESS | 11116 | __metrics 13:41:09 INFO - PROCESS | 11116 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:41:09 INFO - PROCESS | 11116 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:41:10 INFO - TEST-INFO | 11116: exit 0 13:41:10 INFO - Browser initialized. 13:41:10 INFO - Running cycle 1/1 for kraken test... 13:41:10 INFO - TEST-INFO | started process 11198 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps3HD5f/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:41:22 INFO - PROCESS | 11198 | RSS: Main: 150872064 13:41:22 INFO - PROCESS | 11198 | 13:41:24 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55228/tests/kraken/driver.html?testName=audio-beat-detection) 13:41:25 INFO - PROCESS | 11198 | RSS: Main: 187437056 13:41:25 INFO - PROCESS | 11198 | 13:41:27 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55228/tests/kraken/driver.html?testName=audio-dft) 13:41:28 INFO - PROCESS | 11198 | RSS: Main: 176525312 13:41:28 INFO - PROCESS | 11198 | 13:41:31 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55228/tests/kraken/driver.html?testName=audio-fft) 13:41:31 INFO - PROCESS | 11198 | RSS: Main: 162766848 13:41:31 INFO - PROCESS | 11198 | 13:41:33 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55228/tests/kraken/driver.html?testName=audio-oscillator) 13:41:34 INFO - PROCESS | 11198 | RSS: Main: 164364288 13:41:34 INFO - PROCESS | 11198 | 13:41:36 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:41:37 INFO - PROCESS | 11198 | RSS: Main: 167231488 13:41:37 INFO - PROCESS | 11198 | 13:41:40 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55228/tests/kraken/driver.html?testName=imaging-darkroom) 13:41:40 INFO - PROCESS | 11198 | RSS: Main: 165060608 13:41:40 INFO - PROCESS | 11198 | 13:41:44 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55228/tests/kraken/driver.html?testName=imaging-desaturate) 13:41:44 INFO - PROCESS | 11198 | RSS: Main: 167407616 13:41:44 INFO - PROCESS | 11198 | 13:41:47 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55228/tests/kraken/driver.html?testName=json-parse-financial) 13:41:48 INFO - PROCESS | 11198 | RSS: Main: 165392384 13:41:48 INFO - PROCESS | 11198 | 13:41:49 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:41:50 INFO - PROCESS | 11198 | RSS: Main: 177188864 13:41:50 INFO - PROCESS | 11198 | 13:41:52 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55228/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:41:52 INFO - PROCESS | 11198 | RSS: Main: 174276608 13:41:52 INFO - PROCESS | 11198 | 13:41:54 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:41:55 INFO - PROCESS | 11198 | RSS: Main: 186961920 13:41:55 INFO - PROCESS | 11198 | 13:41:57 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:41:58 INFO - PROCESS | 11198 | RSS: Main: 193708032 13:41:58 INFO - PROCESS | 11198 | 13:42:00 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:42:01 INFO - PROCESS | 11198 | RSS: Main: 191463424 13:42:01 INFO - PROCESS | 11198 | 13:42:02 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:55228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55228/tests/kraken/driver.html?testName=ai-astar) 13:42:03 INFO - PROCESS | 11198 | RSS: Main: 249581568 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | __start_tp_report 13:42:03 INFO - PROCESS | 11198 | _x_x_mozilla_page_load 13:42:03 INFO - PROCESS | 11198 | _x_x_mozilla_page_load_details 13:42:03 INFO - PROCESS | 11198 | |i|pagename|runs| 13:42:03 INFO - PROCESS | 11198 | |0;ai-astar;109;109;103;110;110;110;99;109;110;110 13:42:03 INFO - PROCESS | 11198 | |1;audio-beat-detection;145;125;152;170;138;153;152;123;171;126 13:42:03 INFO - PROCESS | 11198 | |2;audio-dft;164;161;161;159;160;161;160;162;161;160 13:42:03 INFO - PROCESS | 11198 | |3;audio-fft;71;71;115;104;74;71;71;103;90;75 13:42:03 INFO - PROCESS | 11198 | |4;audio-oscillator;97;97;154;97;97;97;140;96;97;138 13:42:03 INFO - PROCESS | 11198 | |5;imaging-gaussian-blur;108;108;109;109;109;109;109;109;110;109 13:42:03 INFO - PROCESS | 11198 | |6;imaging-darkroom;146;145;145;149;145;145;145;146;145;146 13:42:03 INFO - PROCESS | 11198 | |7;imaging-desaturate;96;96;95;95;96;96;97;96;96;96 13:42:03 INFO - PROCESS | 11198 | |8;json-parse-financial;56;55;56;55;56;55;55;64;55;53 13:42:03 INFO - PROCESS | 11198 | |9;json-stringify-tinderbox;66;66;67;67;68;68;66;67;67;67 13:42:03 INFO - PROCESS | 11198 | |10;stanford-crypto-aes;81;82;83;83;81;86;89;82;90;82 13:42:03 INFO - PROCESS | 11198 | |11;stanford-crypto-ccm;113;114;125;113;112;117;121;114;114;114 13:42:03 INFO - PROCESS | 11198 | |12;stanford-crypto-pbkdf2;145;136;147;144;144;135;148;144;144;144 13:42:03 INFO - PROCESS | 11198 | |13;stanford-crypto-sha256-iterative;66;68;68;65;68;68;66;68;67;69 13:42:03 INFO - PROCESS | 11198 | __end_tp_report 13:42:03 INFO - PROCESS | 11198 | __start_cc_report 13:42:03 INFO - PROCESS | 11198 | _x_x_mozilla_cycle_collect,950 13:42:03 INFO - PROCESS | 11198 | __end_cc_report 13:42:03 INFO - PROCESS | 11198 | __startTimestamp1452894123219__endTimestamp 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | ------- Summary: start ------- 13:42:03 INFO - PROCESS | 11198 | Number of tests: 14 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.00 stddev:3.78 (3.4%) stddev-sans-first:3.99 13:42:03 INFO - PROCESS | 11198 | Values: 109.0 109.0 103.0 110.0 110.0 110.0 99.0 109.0 110.0 110.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:152.00 stddev:17.49 (11.5%) stddev-sans-first:18.55 13:42:03 INFO - PROCESS | 11198 | Values: 145.0 125.0 152.0 170.0 138.0 153.0 152.0 123.0 171.0 126.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.37 (0.9%) stddev-sans-first:0.88 13:42:03 INFO - PROCESS | 11198 | Values: 164.0 161.0 161.0 159.0 160.0 161.0 160.0 162.0 161.0 160.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#3] audio-fft Cycles:10 Average:84.50 Median:71.00 stddev:17.04 (24.0%) stddev-sans-first:17.36 13:42:03 INFO - PROCESS | 11198 | Values: 71.0 71.0 115.0 104.0 74.0 71.0 71.0 103.0 90.0 75.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:97.00 stddev:23.14 (23.9%) stddev-sans-first:23.98 13:42:03 INFO - PROCESS | 11198 | Values: 97.0 97.0 154.0 97.0 97.0 97.0 140.0 96.0 97.0 138.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 13:42:03 INFO - PROCESS | 11198 | Values: 108.0 108.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:145.50 stddev:1.25 (0.9%) stddev-sans-first:1.32 13:42:03 INFO - PROCESS | 11198 | Values: 146.0 145.0 145.0 149.0 145.0 145.0 145.0 146.0 145.0 146.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:42:03 INFO - PROCESS | 11198 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.50 stddev:2.94 (5.3%) stddev-sans-first:3.12 13:42:03 INFO - PROCESS | 11198 | Values: 56.0 55.0 56.0 55.0 56.0 55.0 55.0 64.0 55.0 53.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 13:42:03 INFO - PROCESS | 11198 | Values: 66.0 66.0 67.0 67.0 68.0 68.0 66.0 67.0 67.0 67.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:3.28 (4.0%) stddev-sans-first:3.31 13:42:03 INFO - PROCESS | 11198 | Values: 81.0 82.0 83.0 83.0 81.0 86.0 89.0 82.0 90.0 82.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:114.00 stddev:4.16 (3.7%) stddev-sans-first:4.30 13:42:03 INFO - PROCESS | 11198 | Values: 113.0 114.0 125.0 113.0 112.0 117.0 121.0 114.0 114.0 114.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:144.00 stddev:4.25 (3.0%) stddev-sans-first:4.46 13:42:03 INFO - PROCESS | 11198 | Values: 145.0 136.0 147.0 144.0 144.0 135.0 148.0 144.0 144.0 144.0 13:42:03 INFO - PROCESS | 11198 | 13:42:03 INFO - PROCESS | 11198 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.24 13:42:03 INFO - PROCESS | 11198 | Values: 66.0 68.0 68.0 65.0 68.0 68.0 66.0 68.0 67.0 69.0 13:42:03 INFO - PROCESS | 11198 | -------- Summary: end -------- 13:42:03 INFO - PROCESS | 11198 | 13:42:04 INFO - TEST-INFO | 11198: exit 0 13:42:04 INFO - TEST-OK | kraken | took 58722ms 13:42:04 INFO - TEST-START | v8_7 13:42:04 INFO - operating with platform_type : linux_ 13:42:04 INFO - Initialising browser for v8_7 test... 13:42:04 INFO - TEST-INFO | started process 11447 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpykiznl/profile http://localhost:55228/getInfo.html) 13:42:07 INFO - PROCESS | 11447 | __metrics Screen width/height:1600/1200 13:42:07 INFO - PROCESS | 11447 | colorDepth:24 13:42:07 INFO - PROCESS | 11447 | Browser inner width/height: 1024/697 13:42:07 INFO - PROCESS | 11447 | __metrics 13:42:07 INFO - PROCESS | 11447 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:42:08 INFO - PROCESS | 11447 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:42:09 INFO - TEST-INFO | 11447: exit 0 13:42:09 INFO - Browser initialized. 13:42:09 INFO - Running cycle 1/1 for v8_7 test... 13:42:09 INFO - TEST-INFO | started process 11529 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpykiznl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:42:20 INFO - PROCESS | 11529 | RSS: Main: 150695936 13:42:20 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | Cycle 1(1): loaded http://localhost:55228/tests/v8_7/run.html (next: http://localhost:55228/tests/v8_7/run.html) 13:42:43 INFO - PROCESS | 11529 | RSS: Main: 577953792 13:42:43 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | __start_tp_report 13:42:43 INFO - PROCESS | 11529 | _x_x_mozilla_page_load 13:42:43 INFO - PROCESS | 11529 | _x_x_mozilla_page_load_details 13:42:43 INFO - PROCESS | 11529 | |i|pagename|runs| 13:42:43 INFO - PROCESS | 11529 | |0;Richards;166.86133822793258 13:42:43 INFO - PROCESS | 11529 | |1;DeltaBlue;188.67924528301887 13:42:43 INFO - PROCESS | 11529 | |2;Encrypt;280.19052956010086 13:42:43 INFO - PROCESS | 11529 | |3;Decrypt;5235.602094240838 13:42:43 INFO - PROCESS | 11529 | |4;RayTrace;1932.4324324324325 13:42:43 INFO - PROCESS | 11529 | |5;Earley;771.0100231303007 13:42:43 INFO - PROCESS | 11529 | |6;Boyer;12144.578313253012 13:42:43 INFO - PROCESS | 11529 | |7;RegExp;42061.22448979592 13:42:43 INFO - PROCESS | 11529 | |8;Splay;630.119722747322 13:42:43 INFO - PROCESS | 11529 | |9;NavierStokes;4840.579710144928 13:42:43 INFO - PROCESS | 11529 | __end_tp_report 13:42:43 INFO - PROCESS | 11529 | __startTimestamp1452894163668__endTimestamp 13:42:43 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | ------- Summary: start ------- 13:42:43 INFO - PROCESS | 11529 | Number of tests: 10 13:42:43 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | [#0] Richards Cycles:1 Average:166.86 Median:166.86 stddev:0.00 (0.0%) 13:42:43 INFO - PROCESS | 11529 | Values: 166.9 13:42:43 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | [#1] DeltaBlue Cycles:1 Average:188.68 Median:188.68 stddev:0.00 (0.0%) 13:42:43 INFO - PROCESS | 11529 | Values: 188.7 13:42:43 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 13:42:43 INFO - PROCESS | 11529 | Values: 280.2 13:42:43 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 13:42:43 INFO - PROCESS | 11529 | Values: 5235.6 13:42:43 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | [#4] RayTrace Cycles:1 Average:1932.43 Median:1932.43 stddev:0.00 (0.0%) 13:42:43 INFO - PROCESS | 11529 | Values: 1932.4 13:42:43 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | [#5] Earley Cycles:1 Average:771.01 Median:771.01 stddev:0.00 (0.0%) 13:42:43 INFO - PROCESS | 11529 | Values: 771.0 13:42:43 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 13:42:43 INFO - PROCESS | 11529 | Values: 12144.6 13:42:43 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | [#7] RegExp Cycles:1 Average:42061.22 Median:42061.22 stddev:0.00 (0.0%) 13:42:43 INFO - PROCESS | 11529 | Values: 42061.2 13:42:43 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | [#8] Splay Cycles:1 Average:630.12 Median:630.12 stddev:0.00 (0.0%) 13:42:43 INFO - PROCESS | 11529 | Values: 630.1 13:42:43 INFO - PROCESS | 11529 | 13:42:43 INFO - PROCESS | 11529 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 13:42:43 INFO - PROCESS | 11529 | Values: 4840.6 13:42:43 INFO - PROCESS | 11529 | -------- Summary: end -------- 13:42:43 INFO - PROCESS | 11529 | 13:42:44 INFO - TEST-INFO | 11529: exit 0 13:42:44 INFO - TEST-OK | v8_7 | took 40443ms 13:42:44 INFO - SUITE-END | took 1212s 13:42:44 INFO - Completed test suite (00:20:12) 13:42:44 INFO - Working with test: dromaeo_css 13:42:44 INFO - Generating results file: dromaeo_css 13:42:44 INFO - Working with test: kraken 13:42:44 INFO - Generating results file: kraken 13:42:44 INFO - javascript benchmark 13:42:44 INFO - Working with test: v8_7 13:42:44 INFO - Generating results file: v8_7 13:42:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:42:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 13:42:44 INFO - process_Request line: dromaeo_css 6657.33 graph.html#tests=[[72,64,35]] 13:42:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:42:44 INFO - process_Request line: kraken 1493.20 graph.html#tests=[[232,64,35]] 13:42:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:42:44 INFO - process_Request line: v8_7 18924.35 graph.html#tests=[[230,64,35]] 13:42:44 INFO - RETURN: dromaeo_css: 6657.33 13:42:44 INFO - RETURN: kraken: 1493.20 13:42:44 INFO - RETURN: v8_7: 18924.35 13:42:44 INFO - javascript benchmark 13:42:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3095.8297293648848, 3103.8292893890825, 3137.811731296124, 3146.7325277351424, 3155.0219431976084, 4833.323334733132, 4911.9017619647675, 4956.182229932061, 4969.602431805456, 4972.22930445781, 4960.082384758822, 5067.594592432606, 5067.6452648314635, 5139.820106296281, 5147.0992576299095, 4615.861524154281, 4620.537946205386, 4631.675782695213, 4670.065986802636, 4720.64595155363, 4583.289590113521, 4638.628909687234, 4718.740469274188, 4742.4309082910095, 4761.690490118149, 4544.227481328182, 4586.3579098926175, 4587.036722288323, 4657.0, 4699.765011749416, 4594.908101837945, 4595.356650068993, 4596.471405788344, 4601.332806743037, 4636.142313671981, 4580.152671755736, 4581.518940511231, 4589.954100458986, 4598.632109431237, 4632.3977882875015, 4828.73441960692, 4887.36464259644, 4945.727984960826, 4992.101421744084, 5023.246513023076, 5402.702851343174, 5446.101393270105, 5448.754806033738, 5449.945500545023, 5454.4545545445535, 5376.758045887906, 5470.671759694391, 5472.890542189174, 5480.616356855022, 5537.944620553783, 5007.474215207387, 5087.109755792721, 5100.362454693163, 5106.259592359124, 5131.640785145079, 5539.501444869981, 5543.390227075019, 5546.112621980464, 5549.38956714761, 5588.133839254922, 5327.547158491494, 5332.840014799563, 5333.973330133402, 5344.251804747339, 5396.433374495621, 5247.05553000456, 5302.125149350314, 5354.982553314858, 5424.755885985141, 5446.128619420953, 5367.221752845893, 5368.731563421813, 5371.409144994048, 5374.220737992969, 5378.704171270618, 5337.706426146521, 5385.649932754359, 5386.434424385383, 5391.757370918318, 5436.401995780461, 4204.62158405745, 4250.23495770758, 4273.380359847804, 4275.144971005811, 4320.697551171451, 3824.980875095662, 3842.865499707497, 3849.2109117630816, 3880.7865567394065, 3885.7279990400402, 4908.116539022939, 5072.594192464594, 5078.517540833689, 5079.796808127708, 5128.00003999224, 5388.757505912244, 5396.487333703292, 5444.265024221759, 5486.615936884459, 5528.834134975958, 5043.3443652325695, 5064.746762661852, 5075.086484432837, 5075.187969924795, 5111.284420181178, 4586.72479651222, 4674.953250467452, 4676.789544470439, 4683.95316046842, 4717.033008233304, 5530.446955304518, 5615.9157612635845, 5657.57568182388, 5665.12190610456, 5715.5427565794635, 5400.648957817729, 5404.297441332602, 5413.648112872651, 5414.539764119936, 5418.051840927901, 5570.944290557205, 5623.746931388179, 5631.887362252814, 5652.293463317085, 5668.914966275592, 5345.0, 5421.891562168814, 5425.972870135624, 5428.104362780097, 5454.400015998316, 5361.731913404392, 5392.595555333287, 5404.54061404785, 5406.432324605859, 5450.073487507054, 5158.432572416956, 5218.817341393033, 5274.12976858814, 5293.179557168645, 5307.150855863043, 5382.058139825594, 5405.108157154025, 5406.486383793534, 5408.972955135199, 5415.350157981067, 5300.469953004668, 5306.920396193983, 5311.707856067954, 5316.946830531645, 5357.223202635674, 5144.228365745168, 5290.841274761763, 5333.0, 5341.572674186134, 5411.134218525017, 5248.265242866079, 5290.232916227203, 5301.098813201688, 5310.787568497217, 5311.229871668664], "unit": "score", "name": "dojo.html", "value": 5017.68027613862}, {"lowerIsBetter": false, "replicates": [518.631771442276, 522.1723568144491, 529.7218960045975, 537.4195868462061, 549.4944650921152, 28269.293267668294, 28944.276393090182, 29012.419751605008, 29016.709832901666, 29033.0, 29435.85282073592, 29583.704162958365, 36600.81699591505, 37384.43923341152, 37571.624283757155, 8300.958495207531, 8454.365922555833, 8457.238848503634, 8458.238758511732, 8470.830583388328, 8254.669813207465, 8372.413931024801, 8383.287420569259, 8385.790355241106, 8390.622421991025, 8386.538740369277, 8404.369672274574, 8447.070822209553, 8457.746267611981, 8479.0, 8447.36644751643, 8532.31741460688, 8535.103814099522, 8535.317174626016, 8556.058833528306, 8421.747347579583, 8484.703035393732, 8533.786655333604, 8551.230389264934, 8560.529170895597, 39168.21663566741, 39447.0, 39545.0, 39570.60429395698, 39592.0, 3161.399334126532, 3181.729552987999, 3205.5512228288057, 3215.0, 3534.2224710563637, 29793.25516862074, 30013.699863001308, 30035.0, 30211.0, 31330.686693133233, 3258.6252580953255, 3274.5415641810164, 3313.5692359993045, 3428.8971330860113, 3472.5485686860798, 255877.0, 256143.0, 256268.0, 256601.0, 257262.0, 50612.74693626508, 51649.0, 51691.0, 57380.426195737506, 57769.0, 45643.315350269775, 63163.0, 63183.368166318665, 63354.68322658357, 63480.0, 12991.350432478339, 13073.607791766262, 13139.802902956464, 13150.342482875818, 13154.539591114266, 8749.0, 9729.367591106555, 9751.024897510193, 9792.167665748491, 9794.853077203848, 16363.345466181458, 19406.514837129183, 19547.267650578324, 19607.803921960596, 20521.38435846927, 7044.436445084381, 7145.8928116078305, 7237.407770290528, 7265.491415600963, 7358.00666909971, 967.1295833749682, 998.1615443027891, 1008.2941940641433, 1064.9733756656146, 1111.8221084626582, 29452.0, 31052.844735776176, 31398.055730399963, 31484.0, 31726.0, 995.6017592962872, 1004.703612434319, 1044.749260177567, 1064.989350106489, 1116.8827273136367, 14790.704185916436, 15267.847321526864, 15313.464028759163, 15330.770038449433, 15516.689666206612, 137862.0, 138625.306873467, 141004.29497852444, 145604.0, 147552.0, 52360.738196308776, 52528.0, 52529.0, 52529.212061819104, 52693.0, 1290.490256348737, 1297.6042307096427, 1306.2097431054265, 1307.6469353274563, 1311.9409626566828, 27339.58990615182, 29069.563956540245, 29155.7084429153, 29536.409271814875, 29598.556021660122, 45161.0, 46464.0, 46587.76706116583, 46595.53404465912, 46629.30056049094, 313467.0, 313507.0, 315139.0, 315205.0, 315351.0, 28100.0, 28589.28526786764, 31521.0, 31894.52158217582, 31949.36101278008, 37178.07054823651, 38004.04989875165, 38049.619503804606, 38184.236315274095, 38359.61640383672, 33236.66763332432, 35629.109272268404, 35852.28295434129, 35913.46129808107, 35980.4602930951, 33175.17062073467, 33467.16332091717, 33701.32597348088, 33781.49327760036, 34105.65894341025, 30341.848290759288, 30595.2351191222, 32936.505952410254, 36305.092372690895, 36440.0, 27043.86478067597, 30152.54771178478, 30809.383812324075, 32483.350332992733, 33620.663793362735, 22902.885485573133, 23251.76748232496, 23877.522449550564, 24198.75801241965, 24593.385165371008], "unit": "score", "name": "ext.html", "value": 17187.72509159497}, {"lowerIsBetter": false, "replicates": [359.89383131976064, 362.56130082600055, 364.8449409001175, 367.9135403180254, 368.8616768711735, 13484.190948543095, 13549.0, 15525.767113493306, 16845.578860528494, 17995.730064049032, 15300.923495382536, 15686.0, 16096.1951902405, 16124.516264512054, 16418.917905410486, 5261.2371206175085, 5456.7544460499175, 5456.945430545703, 5458.754356053987, 5459.590530710193, 3949.7432666876703, 4101.364288535282, 5309.840704778843, 5438.15708565173, 5566.526845218141, 5696.259486266779, 5732.0, 5748.080307150857, 5752.367239603661, 5755.65466072037, 5099.617528685345, 5284.4187139414635, 5294.391145018334, 5308.283381743473, 5311.203319502067, 4948.7278199699, 5097.7196254206, 5131.846044618667, 5136.383633963911, 5140.357455318085, 12395.132340736152, 14151.858481415156, 19414.611707765907, 20328.69506957397, 20353.694694579593, 2049.5695903860205, 2072.1504183284783, 2091.6653335466253, 2136.647453170225, 2227.276135256032, 8840.778980525474, 9434.811303773955, 9525.380850244712, 11316.321020738782, 12720.855123038878, 1728.6974779413679, 1788.2131861980688, 1860.8697391182623, 1893.1102381880494, 1895.3555791031115, 55885.72057139729, 57325.426745732846, 58501.414985850446, 58694.0, 59016.40983590195, 9661.903380966241, 9974.401535907724, 10079.949600251952, 10092.293539452316, 10200.489975501196, 13244.470221191044, 13380.264085475197, 13388.598342049754, 13406.798898016537, 13412.329383530785, 6749.628770417576, 6858.177018757681, 6876.828079298058, 6930.272321406281, 6972.895406568906, 6425.903611445832, 6468.708908099147, 6501.0898474213645, 6503.187101612299, 6511.804645860631, 4372.23485889968, 4426.048399594103, 4434.689571730012, 4453.0, 4495.100979804052, 1683.4697070423022, 1771.6988112020988, 1793.8744287899983, 1822.535253510373, 1842.6222624361974, 858.2275951643571, 872.8297981893597, 873.7854382408457, 913.0413066280512, 977.5747549815853, 13452.596422107157, 14616.342264598119, 15168.103987001625, 15219.771703424458, 15437.536873893801, 914.5884352041608, 934.0426063285051, 943.9103285187896, 967.9370840895319, 968.4141094637642, 7466.0, 8987.236084932854, 9059.682911098213, 9075.455472671529, 9281.72154835356, 341296.0, 341890.0, 451633.0, 478184.0, 497023.0, 42068.579314206465, 49868.750656246484, 53120.734396327774, 70706.0, 72009.0, 1116.9553217871357, 1118.0496577908875, 1125.7748450309807, 1153.400231879418, 1153.5443499817525, 13760.587182384545, 14138.22239776822, 14289.928550357181, 14509.85490145085, 14745.1890146043, 32249.677503224666, 32431.189220269684, 32449.0, 32958.0, 33313.669223000856, 39606.40590391204, 40488.3926741105, 40970.0, 42816.57183428126, 43084.569154308054, 7164.140303163445, 7479.364254038468, 7617.619119044137, 7663.655135518804, 7664.271894170045, 10703.0, 11347.716307092389, 11431.771364572829, 11502.82745758831, 11528.496762696088, 9081.54592270397, 9581.185599224144, 9581.473018984023, 9639.614415423304, 9741.707748767549, 9583.377080489747, 9651.613935442785, 9702.805943881223, 9721.319507634398, 10126.645567405105, 9294.163525282756, 9680.128788408796, 9783.51082445889, 9801.460919649488, 10087.495625218857, 7475.0, 7519.586422746802, 7574.621268936421, 7641.732539361095, 7659.348955338635, 8416.3266938646, 9769.951150244204, 9796.755081123029, 9857.383381202508, 9987.800243995225], "unit": "score", "name": "jquery.html", "value": 7921.818609311578}, {"lowerIsBetter": false, "replicates": [1258.3771033338498, 1448.3192899337312, 1462.4588902106223, 1596.728556145455, 1773.8048814630397, 6702.1957365116195, 7291.963540182298, 7436.814079648005, 7467.589282589455, 7483.588402637853, 7268.890966635505, 7309.926900730991, 7419.183889772121, 7456.217097204783, 7490.250974902507, 2026.8175864172222, 2077.740282464692, 2326.2555982085696, 2351.2123438648073, 2353.8116950643907, 2288.5194109236995, 2339.590571649963, 2342.2856028911174, 2342.3792694935855, 2342.4495243617735, 2253.7408198057187, 2267.7958983691465, 2329.1149363241943, 2330.0796185506715, 2332.4285550040263, 2276.6015947209253, 2283.4405570635217, 2290.7365652949875, 2338.625819868813, 2345.073695890114, 2319.512902290521, 2328.348062542491, 2333.218371845434, 2333.953320933572, 2338.6492026196206, 7554.811129721746, 7596.354309883666, 7603.695852165962, 7608.961955190244, 7611.695532178762, 4734.692245004098, 4845.248986407112, 4848.22428411456, 4858.004109157614, 4858.1012512685265, 3128.9374212515622, 3151.8581663825184, 3151.9842400787848, 3207.053919093873, 3210.357928414303, 962.5898059343026, 973.3235401395962, 987.4272921705393, 993.9552720127612, 1015.8679371681634, 10532.578696852117, 10553.52509137083, 10555.577776888915, 10581.629642962536, 10582.629607963685, 4302.139572085595, 4347.695661303742, 4421.38100665907, 4423.314386270134, 4424.0709451015, 9121.407108538056, 9143.0, 9143.63425462974, 9155.633774648939, 9167.724968250963, 4703.318018887242, 4721.5750582447745, 4729.0, 4741.810327586927, 4752.453467851172, 4194.979025104855, 4236.216299984513, 4245.0, 4262.381954616625, 4290.721103128287, 3433.639467855839, 3467.9306413872087, 3663.670269675742, 3674.7243956703355, 3734.141147536082, 1173.178774857603, 1180.698921774942, 1188.4295538141741, 1190.2441949362044, 1201.7536405036947, 1288.6005338345144, 1292.5476083370934, 1301.0827366706449, 1320.3398300849576, 1346.4614154338342, 6928.341807528277, 6966.338197871194, 7024.683889224997, 7032.859342813115, 7036.859262814817, 1086.6468397770757, 1097.8133717268083, 1105.7069876482738, 1110.5335758981248, 1117.4412793603199, 5694.800681976111, 5782.421757824268, 5785.82642520725, 5787.710614469344, 5788.305403351541, 9211.355205135576, 9315.441073535609, 9529.90470095304, 9537.570809313598, 9547.809043819085, 9411.152996230372, 9413.199878010446, 9417.529123543796, 9418.764530886783, 9423.858642120374, 6977.6511174441075, 7048.400885924651, 7154.284571542804, 7217.953396757441, 7224.891626625605, 7094.716211351488, 7105.467089968376, 7110.786676399716, 7122.5726456412785, 7130.180029296697, 7990.560519171501, 8311.0, 8352.290055345364, 8516.659333626585, 8525.062243153125, 8487.448315859448, 8514.78713032179, 8522.36082293818, 8682.91317086821, 8693.34799889998, 6696.330366963265, 6820.249772524919, 6835.555688880207, 6836.829079272859, 6838.0, 6512.120863683342, 6613.305602911625, 6886.414654754402, 7012.7545535906, 7022.719091236293, 6517.7067031984625, 6623.3376662333385, 6640.369164929324, 6687.395025194016, 6700.698468569024, 6503.219613646393, 6605.966970165118, 6656.633885136364, 6678.933210668026, 6733.764318248838, 6585.176852893388, 6616.702248398929, 6633.303503132294, 6642.335766423319, 6644.767433139817, 6261.279952805486, 6272.843178920563, 6329.082283069021, 6330.3669633036325, 6355.078513615592, 6181.84545386369, 6194.535409844189, 6235.469985051322, 6253.218347706536, 6256.499480041494], "unit": "score", "name": "mootools.html", "value": 4448.562711459691}, {"lowerIsBetter": false, "replicates": [332.25408956891783, 334.76399138607286, 339.1994892054749, 342.9522807822104, 345.7994363269303, 5762.567807414445, 5785.797497087603, 5791.189233507307, 5792.449717276862, 5827.35899051104, 5504.256925315081, 5569.526590239824, 5673.0, 5683.687397193163, 5750.137479378085, 4480.0, 4512.729236245819, 4521.480029796583, 4541.2733962566, 4547.8635640930825, 4313.223619748444, 4523.027549076948, 4526.275795872661, 4530.886727831814, 4534.909301813962, 4367.061081867398, 4394.736315821045, 4444.17782710198, 4451.154280686659, 4459.665525085616, 4456.086502267028, 4461.0, 4462.152191083684, 4467.575580319881, 4504.2793153095345, 3991.401289806552, 3995.580464051291, 3998.640462242822, 3998.8000599969887, 4000.7799571023584, 5444.455554444564, 5509.256250406184, 5534.972325138348, 5547.362053363874, 5548.0845660465975, 5254.8686282842855, 5256.710880901549, 5257.579393648499, 5261.894762104736, 5262.184361423947, 6149.046897730814, 6154.353792851731, 6155.076738489218, 6155.507559395282, 6157.384261573851, 4425.601695847357, 4427.490838553543, 4428.734275943454, 4432.756198409086, 4434.778261086933, 6241.375862413768, 6410.134631824691, 6420.5184611154355, 6440.871182576322, 6497.382748638872, 4541.000979784442, 4544.772761361919, 4545.886352841206, 4550.112728018071, 4551.020306166828, 4599.678022538457, 4601.4248218972625, 4603.217453032992, 4605.355250264965, 4607.2398054320665, 5235.554977826928, 5238.135707608279, 5248.895022099537, 5250.448702886219, 5258.6581872178185, 6044.486218671374, 6151.015837465984, 6192.318844927055, 6199.535034872402, 6199.907001394983, 1591.3475475055172, 1597.1136019509283, 1597.9920100399424, 1598.7042397156563, 1604.5747876812654, 1087.3041253597703, 1102.8309991409133, 1102.9503672334765, 1120.1542835159403, 1122.0406552397747, 5874.265716785402, 5876.500497457679, 5878.823635290948, 5882.088276317178, 5883.852903677357, 6340.524460665469, 6343.460805831463, 6346.27017892939, 6346.4605508532295, 6347.841303967438, 5634.99534318487, 5650.943490565124, 5824.07805424209, 5827.155062515912, 5829.883402332014, 3328.6172090209934, 3370.34278315731, 3375.8312084395684, 3378.138574663494, 3425.2806910548566, 6631.336866313427, 6640.369164929324, 6641.435477984329, 6645.401913827779, 6648.933510664928, 6520.054592084121, 6598.769043083469, 6601.2738598754095, 6614.371634694697, 6615.801525954229, 6541.215054193527, 6660.500462465237, 6661.233958094785, 6668.499862510331, 6676.098726671934, 6387.968060159669, 6394.71223794921, 6396.264429590657, 6398.392152745481, 6404.839879003062, 6329.810105696836, 6335.461485773761, 6337.081123237012, 6344.9048264277, 6346.428821405911, 6528.0, 6655.900161497679, 6657.7669781557415, 6670.933290667225, 6675.766348177791, 4590.2426099693175, 4591.701539399928, 4594.954050459452, 4596.448426188878, 4600.516945720785, 6372.171617689856, 6379.96810015947, 6417.6470294132405, 6422.839429014312, 6430.742770289136, 6124.5712800103565, 6253.78111766086, 6259.280182779039, 6266.717997690206, 6273.905891411724, 6243.406876346739, 6252.1559589456665, 6254.593451425642, 6256.249250090018, 6258.655773932477, 6152.538559607958, 6158.076288556752, 6159.505400312881, 6160.445559899451, 6162.599431037148, 6148.9692551536955, 6278.058291256348, 6284.748610055546, 6297.1813664223355, 6301.149344838572, 5861.443162899518, 5934.673592952429, 5947.256592925884, 6003.519718422428, 6022.909656355246], "unit": "score", "name": "prototype.html", "value": 4703.283674670237}, {"lowerIsBetter": false, "replicates": [667.0527850452357, 674.2953613473919, 720.909886264217, 808.2241048593351, 809.3039985612372, 12572.685682857933, 12644.178128421647, 12644.747105057904, 12750.936245318784, 12752.55366062188, 12618.116731828753, 12673.493060277578, 12685.302308373035, 12689.555865544708, 12689.746205075893, 661.956972796769, 670.0752960913932, 789.0373744032286, 792.4492477727981, 805.0379796143611, 787.0633945604712, 797.6011994002998, 800.9879851802227, 802.891609632698, 803.7387848949086, 838.9161083891623, 844.5101840932244, 850.5279569838737, 850.8893843800297, 852.9829403411928, 693.272064332449, 700.7512333121745, 814.8329592433566, 836.9121242269596, 846.6824940647257, 620.0667994667996, 621.5586933277378, 622.2905887288495, 622.6264241455091, 623.2054130982988, 12853.293068881208, 12870.22778633285, 12887.226766394046, 12912.0, 12933.547325843645, 12299.815502767466, 12869.549565765154, 12993.480260789556, 13364.532241371506, 13409.22082763763, 10295.485225738757, 10411.947940260327, 10466.52900619474, 10507.474626268733, 10520.263581549294, 3577.8747743829103, 3583.552055993001, 3584.7849129052343, 3654.8903532894055, 3724.9068773280883, 48535.75732121352, 48747.512524874655, 48918.0, 48923.75538122322, 48973.51026489725, 9911.504424778732, 10108.292419530562, 10140.391576505433, 10182.18542516597, 10280.897191027994, 17815.73276400855, 18300.08499575016, 18302.542436439195, 18307.176177072062, 18331.908340458212, 7293.854122917512, 7310.488265821447, 7386.409087273005, 7463.14173870001, 7473.626318684044, 4222.704410691222, 4241.172971270573, 4261.403403523509, 4349.456317960255, 4358.36803663467, 3201.071689210103, 3247.57781488405, 3247.57781488405, 3247.626522949891, 3248.2691394436065, 597.9880402391927, 600.6246096189882, 605.140700205709, 614.744880874441, 617.1699064757984, 536.3269097282885, 572.7107810555726, 641.7208514296296, 659.3241927024742, 676.2730065179951, 7949.801254968672, 7968.482048666818, 8124.634391452399, 8133.918660813434, 8333.541655209021, 516.7287174233558, 527.3513578298638, 527.3645257464746, 597.1669521018156, 630.1272737258929, 3561.554805649294, 3608.404613238786, 3655.981720091436, 3739.3082279778328, 3867.555231148454, 54954.72522637441, 55619.721901390236, 55995.44004559984, 59736.0, 59970.40029599648, 44860.55139448629, 45835.54164458313, 45894.541054589026, 46250.30624540635, 46725.29912051322, 41664.58335416668, 42122.57877421248, 43081.78459107747, 46645.99999999932, 47496.5250347499, 8138.796530086795, 8226.341892648694, 8337.333013358795, 8345.687365059333, 8490.957545212234, 34133.0, 34580.82709586537, 34877.30245395027, 35035.29929401448, 35173.47239791354, 42309.0, 42448.78775606102, 45653.77173114113, 46309.536904631874, 46803.0, 10386.740331491774, 10387.169026477712, 10491.527881245209, 10505.212109092, 10541.841872372073, 11198.496067676811, 11440.370779607201, 11458.0, 11521.942390287995, 11855.466504007169, 10155.187584993035, 10349.482525873827, 10671.35971841692, 10692.091172250135, 10829.566817327219, 10615.363078215332, 10825.458727063458, 10973.177011724312, 11090.722731931766, 11449.974846714369, 9668.9033109668, 9986.300958932805, 10026.348287361297, 10049.447280399649, 10426.27016108865, 9056.954715226382, 9196.448213106967, 9245.306602004743, 9602.183814375856, 9692.660756873476, 8100.554469504234, 8271.462354946909, 8300.169983001651, 8608.182222688834, 8795.824083518422], "unit": "score", "name": "yui.html", "value": 6089.711856043224}], "name": "dromaeo_css", "value": 6657.3297475574445}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 103.0, 110.0, 110.0, 110.0, 99.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [145.0, 125.0, 152.0, 170.0, 138.0, 153.0, 152.0, 123.0, 171.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 161.0, 159.0, 160.0, 161.0, 160.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 115.0, 104.0, 74.0, 71.0, 71.0, 103.0, 90.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.5}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 154.0, 97.0, 97.0, 97.0, 140.0, 96.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 111.0}, {"lowerIsBetter": true, "replicates": [108.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 149.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 55.0, 56.0, 55.0, 55.0, 64.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 67.0, 68.0, 68.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 83.0, 83.0, 81.0, 86.0, 89.0, 82.0, 90.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [113.0, 114.0, 125.0, 113.0, 112.0, 117.0, 121.0, 114.0, 114.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.7}, {"lowerIsBetter": true, "replicates": [145.0, 136.0, 147.0, 144.0, 144.0, 135.0, 148.0, 144.0, 144.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 68.0, 65.0, 68.0, 68.0, 66.0, 68.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1493.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.86133822793258], "unit": "score", "name": "Richards", "value": 211.56488599999994}, {"lowerIsBetter": false, "replicates": [188.67924528301887], "unit": "score", "name": "DeltaBlue", "value": 350.4253999999999}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [1932.4324324324325], "unit": "score", "name": "RayTrace", "value": 382.9313706293705}, {"lowerIsBetter": false, "replicates": [771.0100231303007], "unit": "score", "name": "Earley", "value": 864.4025109999995}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [42061.22448979592], "unit": "score", "name": "RegExp", "value": 21.658546821931086}, {"lowerIsBetter": false, "replicates": [630.119722747322], "unit": "score", "name": "Splay", "value": 129.326217}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 18924.347228935265}]} 13:42:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18924.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1493.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6657.33"}}} 13:42:44 INFO - Return code: 0 13:42:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:42:44 INFO - # TBPL SUCCESS # 13:42:44 INFO - Running post-action listener: _resource_record_post_action 13:42:44 INFO - Running post-run listener: _resource_record_post_run 13:42:45 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 12288; Write bytes: 539127808; Read time: 148; Write time: 461244 13:42:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 197361664; Read time: 0; Write time: 196136 13:42:45 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 12288; Write bytes: 301973504; Read time: 148; Write time: 248796 13:42:45 INFO - Running post-run listener: _upload_blobber_files 13:42:45 INFO - Blob upload gear active. 13:42:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:42:45 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 13:42:45 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'] 13:42:45 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 13:42:46 INFO - (blobuploader) - INFO - Open directory for files ... 13:42:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:42:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:42:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:47 INFO - (blobuploader) - INFO - Done attempting. 13:42:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:42:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:42:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:48 INFO - (blobuploader) - INFO - Done attempting. 13:42:48 INFO - (blobuploader) - INFO - Iteration through files over. 13:42:48 INFO - Return code: 0 13:42:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:42:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:42:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0355c337e61310a248c218ad4dadccdf5bc87b28f70fbbcf1296ecd9f7c58066f6d611afd17f56543b75e27f401f9c385bc194d47d9a504a3b45ad87105f700b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d83e49ff81ba3a6192608e9c6cbfc18eec58f969ff2aa1273ed2e087145575a585896227d13e499f5024dda3ac2cd47682dd31b439a011ee05a9a030d4e1ab88"} 13:42:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:42:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:42:48 INFO - Contents: 13:42:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0355c337e61310a248c218ad4dadccdf5bc87b28f70fbbcf1296ecd9f7c58066f6d611afd17f56543b75e27f401f9c385bc194d47d9a504a3b45ad87105f700b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d83e49ff81ba3a6192608e9c6cbfc18eec58f969ff2aa1273ed2e087145575a585896227d13e499f5024dda3ac2cd47682dd31b439a011ee05a9a030d4e1ab88"} 13:42:48 INFO - Running post-run listener: copy_logs_to_upload_dir 13:42:48 INFO - Copying logs to upload dir... 13:42:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:42:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.797107 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-15 13:42:48.171006) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 13:42:48.174101) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434 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/0355c337e61310a248c218ad4dadccdf5bc87b28f70fbbcf1296ecd9f7c58066f6d611afd17f56543b75e27f401f9c385bc194d47d9a504a3b45ad87105f700b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d83e49ff81ba3a6192608e9c6cbfc18eec58f969ff2aa1273ed2e087145575a585896227d13e499f5024dda3ac2cd47682dd31b439a011ee05a9a030d4e1ab88"} build_url:https://queue.taskcluster.net/v1/task/Azl4wFdXSSqhF-yLg0srYQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011512 build_url: 'https://queue.taskcluster.net/v1/task/Azl4wFdXSSqhF-yLg0srYQ/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/0355c337e61310a248c218ad4dadccdf5bc87b28f70fbbcf1296ecd9f7c58066f6d611afd17f56543b75e27f401f9c385bc194d47d9a504a3b45ad87105f700b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d83e49ff81ba3a6192608e9c6cbfc18eec58f969ff2aa1273ed2e087145575a585896227d13e499f5024dda3ac2cd47682dd31b439a011ee05a9a030d4e1ab88"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 13:42:48.199084) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 13:42:48.199411) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452892895.968243-769272434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 13:42:48.283690) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 13:42:48.283993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 13:42:48.284279) ========= ========= Total master_lag: 0.27 =========