builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1451934696.64 results: success (0) buildid: 20160104083143 builduid: c64757a1e5434d6d9a347b78b5d3c26a revision: 9d5029646b5297649513b648d9109f20fdab9845 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.643876) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.644298) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.644617) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005609 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.669308) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.669618) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.689187) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.689525) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003199 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.735693) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.739020) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.739388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.739694) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 11:11: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% 210M=0s 2016-01-04 11:11:36 (210 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104248 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.856554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.856882) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.906956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:36.907401) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d5029646b5297649513b648d9109f20fdab9845 --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 9d5029646b5297649513b648d9109f20fdab9845 --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=a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 11:11:37,060 truncating revision to first 12 chars 2016-01-04 11:11:37,061 Setting DEBUG logging. 2016-01-04 11:11:37,061 attempt 1/10 2016-01-04 11:11:37,061 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d5029646b52?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 11:11:37,292 unpacking tar archive at: fx-team-9d5029646b52/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517704 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:37.438662) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:37.439037) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:37.453021) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:37.453468) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 11:11:37.453970) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-01-04 11:11:37.454303) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:11:37 INFO - MultiFileLogger online at 20160104 11:11:37 in /builds/slave/test-pgo 11:11:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:11:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:11:37 INFO - {'append_to_log': False, 11:11:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:11:37 INFO - 'blob_upload_branch': 'Fx-Team', 11:11:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:11:37 INFO - 'branch': 'Fx-Team', 11:11:37 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:37 INFO - 'config_files': ('talos/linux_config.py',), 11:11:37 INFO - 'default_actions': ('clobber', 11:11:37 INFO - 'read-buildbot-config', 11:11:37 INFO - 'download-and-extract', 11:11:37 INFO - 'populate-webroot', 11:11:37 INFO - 'create-virtualenv', 11:11:37 INFO - 'install', 11:11:37 INFO - 'run-tests'), 11:11:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:37 INFO - 'download_minidump_stackwalk': True, 11:11:37 INFO - 'download_symbols': 'ondemand', 11:11:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:37 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:37 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:37 INFO - 'installer_path': 'installer.exe', 11:11:37 INFO - 'log_level': 'info', 11:11:37 INFO - 'log_name': 'talos', 11:11:37 INFO - 'log_to_console': True, 11:11:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:11:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:11:37 INFO - 'opt_config_files': (), 11:11:37 INFO - 'pip_index': False, 11:11:37 INFO - 'sps_profile': False, 11:11:37 INFO - 'sps_profile_interval': 0, 11:11:37 INFO - 'suite': 'dromaeojs-e10s', 11:11:37 INFO - 'system_bits': '32', 11:11:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:37 INFO - 'title': 'talos-linux64-ix-062', 11:11:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:37 INFO - 'use_talos_json': True, 11:11:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:11:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:37 INFO - 'work_dir': 'build'} 11:11:37 INFO - ##### 11:11:37 INFO - ##### Running clobber step. 11:11:37 INFO - ##### 11:11:37 INFO - Running pre-action listener: _resource_record_pre_action 11:11:37 INFO - Running main action method: clobber 11:11:37 INFO - rmtree: /builds/slave/test-pgo/build 11:11:37 INFO - Running post-action listener: _resource_record_post_action 11:11:37 INFO - ##### 11:11:37 INFO - ##### Running read-buildbot-config step. 11:11:37 INFO - ##### 11:11:37 INFO - Running pre-action listener: _resource_record_pre_action 11:11:37 INFO - Running main action method: read_buildbot_config 11:11:37 INFO - Using buildbot properties: 11:11:37 INFO - { 11:11:37 INFO - "project": "", 11:11:37 INFO - "product": "firefox", 11:11:37 INFO - "script_repo_revision": "production", 11:11:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:11:37 INFO - "repository": "", 11:11:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:11:37 INFO - "buildid": "20160104083143", 11:11:37 INFO - "pgo_build": "True", 11:11:37 INFO - "basedir": "/builds/slave/test-pgo", 11:11:37 INFO - "buildnumber": 421, 11:11:37 INFO - "slavename": "talos-linux64-ix-062", 11:11:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:11:37 INFO - "platform": "ubuntu64_hw", 11:11:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:11:37 INFO - "branch": "fx-team", 11:11:37 INFO - "repo_path": "integration/fx-team", 11:11:37 INFO - "revision": "9d5029646b5297649513b648d9109f20fdab9845", 11:11:37 INFO - "stage_platform": "linux64-pgo", 11:11:37 INFO - "builduid": "c64757a1e5434d6d9a347b78b5d3c26a", 11:11:37 INFO - "slavebuilddir": "test" 11:11:37 INFO - } 11:11:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:11:37 INFO - Running post-action listener: _resource_record_post_action 11:11:37 INFO - ##### 11:11:37 INFO - ##### Running download-and-extract step. 11:11:37 INFO - ##### 11:11:37 INFO - Running pre-action listener: _resource_record_pre_action 11:11:37 INFO - Running main action method: download_and_extract 11:11:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:37 INFO - https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/test_packages.json 11:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/test_packages.json 11:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:11:38 INFO - Downloaded 1302 bytes. 11:11:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:11:38 INFO - Using the following test package requirements: 11:11:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:11:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:38 INFO - u'jsshell-linux-x86_64.zip'], 11:11:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:11:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:11:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:11:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:11:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:11:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:11: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')]} 11:11:38 INFO - https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:11:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:11:39 INFO - Downloaded 23198177 bytes. 11:11:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:11:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:11:40 INFO - Return code: 0 11:11:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:40 INFO - https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:11:41 INFO - Downloaded 23198177 bytes. 11:11:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:11:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:11:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:11:42 INFO - Return code: 0 11:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:42 INFO - https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:11:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:11:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:11:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:11:43 INFO - Downloaded 11132285 bytes. 11:11:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 11:11:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:11:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:11:43 INFO - Return code: 0 11:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:43 INFO - https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:11:45 INFO - Downloaded 54985130 bytes. 11:11:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:11:45 INFO - mkdir: /builds/slave/test-pgo/properties 11:11:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:11:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:11:45 INFO - Contents: 11:11:45 INFO - build_url:https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:11:45 INFO - Running post-action listener: _resource_record_post_action 11:11:45 INFO - Running post-action listener: set_extra_try_arguments 11:11:45 INFO - ##### 11:11:45 INFO - ##### Running populate-webroot step. 11:11:45 INFO - ##### 11:11:45 INFO - Running pre-action listener: _resource_record_pre_action 11:11:45 INFO - Running main action method: populate_webroot 11:11:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:11:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:11:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:11:45 INFO - '--tppagecycles', 11:11:45 INFO - '7'], 11:11:45 INFO - 'tests': ['tsvgm']}}, 11:11:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:11:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:11:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:11:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:11:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:11:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:11:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'talos_options': ['--e10s'], 11:11:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'tests': ['damp', 'tps']}, 11:11:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'talos_options': ['--e10s'], 11:11:45 INFO - 'tests': ['damp', 'tps']}, 11:11:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:11:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:11:45 INFO - 'other': {'tests': ['a11yr', 11:11:45 INFO - 'ts_paint', 11:11:45 INFO - 'tpaint', 11:11:45 INFO - 'sessionrestore', 11:11:45 INFO - 'sessionrestore_no_auto_restore']}, 11:11:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:11:45 INFO - 'tests': ['a11yr', 11:11:45 INFO - 'ts_paint', 11:11:45 INFO - 'tpaint', 11:11:45 INFO - 'sessionrestore', 11:11:45 INFO - 'sessionrestore_no_auto_restore']}, 11:11:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:11:45 INFO - 'tests': ['a11yr', 11:11:45 INFO - 'ts_paint', 11:11:45 INFO - 'tpaint', 11:11:45 INFO - 'sessionrestore', 11:11:45 INFO - 'sessionrestore_no_auto_restore']}, 11:11:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:11:45 INFO - 'tests': ['a11yr', 11:11:45 INFO - 'ts_paint', 11:11:45 INFO - 'tpaint', 11:11:45 INFO - 'sessionrestore', 11:11:45 INFO - 'sessionrestore_no_auto_restore']}, 11:11:45 INFO - 'other_l64': {'tests': ['a11yr', 11:11:45 INFO - 'ts_paint', 11:11:45 INFO - 'tpaint', 11:11:45 INFO - 'sessionrestore', 11:11:45 INFO - 'sessionrestore_no_auto_restore']}, 11:11:45 INFO - 'other_nol64': {'tests': ['a11yr', 11:11:45 INFO - 'ts_paint', 11:11:45 INFO - 'tpaint', 11:11:45 INFO - 'sessionrestore', 11:11:45 INFO - 'sessionrestore_no_auto_restore']}, 11:11:45 INFO - 'svgr': {'tests': ['tsvgx', 11:11:45 INFO - 'tsvgr_opacity', 11:11:45 INFO - 'tart', 11:11:45 INFO - 'tscrollx', 11:11:45 INFO - 'cart']}, 11:11:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:11:45 INFO - 'tests': ['tsvgx', 11:11:45 INFO - 'tsvgr_opacity', 11:11:45 INFO - 'tart', 11:11:45 INFO - 'tscrollx', 11:11:45 INFO - 'cart']}, 11:11:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'tests': ['tp5o']}, 11:11:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'talos_options': ['--e10s'], 11:11:45 INFO - 'tests': ['tp5o']}, 11:11:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'talos_options': ['--xperf_path', 11:11:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:45 INFO - 'tests': ['tp5n']}, 11:11:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'talos_options': ['--e10s', 11:11:45 INFO - '--xperf_path', 11:11:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:45 INFO - 'tests': ['tp5n']}}, 11:11:45 INFO - 'talos.zip': {'path': '', 11:11:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:11:45 INFO - Running post-action listener: _resource_record_post_action 11:11:45 INFO - ##### 11:11:45 INFO - ##### Running create-virtualenv step. 11:11:45 INFO - ##### 11:11:45 INFO - Running pre-action listener: _resource_record_pre_action 11:11:45 INFO - Running main action method: create_virtualenv 11:11:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:11:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 11:11:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:11:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:11:45 INFO - Using real prefix '/usr' 11:11:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:11:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:11:47 INFO - Installing pip.................done. 11:11:47 INFO - Return code: 0 11:11:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4571bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:11:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:11:47 INFO - Using env: {'DISPLAY': ':0', 11:11:47 INFO - 'HOME': '/home/cltbld', 11:11:47 INFO - 'LANG': 'en_US.UTF-8', 11:11:47 INFO - 'LANGUAGE': 'en_US:en', 11:11:47 INFO - 'LOGNAME': 'cltbld', 11:11:47 INFO - 'MAIL': '/var/mail/cltbld', 11:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:47 INFO - 'MOZ_NO_REMOTE': '1', 11:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:47 INFO - 'NO_EM_RESTART': '1', 11:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:11:47 INFO - 'PWD': '/builds/slave/test-pgo', 11:11:47 INFO - 'SHELL': '/bin/bash', 11:11:47 INFO - 'SHLVL': '1', 11:11:47 INFO - 'TERM': 'linux', 11:11:47 INFO - 'TMOUT': '86400', 11:11:47 INFO - 'USER': 'cltbld', 11:11:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 11:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:47 INFO - '_': '/tools/buildbot/bin/python'} 11:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:11:47 INFO - Cleaning up... 11:11:47 INFO - Return code: 0 11:11:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4571bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:11:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:11:47 INFO - Using env: {'DISPLAY': ':0', 11:11:47 INFO - 'HOME': '/home/cltbld', 11:11:47 INFO - 'LANG': 'en_US.UTF-8', 11:11:47 INFO - 'LANGUAGE': 'en_US:en', 11:11:47 INFO - 'LOGNAME': 'cltbld', 11:11:47 INFO - 'MAIL': '/var/mail/cltbld', 11:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:47 INFO - 'MOZ_NO_REMOTE': '1', 11:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:47 INFO - 'NO_EM_RESTART': '1', 11:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:11:47 INFO - 'PWD': '/builds/slave/test-pgo', 11:11:47 INFO - 'SHELL': '/bin/bash', 11:11:47 INFO - 'SHLVL': '1', 11:11:47 INFO - 'TERM': 'linux', 11:11:47 INFO - 'TMOUT': '86400', 11:11:47 INFO - 'USER': 'cltbld', 11:11:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 11:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:47 INFO - '_': '/tools/buildbot/bin/python'} 11:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:48 INFO - Downloading/unpacking psutil>=0.7.1 11:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:11:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:11:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:11:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:49 INFO - Installing collected packages: psutil 11:11:49 INFO - Running setup.py install for psutil 11:11:50 INFO - building 'psutil._psutil_linux' extension 11:11:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:11:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:11:50 INFO - building 'psutil._psutil_posix' extension 11:11:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:11:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:11:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:50 INFO - Successfully installed psutil 11:11:50 INFO - Cleaning up... 11:11:50 INFO - Return code: 0 11:11:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4571bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:11:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:11:50 INFO - Using env: {'DISPLAY': ':0', 11:11:50 INFO - 'HOME': '/home/cltbld', 11:11:50 INFO - 'LANG': 'en_US.UTF-8', 11:11:50 INFO - 'LANGUAGE': 'en_US:en', 11:11:50 INFO - 'LOGNAME': 'cltbld', 11:11:50 INFO - 'MAIL': '/var/mail/cltbld', 11:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:50 INFO - 'MOZ_NO_REMOTE': '1', 11:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:50 INFO - 'NO_EM_RESTART': '1', 11:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:11:50 INFO - 'PWD': '/builds/slave/test-pgo', 11:11:50 INFO - 'SHELL': '/bin/bash', 11:11:50 INFO - 'SHLVL': '1', 11:11:50 INFO - 'TERM': 'linux', 11:11:50 INFO - 'TMOUT': '86400', 11:11:50 INFO - 'USER': 'cltbld', 11:11:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 11:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:50 INFO - '_': '/tools/buildbot/bin/python'} 11:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:11:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:11:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:11:52 INFO - Installing collected packages: mozsystemmonitor 11:11:52 INFO - Running setup.py install for mozsystemmonitor 11:11:52 INFO - Successfully installed mozsystemmonitor 11:11:52 INFO - Cleaning up... 11:11:52 INFO - Return code: 0 11:11:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4571bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:11:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:11:52 INFO - Using env: {'DISPLAY': ':0', 11:11:52 INFO - 'HOME': '/home/cltbld', 11:11:52 INFO - 'LANG': 'en_US.UTF-8', 11:11:52 INFO - 'LANGUAGE': 'en_US:en', 11:11:52 INFO - 'LOGNAME': 'cltbld', 11:11:52 INFO - 'MAIL': '/var/mail/cltbld', 11:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:52 INFO - 'MOZ_NO_REMOTE': '1', 11:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:52 INFO - 'NO_EM_RESTART': '1', 11:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:11:52 INFO - 'PWD': '/builds/slave/test-pgo', 11:11:52 INFO - 'SHELL': '/bin/bash', 11:11:52 INFO - 'SHLVL': '1', 11:11:52 INFO - 'TERM': 'linux', 11:11:52 INFO - 'TMOUT': '86400', 11:11:52 INFO - 'USER': 'cltbld', 11:11:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 11:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:52 INFO - '_': '/tools/buildbot/bin/python'} 11:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:11:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:11:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:11:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:11:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:11:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:55 INFO - Downloading docopt-0.6.1.tar.gz 11:11:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:11:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:11:55 INFO - Installing collected packages: blobuploader, requests, docopt 11:11:55 INFO - Running setup.py install for blobuploader 11:11:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:11:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:11:55 INFO - Running setup.py install for requests 11:11:55 INFO - Running setup.py install for docopt 11:11:55 INFO - Successfully installed blobuploader requests docopt 11:11:55 INFO - Cleaning up... 11:11:55 INFO - Return code: 0 11:11:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4571bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:11:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:11:55 INFO - Using env: {'DISPLAY': ':0', 11:11:55 INFO - 'HOME': '/home/cltbld', 11:11:55 INFO - 'LANG': 'en_US.UTF-8', 11:11:55 INFO - 'LANGUAGE': 'en_US:en', 11:11:55 INFO - 'LOGNAME': 'cltbld', 11:11:55 INFO - 'MAIL': '/var/mail/cltbld', 11:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:55 INFO - 'MOZ_NO_REMOTE': '1', 11:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:55 INFO - 'NO_EM_RESTART': '1', 11:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:11:55 INFO - 'PWD': '/builds/slave/test-pgo', 11:11:55 INFO - 'SHELL': '/bin/bash', 11:11:55 INFO - 'SHLVL': '1', 11:11:55 INFO - 'TERM': 'linux', 11:11:55 INFO - 'TMOUT': '86400', 11:11:55 INFO - 'USER': 'cltbld', 11:11:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 11:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:55 INFO - '_': '/tools/buildbot/bin/python'} 11:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:11:56 INFO - Running setup.py (path:/tmp/pip-I2Uo8P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:11:56 INFO - Running setup.py (path:/tmp/pip-dtX9HO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:11:56 INFO - Running setup.py (path:/tmp/pip-kTn4wu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:11:56 INFO - Running setup.py (path:/tmp/pip-wtKhyQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:11:56 INFO - Running setup.py (path:/tmp/pip-GC4dpn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:11:56 INFO - Running setup.py (path:/tmp/pip-ctl5ZL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:11:56 INFO - Running setup.py (path:/tmp/pip-Pp5C9g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:11:56 INFO - Running setup.py (path:/tmp/pip-cq7ZYj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:11:56 INFO - Running setup.py (path:/tmp/pip-1mzguB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:11:56 INFO - Running setup.py (path:/tmp/pip-TPn3of-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:11:56 INFO - Running setup.py (path:/tmp/pip-SnsJ3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:11:56 INFO - Running setup.py (path:/tmp/pip-Vpmflt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:11:56 INFO - Running setup.py (path:/tmp/pip-BgotCf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:11:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:11:56 INFO - Running setup.py (path:/tmp/pip-Sk5nwC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:11:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:11:57 INFO - Running setup.py (path:/tmp/pip-DxxoJ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:11:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:11:57 INFO - Running setup.py (path:/tmp/pip-RhxMwG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:11:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:11:57 INFO - Running setup.py (path:/tmp/pip-LgGrlI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:11:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:11:57 INFO - Running setup.py install for manifestparser 11:11:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:11:57 INFO - Running setup.py install for mozcrash 11:11:57 INFO - Running setup.py install for mozdebug 11:11:57 INFO - Running setup.py install for mozdevice 11:11:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:11:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:11:57 INFO - Running setup.py install for mozfile 11:11:57 INFO - Running setup.py install for mozhttpd 11:11:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:11:57 INFO - Running setup.py install for mozinfo 11:11:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:11:57 INFO - Running setup.py install for mozInstall 11:11:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:11:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:11:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:11:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:11:58 INFO - Running setup.py install for mozleak 11:11:58 INFO - Running setup.py install for mozlog 11:11:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:11:58 INFO - Running setup.py install for moznetwork 11:11:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:11:58 INFO - Running setup.py install for mozprocess 11:11:58 INFO - Running setup.py install for mozprofile 11:11:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:11:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:11:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:11:58 INFO - Running setup.py install for mozrunner 11:11:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:11:58 INFO - Running setup.py install for mozscreenshot 11:11:58 INFO - Running setup.py install for moztest 11:11:58 INFO - Running setup.py install for mozversion 11:11:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:11:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:11:59 INFO - Cleaning up... 11:11:59 INFO - Return code: 0 11:11:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4571bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:11:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:11:59 INFO - Using env: {'DISPLAY': ':0', 11:11:59 INFO - 'HOME': '/home/cltbld', 11:11:59 INFO - 'LANG': 'en_US.UTF-8', 11:11:59 INFO - 'LANGUAGE': 'en_US:en', 11:11:59 INFO - 'LOGNAME': 'cltbld', 11:11:59 INFO - 'MAIL': '/var/mail/cltbld', 11:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:59 INFO - 'MOZ_NO_REMOTE': '1', 11:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:59 INFO - 'NO_EM_RESTART': '1', 11:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:11:59 INFO - 'PWD': '/builds/slave/test-pgo', 11:11:59 INFO - 'SHELL': '/bin/bash', 11:11:59 INFO - 'SHLVL': '1', 11:11:59 INFO - 'TERM': 'linux', 11:11:59 INFO - 'TMOUT': '86400', 11:11:59 INFO - 'USER': 'cltbld', 11:11:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 11:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:59 INFO - '_': '/tools/buildbot/bin/python'} 11:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:11:59 INFO - Running setup.py (path:/tmp/pip-aaV5XO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 11:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:11:59 INFO - Running setup.py (path:/tmp/pip-_vpMJI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:11:59 INFO - Running setup.py (path:/tmp/pip-5G4iKj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:11:59 INFO - Running setup.py (path:/tmp/pip-_l0El8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:11:59 INFO - Running setup.py (path:/tmp/pip-wEHlVt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 11:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:11:59 INFO - Running setup.py (path:/tmp/pip-0JMiOy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 11:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:11:59 INFO - Running setup.py (path:/tmp/pip-D5U1XA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 11:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:11:59 INFO - Running setup.py (path:/tmp/pip-D_l26E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 11:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:11:59 INFO - Running setup.py (path:/tmp/pip-2YEiot-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 11:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:11:59 INFO - Running setup.py (path:/tmp/pip-FJzUNK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:11:59 INFO - Running setup.py (path:/tmp/pip-umg_Il-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 11:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:12:00 INFO - Running setup.py (path:/tmp/pip-Qi3H_s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 11:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:12:00 INFO - Running setup.py (path:/tmp/pip-zDwRBE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 11:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:12:00 INFO - Running setup.py (path:/tmp/pip-svVMXx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 11:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:12:00 INFO - Running setup.py (path:/tmp/pip-BrbXRj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 11:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:12:00 INFO - Running setup.py (path:/tmp/pip-Y90P9p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 11:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:12:00 INFO - Running setup.py (path:/tmp/pip-kK8qEu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:02 INFO - Downloading blessings-1.5.1.tar.gz 11:12:02 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 11:12:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:02 INFO - Installing collected packages: blessings 11:12:02 INFO - Running setup.py install for blessings 11:12:02 INFO - Successfully installed blessings 11:12:02 INFO - Cleaning up... 11:12:02 INFO - Return code: 0 11:12:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:12:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:12:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:12:02 INFO - Reading from file tmpfile_stdout 11:12:02 INFO - Current package versions: 11:12:02 INFO - argparse == 1.2.1 11:12:02 INFO - blessings == 1.5.1 11:12:02 INFO - blobuploader == 1.2.4 11:12:02 INFO - docopt == 0.6.1 11:12:02 INFO - manifestparser == 1.1 11:12:02 INFO - mozInstall == 1.12 11:12:02 INFO - mozcrash == 0.16 11:12:02 INFO - mozdebug == 0.1 11:12:02 INFO - mozdevice == 0.47 11:12:02 INFO - mozfile == 1.2 11:12:02 INFO - mozhttpd == 0.7 11:12:02 INFO - mozinfo == 0.9 11:12:02 INFO - mozleak == 0.1 11:12:02 INFO - mozlog == 3.1 11:12:02 INFO - moznetwork == 0.27 11:12:02 INFO - mozprocess == 0.22 11:12:02 INFO - mozprofile == 0.28 11:12:02 INFO - mozrunner == 6.11 11:12:02 INFO - mozscreenshot == 0.1 11:12:02 INFO - mozsystemmonitor == 0.0 11:12:02 INFO - moztest == 0.7 11:12:02 INFO - mozversion == 1.4 11:12:02 INFO - psutil == 3.1.1 11:12:02 INFO - requests == 1.2.3 11:12:02 INFO - wsgiref == 0.1.2 11:12:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4571bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 11:12:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:02 INFO - Using env: {'DISPLAY': ':0', 11:12:02 INFO - 'HOME': '/home/cltbld', 11:12:02 INFO - 'LANG': 'en_US.UTF-8', 11:12:02 INFO - 'LANGUAGE': 'en_US:en', 11:12:02 INFO - 'LOGNAME': 'cltbld', 11:12:02 INFO - 'MAIL': '/var/mail/cltbld', 11:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:02 INFO - 'MOZ_NO_REMOTE': '1', 11:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:02 INFO - 'NO_EM_RESTART': '1', 11:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:02 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:02 INFO - 'SHELL': '/bin/bash', 11:12:02 INFO - 'SHLVL': '1', 11:12:02 INFO - 'TERM': 'linux', 11:12:02 INFO - 'TMOUT': '86400', 11:12:02 INFO - 'USER': 'cltbld', 11:12:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 11:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:02 INFO - '_': '/tools/buildbot/bin/python'} 11:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 11:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 11:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 11:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 11:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 11:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 11:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 11:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:12:02 INFO - Cleaning up... 11:12:02 INFO - Return code: 0 11:12:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4571bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:12:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:12:02 INFO - Using env: {'DISPLAY': ':0', 11:12:02 INFO - 'HOME': '/home/cltbld', 11:12:02 INFO - 'LANG': 'en_US.UTF-8', 11:12:02 INFO - 'LANGUAGE': 'en_US:en', 11:12:02 INFO - 'LOGNAME': 'cltbld', 11:12:02 INFO - 'MAIL': '/var/mail/cltbld', 11:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:02 INFO - 'MOZ_NO_REMOTE': '1', 11:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:02 INFO - 'NO_EM_RESTART': '1', 11:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:02 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:02 INFO - 'SHELL': '/bin/bash', 11:12:02 INFO - 'SHLVL': '1', 11:12:02 INFO - 'TERM': 'linux', 11:12:02 INFO - 'TMOUT': '86400', 11:12:02 INFO - 'USER': 'cltbld', 11:12:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 11:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:02 INFO - '_': '/tools/buildbot/bin/python'} 11:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:03 INFO - Downloading/unpacking jsonschema 11:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 11:12:04 INFO - Downloading/unpacking functools32 (from jsonschema) 11:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:12:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:05 INFO - warning: no files found matching '*.txt' 11:12:05 INFO - no previously-included directories found matching 'build' 11:12:05 INFO - no previously-included directories found matching 'dist' 11:12:05 INFO - no previously-included directories found matching '.git*' 11:12:05 INFO - Installing collected packages: jsonschema, functools32 11:12:05 INFO - Running setup.py install for functools32 11:12:05 INFO - warning: no files found matching '*.txt' 11:12:05 INFO - no previously-included directories found matching 'build' 11:12:05 INFO - no previously-included directories found matching 'dist' 11:12:05 INFO - no previously-included directories found matching '.git*' 11:12:05 INFO - Successfully installed jsonschema functools32 11:12:05 INFO - Cleaning up... 11:12:05 INFO - Return code: 0 11:12:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4571bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:12:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:12:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:12:05 INFO - Using env: {'DISPLAY': ':0', 11:12:05 INFO - 'HOME': '/home/cltbld', 11:12:05 INFO - 'LANG': 'en_US.UTF-8', 11:12:05 INFO - 'LANGUAGE': 'en_US:en', 11:12:05 INFO - 'LOGNAME': 'cltbld', 11:12:05 INFO - 'MAIL': '/var/mail/cltbld', 11:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:05 INFO - 'MOZ_NO_REMOTE': '1', 11:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:05 INFO - 'NO_EM_RESTART': '1', 11:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:05 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:05 INFO - 'SHELL': '/bin/bash', 11:12:05 INFO - 'SHLVL': '1', 11:12:05 INFO - 'TERM': 'linux', 11:12:05 INFO - 'TMOUT': '86400', 11:12:05 INFO - 'USER': 'cltbld', 11:12:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 11:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:05 INFO - '_': '/tools/buildbot/bin/python'} 11:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:05 INFO - Downloading/unpacking flake8 11:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:12:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 11:12:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:12:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 11:12:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 11:12:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:12:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:12:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:07 INFO - no previously-included directories found matching 'docs/_build' 11:12:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:12:07 INFO - Running setup.py install for pep8 11:12:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:07 INFO - no previously-included directories found matching 'docs/_build' 11:12:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:12:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:12:08 INFO - Cleaning up... 11:12:08 INFO - Return code: 0 11:12:08 INFO - Running post-action listener: _resource_record_post_action 11:12:08 INFO - Running post-action listener: _start_resource_monitoring 11:12:08 INFO - Starting resource monitoring. 11:12:08 INFO - ##### 11:12:08 INFO - ##### Running install step. 11:12:08 INFO - ##### 11:12:08 INFO - Running pre-action listener: _resource_record_pre_action 11:12:08 INFO - Running main action method: install 11:12:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:12:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:12:08 INFO - Reading from file tmpfile_stdout 11:12:08 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:12:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:12:08 INFO - Reading from file tmpfile_stdout 11:12:08 INFO - Output received: 11:12:08 INFO - Usage: mozinstall [options] installer 11:12:08 INFO - Options: 11:12:08 INFO - -h, --help show this help message and exit 11:12:08 INFO - -d DEST, --destination=DEST 11:12:08 INFO - Directory to install application into. [default: 11:12:08 INFO - "/builds/slave/test-pgo"] 11:12:08 INFO - --app=APP Application being installed. [default: firefox] 11:12:08 INFO - mkdir: /builds/slave/test-pgo/build/application 11:12:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:12:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:12:24 INFO - Reading from file tmpfile_stdout 11:12:24 INFO - Output received: 11:12:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:12:24 INFO - Running post-action listener: _resource_record_post_action 11:12:24 INFO - ##### 11:12:24 INFO - ##### Running run-tests step. 11:12:24 INFO - ##### 11:12:24 INFO - Running pre-action listener: _resource_record_pre_action 11:12:24 INFO - Running main action method: run_tests 11:12:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:12:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:12:24 INFO - Python 2.7.3 11:12:24 INFO - Return code: 0 11:12:24 INFO - grabbing minidump binary from tooltool 11:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b0840>, '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 0x241d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:12:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 11:12:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:12:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:24 INFO - Return code: 0 11:12:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:12:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:12:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:12:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:12:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:12:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:12:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:12:25 INFO - Return code: 0 11:12:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 11:12:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:12:25 INFO - Using env: {'DISPLAY': ':0', 11:12:25 INFO - 'HOME': '/home/cltbld', 11:12:25 INFO - 'LANG': 'en_US.UTF-8', 11:12:25 INFO - 'LANGUAGE': 'en_US:en', 11:12:25 INFO - 'LOGNAME': 'cltbld', 11:12:25 INFO - 'MAIL': '/var/mail/cltbld', 11:12:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:12:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:25 INFO - 'MOZ_NO_REMOTE': '1', 11:12:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:25 INFO - 'NO_EM_RESTART': '1', 11:12:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:12:25 INFO - 'SHELL': '/bin/bash', 11:12:25 INFO - 'SHLVL': '1', 11:12:25 INFO - 'TERM': 'linux', 11:12:25 INFO - 'TMOUT': '86400', 11:12:25 INFO - 'USER': 'cltbld', 11:12:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772', 11:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:25 INFO - '_': '/tools/buildbot/bin/python'} 11:12:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:12:25 INFO - mozversion application_buildid: 20160104083143 11:12:25 INFO - mozversion application_changeset: 9d5029646b5297649513b648d9109f20fdab9845 11:12:25 INFO - mozversion application_display_name: Nightly 11:12:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:12:25 INFO - mozversion application_name: Firefox 11:12:25 INFO - mozversion application_remotingname: firefox 11:12:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:12:25 INFO - mozversion application_vendor: Mozilla 11:12:25 INFO - mozversion application_version: 46.0a1 11:12:25 INFO - mozversion platform_buildid: 20160104083143 11:12:25 INFO - mozversion platform_changeset: 9d5029646b5297649513b648d9109f20fdab9845 11:12:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:12:25 INFO - mozversion platform_version: 46.0a1 11:12:25 INFO - using testdate: 1451934745 11:12:25 INFO - actual date: 1451934745 11:12:25 INFO - starting webserver on 'localhost:45856' 11:12:25 INFO - SUITE-START | Running 3 tests 11:12:25 INFO - TEST-START | dromaeo_css 11:12:25 INFO - operating with platform_type : linux_ 11:12:25 INFO - Initialising browser for dromaeo_css test... 11:12:25 INFO - TEST-INFO | started process 27636 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjBF_mO/profile http://localhost:45856/getInfo.html) 11:12:29 INFO - PROCESS | 27636 | __metrics Screen width/height:1600/1200 11:12:29 INFO - PROCESS | 27636 | colorDepth:24 11:12:29 INFO - PROCESS | 27636 | Browser inner width/height: 1024/697 11:12:29 INFO - PROCESS | 27636 | __metrics 11:12:29 INFO - PROCESS | 27636 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:12:30 INFO - TEST-INFO | 27636: exit 0 11:12:30 INFO - Browser initialized. 11:12:30 INFO - Running cycle 1/1 for dromaeo_css test... 11:12:30 INFO - TEST-INFO | started process 27769 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjBF_mO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:12:42 INFO - PROCESS | 27769 | RSS: Main: 150724608 11:12:42 INFO - PROCESS | 27769 | 11:13:31 INFO - PROCESS | 27769 | 1451934811942 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:15:41 INFO - PROCESS | 27769 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45856/tests/dromaeo/cssquery-ext.html) 11:15:42 INFO - PROCESS | 27769 | RSS: Main: 157106176 11:15:42 INFO - PROCESS | 27769 | 11:18:44 INFO - PROCESS | 27769 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-ext.html (next: http://localhost:45856/tests/dromaeo/cssquery-jquery.html) 11:18:44 INFO - PROCESS | 27769 | RSS: Main: 152461312 11:18:44 INFO - PROCESS | 27769 | 11:21:46 INFO - PROCESS | 27769 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45856/tests/dromaeo/cssquery-mootools.html) 11:21:47 INFO - PROCESS | 27769 | RSS: Main: 155709440 11:21:47 INFO - PROCESS | 27769 | 11:24:48 INFO - PROCESS | 27769 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45856/tests/dromaeo/cssquery-prototype.html) 11:24:49 INFO - PROCESS | 27769 | RSS: Main: 152502272 11:24:49 INFO - PROCESS | 27769 | 11:27:51 INFO - PROCESS | 27769 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45856/tests/dromaeo/cssquery-yui.html) 11:27:52 INFO - PROCESS | 27769 | RSS: Main: 153473024 11:27:52 INFO - PROCESS | 27769 | 11:30:55 INFO - PROCESS | 27769 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-yui.html (next: http://localhost:45856/tests/dromaeo/cssquery-dojo.html) 11:30:55 INFO - PROCESS | 27769 | RSS: Main: 155607040 11:30:55 INFO - PROCESS | 27769 | 11:30:55 INFO - PROCESS | 27769 | __start_tp_report 11:30:55 INFO - PROCESS | 27769 | _x_x_mozilla_page_load 11:30:55 INFO - PROCESS | 27769 | _x_x_mozilla_page_load_details 11:30:55 INFO - PROCESS | 27769 | |i|pagename|runs| 11:30:55 INFO - PROCESS | 27769 | |0;dojo.html;3118.1269244611517;3118.719315261626;3179.984100079499;3200.487921932491;3216.0834162263745;5273.5781137509;5360.544353729928;5390.595705322102;5405.648632838863;5407.05376559102;5341.545968592664;5347.6256662033675;5374.4894235047705;5380.112281473562;5383.730813459321;4908.877278068041;4952;4972.925406118911;4997.625178111647;5020.0712868119335;4941.135301322272;4997.850064498053;5002.8249011284615;5038.7984480620735;5051.040302342543;4790.7604619769045;4836.081144582553;4920.065187614342;4935.136351138536;5043.52086551777;4891.657583969123;4897.461279259279;4924.14226630283;4988.825391111293;5035.748212589356;4791.808327666889;4913.336699545552;4953.578945789613;4990.750462476898;5021.673591216596;5231.267622532849;5291.814786482455;5296.92054619181;5324.92012619811;5349.358077030781;5720.370759216483;5727.77088916447;5765.106408506688;5800.361960184377;5805.3323867755325;5741.827745167651;5802.448767367136;5832.358440571534;5848.5321174305955;5880.382559831199;5379.81170659029;5420.214068960057;5425.810096646677;5439.401665816757;5464.9453505464835;5903.911441328383;5905.940940590539;5947.851303717355;5970.164177015221;5976.432238937294;5555.833325000256;5714.714264286769;5718.399568045295;5724.370319264877;5739;5834.504067154255;5876.970615146897;5898.616589921641;5920.2303700519515;5951.791687290924;5711.8000869969355;5727.570432217601;5762.855928601734;5767.077267637158;5785.10330898703;5620.1569764534825;5720.971395142998;5723.914141287884;5790;5794.333651630117;4430.446194225722;4443.044745379759;4457.754823484739;4532.637389008872;4572.51988541205;4010.017545701322;4012.257732319472;4022.8189731462153;4051.493563304587;4072.857449989236;5318.946810531923;5432.51107400328;5504.4495550444635;5517.200005999108;5540.335159780852;5728.742206600713;5746.02317606008;5746.9425305747245;5758.193852860602;5770.019096753562;5420.563550659079;5421.322334708161;5424.159255315432;5490.203920431515;5537.307836520435;4920.286558449005;4923.903312444032;4941.827036053721;4947.060058588857;5020.698758074527;5787.450192231731;5963.850903727442;5996.940030599725;6046.516278697693;6069.908951365733;5712.6001179917;5771.278590176228;5799.362070172362;5816.127580862904;5831.446012628793;5960.314563825215;5999.70001499932;6001.519878409629;6031.09533569968;6123.571350005457;5726.854629074119;5751.884962300815;5770.567207459541;5776.133579963039;5792.4497172768515;5804.564657650778;5847.853803654943;5858.648481091148;5876.911846322394;5882.294124705063;5580.693061881473;5627.958827616904;5686.9715651421475;5713.371529131875;5747.9137812932;5681.0910254359105;5698.886022279448;5712.828615141386;5724.427557244242;5752.597318187854;5567.137093750475;5591.440855914376;5596.132599447093;5597.972010140086;5606.943930560642;5612.242347283228;5676.716164191691;5709.029464990878;5807.390224026416;5854.268216472941;5586.217929489793;5619.578531610064;5622.269105016322;5627.831165065055;5658.236138121301 11:30:55 INFO - PROCESS | 27769 | |1;ext.html;530.6868947321079;535.8981793459245;541.4531323363403;553.239295968044;553.2917865132632;34636;35456.29087418257;35710.464343034844;35752.2849543009;35890.64109358909;38858.8057059715;38903.61096389035;38947.41578876312;39297.21405571894;39321.60678393222;8506.744797656065;8575.699850505234;8621.267192288664;8639;8651.65393384264;8330.875036874451;8344.874826877602;8377.120402357756;8404.07555168931;8446.324294056492;8614.956925215396;8706.825863482727;8714.433561818492;8720.912790872073;8737.7815554611;8553;8581.570921453902;8659.177378149097;8676.652933882637;8734.301255899576;8444.197801208875;8513.318934485289;8593.914060859437;8601.354898382646;8606.096359882247;38894.41658375126;39020;39465.21069578592;39526;39658.60341396578;3147.921301967446;3176.5076413156;3245.8539365728598;3380;3722.627737226283;27447.17658470249;27640.861795690893;27741.306467338276;27957.440851182862;28825.135245942656;3788.5264341957254;3799.202167544819;3809.2381523695094;3904.7461914975434;4019.2363450944226;256605;257033;258023;310087;311251;56734.43265567374;57600.42399576034;57808.71095644495;57942;57994.13008804871;62483;62558.374416255254;62810.371896281365;62861.37138628647;62889;13839.377228024763;13987.090839095426;14019.649508762159;14026.08830426019;14042.438302467992;11825.172237943261;11849.822252666218;11853.88146118545;11860.584879529175;11892.881071189351;19583.314583989493;19596.314129005703;19615.901920490305;19893.403197904085;19937.60124797496;7852.646630901623;8050.879236811453;8078.919210807934;8110.31062359706;8197.631106600218;892.2326798952895;953.2421724728857;1028.681108856257;1059.4067322299536;1075.7310672331917;26402.339941501617;27108.457830843272;27662;27679.584806227922;27817.860910695315;1036.362636978268;1039.5633833789827;1053.2732414633879;1148.472531533059;1161.5644133449957;14345.928270358581;14405.85594144066;14484.275786210857;14627.26863656813;14811.481598144013;386360;387719;388527;392240;392357;53638;53808.46191538034;53950.460495394545;54046;54839.72580137153;1328.860469650692;1329.335332333833;1333.8199343088559;1338.2773302416585;1491.8582734640192;26532.336691582866;27530.44939101247;27773.305667358476;27858.442831142856;27898.44203115967;42521.574784252996;42958.78520607377;42979.355309671;43143.78428107839;43210.78394608007;282078;284989;287641;287851;287867;31911.84044079765;42109.78945105255;42618.1476370477;42880.78559607182;42929.141417172104;44143.55856441394;45104.323435147846;46206;48337;49289;36094.37575309065;36334.273314533035;36546.451803222444;36894.8155259222;37555.436668450544;37070.8146459266;37507.2498550022;38803.80598096991;39568.60431395649;40235.79292621226;33988;34176.14559636029;34569.65430345664;34617;34689.82655086708;30473.695263047084;31723.84138079295;32829.17927051843;32855.342893141526;33089.66910330962;24677.259682208845;25213.24360269195;25460.363490912874;25533;25568.360790980376 11:30:55 INFO - PROCESS | 27769 | |2;jquery.html;361.9927601447971;364.229654281195;364.7136997456995;368.1991668121834;369.85575625506056;16488.258028388722;16975.151242437874;17492.21285042173;17827.108644567783;18574.628507429843;14784.965052446332;15612.687746245068;15756.527304180892;15837.84162158378;15905.44330948417;4927.852164435064;5058.620603454738;5060.291559181717;5065.873353166164;5068.873278168038;4630;5021.723805190713;5034.345535080434;5040.395152581696;5043.445221025684;5344.518993290603;5367.892642147155;5377.569794416438;5478.561715062805;5489.835304940858;4961.5038496150455;5378.354597448311;5425.647332923348;5429.592780541456;5436.864078398032;4804.5916097131785;4807.302941073524;4814.085323788469;4814.831480898151;4826.831060912887;12921.547745828944;13010.479580816756;18448.354307599304;20250.291239806684;20273.69589456159;1963.813437723414;1965.518447980254;2003.8396928245852;2016.2942969960543;2134.455713792973;9079.546022698838;9115.680951166743;10536.736581585445;11393.430328483626;11770.176087673866;1459.0880699562774;1474.705058988196;1558.4155941521929;1561.8047744031996;1594.3463180096105;52785.472145278436;55935.44064559384;60123.398766012215;63027;64156;10381.896181038093;10387.532561034772;10470.424126672953;10505.474726263656;10510.789784204426;12740.36298185087;13089.541866034833;13113.147645403018;13171.802422963663;13463.528776492776;7085.964570177116;7297.9635101825215;7394.038774959221;7398.519096258726;7436.107667079985;7263.89104163438;7336.37640800538;7386.0767404074495;7434.516756410816;7495.587742674096;4506.549345065533;4552.931706024412;4564.954350456453;4586.036932244199;4600.447946246405;1835.5411147213197;1838.3657638114828;1873.4098758890905;1888.792232854385;1898.9145488453053;880.3265501891059;915.3546749541557;986.9358491698017;1021.7037059252733;1048.9405700242658;16018.439354622766;16229.2696828643;16496.34014639401;16791.328346866234;16828.158592070347;880.2974867157892;925.6621333213463;930.6696122876417;947.9810403791886;1007.561710655867;9306.208972237435;9386.67146649864;9389.295802814817;9453.810923781486;9468.715938521718;545030;570080;578477;579586.3268887509;583664;75395.24604753991;75508;75557.62221188968;76790;80329.59835200786;1047.6647472808781;1068.3109394440542;1077.579743899864;1081.6268387406333;1089.4716062709738;14491.78262326045;14545.127292362069;14607.780883286972;14881.553553393416;15203.847961520243;30770.230744231572;33236.833815831735;33763.3247335047;33873.830630846685;34056.829715851265;40437;40648.390274146506;42350.576494234665;44816.32775508435;44931.32603011023;9357.39176953496;9571.521423928914;9724.659636912675;9767.9023209767;9836.950815246164;11404;11426.25729327591;11489.885101148882;12624;16938.576535586217;13002.08985371015;13095;13310.201387916368;13353.732925341634;14084.15495070299;13939.860601394263;14176.149431034171;14404.495842645458;14461.13233206011;14465.855341446451;13979.930100349433;14490.782638260645;14524.564263072125;14621.19583422922;14755.55733328002;9173.770655733393;9217.677381291622;9617.374870633386;9671.806563868542;9811.558479868565;9781.902180978099;12580.496780128693;12878.871211287767;12947.352632368156;13461.663458413617 11:30:55 INFO - PROCESS | 27769 | |3;mootools.html;1483.8219413670358;1502.376513746795;1662.1356894414905;1760.9295628174873;1807.5327178401485;7497.28775766302;7555.584442855641;7595.848083038343;7645.426593005533;7691.6154192290305;7681.769546913588;7714.228577142283;7723.189065148149;7777.261160189773;7799.883001754978;2229.6766968789516;2230.2194232018787;2255.3459496746004;2258.5821622999715;2263.977360226393;2265.7734226577295;2270.8523945943543;2298.9195378161767;2308.8614683119067;2321.9071237150492;2228.6322756745117;2231.5983123037845;2260.570491606598;2266.5353602511527;2267.093162734911;2261.7851304126248;2284.4745708487058;2295.667128266409;2310.90756369745;2321.802646775026;2279.384566167142;2316.7683231676697;2326.0463210083785;2332.825038122148;2333;7486.401087913008;7537.585432801194;7578.469507134503;7583.5070720403;7598.962005189994;4541;4633.4208223972;4650.9767451162525;4657.534246575316;4667.276572131325;3013.3069394039276;3085.629724433082;3127.0775121339034;3131.9530207046914;3145.2923092304277;1018.2719355660738;1038.0294424712843;1067.7330667333167;1074.790415868906;1085.6634443322596;10549.84175237372;10580.629677961311;10614.203934704929;10709.732256693567;10742.838857417068;4087.2234275487563;4152.356384760367;4173.1862286854375;4178.310578754532;4232.830686772556;8465.153484651486;8598.699045533376;8620.612072456754;8634.78413039679;8640.8766860309;4590.42619672541;4596.839110631178;4604.769761511911;4620.8151673933335;4630.72215667061;4246.44796176495;4249.3625956106835;4255.914881702411;4274.465691788527;4288.120935208275;3384.1201287665385;3388.661133886641;3392.542006829096;3418.3163367326633;3437.432823584081;1050.417018554694;1058.9682309530726;1060.7560261139981;1067.1302888146136;1068.9358638481715;927.1099744245599;927.2257664849791;973.8198433289864;983.5819776594918;1216.3492531495783;6771.424428923498;6847;6863.142107236596;6889.0355350251;6907.412869906014;1039.1219419590434;1063.324788759128;1113.0427832064418;1132.8583927009124;1167.9299242045504;5492.176173573916;5495.148252020943;5498.945010549924;5538.723063846792;5618.0449323615085;8926.910730892609;9399.718008459757;9410.294227932796;9414.67048653294;9450.385724927995;9237.630494780133;9269.67556135532;9286.95356523213;9318.72043838686;9371.531423428938;6976.127984002;7059.682314295869;7097.89353159703;7121.181064177582;7140.821479463055;6876.518643694893;6892.172939247323;6939.132608423947;6980.371766541036;6983.092198014226;7792.181820908723;7897.605119744105;8110.188981101843;8114.43198976066;8189.303909167787;8036.517808931483;8043.115257321573;8102.351811854919;8105.513669179632;8133.877991830245;6265.624062556261;6391.009393544008;6412.935870641234;6455.870882582228;6473.935260647333;6739.42714869222;6810.761623343159;6813.965930170318;6826.93173068263;6854.383105520527;6326.240851097714;6542.640154791342;6723;6813.591184528944;6869.656517174021;6459.870802584016;6473.935260647333;6553.672316384257;6615.966920165369;6631.867362652816;6025.517958563392;6070;6209.379062093754;6243.594166379171;6261.812145635638;5885.61743486672;5908.911366329595;5932.2584676915385;5948.5538584605465;5984.13230081627;5923.7926672566255;6042.848928776816;6091.847703807441;6103.298120715996;6113.51091912637 11:30:55 INFO - PROCESS | 27769 | |4;prototype.html;339.75537612918697;348.81512798216954;349.0819145646947;350.3815765174466;350.78952628422934;6250.312465628783;6261.874762504747;6280.246370435549;6298.275698294698;6442;6281.057841323804;6293.24481062272;6294.339094395092;6296.055591661253;6320.273168585614;4820.252860806563;4822.083804077214;4824.228123500241;4828.444728856191;4829.68607040543;4817.373741413611;4822.927656085161;4826.589739872115;4827.734474603895;4828.275758636215;4695.530446955294;4774.59415949643;4778.832740854071;4790.42514898211;4796.56830885222;4712.528747125277;4756.833510827105;4762.880927976794;4782.832600858953;4795.472498025214;4126.442930204414;4145.2124096421585;4150.107726838714;4165.541790403053;4168.979155104205;5972.522198224132;6000.489958353545;6003.129546215818;6010.098485227207;6022.728977195993;5437.510624043815;5571.888562228733;5588.469095435927;5594.440555944414;5598.524125449342;6686.930091185387;6696.397324240842;6701.195856497203;6706.2287836898895;6720.899186512206;4624.930626040612;4627.953720462786;4628.837990670344;4631.560001799824;4653.278741795028;6787.796366108975;6908.101946746941;6999.82500437488;7014.088168538057;7041.4718896082995;4714.575688188011;4715.22198837188;4716.292556116541;4752.358431611758;4752.405949256343;4768.570828625371;4769.356136921471;4787.712737235777;4802.087603355351;4803.207470767354;5505.944940550623;5544.362398324163;5548.167774833807;5560.332760068818;5573.331200255995;6447.1296374989715;6597.7690780823405;6609.438197753245;6664.333566643394;6743.730250790011;1639.7786298849742;1659.0709202846444;1668.6412421329474;1679.7480377943161;1682.343885884506;1106.2256420505678;1118.3848883114417;1122.4275619434147;1127.6504283671925;1135.1032684179406;6187.81436556904;6211.3167551569295;6258.906116408258;6285.151504546828;6294.496440284766;6800.183977922582;6809.421199198124;6813.727450902007;6815.079964204769;6815.352541508549;6133.049377346519;6213.409726076015;6276.121343011982;6285.528585356116;6286.214223222098;3690.446433035066;3705.370087085202;3711.888643340704;3712.276106159273;3724.2923844469465;7082.29177082298;7094.574325540484;7142.178649455275;7157.320054594805;7158.677859496335;6871.209810871714;7025.8243543910785;7036.577805331696;7042.577445353295;7044.577325360495;7095.361417472453;7201.747938822116;7264.927350726425;7289.635518224068;7318.3047610476915;6874.828129296808;6913.10129683138;6943.826404339729;6950.374466297855;6982.057422247932;6657.866842663023;6764.763233286812;6808;6811.080504131879;6880.9655951721925;7174.3184397482155;7216.134063912364;7228.855422891618;7311.23232060626;7324.157721862054;4704.835330763407;4733.692309999839;4751.619870410428;4755.167845626932;4756.9762151189025;6799.864002720017;6928.203256625553;6985.755498557526;6993.055937448379;7009.334113259232;6565.606063636197;6568.507361947969;6577;6632.469402447696;6723.092382528492;6697.698603562949;6722.260551339251;6750.122484077038;6766.883464228347;6773.119494465688;6516.087747715229;6626.933730662631;6649.900251496329;6657.234418041987;6664.466842652673;6771.356721111487;6816.693248803716;6825.010373495716;6837.179538455417;6855.965720171367;6599.67001649906;6648.135742353463;6648.936170212743;6658.3674550917585;6662.233843107911 11:30:55 INFO - PROCESS | 27769 | |5;yui.html;788.2028973939416;827.1356432528007;830.1490971753951;839.236294971576;851.8551846186156;12105.515779368814;12132.514699412024;12141.210821296632;12172.08709346798;12247.693807654801;11269.53496045513;11299.265547739411;11310.038646715018;11348.432578371068;11379.715507112327;662.9602223866559;681.5025031726842;819.5656302159865;835.1439774231401;840.2060053249681;825.4881973176639;827.420805436197;830.5930094253832;834.9039860416069;836.4270474724802;871.8692196170562;874.54960695242;875.5797217335682;878.4992554244084;878.5870640798814;855.7176131876466;864.2049314630555;865.11758006833;869.5174178331024;869.6695255802817;630.5019034962374;636.9490440764728;639.987200255997;646.1470858466826;646.2826262848234;11549.13381496391;11689.76620467586;11700;11704.53181872724;11709.414529273587;11265;11348.319100853892;11662.76674466506;11664;11743.765124697544;9608.231341492663;9650.469224192666;9668.419894806335;9690.418574885529;9845.753856153582;3332.8833490827706;3414.6585341465657;3523.8061906595126;3533.116720819795;3536.0452677776857;45496;46166.76916615429;49013;49152.262716059646;49237.50762492365;8553.101924297858;8616.569171541523;8649.048604653482;8770.780730481662;8852.557372131369;17425.39011134604;17473.475795725895;17572.91213543924;17610.64778704419;17627.735583966252;7256;7340.779776606603;7438.367738742268;7481.064866891638;7512.737054203077;3734.439834024918;3865.4974853268895;3867.45855580219;3983.900402489961;4018.9196216075516;3173.508106243536;3186.330870517171;3207.951880721791;3207.967920320767;3217.7104060634188;535.4030256264238;545.0461692038932;552.3151292397398;628.8207860759661;653;526.4209369693307;580.4021857486796;584.5090124295527;606.3996643323167;614.6987975891781;7597.354224890946;7817.804554886174;7846.764597062097;7908.498031574421;7959.243871832166;444.09404814178714;450.5381983466907;456.1993701054628;500.60202139298616;535.8633548445122;3439.6216416194197;3627.4014787560286;3692.9076773080888;3828.942565861514;3845.7115716321387;54285;55464.72267638636;55786;56365.43634563684;56528.717356412955;48927.75536122368;49492.50507494879;50120.49879501231;50275;50379;44507.55492445099;44845;45350.54649453463;45676;45829.7708511462;7350.338469537767;7416.7774966751085;7468.663910124166;7503.587302698404;7621.352185064332;33869.83065084659;33899.49150762691;34328;35483.64516354907;37584.812075939444;40724.796376017934;41489.37765933453;41971.160576788905;42238;43079.35380969225;9879.506024698592;9962.352447090916;9981.15160211361;10042.046005629454;10095.343802652804;10738.409387483764;11123.833142502706;11132.165087618623;11232.708238552344;11382.487788049722;9975.900240997496;10003.499825008867;10192.235582331206;10204.948975255076;10340.457969924211;9188.770280743034;9537.237021038161;9591.18474929611;9760.951195243979;9893.65372211998;8973.955130224307;9847.901520984698;9999.850002249827;10024.899751002687;10475.790484190426;8302;8332.250097491255;8440.53577053268;8533.189347012023;9066.592003359996;7535.623218839146;8105.918940810517;8133.34933205354;8172.632231549475;8572.657093716181 11:30:55 INFO - PROCESS | 27769 | __end_tp_report 11:30:55 INFO - PROCESS | 27769 | __start_cc_report 11:30:55 INFO - PROCESS | 27769 | _x_x_mozilla_cycle_collect,310 11:30:55 INFO - PROCESS | 27769 | __end_cc_report 11:30:55 INFO - PROCESS | 27769 | __startTimestamp1451935855287__endTimestamp 11:30:55 INFO - PROCESS | 27769 | 11:30:55 INFO - PROCESS | 27769 | ------- Summary: start ------- 11:30:55 INFO - PROCESS | 27769 | Number of tests: 6 11:30:55 INFO - PROCESS | 27769 | 11:30:55 INFO - PROCESS | 27769 | [#0] dojo.html Cycles:165 Average:5389.60 Median:5606.94 stddev:601.25 (10.7%) stddev-sans-first:576.08 11:30:55 INFO - PROCESS | 27769 | Values: 3118.1 3118.7 3180.0 3200.5 3216.1 5273.6 5360.5 5390.6 5405.6 5407.1 5341.5 5347.6 5374.5 5380.1 5383.7 4908.9 4952.0 4972.9 4997.6 5020.1 4941.1 4997.9 5002.8 5038.8 5051.0 4790.8 4836.1 4920.1 4935.1 5043.5 4891.7 4897.5 4924.1 4988.8 5035.7 4791.8 4913.3 4953.6 4990.8 5021.7 5231.3 5291.8 5296.9 5324.9 5349.4 5720.4 5727.8 5765.1 5800.4 5805.3 5741.8 5802.4 5832.4 5848.5 5880.4 5379.8 5420.2 5425.8 5439.4 5464.9 5903.9 5905.9 5947.9 5970.2 5976.4 5555.8 5714.7 5718.4 5724.4 5739.0 5834.5 5877.0 5898.6 5920.2 5951.8 5711.8 5727.6 5762.9 5767.1 5785.1 5620.2 5721.0 5723.9 5790.0 5794.3 4430.4 4443.0 4457.8 4532.6 4572.5 4010.0 4012.3 4022.8 4051.5 4072.9 5318.9 5432.5 5504.4 5517.2 5540.3 5728.7 5746.0 5746.9 5758.2 5770.0 5420.6 5421.3 5424.2 5490.2 5537.3 4920.3 4923.9 4941.8 4947.1 5020.7 5787.5 5963.9 5996.9 6046.5 6069.9 5712.6 5771.3 5799.4 5816.1 5831.4 5960.3 5999.7 6001.5 6031.1 6123.6 5726.9 5751.9 5770.6 5776.1 5792.4 5804.6 5847.9 5858.6 5876.9 5882.3 5580.7 5628.0 5687.0 5713.4 5747.9 5681.1 5698.9 5712.8 5724.4 5752.6 5567.1 5591.4 5596.1 5598.0 5606.9 5612.2 5676.7 5709.0 5807.4 5854.3 5586.2 5619.6 5622.3 5627.8 5658.2 11:30:55 INFO - PROCESS | 27769 | 11:30:55 INFO - PROCESS | 27769 | [#1] ext.html Cycles:180 Average:48463.06 Median:20671.98 stddev:84702.16 (409.7%) stddev-sans-first:84863.31 11:30:55 INFO - PROCESS | 27769 | Values: 530.7 535.9 541.5 553.2 553.3 34636.0 35456.3 35710.5 35752.3 35890.6 38858.8 38903.6 38947.4 39297.2 39321.6 8506.7 8575.7 8621.3 8639.0 8651.7 8330.9 8344.9 8377.1 8404.1 8446.3 8615.0 8706.8 8714.4 8720.9 8737.8 8553.0 8581.6 8659.2 8676.7 8734.3 8444.2 8513.3 8593.9 8601.4 8606.1 38894.4 39020.0 39465.2 39526.0 39658.6 3147.9 3176.5 3245.9 3380.0 3722.6 27447.2 27640.9 27741.3 27957.4 28825.1 3788.5 3799.2 3809.2 3904.7 4019.2 256605.0 257033.0 258023.0 310087.0 311251.0 56734.4 57600.4 57808.7 57942.0 57994.1 62483.0 62558.4 62810.4 62861.4 62889.0 13839.4 13987.1 14019.6 14026.1 14042.4 11825.2 11849.8 11853.9 11860.6 11892.9 19583.3 19596.3 19615.9 19893.4 19937.6 7852.6 8050.9 8078.9 8110.3 8197.6 892.2 953.2 1028.7 1059.4 1075.7 26402.3 27108.5 27662.0 27679.6 27817.9 1036.4 1039.6 1053.3 1148.5 1161.6 14345.9 14405.9 14484.3 14627.3 14811.5 386360.0 387719.0 388527.0 392240.0 392357.0 53638.0 53808.5 53950.5 54046.0 54839.7 1328.9 1329.3 1333.8 1338.3 1491.9 26532.3 27530.4 27773.3 27858.4 27898.4 42521.6 42958.8 42979.4 43143.8 43210.8 282078.0 284989.0 287641.0 287851.0 287867.0 31911.8 42109.8 42618.1 42880.8 42929.1 44143.6 45104.3 46206.0 48337.0 49289.0 36094.4 36334.3 36546.5 36894.8 37555.4 37070.8 37507.2 38803.8 39568.6 40235.8 33988.0 34176.1 34569.7 34617.0 34689.8 30473.7 31723.8 32829.2 32855.3 33089.7 24677.3 25213.2 25460.4 25533.0 25568.4 11:30:55 INFO - PROCESS | 27769 | 11:30:55 INFO - PROCESS | 27769 | [#2] jquery.html Cycles:180 Average:29100.67 Median:363.11 stddev:93307.83 (25696.8%) stddev-sans-first:93544.63 11:30:55 INFO - PROCESS | 27769 | Values: 362.0 364.2 364.7 368.2 369.9 16488.3 16975.2 17492.2 17827.1 18574.6 14785.0 15612.7 15756.5 15837.8 15905.4 4927.9 5058.6 5060.3 5065.9 5068.9 4630.0 5021.7 5034.3 5040.4 5043.4 5344.5 5367.9 5377.6 5478.6 5489.8 4961.5 5378.4 5425.6 5429.6 5436.9 4804.6 4807.3 4814.1 4814.8 4826.8 12921.5 13010.5 18448.4 20250.3 20273.7 1963.8 1965.5 2003.8 2016.3 2134.5 9079.5 9115.7 10536.7 11393.4 11770.2 1459.1 1474.7 1558.4 1561.8 1594.3 52785.5 55935.4 60123.4 63027.0 64156.0 10381.9 10387.5 10470.4 10505.5 10510.8 12740.4 13089.5 13113.1 13171.8 13463.5 7086.0 7298.0 7394.0 7398.5 7436.1 7263.9 7336.4 7386.1 7434.5 7495.6 4506.5 4552.9 4565.0 4586.0 4600.4 1835.5 1838.4 1873.4 1888.8 1898.9 880.3 915.4 986.9 1021.7 1048.9 16018.4 16229.3 16496.3 16791.3 16828.2 880.3 925.7 930.7 948.0 1007.6 9306.2 9386.7 9389.3 9453.8 9468.7 545030.0 570080.0 578477.0 579586.3 583664.0 75395.2 75508.0 75557.6 76790.0 80329.6 1047.7 1068.3 1077.6 1081.6 1089.5 14491.8 14545.1 14607.8 14881.6 15203.8 30770.2 33236.8 33763.3 33873.8 34056.8 40437.0 40648.4 42350.6 44816.3 44931.3 9357.4 9571.5 9724.7 9767.9 9837.0 11404.0 11426.3 11489.9 12624.0 16938.6 13002.1 13095.0 13310.2 13353.7 14084.2 13939.9 14176.1 14404.5 14461.1 14465.9 13979.9 14490.8 14524.6 14621.2 14755.6 9173.8 9217.7 9617.4 9671.8 9811.6 9781.9 12580.5 12878.9 12947.4 13461.7 11:30:55 INFO - PROCESS | 27769 | 11:30:55 INFO - PROCESS | 27769 | [#3] mootools.html Cycles:180 Average:5256.97 Median:5966.34 stddev:2708.84 (45.4%) stddev-sans-first:2701.59 11:30:55 INFO - PROCESS | 27769 | Values: 1483.8 1502.4 1662.1 1760.9 1807.5 7497.3 7555.6 7595.8 7645.4 7691.6 7681.8 7714.2 7723.2 7777.3 7799.9 2229.7 2230.2 2255.3 2258.6 2264.0 2265.8 2270.9 2298.9 2308.9 2321.9 2228.6 2231.6 2260.6 2266.5 2267.1 2261.8 2284.5 2295.7 2310.9 2321.8 2279.4 2316.8 2326.0 2332.8 2333.0 7486.4 7537.6 7578.5 7583.5 7599.0 4541.0 4633.4 4651.0 4657.5 4667.3 3013.3 3085.6 3127.1 3132.0 3145.3 1018.3 1038.0 1067.7 1074.8 1085.7 10549.8 10580.6 10614.2 10709.7 10742.8 4087.2 4152.4 4173.2 4178.3 4232.8 8465.2 8598.7 8620.6 8634.8 8640.9 4590.4 4596.8 4604.8 4620.8 4630.7 4246.4 4249.4 4255.9 4274.5 4288.1 3384.1 3388.7 3392.5 3418.3 3437.4 1050.4 1059.0 1060.8 1067.1 1068.9 927.1 927.2 973.8 983.6 1216.3 6771.4 6847.0 6863.1 6889.0 6907.4 1039.1 1063.3 1113.0 1132.9 1167.9 5492.2 5495.1 5498.9 5538.7 5618.0 8926.9 9399.7 9410.3 9414.7 9450.4 9237.6 9269.7 9287.0 9318.7 9371.5 6976.1 7059.7 7097.9 7121.2 7140.8 6876.5 6892.2 6939.1 6980.4 6983.1 7792.2 7897.6 8110.2 8114.4 8189.3 8036.5 8043.1 8102.4 8105.5 8133.9 6265.6 6391.0 6412.9 6455.9 6473.9 6739.4 6810.8 6814.0 6826.9 6854.4 6326.2 6542.6 6723.0 6813.6 6869.7 6459.9 6473.9 6553.7 6616.0 6631.9 6025.5 6070.0 6209.4 6243.6 6261.8 5885.6 5908.9 5932.3 5948.6 5984.1 5923.8 6042.8 6091.8 6103.3 6113.5 11:30:55 INFO - PROCESS | 27769 | 11:30:55 INFO - PROCESS | 27769 | [#4] prototype.html Cycles:180 Average:5584.90 Median:6285.34 stddev:1693.68 (26.9%) stddev-sans-first:1652.05 11:30:55 INFO - PROCESS | 27769 | Values: 339.8 348.8 349.1 350.4 350.8 6250.3 6261.9 6280.2 6298.3 6442.0 6281.1 6293.2 6294.3 6296.1 6320.3 4820.3 4822.1 4824.2 4828.4 4829.7 4817.4 4822.9 4826.6 4827.7 4828.3 4695.5 4774.6 4778.8 4790.4 4796.6 4712.5 4756.8 4762.9 4782.8 4795.5 4126.4 4145.2 4150.1 4165.5 4169.0 5972.5 6000.5 6003.1 6010.1 6022.7 5437.5 5571.9 5588.5 5594.4 5598.5 6686.9 6696.4 6701.2 6706.2 6720.9 4624.9 4628.0 4628.8 4631.6 4653.3 6787.8 6908.1 6999.8 7014.1 7041.5 4714.6 4715.2 4716.3 4752.4 4752.4 4768.6 4769.4 4787.7 4802.1 4803.2 5505.9 5544.4 5548.2 5560.3 5573.3 6447.1 6597.8 6609.4 6664.3 6743.7 1639.8 1659.1 1668.6 1679.7 1682.3 1106.2 1118.4 1122.4 1127.7 1135.1 6187.8 6211.3 6258.9 6285.2 6294.5 6800.2 6809.4 6813.7 6815.1 6815.4 6133.0 6213.4 6276.1 6285.5 6286.2 3690.4 3705.4 3711.9 3712.3 3724.3 7082.3 7094.6 7142.2 7157.3 7158.7 6871.2 7025.8 7036.6 7042.6 7044.6 7095.4 7201.7 7264.9 7289.6 7318.3 6874.8 6913.1 6943.8 6950.4 6982.1 6657.9 6764.8 6808.0 6811.1 6881.0 7174.3 7216.1 7228.9 7311.2 7324.2 4704.8 4733.7 4751.6 4755.2 4757.0 6799.9 6928.2 6985.8 6993.1 7009.3 6565.6 6568.5 6577.0 6632.5 6723.1 6697.7 6722.3 6750.1 6766.9 6773.1 6516.1 6626.9 6649.9 6657.2 6664.5 6771.4 6816.7 6825.0 6837.2 6856.0 6599.7 6648.1 6648.9 6658.4 6662.2 11:30:55 INFO - PROCESS | 27769 | 11:30:55 INFO - PROCESS | 27769 | [#5] yui.html Cycles:180 Average:13024.49 Median:27415.02 stddev:15593.90 (56.9%) stddev-sans-first:15610.57 11:30:55 INFO - PROCESS | 27769 | Values: 788.2 827.1 830.1 839.2 851.9 12105.5 12132.5 12141.2 12172.1 12247.7 11269.5 11299.3 11310.0 11348.4 11379.7 663.0 681.5 819.6 835.1 840.2 825.5 827.4 830.6 834.9 836.4 871.9 874.5 875.6 878.5 878.6 855.7 864.2 865.1 869.5 869.7 630.5 636.9 640.0 646.1 646.3 11549.1 11689.8 11700.0 11704.5 11709.4 11265.0 11348.3 11662.8 11664.0 11743.8 9608.2 9650.5 9668.4 9690.4 9845.8 3332.9 3414.7 3523.8 3533.1 3536.0 45496.0 46166.8 49013.0 49152.3 49237.5 8553.1 8616.6 8649.0 8770.8 8852.6 17425.4 17473.5 17572.9 17610.6 17627.7 7256.0 7340.8 7438.4 7481.1 7512.7 3734.4 3865.5 3867.5 3983.9 4018.9 3173.5 3186.3 3208.0 3208.0 3217.7 535.4 545.0 552.3 628.8 653.0 526.4 580.4 584.5 606.4 614.7 7597.4 7817.8 7846.8 7908.5 7959.2 444.1 450.5 456.2 500.6 535.9 3439.6 3627.4 3692.9 3828.9 3845.7 54285.0 55464.7 55786.0 56365.4 56528.7 48927.8 49492.5 50120.5 50275.0 50379.0 44507.6 44845.0 45350.5 45676.0 45829.8 7350.3 7416.8 7468.7 7503.6 7621.4 33869.8 33899.5 34328.0 35483.6 37584.8 40724.8 41489.4 41971.2 42238.0 43079.4 9879.5 9962.4 9981.2 10042.0 10095.3 10738.4 11123.8 11132.2 11232.7 11382.5 9975.9 10003.5 10192.2 10204.9 10340.5 9188.8 9537.2 9591.2 9761.0 9893.7 8974.0 9847.9 9999.9 10024.9 10475.8 8302.0 8332.3 8440.5 8533.2 9066.6 7535.6 8105.9 8133.3 8172.6 8572.7 11:30:55 INFO - PROCESS | 27769 | -------- Summary: end -------- 11:30:55 INFO - PROCESS | 27769 | 11:30:55 INFO - TEST-INFO | 27769: exit 0 11:30:55 INFO - TEST-OK | dromaeo_css | took 1110538ms 11:30:55 INFO - TEST-START | kraken 11:30:55 INFO - operating with platform_type : linux_ 11:30:55 INFO - Initialising browser for kraken test... 11:30:56 INFO - TEST-INFO | started process 28013 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp41JHne/profile http://localhost:45856/getInfo.html) 11:31:00 INFO - PROCESS | 28013 | __metrics Screen width/height:1600/1200 11:31:00 INFO - PROCESS | 28013 | colorDepth:24 11:31:00 INFO - PROCESS | 28013 | Browser inner width/height: 1024/697 11:31:00 INFO - PROCESS | 28013 | __metrics 11:31:00 INFO - PROCESS | 28013 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:31:01 INFO - TEST-INFO | 28013: exit 0 11:31:01 INFO - Browser initialized. 11:31:01 INFO - Running cycle 1/1 for kraken test... 11:31:01 INFO - TEST-INFO | started process 28134 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp41JHne/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:12 INFO - PROCESS | 28134 | RSS: Main: 150425600 11:31:12 INFO - PROCESS | 28134 | 11:31:15 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45856/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:15 INFO - PROCESS | 28134 | RSS: Main: 152043520 11:31:15 INFO - PROCESS | 28134 | 11:31:18 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45856/tests/kraken/driver.html?testName=audio-dft) 11:31:19 INFO - PROCESS | 28134 | RSS: Main: 151318528 11:31:19 INFO - PROCESS | 28134 | 11:31:22 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45856/tests/kraken/driver.html?testName=audio-fft) 11:31:22 INFO - PROCESS | 28134 | RSS: Main: 146337792 11:31:22 INFO - PROCESS | 28134 | 11:31:24 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45856/tests/kraken/driver.html?testName=audio-oscillator) 11:31:25 INFO - PROCESS | 28134 | RSS: Main: 145756160 11:31:25 INFO - PROCESS | 28134 | 11:31:27 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45856/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:31:28 INFO - PROCESS | 28134 | RSS: Main: 146309120 11:31:28 INFO - PROCESS | 28134 | 11:31:31 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45856/tests/kraken/driver.html?testName=imaging-darkroom) 11:31:31 INFO - PROCESS | 28134 | RSS: Main: 147607552 11:31:31 INFO - PROCESS | 28134 | 11:31:35 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45856/tests/kraken/driver.html?testName=imaging-desaturate) 11:31:35 INFO - PROCESS | 28134 | RSS: Main: 148545536 11:31:35 INFO - PROCESS | 28134 | 11:31:38 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45856/tests/kraken/driver.html?testName=json-parse-financial) 11:31:39 INFO - PROCESS | 28134 | RSS: Main: 149049344 11:31:39 INFO - PROCESS | 28134 | 11:31:40 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45856/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:31:41 INFO - PROCESS | 28134 | RSS: Main: 149061632 11:31:41 INFO - PROCESS | 28134 | 11:31:43 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:31:43 INFO - PROCESS | 28134 | RSS: Main: 148557824 11:31:43 INFO - PROCESS | 28134 | 11:31:45 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:31:46 INFO - PROCESS | 28134 | RSS: Main: 149315584 11:31:46 INFO - PROCESS | 28134 | 11:31:49 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:31:49 INFO - PROCESS | 28134 | RSS: Main: 149344256 11:31:49 INFO - PROCESS | 28134 | 11:31:52 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:31:52 INFO - PROCESS | 28134 | RSS: Main: 149450752 11:31:52 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45856/tests/kraken/driver.html?testName=ai-astar) 11:31:54 INFO - PROCESS | 28134 | RSS: Main: 149397504 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | __start_tp_report 11:31:54 INFO - PROCESS | 28134 | _x_x_mozilla_page_load 11:31:54 INFO - PROCESS | 28134 | _x_x_mozilla_page_load_details 11:31:54 INFO - PROCESS | 28134 | |i|pagename|runs| 11:31:54 INFO - PROCESS | 28134 | |0;ai-astar;113;106;111;112;111;122;112;111;113;113 11:31:54 INFO - PROCESS | 28134 | |1;audio-beat-detection;155;134;165;161;127;149;150;128;164;128 11:31:54 INFO - PROCESS | 28134 | |2;audio-dft;162;163;161;164;161;160;162;165;169;161 11:31:54 INFO - PROCESS | 28134 | |3;audio-fft;73;76;82;75;75;75;75;145;73;72 11:31:54 INFO - PROCESS | 28134 | |4;audio-oscillator;97;98;138;97;97;97;146;96;97;135 11:31:54 INFO - PROCESS | 28134 | |5;imaging-gaussian-blur;110;111;111;110;110;110;110;110;111;111 11:31:54 INFO - PROCESS | 28134 | |6;imaging-darkroom;148;149;150;147;148;150;148;150;148;147 11:31:54 INFO - PROCESS | 28134 | |7;imaging-desaturate;96;97;97;97;97;97;97;97;97;97 11:31:54 INFO - PROCESS | 28134 | |8;json-parse-financial;61;63;59;60;62;60;60;60;60;57 11:31:54 INFO - PROCESS | 28134 | |9;json-stringify-tinderbox;68;68;68;68;68;69;68;69;68;68 11:31:54 INFO - PROCESS | 28134 | |10;stanford-crypto-aes;86;87;89;88;95;91;89;89;88;89 11:31:54 INFO - PROCESS | 28134 | |11;stanford-crypto-ccm;121;125;136;124;134;120;127;120;121;129 11:31:54 INFO - PROCESS | 28134 | |12;stanford-crypto-pbkdf2;143;153;153;158;150;159;156;161;153;144 11:31:54 INFO - PROCESS | 28134 | |13;stanford-crypto-sha256-iterative;71;70;70;72;70;69;71;72;69;70 11:31:54 INFO - PROCESS | 28134 | __end_tp_report 11:31:54 INFO - PROCESS | 28134 | __start_cc_report 11:31:54 INFO - PROCESS | 28134 | _x_x_mozilla_cycle_collect,710 11:31:54 INFO - PROCESS | 28134 | __end_cc_report 11:31:54 INFO - PROCESS | 28134 | __startTimestamp1451935914762__endTimestamp 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | ------- Summary: start ------- 11:31:54 INFO - PROCESS | 28134 | Number of tests: 14 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:3.95 (3.5%) stddev-sans-first:4.18 11:31:54 INFO - PROCESS | 28134 | Values: 113.0 106.0 111.0 112.0 111.0 122.0 112.0 111.0 113.0 113.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:152.50 stddev:15.52 (10.2%) stddev-sans-first:16.13 11:31:54 INFO - PROCESS | 28134 | Values: 155.0 134.0 165.0 161.0 127.0 149.0 150.0 128.0 164.0 128.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:2.66 (1.6%) stddev-sans-first:2.80 11:31:54 INFO - PROCESS | 28134 | Values: 162.0 163.0 161.0 164.0 161.0 160.0 162.0 165.0 169.0 161.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:22.27 (29.7%) stddev-sans-first:23.37 11:31:54 INFO - PROCESS | 28134 | Values: 73.0 76.0 82.0 75.0 75.0 75.0 75.0 145.0 73.0 72.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:97.00 stddev:20.79 (21.4%) stddev-sans-first:21.53 11:31:54 INFO - PROCESS | 28134 | Values: 97.0 98.0 138.0 97.0 97.0 97.0 146.0 96.0 97.0 135.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:31:54 INFO - PROCESS | 28134 | Values: 110.0 111.0 111.0 110.0 110.0 110.0 110.0 110.0 111.0 111.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:1.18 (0.8%) stddev-sans-first:1.24 11:31:54 INFO - PROCESS | 28134 | Values: 148.0 149.0 150.0 147.0 148.0 150.0 148.0 150.0 148.0 147.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 11:31:54 INFO - PROCESS | 28134 | Values: 96.0 97.0 97.0 97.0 97.0 97.0 97.0 97.0 97.0 97.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:1.62 (2.7%) stddev-sans-first:1.69 11:31:54 INFO - PROCESS | 28134 | Values: 61.0 63.0 59.0 60.0 62.0 60.0 60.0 60.0 60.0 57.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 11:31:54 INFO - PROCESS | 28134 | Values: 68.0 68.0 68.0 68.0 68.0 69.0 68.0 69.0 68.0 68.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:89.00 stddev:2.47 (2.8%) stddev-sans-first:2.35 11:31:54 INFO - PROCESS | 28134 | Values: 86.0 87.0 89.0 88.0 95.0 91.0 89.0 89.0 88.0 89.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:126.00 stddev:5.77 (4.6%) stddev-sans-first:5.87 11:31:54 INFO - PROCESS | 28134 | Values: 121.0 125.0 136.0 124.0 134.0 120.0 127.0 120.0 121.0 129.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:154.50 stddev:6.00 (3.9%) stddev-sans-first:5.16 11:31:54 INFO - PROCESS | 28134 | Values: 143.0 153.0 153.0 158.0 150.0 159.0 156.0 161.0 153.0 144.0 11:31:54 INFO - PROCESS | 28134 | 11:31:54 INFO - PROCESS | 28134 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.07 (1.5%) stddev-sans-first:1.12 11:31:54 INFO - PROCESS | 28134 | Values: 71.0 70.0 70.0 72.0 70.0 69.0 71.0 72.0 69.0 70.0 11:31:54 INFO - PROCESS | 28134 | -------- Summary: end -------- 11:31:54 INFO - PROCESS | 28134 | 11:31:55 INFO - TEST-INFO | 28134: exit 0 11:31:55 INFO - TEST-OK | kraken | took 59782ms 11:31:55 INFO - TEST-START | v8_7 11:31:55 INFO - operating with platform_type : linux_ 11:31:55 INFO - Initialising browser for v8_7 test... 11:31:55 INFO - TEST-INFO | started process 28423 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA3o9fo/profile http://localhost:45856/getInfo.html) 11:31:59 INFO - PROCESS | 28423 | __metrics Screen width/height:1600/1200 11:31:59 INFO - PROCESS | 28423 | colorDepth:24 11:31:59 INFO - PROCESS | 28423 | Browser inner width/height: 1024/697 11:31:59 INFO - PROCESS | 28423 | __metrics 11:31:59 INFO - PROCESS | 28423 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:32:00 INFO - TEST-INFO | 28423: exit 0 11:32:00 INFO - Browser initialized. 11:32:00 INFO - Running cycle 1/1 for v8_7 test... 11:32:00 INFO - TEST-INFO | started process 28546 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA3o9fo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:12 INFO - PROCESS | 28546 | RSS: Main: 149872640 11:32:12 INFO - PROCESS | 28546 | 11:32:33 INFO - PROCESS | 28546 | Cycle 1(1): loaded http://localhost:45856/tests/v8_7/run.html (next: http://localhost:45856/tests/v8_7/run.html) 11:32:34 INFO - PROCESS | 28546 | RSS: Main: 146776064 11:32:34 INFO - PROCESS | 28546 | 11:32:34 INFO - PROCESS | 28546 | __start_tp_report 11:32:34 INFO - PROCESS | 28546 | _x_x_mozilla_page_load 11:32:34 INFO - PROCESS | 28546 | _x_x_mozilla_page_load_details 11:32:34 INFO - PROCESS | 28546 | |i|pagename|runs| 11:32:34 INFO - PROCESS | 28546 | |0;Richards;167.16817118020728 11:32:34 INFO - PROCESS | 28546 | |1;DeltaBlue;189.82536066818528 11:32:34 INFO - PROCESS | 28546 | |2;Encrypt;280.2690582959641 11:32:34 INFO - PROCESS | 28546 | |3;Decrypt;5273.684210526316 11:32:34 INFO - PROCESS | 28546 | |4;RayTrace;1050.420168067227 11:32:34 INFO - PROCESS | 28546 | |5;Earley;709.2198581560284 11:32:34 INFO - PROCESS | 28546 | |6;Boyer;12180.722891566265 11:32:34 INFO - PROCESS | 28546 | |7;RegExp;25769.23076923077 11:32:34 INFO - PROCESS | 28546 | |8;Splay;584.7953216374269 11:32:34 INFO - PROCESS | 28546 | |9;NavierStokes;4864.077669902913 11:32:34 INFO - PROCESS | 28546 | __end_tp_report 11:32:34 INFO - PROCESS | 28546 | __startTimestamp1451935954237__endTimestamp 11:32:34 INFO - PROCESS | 28546 | 11:32:34 INFO - PROCESS | 28546 | ------- Summary: start ------- 11:32:34 INFO - PROCESS | 28546 | Number of tests: 10 11:32:34 INFO - PROCESS | 28546 | 11:32:34 INFO - PROCESS | 28546 | [#0] Richards Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 11:32:34 INFO - PROCESS | 28546 | Values: 167.2 11:32:34 INFO - PROCESS | 28546 | 11:32:34 INFO - PROCESS | 28546 | [#1] DeltaBlue Cycles:1 Average:189.83 Median:189.83 stddev:0.00 (0.0%) 11:32:34 INFO - PROCESS | 28546 | Values: 189.8 11:32:34 INFO - PROCESS | 28546 | 11:32:34 INFO - PROCESS | 28546 | [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 11:32:34 INFO - PROCESS | 28546 | Values: 280.3 11:32:34 INFO - PROCESS | 28546 | 11:32:34 INFO - PROCESS | 28546 | [#3] Decrypt Cycles:1 Average:5273.68 Median:5273.68 stddev:0.00 (0.0%) 11:32:34 INFO - PROCESS | 28546 | Values: 5273.7 11:32:34 INFO - PROCESS | 28546 | 11:32:34 INFO - PROCESS | 28546 | [#4] RayTrace Cycles:1 Average:1050.42 Median:1050.42 stddev:0.00 (0.0%) 11:32:34 INFO - PROCESS | 28546 | Values: 1050.4 11:32:34 INFO - PROCESS | 28546 | 11:32:34 INFO - PROCESS | 28546 | [#5] Earley Cycles:1 Average:709.22 Median:709.22 stddev:0.00 (0.0%) 11:32:34 INFO - PROCESS | 28546 | Values: 709.2 11:32:34 INFO - PROCESS | 28546 | 11:32:34 INFO - PROCESS | 28546 | [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 11:32:34 INFO - PROCESS | 28546 | Values: 12180.7 11:32:34 INFO - PROCESS | 28546 | 11:32:34 INFO - PROCESS | 28546 | [#7] RegExp Cycles:1 Average:25769.23 Median:25769.23 stddev:0.00 (0.0%) 11:32:34 INFO - PROCESS | 28546 | Values: 25769.2 11:32:34 INFO - PROCESS | 28546 | 11:32:34 INFO - PROCESS | 28546 | [#8] Splay Cycles:1 Average:584.80 Median:584.80 stddev:0.00 (0.0%) 11:32:34 INFO - PROCESS | 28546 | Values: 584.8 11:32:34 INFO - PROCESS | 28546 | 11:32:34 INFO - PROCESS | 28546 | [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 11:32:34 INFO - PROCESS | 28546 | Values: 4864.1 11:32:34 INFO - PROCESS | 28546 | -------- Summary: end -------- 11:32:34 INFO - PROCESS | 28546 | 11:32:35 INFO - TEST-INFO | 28546: exit 0 11:32:35 INFO - TEST-OK | v8_7 | took 39347ms 11:32:35 INFO - SUITE-END | took 1209s 11:32:35 INFO - Completed test suite (00:20:09) 11:32:35 INFO - Working with test: dromaeo_css 11:32:35 INFO - Generating results file: dromaeo_css 11:32:35 INFO - Working with test: kraken 11:32:35 INFO - Generating results file: kraken 11:32:35 INFO - javascript benchmark 11:32:35 INFO - Working with test: v8_7 11:32:35 INFO - Generating results file: v8_7 11:32:35 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:32:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:32:35 INFO - process_Request line: dromaeo_css 6912.03 graph.html#tests=[[72,64,43]] 11:32:35 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:32:35 INFO - process_Request line: kraken 1535.60 graph.html#tests=[[232,64,43]] 11:32:35 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:32:35 INFO - process_Request line: v8_7 21383.47 graph.html#tests=[[230,64,43]] 11:32:35 INFO - RETURN: dromaeo_css: 6912.03 11:32:35 INFO - RETURN: kraken: 1535.60 11:32:35 INFO - RETURN: v8_7: 21383.47 11:32:35 INFO - javascript benchmark 11:32:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3118.1269244611517, 3118.719315261626, 3179.984100079499, 3200.487921932491, 3216.0834162263745, 5273.5781137509, 5360.544353729928, 5390.595705322102, 5405.648632838863, 5407.05376559102, 5341.545968592664, 5347.6256662033675, 5374.4894235047705, 5380.112281473562, 5383.730813459321, 4908.877278068041, 4952.0, 4972.925406118911, 4997.625178111647, 5020.0712868119335, 4941.135301322272, 4997.850064498053, 5002.8249011284615, 5038.7984480620735, 5051.040302342543, 4790.7604619769045, 4836.081144582553, 4920.065187614342, 4935.136351138536, 5043.52086551777, 4891.657583969123, 4897.461279259279, 4924.14226630283, 4988.825391111293, 5035.748212589356, 4791.808327666889, 4913.336699545552, 4953.578945789613, 4990.750462476898, 5021.673591216596, 5231.267622532849, 5291.814786482455, 5296.92054619181, 5324.92012619811, 5349.358077030781, 5720.370759216483, 5727.77088916447, 5765.106408506688, 5800.361960184377, 5805.3323867755325, 5741.827745167651, 5802.448767367136, 5832.358440571534, 5848.5321174305955, 5880.382559831199, 5379.81170659029, 5420.214068960057, 5425.810096646677, 5439.401665816757, 5464.9453505464835, 5903.911441328383, 5905.940940590539, 5947.851303717355, 5970.164177015221, 5976.432238937294, 5555.833325000256, 5714.714264286769, 5718.399568045295, 5724.370319264877, 5739.0, 5834.504067154255, 5876.970615146897, 5898.616589921641, 5920.2303700519515, 5951.791687290924, 5711.8000869969355, 5727.570432217601, 5762.855928601734, 5767.077267637158, 5785.10330898703, 5620.1569764534825, 5720.971395142998, 5723.914141287884, 5790.0, 5794.333651630117, 4430.446194225722, 4443.044745379759, 4457.754823484739, 4532.637389008872, 4572.51988541205, 4010.017545701322, 4012.257732319472, 4022.8189731462153, 4051.493563304587, 4072.857449989236, 5318.946810531923, 5432.51107400328, 5504.4495550444635, 5517.200005999108, 5540.335159780852, 5728.742206600713, 5746.02317606008, 5746.9425305747245, 5758.193852860602, 5770.019096753562, 5420.563550659079, 5421.322334708161, 5424.159255315432, 5490.203920431515, 5537.307836520435, 4920.286558449005, 4923.903312444032, 4941.827036053721, 4947.060058588857, 5020.698758074527, 5787.450192231731, 5963.850903727442, 5996.940030599725, 6046.516278697693, 6069.908951365733, 5712.6001179917, 5771.278590176228, 5799.362070172362, 5816.127580862904, 5831.446012628793, 5960.314563825215, 5999.70001499932, 6001.519878409629, 6031.09533569968, 6123.571350005457, 5726.854629074119, 5751.884962300815, 5770.567207459541, 5776.133579963039, 5792.4497172768515, 5804.564657650778, 5847.853803654943, 5858.648481091148, 5876.911846322394, 5882.294124705063, 5580.693061881473, 5627.958827616904, 5686.9715651421475, 5713.371529131875, 5747.9137812932, 5681.0910254359105, 5698.886022279448, 5712.828615141386, 5724.427557244242, 5752.597318187854, 5567.137093750475, 5591.440855914376, 5596.132599447093, 5597.972010140086, 5606.943930560642, 5612.242347283228, 5676.716164191691, 5709.029464990878, 5807.390224026416, 5854.268216472941, 5586.217929489793, 5619.578531610064, 5622.269105016322, 5627.831165065055, 5658.236138121301], "unit": "score", "name": "dojo.html", "value": 5349.956488103292}, {"lowerIsBetter": false, "replicates": [530.6868947321079, 535.8981793459245, 541.4531323363403, 553.239295968044, 553.2917865132632, 34636.0, 35456.29087418257, 35710.464343034844, 35752.2849543009, 35890.64109358909, 38858.8057059715, 38903.61096389035, 38947.41578876312, 39297.21405571894, 39321.60678393222, 8506.744797656065, 8575.699850505234, 8621.267192288664, 8639.0, 8651.65393384264, 8330.875036874451, 8344.874826877602, 8377.120402357756, 8404.07555168931, 8446.324294056492, 8614.956925215396, 8706.825863482727, 8714.433561818492, 8720.912790872073, 8737.7815554611, 8553.0, 8581.570921453902, 8659.177378149097, 8676.652933882637, 8734.301255899576, 8444.197801208875, 8513.318934485289, 8593.914060859437, 8601.354898382646, 8606.096359882247, 38894.41658375126, 39020.0, 39465.21069578592, 39526.0, 39658.60341396578, 3147.921301967446, 3176.5076413156, 3245.8539365728598, 3380.0, 3722.627737226283, 27447.17658470249, 27640.861795690893, 27741.306467338276, 27957.440851182862, 28825.135245942656, 3788.5264341957254, 3799.202167544819, 3809.2381523695094, 3904.7461914975434, 4019.2363450944226, 256605.0, 257033.0, 258023.0, 310087.0, 311251.0, 56734.43265567374, 57600.42399576034, 57808.71095644495, 57942.0, 57994.13008804871, 62483.0, 62558.374416255254, 62810.371896281365, 62861.37138628647, 62889.0, 13839.377228024763, 13987.090839095426, 14019.649508762159, 14026.08830426019, 14042.438302467992, 11825.172237943261, 11849.822252666218, 11853.88146118545, 11860.584879529175, 11892.881071189351, 19583.314583989493, 19596.314129005703, 19615.901920490305, 19893.403197904085, 19937.60124797496, 7852.646630901623, 8050.879236811453, 8078.919210807934, 8110.31062359706, 8197.631106600218, 892.2326798952895, 953.2421724728857, 1028.681108856257, 1059.4067322299536, 1075.7310672331917, 26402.339941501617, 27108.457830843272, 27662.0, 27679.584806227922, 27817.860910695315, 1036.362636978268, 1039.5633833789827, 1053.2732414633879, 1148.472531533059, 1161.5644133449957, 14345.928270358581, 14405.85594144066, 14484.275786210857, 14627.26863656813, 14811.481598144013, 386360.0, 387719.0, 388527.0, 392240.0, 392357.0, 53638.0, 53808.46191538034, 53950.460495394545, 54046.0, 54839.72580137153, 1328.860469650692, 1329.335332333833, 1333.8199343088559, 1338.2773302416585, 1491.8582734640192, 26532.336691582866, 27530.44939101247, 27773.305667358476, 27858.442831142856, 27898.44203115967, 42521.574784252996, 42958.78520607377, 42979.355309671, 43143.78428107839, 43210.78394608007, 282078.0, 284989.0, 287641.0, 287851.0, 287867.0, 31911.84044079765, 42109.78945105255, 42618.1476370477, 42880.78559607182, 42929.141417172104, 44143.55856441394, 45104.323435147846, 46206.0, 48337.0, 49289.0, 36094.37575309065, 36334.273314533035, 36546.451803222444, 36894.8155259222, 37555.436668450544, 37070.8146459266, 37507.2498550022, 38803.80598096991, 39568.60431395649, 40235.79292621226, 33988.0, 34176.14559636029, 34569.65430345664, 34617.0, 34689.82655086708, 30473.695263047084, 31723.84138079295, 32829.17927051843, 32855.342893141526, 33089.66910330962, 24677.259682208845, 25213.24360269195, 25460.363490912874, 25533.0, 25568.360790980376], "unit": "score", "name": "ext.html", "value": 18499.141549046944}, {"lowerIsBetter": false, "replicates": [361.9927601447971, 364.229654281195, 364.7136997456995, 368.1991668121834, 369.85575625506056, 16488.258028388722, 16975.151242437874, 17492.21285042173, 17827.108644567783, 18574.628507429843, 14784.965052446332, 15612.687746245068, 15756.527304180892, 15837.84162158378, 15905.44330948417, 4927.852164435064, 5058.620603454738, 5060.291559181717, 5065.873353166164, 5068.873278168038, 4630.0, 5021.723805190713, 5034.345535080434, 5040.395152581696, 5043.445221025684, 5344.518993290603, 5367.892642147155, 5377.569794416438, 5478.561715062805, 5489.835304940858, 4961.5038496150455, 5378.354597448311, 5425.647332923348, 5429.592780541456, 5436.864078398032, 4804.5916097131785, 4807.302941073524, 4814.085323788469, 4814.831480898151, 4826.831060912887, 12921.547745828944, 13010.479580816756, 18448.354307599304, 20250.291239806684, 20273.69589456159, 1963.813437723414, 1965.518447980254, 2003.8396928245852, 2016.2942969960543, 2134.455713792973, 9079.546022698838, 9115.680951166743, 10536.736581585445, 11393.430328483626, 11770.176087673866, 1459.0880699562774, 1474.705058988196, 1558.4155941521929, 1561.8047744031996, 1594.3463180096105, 52785.472145278436, 55935.44064559384, 60123.398766012215, 63027.0, 64156.0, 10381.896181038093, 10387.532561034772, 10470.424126672953, 10505.474726263656, 10510.789784204426, 12740.36298185087, 13089.541866034833, 13113.147645403018, 13171.802422963663, 13463.528776492776, 7085.964570177116, 7297.9635101825215, 7394.038774959221, 7398.519096258726, 7436.107667079985, 7263.89104163438, 7336.37640800538, 7386.0767404074495, 7434.516756410816, 7495.587742674096, 4506.549345065533, 4552.931706024412, 4564.954350456453, 4586.036932244199, 4600.447946246405, 1835.5411147213197, 1838.3657638114828, 1873.4098758890905, 1888.792232854385, 1898.9145488453053, 880.3265501891059, 915.3546749541557, 986.9358491698017, 1021.7037059252733, 1048.9405700242658, 16018.439354622766, 16229.2696828643, 16496.34014639401, 16791.328346866234, 16828.158592070347, 880.2974867157892, 925.6621333213463, 930.6696122876417, 947.9810403791886, 1007.561710655867, 9306.208972237435, 9386.67146649864, 9389.295802814817, 9453.810923781486, 9468.715938521718, 545030.0, 570080.0, 578477.0, 579586.3268887509, 583664.0, 75395.24604753991, 75508.0, 75557.62221188968, 76790.0, 80329.59835200786, 1047.6647472808781, 1068.3109394440542, 1077.579743899864, 1081.6268387406333, 1089.4716062709738, 14491.78262326045, 14545.127292362069, 14607.780883286972, 14881.553553393416, 15203.847961520243, 30770.230744231572, 33236.833815831735, 33763.3247335047, 33873.830630846685, 34056.829715851265, 40437.0, 40648.390274146506, 42350.576494234665, 44816.32775508435, 44931.32603011023, 9357.39176953496, 9571.521423928914, 9724.659636912675, 9767.9023209767, 9836.950815246164, 11404.0, 11426.25729327591, 11489.885101148882, 12624.0, 16938.576535586217, 13002.08985371015, 13095.0, 13310.201387916368, 13353.732925341634, 14084.15495070299, 13939.860601394263, 14176.149431034171, 14404.495842645458, 14461.13233206011, 14465.855341446451, 13979.930100349433, 14490.782638260645, 14524.564263072125, 14621.19583422922, 14755.55733328002, 9173.770655733393, 9217.677381291622, 9617.374870633386, 9671.806563868542, 9811.558479868565, 9781.902180978099, 12580.496780128693, 12878.871211287767, 12947.352632368156, 13461.663458413617], "unit": "score", "name": "jquery.html", "value": 8571.4320758885}, {"lowerIsBetter": false, "replicates": [1483.8219413670358, 1502.376513746795, 1662.1356894414905, 1760.9295628174873, 1807.5327178401485, 7497.28775766302, 7555.584442855641, 7595.848083038343, 7645.426593005533, 7691.6154192290305, 7681.769546913588, 7714.228577142283, 7723.189065148149, 7777.261160189773, 7799.883001754978, 2229.6766968789516, 2230.2194232018787, 2255.3459496746004, 2258.5821622999715, 2263.977360226393, 2265.7734226577295, 2270.8523945943543, 2298.9195378161767, 2308.8614683119067, 2321.9071237150492, 2228.6322756745117, 2231.5983123037845, 2260.570491606598, 2266.5353602511527, 2267.093162734911, 2261.7851304126248, 2284.4745708487058, 2295.667128266409, 2310.90756369745, 2321.802646775026, 2279.384566167142, 2316.7683231676697, 2326.0463210083785, 2332.825038122148, 2333.0, 7486.401087913008, 7537.585432801194, 7578.469507134503, 7583.5070720403, 7598.962005189994, 4541.0, 4633.4208223972, 4650.9767451162525, 4657.534246575316, 4667.276572131325, 3013.3069394039276, 3085.629724433082, 3127.0775121339034, 3131.9530207046914, 3145.2923092304277, 1018.2719355660738, 1038.0294424712843, 1067.7330667333167, 1074.790415868906, 1085.6634443322596, 10549.84175237372, 10580.629677961311, 10614.203934704929, 10709.732256693567, 10742.838857417068, 4087.2234275487563, 4152.356384760367, 4173.1862286854375, 4178.310578754532, 4232.830686772556, 8465.153484651486, 8598.699045533376, 8620.612072456754, 8634.78413039679, 8640.8766860309, 4590.42619672541, 4596.839110631178, 4604.769761511911, 4620.8151673933335, 4630.72215667061, 4246.44796176495, 4249.3625956106835, 4255.914881702411, 4274.465691788527, 4288.120935208275, 3384.1201287665385, 3388.661133886641, 3392.542006829096, 3418.3163367326633, 3437.432823584081, 1050.417018554694, 1058.9682309530726, 1060.7560261139981, 1067.1302888146136, 1068.9358638481715, 927.1099744245599, 927.2257664849791, 973.8198433289864, 983.5819776594918, 1216.3492531495783, 6771.424428923498, 6847.0, 6863.142107236596, 6889.0355350251, 6907.412869906014, 1039.1219419590434, 1063.324788759128, 1113.0427832064418, 1132.8583927009124, 1167.9299242045504, 5492.176173573916, 5495.148252020943, 5498.945010549924, 5538.723063846792, 5618.0449323615085, 8926.910730892609, 9399.718008459757, 9410.294227932796, 9414.67048653294, 9450.385724927995, 9237.630494780133, 9269.67556135532, 9286.95356523213, 9318.72043838686, 9371.531423428938, 6976.127984002, 7059.682314295869, 7097.89353159703, 7121.181064177582, 7140.821479463055, 6876.518643694893, 6892.172939247323, 6939.132608423947, 6980.371766541036, 6983.092198014226, 7792.181820908723, 7897.605119744105, 8110.188981101843, 8114.43198976066, 8189.303909167787, 8036.517808931483, 8043.115257321573, 8102.351811854919, 8105.513669179632, 8133.877991830245, 6265.624062556261, 6391.009393544008, 6412.935870641234, 6455.870882582228, 6473.935260647333, 6739.42714869222, 6810.761623343159, 6813.965930170318, 6826.93173068263, 6854.383105520527, 6326.240851097714, 6542.640154791342, 6723.0, 6813.591184528944, 6869.656517174021, 6459.870802584016, 6473.935260647333, 6553.672316384257, 6615.966920165369, 6631.867362652816, 6025.517958563392, 6070.0, 6209.379062093754, 6243.594166379171, 6261.812145635638, 5885.61743486672, 5908.911366329595, 5932.2584676915385, 5948.5538584605465, 5984.13230081627, 5923.7926672566255, 6042.848928776816, 6091.847703807441, 6103.298120715996, 6113.51091912637], "unit": "score", "name": "mootools.html", "value": 4341.644295828607}, {"lowerIsBetter": false, "replicates": [339.75537612918697, 348.81512798216954, 349.0819145646947, 350.3815765174466, 350.78952628422934, 6250.312465628783, 6261.874762504747, 6280.246370435549, 6298.275698294698, 6442.0, 6281.057841323804, 6293.24481062272, 6294.339094395092, 6296.055591661253, 6320.273168585614, 4820.252860806563, 4822.083804077214, 4824.228123500241, 4828.444728856191, 4829.68607040543, 4817.373741413611, 4822.927656085161, 4826.589739872115, 4827.734474603895, 4828.275758636215, 4695.530446955294, 4774.59415949643, 4778.832740854071, 4790.42514898211, 4796.56830885222, 4712.528747125277, 4756.833510827105, 4762.880927976794, 4782.832600858953, 4795.472498025214, 4126.442930204414, 4145.2124096421585, 4150.107726838714, 4165.541790403053, 4168.979155104205, 5972.522198224132, 6000.489958353545, 6003.129546215818, 6010.098485227207, 6022.728977195993, 5437.510624043815, 5571.888562228733, 5588.469095435927, 5594.440555944414, 5598.524125449342, 6686.930091185387, 6696.397324240842, 6701.195856497203, 6706.2287836898895, 6720.899186512206, 4624.930626040612, 4627.953720462786, 4628.837990670344, 4631.560001799824, 4653.278741795028, 6787.796366108975, 6908.101946746941, 6999.82500437488, 7014.088168538057, 7041.4718896082995, 4714.575688188011, 4715.22198837188, 4716.292556116541, 4752.358431611758, 4752.405949256343, 4768.570828625371, 4769.356136921471, 4787.712737235777, 4802.087603355351, 4803.207470767354, 5505.944940550623, 5544.362398324163, 5548.167774833807, 5560.332760068818, 5573.331200255995, 6447.1296374989715, 6597.7690780823405, 6609.438197753245, 6664.333566643394, 6743.730250790011, 1639.7786298849742, 1659.0709202846444, 1668.6412421329474, 1679.7480377943161, 1682.343885884506, 1106.2256420505678, 1118.3848883114417, 1122.4275619434147, 1127.6504283671925, 1135.1032684179406, 6187.81436556904, 6211.3167551569295, 6258.906116408258, 6285.151504546828, 6294.496440284766, 6800.183977922582, 6809.421199198124, 6813.727450902007, 6815.079964204769, 6815.352541508549, 6133.049377346519, 6213.409726076015, 6276.121343011982, 6285.528585356116, 6286.214223222098, 3690.446433035066, 3705.370087085202, 3711.888643340704, 3712.276106159273, 3724.2923844469465, 7082.29177082298, 7094.574325540484, 7142.178649455275, 7157.320054594805, 7158.677859496335, 6871.209810871714, 7025.8243543910785, 7036.577805331696, 7042.577445353295, 7044.577325360495, 7095.361417472453, 7201.747938822116, 7264.927350726425, 7289.635518224068, 7318.3047610476915, 6874.828129296808, 6913.10129683138, 6943.826404339729, 6950.374466297855, 6982.057422247932, 6657.866842663023, 6764.763233286812, 6808.0, 6811.080504131879, 6880.9655951721925, 7174.3184397482155, 7216.134063912364, 7228.855422891618, 7311.23232060626, 7324.157721862054, 4704.835330763407, 4733.692309999839, 4751.619870410428, 4755.167845626932, 4756.9762151189025, 6799.864002720017, 6928.203256625553, 6985.755498557526, 6993.055937448379, 7009.334113259232, 6565.606063636197, 6568.507361947969, 6577.0, 6632.469402447696, 6723.092382528492, 6697.698603562949, 6722.260551339251, 6750.122484077038, 6766.883464228347, 6773.119494465688, 6516.087747715229, 6626.933730662631, 6649.900251496329, 6657.234418041987, 6664.466842652673, 6771.356721111487, 6816.693248803716, 6825.010373495716, 6837.179538455417, 6855.965720171367, 6599.67001649906, 6648.135742353463, 6648.936170212743, 6658.3674550917585, 6662.233843107911], "unit": "score", "name": "prototype.html", "value": 5030.654931458814}, {"lowerIsBetter": false, "replicates": [788.2028973939416, 827.1356432528007, 830.1490971753951, 839.236294971576, 851.8551846186156, 12105.515779368814, 12132.514699412024, 12141.210821296632, 12172.08709346798, 12247.693807654801, 11269.53496045513, 11299.265547739411, 11310.038646715018, 11348.432578371068, 11379.715507112327, 662.9602223866559, 681.5025031726842, 819.5656302159865, 835.1439774231401, 840.2060053249681, 825.4881973176639, 827.420805436197, 830.5930094253832, 834.9039860416069, 836.4270474724802, 871.8692196170562, 874.54960695242, 875.5797217335682, 878.4992554244084, 878.5870640798814, 855.7176131876466, 864.2049314630555, 865.11758006833, 869.5174178331024, 869.6695255802817, 630.5019034962374, 636.9490440764728, 639.987200255997, 646.1470858466826, 646.2826262848234, 11549.13381496391, 11689.76620467586, 11700.0, 11704.53181872724, 11709.414529273587, 11265.0, 11348.319100853892, 11662.76674466506, 11664.0, 11743.765124697544, 9608.231341492663, 9650.469224192666, 9668.419894806335, 9690.418574885529, 9845.753856153582, 3332.8833490827706, 3414.6585341465657, 3523.8061906595126, 3533.116720819795, 3536.0452677776857, 45496.0, 46166.76916615429, 49013.0, 49152.262716059646, 49237.50762492365, 8553.101924297858, 8616.569171541523, 8649.048604653482, 8770.780730481662, 8852.557372131369, 17425.39011134604, 17473.475795725895, 17572.91213543924, 17610.64778704419, 17627.735583966252, 7256.0, 7340.779776606603, 7438.367738742268, 7481.064866891638, 7512.737054203077, 3734.439834024918, 3865.4974853268895, 3867.45855580219, 3983.900402489961, 4018.9196216075516, 3173.508106243536, 3186.330870517171, 3207.951880721791, 3207.967920320767, 3217.7104060634188, 535.4030256264238, 545.0461692038932, 552.3151292397398, 628.8207860759661, 653.0, 526.4209369693307, 580.4021857486796, 584.5090124295527, 606.3996643323167, 614.6987975891781, 7597.354224890946, 7817.804554886174, 7846.764597062097, 7908.498031574421, 7959.243871832166, 444.09404814178714, 450.5381983466907, 456.1993701054628, 500.60202139298616, 535.8633548445122, 3439.6216416194197, 3627.4014787560286, 3692.9076773080888, 3828.942565861514, 3845.7115716321387, 54285.0, 55464.72267638636, 55786.0, 56365.43634563684, 56528.717356412955, 48927.75536122368, 49492.50507494879, 50120.49879501231, 50275.0, 50379.0, 44507.55492445099, 44845.0, 45350.54649453463, 45676.0, 45829.7708511462, 7350.338469537767, 7416.7774966751085, 7468.663910124166, 7503.587302698404, 7621.352185064332, 33869.83065084659, 33899.49150762691, 34328.0, 35483.64516354907, 37584.812075939444, 40724.796376017934, 41489.37765933453, 41971.160576788905, 42238.0, 43079.35380969225, 9879.506024698592, 9962.352447090916, 9981.15160211361, 10042.046005629454, 10095.343802652804, 10738.409387483764, 11123.833142502706, 11132.165087618623, 11232.708238552344, 11382.487788049722, 9975.900240997496, 10003.499825008867, 10192.235582331206, 10204.948975255076, 10340.457969924211, 9188.770280743034, 9537.237021038161, 9591.18474929611, 9760.951195243979, 9893.65372211998, 8973.955130224307, 9847.901520984698, 9999.850002249827, 10024.899751002687, 10475.790484190426, 8302.0, 8332.250097491255, 8440.53577053268, 8533.189347012023, 9066.592003359996, 7535.623218839146, 8105.918940810517, 8133.34933205354, 8172.632231549475, 8572.657093716181], "unit": "score", "name": "yui.html", "value": 5885.229970862877}], "name": "dromaeo_css", "value": 6912.035856184138}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 111.0, 112.0, 111.0, 122.0, 112.0, 111.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [155.0, 134.0, 165.0, 161.0, 127.0, 149.0, 150.0, 128.0, 164.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 164.0, 161.0, 160.0, 162.0, 165.0, 169.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 82.0, 75.0, 75.0, 75.0, 75.0, 145.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 138.0, 97.0, 97.0, 97.0, 146.0, 96.0, 97.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 150.0, 147.0, 148.0, 150.0, 148.0, 150.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [61.0, 63.0, 59.0, 60.0, 62.0, 60.0, 60.0, 60.0, 60.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 89.0, 88.0, 95.0, 91.0, 89.0, 89.0, 88.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.1}, {"lowerIsBetter": true, "replicates": [121.0, 125.0, 136.0, 124.0, 134.0, 120.0, 127.0, 120.0, 121.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.7}, {"lowerIsBetter": true, "replicates": [143.0, 153.0, 153.0, 158.0, 150.0, 159.0, 156.0, 161.0, 153.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.0}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 72.0, 70.0, 69.0, 71.0, 72.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1535.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "Richards", "value": 211.17656399999993}, {"lowerIsBetter": false, "replicates": [189.82536066818528], "unit": "score", "name": "DeltaBlue", "value": 348.30962399999987}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5273.684210526316], "unit": "score", "name": "Decrypt", "value": 50.47344311377245}, {"lowerIsBetter": false, "replicates": [1050.420168067227], "unit": "score", "name": "RayTrace", "value": 704.469528}, {"lowerIsBetter": false, "replicates": [709.2198581560284], "unit": "score", "name": "Earley", "value": 939.71283}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [25769.23076923077], "unit": "score", "name": "RegExp", "value": 35.3516567164179}, {"lowerIsBetter": false, "replicates": [584.7953216374269], "unit": "score", "name": "Splay", "value": 139.34960999999998}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 21383.469468719355}]} 11:32:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21383.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1535.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6912.03"}}} 11:32:35 INFO - Return code: 0 11:32:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:32:35 INFO - # TBPL SUCCESS # 11:32:35 INFO - Running post-action listener: _resource_record_post_action 11:32:35 INFO - Running post-run listener: _resource_record_post_run 11:32:36 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 560050176; Read time: 0; Write time: 577432 11:32:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239595520; Read time: 0; Write time: 351504 11:32:36 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 320454656; Read time: 0; Write time: 225928 11:32:36 INFO - Running post-run listener: _upload_blobber_files 11:32:36 INFO - Blob upload gear active. 11:32:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:32:36 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:32:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:32:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:32:37 INFO - (blobuploader) - INFO - Open directory for files ... 11:32:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:32:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:32:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:37 INFO - (blobuploader) - INFO - Done attempting. 11:32:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:32:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:32:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:38 INFO - (blobuploader) - INFO - Done attempting. 11:32:38 INFO - (blobuploader) - INFO - Iteration through files over. 11:32:38 INFO - Return code: 0 11:32:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:32:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:32:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1bfa942312cd730211cff025afafd61abc79254c306ee96de0cd77b04f83544f3c562bca5bf17fd3c47d0e9380376663113f2fd7b40b520c1b9e0038bc2ae02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac27f705d2eb24f8f200a07791e90384a87711d6995defc53f332d1aee46aadf037a12783614ea300e2bedf10eeef3f133c146f1c6d1710293691dd919171535"} 11:32:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:32:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:32:38 INFO - Contents: 11:32:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1bfa942312cd730211cff025afafd61abc79254c306ee96de0cd77b04f83544f3c562bca5bf17fd3c47d0e9380376663113f2fd7b40b520c1b9e0038bc2ae02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac27f705d2eb24f8f200a07791e90384a87711d6995defc53f332d1aee46aadf037a12783614ea300e2bedf10eeef3f133c146f1c6d1710293691dd919171535"} 11:32:38 INFO - Copying logs to upload dir... 11:32:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.179048 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-01-04 11:32:38.654696) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 11:32:38.658546) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1bfa942312cd730211cff025afafd61abc79254c306ee96de0cd77b04f83544f3c562bca5bf17fd3c47d0e9380376663113f2fd7b40b520c1b9e0038bc2ae02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac27f705d2eb24f8f200a07791e90384a87711d6995defc53f332d1aee46aadf037a12783614ea300e2bedf10eeef3f133c146f1c6d1710293691dd919171535"} build_url:https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1bfa942312cd730211cff025afafd61abc79254c306ee96de0cd77b04f83544f3c562bca5bf17fd3c47d0e9380376663113f2fd7b40b520c1b9e0038bc2ae02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac27f705d2eb24f8f200a07791e90384a87711d6995defc53f332d1aee46aadf037a12783614ea300e2bedf10eeef3f133c146f1c6d1710293691dd919171535"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 11:32:38.686226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:32:38.686843) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1451934695.827086-1377386772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:32:38.771374) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 11:32:38.771758) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 11:32:38.772134) ========= ========= Total master_lag: 0.25 =========