builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1451588184.87 results: success (0) buildid: 20151231083108 builduid: c1ecf27c3c494246a64d4150abac1a24 revision: ff863d8cdf7ad551bc4843e3614e09236400a6da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:24.872043) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:24.872523) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:24.872808) ========= 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=447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006342 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:24.928797) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:24.929089) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:25.016764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:25.017022) ========= 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=447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004816 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:25.070729) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:25.071024) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:25.071388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:25.071669) ========= 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=447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 10:56:25-- 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% 219M=0s 2015-12-31 10:56:25 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.243556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:25.327216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:25.327512) ========= 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=447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015725 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:25.376456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:25.376790) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff863d8cdf7ad551bc4843e3614e09236400a6da --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 ff863d8cdf7ad551bc4843e3614e09236400a6da --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=447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 10:56:25,969 truncating revision to first 12 chars 2015-12-31 10:56:25,969 Setting DEBUG logging. 2015-12-31 10:56:25,969 attempt 1/10 2015-12-31 10:56:25,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff863d8cdf7a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 10:56:26,400 unpacking tar archive at: fx-team-ff863d8cdf7a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723431 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:26.112648) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:26.112952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:26.120834) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:26.121128) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 10:56:26.121526) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-31 10:56:26.121807) ========= /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=447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:56:26 INFO - MultiFileLogger online at 20151231 10:56:26 in /builds/slave/test-pgo 10:56:26 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 10:56:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:56:26 INFO - {'append_to_log': False, 10:56:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:56:26 INFO - 'blob_upload_branch': 'Fx-Team', 10:56:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:56:26 INFO - 'branch': 'Fx-Team', 10:56:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:56:26 INFO - 'config_files': ('talos/linux_config.py',), 10:56:26 INFO - 'default_actions': ('clobber', 10:56:26 INFO - 'read-buildbot-config', 10:56:26 INFO - 'download-and-extract', 10:56:26 INFO - 'populate-webroot', 10:56:26 INFO - 'create-virtualenv', 10:56:26 INFO - 'install', 10:56:26 INFO - 'run-tests'), 10:56:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:56:26 INFO - 'download_minidump_stackwalk': True, 10:56:26 INFO - 'download_symbols': 'ondemand', 10:56:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:56:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:56:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:56:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:56:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:56:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:56:26 INFO - 'installer_path': 'installer.exe', 10:56:26 INFO - 'log_level': 'info', 10:56:26 INFO - 'log_name': 'talos', 10:56:26 INFO - 'log_to_console': True, 10:56:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:56:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:56:26 INFO - 'opt_config_files': (), 10:56:26 INFO - 'pip_index': False, 10:56:26 INFO - 'sps_profile': False, 10:56:26 INFO - 'sps_profile_interval': 0, 10:56:26 INFO - 'suite': 'dromaeojs-e10s', 10:56:26 INFO - 'system_bits': '32', 10:56:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:56:26 INFO - 'title': 'talos-linux64-ix-027', 10:56:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:56:26 INFO - 'use_talos_json': True, 10:56:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:56:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:56:26 INFO - 'work_dir': 'build'} 10:56:26 INFO - ##### 10:56:26 INFO - ##### Running clobber step. 10:56:26 INFO - ##### 10:56:26 INFO - Running pre-action listener: _resource_record_pre_action 10:56:26 INFO - Running main action method: clobber 10:56:26 INFO - rmtree: /builds/slave/test-pgo/build 10:56:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:56:27 INFO - Running post-action listener: _resource_record_post_action 10:56:27 INFO - ##### 10:56:27 INFO - ##### Running read-buildbot-config step. 10:56:27 INFO - ##### 10:56:27 INFO - Running pre-action listener: _resource_record_pre_action 10:56:27 INFO - Running main action method: read_buildbot_config 10:56:27 INFO - Using buildbot properties: 10:56:27 INFO - { 10:56:27 INFO - "project": "", 10:56:27 INFO - "product": "firefox", 10:56:27 INFO - "script_repo_revision": "production", 10:56:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:56:27 INFO - "repository": "", 10:56:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:56:27 INFO - "buildid": "20151231083108", 10:56:27 INFO - "pgo_build": "True", 10:56:27 INFO - "basedir": "/builds/slave/test-pgo", 10:56:27 INFO - "buildnumber": 419, 10:56:27 INFO - "slavename": "talos-linux64-ix-027", 10:56:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:56:27 INFO - "platform": "ubuntu64_hw", 10:56:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:56:27 INFO - "branch": "fx-team", 10:56:27 INFO - "repo_path": "integration/fx-team", 10:56:27 INFO - "revision": "ff863d8cdf7ad551bc4843e3614e09236400a6da", 10:56:27 INFO - "stage_platform": "linux64-pgo", 10:56:27 INFO - "builduid": "c1ecf27c3c494246a64d4150abac1a24", 10:56:27 INFO - "slavebuilddir": "test" 10:56:27 INFO - } 10:56:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:56:27 INFO - Running post-action listener: _resource_record_post_action 10:56:27 INFO - ##### 10:56:27 INFO - ##### Running download-and-extract step. 10:56:27 INFO - ##### 10:56:27 INFO - Running pre-action listener: _resource_record_pre_action 10:56:27 INFO - Running main action method: download_and_extract 10:56:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:56:27 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')]} 10:56:27 INFO - https://queue.taskcluster.net/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:56:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/test_packages.json 10:56:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/test_packages.json 10:56:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:56:38 INFO - Downloaded 1302 bytes. 10:56:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:56:38 INFO - Using the following test package requirements: 10:56:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:56:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'jsshell-linux-x86_64.zip'], 10:56:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:56:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:56:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:56:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:56:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:56:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:56: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')]} 10:56:38 INFO - https://queue.taskcluster.net/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/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 10:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/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 10:56:47 INFO - Downloaded 23195144 bytes. 10:56:47 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 10:56:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:47 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 10:56:48 INFO - Return code: 0 10:56:48 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 10:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:48 INFO - https://queue.taskcluster.net/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:56:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/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 10:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/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 10:56:50 INFO - Downloaded 23195144 bytes. 10:56:50 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 10:56:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:50 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 10:56:51 INFO - Return code: 0 10:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:51 INFO - https://queue.taskcluster.net/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:56:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/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 10:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/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 10:56:52 INFO - Downloaded 11132285 bytes. 10:56:52 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 10:56:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:52 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 10:56:52 INFO - Return code: 0 10:56: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')]} 10:56:52 INFO - https://queue.taskcluster.net/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:56:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/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 10:56:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/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 10:56:53 INFO - Downloaded 54954726 bytes. 10:56:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:53 INFO - mkdir: /builds/slave/test-pgo/properties 10:56:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:56:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:56:53 INFO - Contents: 10:56:53 INFO - build_url:https://queue.taskcluster.net/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:53 INFO - Running post-action listener: _resource_record_post_action 10:56:53 INFO - Running post-action listener: set_extra_try_arguments 10:56:53 INFO - ##### 10:56:53 INFO - ##### Running populate-webroot step. 10:56:53 INFO - ##### 10:56:53 INFO - Running pre-action listener: _resource_record_pre_action 10:56:53 INFO - Running main action method: populate_webroot 10:56:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:56:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:56:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:56:53 INFO - '--tppagecycles', 10:56:53 INFO - '7'], 10:56:53 INFO - 'tests': ['tsvgm']}}, 10:56:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:56:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:56:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:56:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:56:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:56:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:56:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:53 INFO - 'talos_options': ['--e10s'], 10:56:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:53 INFO - 'tests': ['damp', 'tps']}, 10:56:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:53 INFO - 'talos_options': ['--e10s'], 10:56:53 INFO - 'tests': ['damp', 'tps']}, 10:56:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:56:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:56:53 INFO - 'other': {'tests': ['a11yr', 10:56:53 INFO - 'ts_paint', 10:56:53 INFO - 'tpaint', 10:56:53 INFO - 'sessionrestore', 10:56:53 INFO - 'sessionrestore_no_auto_restore']}, 10:56:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:56:53 INFO - 'tests': ['a11yr', 10:56:53 INFO - 'ts_paint', 10:56:53 INFO - 'tpaint', 10:56:53 INFO - 'sessionrestore', 10:56:53 INFO - 'sessionrestore_no_auto_restore']}, 10:56:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:56:53 INFO - 'tests': ['a11yr', 10:56:53 INFO - 'ts_paint', 10:56:53 INFO - 'tpaint', 10:56:53 INFO - 'sessionrestore', 10:56:53 INFO - 'sessionrestore_no_auto_restore']}, 10:56:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:56:53 INFO - 'tests': ['a11yr', 10:56:53 INFO - 'ts_paint', 10:56:53 INFO - 'tpaint', 10:56:53 INFO - 'sessionrestore', 10:56:53 INFO - 'sessionrestore_no_auto_restore']}, 10:56:53 INFO - 'other_l64': {'tests': ['a11yr', 10:56:53 INFO - 'ts_paint', 10:56:53 INFO - 'tpaint', 10:56:53 INFO - 'sessionrestore', 10:56:53 INFO - 'sessionrestore_no_auto_restore']}, 10:56:53 INFO - 'other_nol64': {'tests': ['a11yr', 10:56:53 INFO - 'ts_paint', 10:56:53 INFO - 'tpaint', 10:56:53 INFO - 'sessionrestore', 10:56:53 INFO - 'sessionrestore_no_auto_restore']}, 10:56:53 INFO - 'svgr': {'tests': ['tsvgx', 10:56:53 INFO - 'tsvgr_opacity', 10:56:53 INFO - 'tart', 10:56:53 INFO - 'tscrollx', 10:56:53 INFO - 'cart']}, 10:56:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:56:53 INFO - 'tests': ['tsvgx', 10:56:53 INFO - 'tsvgr_opacity', 10:56:53 INFO - 'tart', 10:56:53 INFO - 'tscrollx', 10:56:53 INFO - 'cart']}, 10:56:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:53 INFO - 'tests': ['tp5o']}, 10:56:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:53 INFO - 'talos_options': ['--e10s'], 10:56:53 INFO - 'tests': ['tp5o']}, 10:56:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:53 INFO - 'talos_options': ['--xperf_path', 10:56:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:53 INFO - 'tests': ['tp5n']}, 10:56:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:53 INFO - 'talos_options': ['--e10s', 10:56:53 INFO - '--xperf_path', 10:56:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:53 INFO - 'tests': ['tp5n']}}, 10:56:53 INFO - 'talos.zip': {'path': '', 10:56:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:56:53 INFO - Running post-action listener: _resource_record_post_action 10:56:53 INFO - ##### 10:56:53 INFO - ##### Running create-virtualenv step. 10:56:53 INFO - ##### 10:56:53 INFO - Running pre-action listener: _resource_record_pre_action 10:56:53 INFO - Running main action method: create_virtualenv 10:56:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:56:53 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 10:56:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:56:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:56:54 INFO - Using real prefix '/usr' 10:56:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:56:54 INFO - Installing distribute.............................................................................................................................................................................................done. 10:56:56 INFO - Installing pip.................done. 10:56:56 INFO - Return code: 0 10:56:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:56:56 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')]} 10:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:56 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')]} 10:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:56 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 0x7fbf243c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c840>, '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 0x13b96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', '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 10:56:56 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 10:56:56 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 10:56:56 INFO - Using env: {'DISPLAY': ':0', 10:56:56 INFO - 'HOME': '/home/cltbld', 10:56:56 INFO - 'LANG': 'en_US.UTF-8', 10:56:56 INFO - 'LANGUAGE': 'en_US:en', 10:56:56 INFO - 'LOGNAME': 'cltbld', 10:56:56 INFO - 'MAIL': '/var/mail/cltbld', 10:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:56 INFO - 'MOZ_NO_REMOTE': '1', 10:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:56 INFO - 'NO_EM_RESTART': '1', 10:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:56 INFO - 'SHELL': '/bin/bash', 10:56:56 INFO - 'SHLVL': '1', 10:56:56 INFO - 'TERM': 'linux', 10:56:56 INFO - 'TMOUT': '86400', 10:56:56 INFO - 'USER': 'cltbld', 10:56:56 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', 10:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:56 INFO - '_': '/tools/buildbot/bin/python'} 10:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:56 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 10:56:56 INFO - Cleaning up... 10:56:56 INFO - Return code: 0 10:56:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:56:56 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')]} 10:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:56 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')]} 10:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:56 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 0x7fbf243c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c840>, '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 0x13b96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', '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 10:56:56 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 10:56:56 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 10:56:56 INFO - Using env: {'DISPLAY': ':0', 10:56:56 INFO - 'HOME': '/home/cltbld', 10:56:56 INFO - 'LANG': 'en_US.UTF-8', 10:56:56 INFO - 'LANGUAGE': 'en_US:en', 10:56:56 INFO - 'LOGNAME': 'cltbld', 10:56:56 INFO - 'MAIL': '/var/mail/cltbld', 10:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:56 INFO - 'MOZ_NO_REMOTE': '1', 10:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:56 INFO - 'NO_EM_RESTART': '1', 10:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:56 INFO - 'SHELL': '/bin/bash', 10:56:56 INFO - 'SHLVL': '1', 10:56:56 INFO - 'TERM': 'linux', 10:56:56 INFO - 'TMOUT': '86400', 10:56:56 INFO - 'USER': 'cltbld', 10:56:56 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', 10:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:56 INFO - '_': '/tools/buildbot/bin/python'} 10:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:56 INFO - Downloading/unpacking psutil>=0.7.1 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 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 10:56:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:56:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:56:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:56:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:58 INFO - Installing collected packages: psutil 10:56:58 INFO - Running setup.py install for psutil 10:56:58 INFO - building 'psutil._psutil_linux' extension 10:56:58 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 10:56:58 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 10:56:59 INFO - building 'psutil._psutil_posix' extension 10:56:59 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 10:56:59 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 10:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:59 INFO - Successfully installed psutil 10:56:59 INFO - Cleaning up... 10:56:59 INFO - Return code: 0 10:56:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:56: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')]} 10:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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')]} 10:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbf243c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c840>, '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 0x13b96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', '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 10:56:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:56:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:56:59 INFO - Using env: {'DISPLAY': ':0', 10:56:59 INFO - 'HOME': '/home/cltbld', 10:56:59 INFO - 'LANG': 'en_US.UTF-8', 10:56:59 INFO - 'LANGUAGE': 'en_US:en', 10:56:59 INFO - 'LOGNAME': 'cltbld', 10:56:59 INFO - 'MAIL': '/var/mail/cltbld', 10:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:59 INFO - 'MOZ_NO_REMOTE': '1', 10:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:59 INFO - 'NO_EM_RESTART': '1', 10:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:59 INFO - 'SHELL': '/bin/bash', 10:56:59 INFO - 'SHLVL': '1', 10:56:59 INFO - 'TERM': 'linux', 10:56:59 INFO - 'TMOUT': '86400', 10:56:59 INFO - 'USER': 'cltbld', 10:56:59 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', 10:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:59 INFO - '_': '/tools/buildbot/bin/python'} 10:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:57:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:57:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:57:01 INFO - Installing collected packages: mozsystemmonitor 10:57:01 INFO - Running setup.py install for mozsystemmonitor 10:57:01 INFO - Successfully installed mozsystemmonitor 10:57:01 INFO - Cleaning up... 10:57:01 INFO - Return code: 0 10:57:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:01 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 0x7fbf243c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c840>, '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 0x13b96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', '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 10:57:01 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 10:57:01 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 10:57:01 INFO - Using env: {'DISPLAY': ':0', 10:57:01 INFO - 'HOME': '/home/cltbld', 10:57:01 INFO - 'LANG': 'en_US.UTF-8', 10:57:01 INFO - 'LANGUAGE': 'en_US:en', 10:57:01 INFO - 'LOGNAME': 'cltbld', 10:57:01 INFO - 'MAIL': '/var/mail/cltbld', 10:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:01 INFO - 'MOZ_NO_REMOTE': '1', 10:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:01 INFO - 'NO_EM_RESTART': '1', 10:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:01 INFO - 'SHELL': '/bin/bash', 10:57:01 INFO - 'SHLVL': '1', 10:57:01 INFO - 'TERM': 'linux', 10:57:01 INFO - 'TMOUT': '86400', 10:57:01 INFO - 'USER': 'cltbld', 10:57:01 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', 10:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:01 INFO - '_': '/tools/buildbot/bin/python'} 10:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:01 INFO - Downloading/unpacking blobuploader==1.2.4 10:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:03 INFO - Downloading blobuploader-1.2.4.tar.gz 10:57:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:57:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:57:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:57:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:57:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:04 INFO - Downloading docopt-0.6.1.tar.gz 10:57:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:57:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:57:04 INFO - Installing collected packages: blobuploader, requests, docopt 10:57:04 INFO - Running setup.py install for blobuploader 10:57:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:57:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:57:04 INFO - Running setup.py install for requests 10:57:04 INFO - Running setup.py install for docopt 10:57:04 INFO - Successfully installed blobuploader requests docopt 10:57:04 INFO - Cleaning up... 10:57:04 INFO - Return code: 0 10:57:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:57:04 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')]} 10:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:04 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')]} 10:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:04 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 0x7fbf243c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c840>, '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 0x13b96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', '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 10:57:04 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 10:57:04 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 10:57:04 INFO - Using env: {'DISPLAY': ':0', 10:57:04 INFO - 'HOME': '/home/cltbld', 10:57:04 INFO - 'LANG': 'en_US.UTF-8', 10:57:04 INFO - 'LANGUAGE': 'en_US:en', 10:57:04 INFO - 'LOGNAME': 'cltbld', 10:57:04 INFO - 'MAIL': '/var/mail/cltbld', 10:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:04 INFO - 'MOZ_NO_REMOTE': '1', 10:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:04 INFO - 'NO_EM_RESTART': '1', 10:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:04 INFO - 'SHELL': '/bin/bash', 10:57:04 INFO - 'SHLVL': '1', 10:57:04 INFO - 'TERM': 'linux', 10:57:04 INFO - 'TMOUT': '86400', 10:57:04 INFO - 'USER': 'cltbld', 10:57:04 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', 10:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:04 INFO - '_': '/tools/buildbot/bin/python'} 10:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:57:04 INFO - Running setup.py (path:/tmp/pip-cCk0et-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:57:05 INFO - Running setup.py (path:/tmp/pip-kGI5I4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:57:05 INFO - Running setup.py (path:/tmp/pip-pOV9HQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:57:05 INFO - Running setup.py (path:/tmp/pip-NFOXsn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:57:05 INFO - Running setup.py (path:/tmp/pip-iYfmfS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:57:05 INFO - Running setup.py (path:/tmp/pip-OKRhTk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:57:05 INFO - Running setup.py (path:/tmp/pip-SXGiNL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:57:05 INFO - Running setup.py (path:/tmp/pip-JSF61c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:57:05 INFO - Running setup.py (path:/tmp/pip-FL4nGn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:57:05 INFO - Running setup.py (path:/tmp/pip-z3KDT_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:57:05 INFO - Running setup.py (path:/tmp/pip-AZX23W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:57:05 INFO - Running setup.py (path:/tmp/pip-t3NRU5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:57:05 INFO - Running setup.py (path:/tmp/pip-W1f62c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:57:05 INFO - Running setup.py (path:/tmp/pip-u2uYfI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:57:06 INFO - Running setup.py (path:/tmp/pip-lnHvSc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:57:06 INFO - Running setup.py (path:/tmp/pip-NuABNa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:57:06 INFO - Running setup.py (path:/tmp/pip-BH2UjC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:57:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:57:06 INFO - Running setup.py install for manifestparser 10:57:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:57:06 INFO - Running setup.py install for mozcrash 10:57:06 INFO - Running setup.py install for mozdebug 10:57:06 INFO - Running setup.py install for mozdevice 10:57:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:57:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:57:06 INFO - Running setup.py install for mozfile 10:57:06 INFO - Running setup.py install for mozhttpd 10:57:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:57:06 INFO - Running setup.py install for mozinfo 10:57:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:57:06 INFO - Running setup.py install for mozInstall 10:57:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:57:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:57:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:57:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:57:07 INFO - Running setup.py install for mozleak 10:57:07 INFO - Running setup.py install for mozlog 10:57:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:57:07 INFO - Running setup.py install for moznetwork 10:57:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:57:07 INFO - Running setup.py install for mozprocess 10:57:07 INFO - Running setup.py install for mozprofile 10:57:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:57:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:57:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:57:07 INFO - Running setup.py install for mozrunner 10:57:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:57:07 INFO - Running setup.py install for mozscreenshot 10:57:07 INFO - Running setup.py install for moztest 10:57:07 INFO - Running setup.py install for mozversion 10:57:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:57:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:57:07 INFO - Cleaning up... 10:57:08 INFO - Return code: 0 10:57:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:57:08 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')]} 10:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:08 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')]} 10:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:08 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 0x7fbf243c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c840>, '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 0x13b96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', '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 10:57:08 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 10:57:08 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 10:57:08 INFO - Using env: {'DISPLAY': ':0', 10:57:08 INFO - 'HOME': '/home/cltbld', 10:57:08 INFO - 'LANG': 'en_US.UTF-8', 10:57:08 INFO - 'LANGUAGE': 'en_US:en', 10:57:08 INFO - 'LOGNAME': 'cltbld', 10:57:08 INFO - 'MAIL': '/var/mail/cltbld', 10:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:08 INFO - 'MOZ_NO_REMOTE': '1', 10:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:08 INFO - 'NO_EM_RESTART': '1', 10:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:08 INFO - 'SHELL': '/bin/bash', 10:57:08 INFO - 'SHLVL': '1', 10:57:08 INFO - 'TERM': 'linux', 10:57:08 INFO - 'TMOUT': '86400', 10:57:08 INFO - 'USER': 'cltbld', 10:57:08 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', 10:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:08 INFO - '_': '/tools/buildbot/bin/python'} 10:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:57:08 INFO - Running setup.py (path:/tmp/pip-wwEhF2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:57:08 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)) 10:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:57:08 INFO - Running setup.py (path:/tmp/pip-qZyLs6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:57:08 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)) 10:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:57:08 INFO - Running setup.py (path:/tmp/pip-wz9HP1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:57:08 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)) 10:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:57:08 INFO - Running setup.py (path:/tmp/pip-WFb8Wn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:57:08 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)) 10:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:57:08 INFO - Running setup.py (path:/tmp/pip-MqxWoc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:57:08 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)) 10:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:57:08 INFO - Running setup.py (path:/tmp/pip-LthAkj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:57:08 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)) 10:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:57:08 INFO - Running setup.py (path:/tmp/pip-NNmuqy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:57:08 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)) 10:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:57:08 INFO - Running setup.py (path:/tmp/pip-pehpoW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:57:08 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)) 10:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:57:08 INFO - Running setup.py (path:/tmp/pip-3XJBny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:57:08 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)) 10:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:57:08 INFO - Running setup.py (path:/tmp/pip-MqwsBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:57:08 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)) 10:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:57:08 INFO - Running setup.py (path:/tmp/pip-2CwmRD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:57:09 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)) 10:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:57:09 INFO - Running setup.py (path:/tmp/pip-XwDYZh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:57:09 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)) 10:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:57:09 INFO - Running setup.py (path:/tmp/pip-7pMFsJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:57:09 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)) 10:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:57:09 INFO - Running setup.py (path:/tmp/pip-692Y9S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:57:09 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)) 10:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:57:09 INFO - Running setup.py (path:/tmp/pip-pclteV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:57:09 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)) 10:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:57:09 INFO - Running setup.py (path:/tmp/pip-TU2vv7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:57:09 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)) 10:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:57:09 INFO - Running setup.py (path:/tmp/pip-z8KDeH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:57:09 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)) 10:57:09 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)) 10:57:09 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)) 10:57:09 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)) 10:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:57:09 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)) 10:57:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:11 INFO - Downloading blessings-1.5.1.tar.gz 10:57:11 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 10:57:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:57:11 INFO - Installing collected packages: blessings 10:57:11 INFO - Running setup.py install for blessings 10:57:11 INFO - Successfully installed blessings 10:57:11 INFO - Cleaning up... 10:57:11 INFO - Return code: 0 10:57:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:57:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:57:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:57:11 INFO - Reading from file tmpfile_stdout 10:57:11 INFO - Current package versions: 10:57:11 INFO - argparse == 1.2.1 10:57:11 INFO - blessings == 1.5.1 10:57:11 INFO - blobuploader == 1.2.4 10:57:11 INFO - docopt == 0.6.1 10:57:11 INFO - manifestparser == 1.1 10:57:11 INFO - mozInstall == 1.12 10:57:11 INFO - mozcrash == 0.16 10:57:11 INFO - mozdebug == 0.1 10:57:11 INFO - mozdevice == 0.47 10:57:11 INFO - mozfile == 1.2 10:57:11 INFO - mozhttpd == 0.7 10:57:11 INFO - mozinfo == 0.9 10:57:11 INFO - mozleak == 0.1 10:57:11 INFO - mozlog == 3.1 10:57:11 INFO - moznetwork == 0.27 10:57:11 INFO - mozprocess == 0.22 10:57:11 INFO - mozprofile == 0.28 10:57:11 INFO - mozrunner == 6.11 10:57:11 INFO - mozscreenshot == 0.1 10:57:11 INFO - mozsystemmonitor == 0.0 10:57:11 INFO - moztest == 0.7 10:57:11 INFO - mozversion == 1.4 10:57:11 INFO - psutil == 3.1.1 10:57:11 INFO - requests == 1.2.3 10:57:11 INFO - wsgiref == 0.1.2 10:57:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:57:11 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')]} 10:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:11 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')]} 10:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:11 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 0x7fbf243c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c840>, '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 0x13b96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', '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 10:57:11 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 10:57:11 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 10:57:11 INFO - Using env: {'DISPLAY': ':0', 10:57:11 INFO - 'HOME': '/home/cltbld', 10:57:11 INFO - 'LANG': 'en_US.UTF-8', 10:57:11 INFO - 'LANGUAGE': 'en_US:en', 10:57:11 INFO - 'LOGNAME': 'cltbld', 10:57:11 INFO - 'MAIL': '/var/mail/cltbld', 10:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:11 INFO - 'MOZ_NO_REMOTE': '1', 10:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:11 INFO - 'NO_EM_RESTART': '1', 10:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:11 INFO - 'SHELL': '/bin/bash', 10:57:11 INFO - 'SHLVL': '1', 10:57:11 INFO - 'TERM': 'linux', 10:57:11 INFO - 'TMOUT': '86400', 10:57:11 INFO - 'USER': 'cltbld', 10:57:11 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', 10:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:11 INFO - '_': '/tools/buildbot/bin/python'} 10:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:11 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)) 10:57:11 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)) 10:57:11 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)) 10:57:11 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)) 10:57:11 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)) 10:57:11 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)) 10:57:11 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)) 10:57:11 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)) 10:57:11 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)) 10:57:11 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)) 10:57:11 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)) 10:57:11 INFO - Cleaning up... 10:57:11 INFO - Return code: 0 10:57:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:57:11 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')]} 10:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:11 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')]} 10:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:11 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 0x7fbf243c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c840>, '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 0x13b96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', '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 10:57:11 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 10:57:11 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 10:57:11 INFO - Using env: {'DISPLAY': ':0', 10:57:11 INFO - 'HOME': '/home/cltbld', 10:57:11 INFO - 'LANG': 'en_US.UTF-8', 10:57:11 INFO - 'LANGUAGE': 'en_US:en', 10:57:11 INFO - 'LOGNAME': 'cltbld', 10:57:11 INFO - 'MAIL': '/var/mail/cltbld', 10:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:11 INFO - 'MOZ_NO_REMOTE': '1', 10:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:11 INFO - 'NO_EM_RESTART': '1', 10:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:11 INFO - 'SHELL': '/bin/bash', 10:57:11 INFO - 'SHLVL': '1', 10:57:11 INFO - 'TERM': 'linux', 10:57:11 INFO - 'TMOUT': '86400', 10:57:11 INFO - 'USER': 'cltbld', 10:57:11 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', 10:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:11 INFO - '_': '/tools/buildbot/bin/python'} 10:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:11 INFO - Downloading/unpacking jsonschema 10:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:57:13 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 10:57:13 INFO - Downloading/unpacking functools32 (from jsonschema) 10:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:13 INFO - Downloading functools32-3.2.3-2.tar.gz 10:57:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:57:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:57:13 INFO - warning: no files found matching '*.txt' 10:57:13 INFO - no previously-included directories found matching 'build' 10:57:13 INFO - no previously-included directories found matching 'dist' 10:57:13 INFO - no previously-included directories found matching '.git*' 10:57:13 INFO - Installing collected packages: jsonschema, functools32 10:57:13 INFO - Running setup.py install for functools32 10:57:14 INFO - warning: no files found matching '*.txt' 10:57:14 INFO - no previously-included directories found matching 'build' 10:57:14 INFO - no previously-included directories found matching 'dist' 10:57:14 INFO - no previously-included directories found matching '.git*' 10:57:14 INFO - Successfully installed jsonschema functools32 10:57:14 INFO - Cleaning up... 10:57:14 INFO - Return code: 0 10:57:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:57:14 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')]} 10:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:14 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')]} 10:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:14 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 0x7fbf243c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c840>, '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 0x13b96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', '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 10:57:14 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 10:57:14 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 10:57:14 INFO - Using env: {'DISPLAY': ':0', 10:57:14 INFO - 'HOME': '/home/cltbld', 10:57:14 INFO - 'LANG': 'en_US.UTF-8', 10:57:14 INFO - 'LANGUAGE': 'en_US:en', 10:57:14 INFO - 'LOGNAME': 'cltbld', 10:57:14 INFO - 'MAIL': '/var/mail/cltbld', 10:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:14 INFO - 'MOZ_NO_REMOTE': '1', 10:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:14 INFO - 'NO_EM_RESTART': '1', 10:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:14 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:14 INFO - 'SHELL': '/bin/bash', 10:57:14 INFO - 'SHLVL': '1', 10:57:14 INFO - 'TERM': 'linux', 10:57:14 INFO - 'TMOUT': '86400', 10:57:14 INFO - 'USER': 'cltbld', 10:57:14 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', 10:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:14 INFO - '_': '/tools/buildbot/bin/python'} 10:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:14 INFO - Downloading/unpacking flake8 10:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:57:16 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 10:57:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:57:16 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 10:57:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 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 10:57:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:57:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:57:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:16 INFO - no previously-included directories found matching 'docs/_build' 10:57:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:57:16 INFO - Running setup.py install for pep8 10:57:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:16 INFO - no previously-included directories found matching 'docs/_build' 10:57:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:57:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:57:16 INFO - Cleaning up... 10:57:16 INFO - Return code: 0 10:57:16 INFO - Running post-action listener: _resource_record_post_action 10:57:16 INFO - Running post-action listener: _start_resource_monitoring 10:57:16 INFO - Starting resource monitoring. 10:57:16 INFO - ##### 10:57:16 INFO - ##### Running install step. 10:57:16 INFO - ##### 10:57:16 INFO - Running pre-action listener: _resource_record_pre_action 10:57:16 INFO - Running main action method: install 10:57:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:57:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:57:17 INFO - Reading from file tmpfile_stdout 10:57:17 INFO - Detecting whether we're running mozinstall >=1.0... 10:57:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:57:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:57:17 INFO - Reading from file tmpfile_stdout 10:57:17 INFO - Output received: 10:57:17 INFO - Usage: mozinstall [options] installer 10:57:17 INFO - Options: 10:57:17 INFO - -h, --help show this help message and exit 10:57:17 INFO - -d DEST, --destination=DEST 10:57:17 INFO - Directory to install application into. [default: 10:57:17 INFO - "/builds/slave/test-pgo"] 10:57:17 INFO - --app=APP Application being installed. [default: firefox] 10:57:17 INFO - mkdir: /builds/slave/test-pgo/build/application 10:57:17 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'] 10:57:17 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 10:57:33 INFO - Reading from file tmpfile_stdout 10:57:33 INFO - Output received: 10:57:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:57:33 INFO - Running post-action listener: _resource_record_post_action 10:57:33 INFO - ##### 10:57:33 INFO - ##### Running run-tests step. 10:57:33 INFO - ##### 10:57:33 INFO - Running pre-action listener: _resource_record_pre_action 10:57:33 INFO - Running main action method: run_tests 10:57:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:57:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:57:33 INFO - Python 2.7.3 10:57:33 INFO - Return code: 0 10:57:33 INFO - grabbing minidump binary from tooltool 10:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:33 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 0x144c840>, '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 0x13b96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b9b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:57:33 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 10:57:33 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 10:57:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:57:33 INFO - Return code: 0 10:57:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:57:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:57:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:57:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:57:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:57:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:57:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:57:34 INFO - Return code: 0 10:57:34 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/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 10:57:34 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/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 10:57:34 INFO - Using env: {'DISPLAY': ':0', 10:57:34 INFO - 'HOME': '/home/cltbld', 10:57:34 INFO - 'LANG': 'en_US.UTF-8', 10:57:34 INFO - 'LANGUAGE': 'en_US:en', 10:57:34 INFO - 'LOGNAME': 'cltbld', 10:57:34 INFO - 'MAIL': '/var/mail/cltbld', 10:57:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:57:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:34 INFO - 'MOZ_NO_REMOTE': '1', 10:57:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:34 INFO - 'NO_EM_RESTART': '1', 10:57:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:34 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:57:34 INFO - 'SHELL': '/bin/bash', 10:57:34 INFO - 'SHLVL': '1', 10:57:34 INFO - 'TERM': 'linux', 10:57:34 INFO - 'TMOUT': '86400', 10:57:34 INFO - 'USER': 'cltbld', 10:57:34 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133', 10:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:34 INFO - '_': '/tools/buildbot/bin/python'} 10:57:34 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/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 10:57:34 INFO - mozversion application_buildid: 20151231083108 10:57:34 INFO - mozversion application_changeset: ff863d8cdf7ad551bc4843e3614e09236400a6da 10:57:34 INFO - mozversion application_display_name: Nightly 10:57:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:57:34 INFO - mozversion application_name: Firefox 10:57:34 INFO - mozversion application_remotingname: firefox 10:57:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:57:34 INFO - mozversion application_vendor: Mozilla 10:57:34 INFO - mozversion application_version: 46.0a1 10:57:34 INFO - mozversion platform_buildid: 20151231083108 10:57:34 INFO - mozversion platform_changeset: ff863d8cdf7ad551bc4843e3614e09236400a6da 10:57:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:57:34 INFO - mozversion platform_version: 46.0a1 10:57:34 INFO - using testdate: 1451588254 10:57:34 INFO - actual date: 1451588254 10:57:34 INFO - starting webserver on 'localhost:47890' 10:57:34 INFO - SUITE-START | Running 3 tests 10:57:34 INFO - TEST-START | dromaeo_css 10:57:34 INFO - operating with platform_type : linux_ 10:57:34 INFO - Initialising browser for dromaeo_css test... 10:57:34 INFO - TEST-INFO | started process 18389 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprTCqla/profile http://localhost:47890/getInfo.html) 10:57:39 INFO - PROCESS | 18389 | __metrics Screen width/height:1600/1200 10:57:39 INFO - PROCESS | 18389 | colorDepth:24 10:57:39 INFO - PROCESS | 18389 | Browser inner width/height: 1024/697 10:57:39 INFO - PROCESS | 18389 | __metrics 10:57:39 INFO - PROCESS | 18389 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:57:40 INFO - TEST-INFO | 18389: exit 0 10:57:40 INFO - Browser initialized. 10:57:40 INFO - Running cycle 1/1 for dromaeo_css test... 10:57:40 INFO - TEST-INFO | started process 18521 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprTCqla/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:51 INFO - PROCESS | 18521 | RSS: Main: 150970368 10:57:51 INFO - PROCESS | 18521 | 10:58:41 INFO - PROCESS | 18521 | 1451588321481 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:00:50 INFO - PROCESS | 18521 | Cycle 1(1): loaded http://localhost:47890/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47890/tests/dromaeo/cssquery-ext.html) 11:00:51 INFO - PROCESS | 18521 | RSS: Main: 157921280 11:00:51 INFO - PROCESS | 18521 | 11:03:54 INFO - PROCESS | 18521 | Cycle 1(1): loaded http://localhost:47890/tests/dromaeo/cssquery-ext.html (next: http://localhost:47890/tests/dromaeo/cssquery-jquery.html) 11:03:54 INFO - PROCESS | 18521 | RSS: Main: 155893760 11:03:54 INFO - PROCESS | 18521 | 11:06:56 INFO - PROCESS | 18521 | Cycle 1(1): loaded http://localhost:47890/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47890/tests/dromaeo/cssquery-mootools.html) 11:06:56 INFO - PROCESS | 18521 | RSS: Main: 154095616 11:06:56 INFO - PROCESS | 18521 | 11:09:58 INFO - PROCESS | 18521 | Cycle 1(1): loaded http://localhost:47890/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47890/tests/dromaeo/cssquery-prototype.html) 11:09:59 INFO - PROCESS | 18521 | RSS: Main: 152244224 11:09:59 INFO - PROCESS | 18521 | 11:13:01 INFO - PROCESS | 18521 | Cycle 1(1): loaded http://localhost:47890/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47890/tests/dromaeo/cssquery-yui.html) 11:13:02 INFO - PROCESS | 18521 | RSS: Main: 153559040 11:13:02 INFO - PROCESS | 18521 | 11:16:04 INFO - PROCESS | 18521 | Cycle 1(1): loaded http://localhost:47890/tests/dromaeo/cssquery-yui.html (next: http://localhost:47890/tests/dromaeo/cssquery-dojo.html) 11:16:04 INFO - PROCESS | 18521 | RSS: Main: 155389952 11:16:04 INFO - PROCESS | 18521 | 11:16:04 INFO - PROCESS | 18521 | __start_tp_report 11:16:04 INFO - PROCESS | 18521 | _x_x_mozilla_page_load 11:16:04 INFO - PROCESS | 18521 | _x_x_mozilla_page_load_details 11:16:04 INFO - PROCESS | 18521 | |i|pagename|runs| 11:16:04 INFO - PROCESS | 18521 | |0;dojo.html;3147.386259679363;3197.184717896936;3236.70869621734;3239.1740106272896;3266.2487627845594;5306;5388.40727519973;5419.241306217123;5423.755930983105;5424.972875135623;5361.383440904287;5369.221462887879;5376.462353764621;5463.96184724902;5586;4927.408710954691;4942.6293028022865;5101.897962040775;5109.923351149736;5114.386273647167;4878.560929516343;4978.153713868633;5030.446650868402;5049.899002019957;5094.388673359202;4890.755462226893;4968.751562421864;4982.975085124551;4989.426215985171;5012.423571289312;4958.157113290749;4974.801007959677;4981.850544483671;4995.675281106753;5033.3205017322925;4864.391951006124;4878.219484882437;4961.156603377434;4993.575546078588;5019.171836646949;5250.107481728115;5250.81622143227;5275.155975044013;5316.787328506855;5318.787248510055;5840.240768700041;5841.912371314434;5845.357010728816;5848.707564621752;5849.2980842298775;5783.9710801446145;5850.0932355484965;5886.323072846634;5886.735096920649;5991.2510936132985;5463.2078348639625;5481.040817856859;5481.068218402881;5488.862778430571;5493.2034854946205;5890.587658863838;5919.437653422918;5935.821925342247;5937.050071988461;5942.465178133989;5666.886662266732;5738.110592858114;5806.187133801272;5891.558133140032;5908.291005079418;5734.16854556087;5784.334801497797;5788.681622510718;5796.94203057964;5797.855053623609;5696.430356964271;5721.113227449752;5761.827145185651;5762.74067666956;5773.336066352424;5715.5427565794635;5773.595848290579;5820.82537523875;5839.182514447981;5913.46778789911;4517.435320584927;4537.0925814837165;4550.362949187116;4564.178447879347;4591.931121033187;3973.344398174269;4022.9798851006144;4041.8585349512628;4053.493313335833;4091.8363265469643;5414.3232095988005;5430.239766432703;5456.8090116846515;5461.453854614507;5523.502884740312;5881.529477641779;5895.882082358415;5931.466168044811;5934.8813023739285;5949.881002379928;5217.660852044605;5330.253764472977;5479.917801232985;5503.064479038573;5535.58483113768;4917.680350777188;4994.2508623706735;5021.623378246573;5030.144875371123;5039.370078740158;5964.343922168558;6008.24896887889;6009.669468179205;6077.939220607737;6105;5835.241418615553;5846;5849.327327357409;5850.473457388855;5883.735231914488;5844.26946631671;5873.03094989322;6049.758009679564;6050.818475445743;6081.27024757032;5671.631343962629;5705.7147142643535;5709.800156994485;5716.885662286648;5749.91375129365;5845.3570107289015;5902.1441890926435;5904.881902362014;5913.763449461973;5914.053751399755;5538.889222215453;5585.469380408855;5710.2862142232225;5740.540756739368;5761.07822748375;5651.971740141273;5694.373618901835;5700.372958974593;5716;5736.913946290892;5561.304836895388;5572.4706152915405;5601.80393686219;5609.411011843697;5619.269494965628;5579.832605021694;5633.352164501135;5704.286964129484;5711.8000869969355;5751.022326204639;5620.803271885465;5658.603897727119;5685.8862822742485;5686.715664216856;5713.485786279255 11:16:04 INFO - PROCESS | 18521 | |1;ext.html;509.03537795876815;537.9085555455573;550.0593984286869;565.2369301443052;581.9156222347759;35026.824865875664;35684.464733029025;35744.82127589365;35746.8212658937;35862.64137358626;38839.80580097096;39444.80277598615;39518.60481395185;39645.80177099118;39665;8472;8599.61301741423;8646.437981531211;8654.264387527037;8663.133686631318;8436.873446898302;8460.915390846074;8535.829283414329;8749.868751968726;8774.868376974318;8611.13888611137;8710.303175745925;8751.3874028818;8754.86867696985;8784.912150878474;8690.86963695542;8735.912640873605;8737.169968852948;8751.299896008304;8756.649734010696;8567.443116197428;8650.264727498106;8689.69586064491;8695.652173913037;8702.695405660772;38075.428868566996;38461.42307865384;38529.61470385316;38732.41901371482;38885.611143888484;3232.402005628966;3397.96602033979;3489.1626009757474;3531.0113168312914;3681.6134305897763;28623.57064644032;29068.27329316763;29239.122826315244;29304.41391172186;29678.70321296781;3800.5629352624524;3826.2730081284467;3892.785896775676;3937.586553411908;3967.3652215645357;270859;270954;271132;271145.64427177934;271794;56002.719986400625;56083.43916560864;56145.719271404196;56178.43821561814;56202;58826.411735882946;65268.673656631414;65764;66178.33821661818;66210.33789662042;15369.385224591115;15473.381064757283;15495.225238738018;15676.216189190494;15698.136602486973;11998.400079995965;12050.51797928073;12154.088443366783;12167.452464639113;12194.75610487803;19430.22279108848;19667.73821010602;19682.11430485603;19866.50333741668;19887.801121988596;8144.837103257902;8319.084900660922;8347.12355202695;8413.537255451009;8474;1007.9748006299754;1020.6937918624383;1076.8115579773507;1079.4171147580375;1087.907527860125;28459.715402845708;28495.369911364174;28583.571246431322;28593.57109643357;28983.420331593672;1044.556063672936;1046.7016900183412;1089.7983872983523;1094.6223552874246;1108.3516143056402;14872.405103795727;15014.624634384229;15036.398544058335;15203;15239.466618668293;312497;313495;314538;314782;315726;50587;50841.745791270805;50865;51050;51189.720256993125;1373.986260137406;1382.571402865095;1382.6958069224754;1383.5918404071024;1389.715108402775;27158.1852544424;28317.433651327272;28554;31001.68998309988;31425.8428707855;45285.54714452814;45338.54661453475;45652.315215271134;45873;46121.53878461172;292109;294736;296576;298990;299105;42093.57906420896;42895.57104429041;43020.35469467898;43967.340489893315;44230.77884610685;38866.6113338863;39086.2182756349;39468.60531394764;39863.60136398599;39974.20051598894;33063.669363307024;33161.50257746087;33939.321213575095;33957.49063763996;34391.31217375689;33280.50079248765;34172;34412.655873441945;34497.137571559906;34573.65426345805;37520.061998450255;37862;38296.42555361616;38429.61570384372;38462.6153738459;30907.227319317197;31037.534436983915;33394.4990825133;33554;33819.32361352808;24681.876590616932;24883.12909048247;25163.24510264695;25212.059882734575;25408.74591254064 11:16:04 INFO - PROCESS | 18521 | |2;jquery.html;334.1029336232218;340.7291203493223;341.13692358333424;343.7731097475665;344.0778713049028;16109;16401.261943212554;18047.729284060733;18309.908450457762;19027.619447611076;9865.457399843006;11001.779964400726;15417.152056636909;15426.61433464164;15456.845431545682;4839.274108883669;5183.196604526304;5336.67979921206;5374.731263436813;5381.569474442035;4447.710898791568;5295.443978382272;5302.3902251241025;5311.389190243133;5315.123004704219;5035.194368900977;5190.299309593213;5196.142636464979;5298.92051619226;5305.708186049766;5117.795288188468;5154.407243167027;5166.896662066775;5171.301874246966;5423.2136340230445;4947.604191664658;4947.901041979177;4953.826616068421;4961.925571116436;4963.4292056413615;13597.728045439135;18886.716699249522;19089.9045504773;19590.51023724404;19601.607967840708;2061.9070149662516;2150.3871396652034;2158.2338269914267;2217.3569664797187;2290.095412312144;9180.17378435944;9490.952545237298;9546.713598591983;9787.951060244724;9965.35225210359;1721.8364255395718;1757.2970811675432;1768.6639538487645;1831.8534517238588;1892.6593213221615;58441.707791461195;59569.40430595682;60184.39815601832;60891.39108608902;61546.38453615451;9170.266378689688;9269.490178040272;9284.210842078499;9284.675036373694;9368.95315523418;12148.635540933787;12175.695607609881;12176.452059657337;12185.329806860707;12213.633590992284;6857.177138743383;7045.718171273092;7263.782086537412;7278.09023872016;7317.26827317264;7212;7216.5670059796585;7217.530860494051;7266.890996635055;7284.053073100463;3928.3125453045604;3934.9803250983564;3938;3941.586133456003;3941.763494190358;1841.986907201034;1862.981370186308;1871.5788947486706;1880.61447403282;1884.9717254240923;855.5251835231506;933.6452148183647;947.673052796784;973.4110862927827;1007.3452256033637;16275.348986040663;16545.91727041357;16917.7462338065;17376.3049478022;18165.818341816677;905.4765927840253;948.800751842107;951.8952915179325;952.538019060755;998.1665309466676;9399.671011514563;9467.431954082776;9600.66397676092;9657.90342096584;9720.562574684156;493898;496838;497172;531462;554600;73779.46654000971;74222;77142.6142869282;77194;78541.60729196317;1160.3965937712342;1166.393475392791;1170.104869774623;1173.647905628308;1183.7395772929942;14779.852201477848;14956.700865982402;14974.625634358792;15040.398384064514;15156.621084472976;31553;31785;32107.83946080255;33905.66094339025;34749.47875781916;38288;40063;41080.794596026826;41375.58624413717;42687.14625707406;8772.166644168794;9478.336516443782;9577.138057574852;9661.420314781135;9674.1135478581;11661.416929153338;11771.352575608424;11821.76356472883;11854.229475084092;11859.644210673694;12031.578894738643;13048.608541743763;13147.60557183286;13310.534131305358;14026.08830426019;13655.453781848615;13845.653858653212;13856.307184640526;13928.721425571635;14297.785533217218;13170.802437963246;13813.654658633615;14071.085379450304;14113.647158821112;14358.928205358907;9218.539073046186;9265.397749146285;9280.62877484893;9283.442993420416;9540.95229523848;11223.55105795759;14271;14409;14631.853681463475;14858.554243372717 11:16:04 INFO - PROCESS | 18521 | |3;mootools.html;1462.0423622527244;1464.8022516960207;1621.1407953784492;1747.7028905086133;1773.255232802222;6541.57479763815;6632.60204387737;7427.480076394654;7581.810454738635;7636.923630763691;7170.569765814055;7240.167380751215;7320.048393708824;7476.21499742526;7485.925140748591;2229.3391423389558;2242.6523888797265;2265.569541787055;2278.2823410625683;2281.7261928568596;2248.6289762189217;2258.4579700871836;2279.658051292303;2308.272894038381;2311.3181611424584;2184.4429670434015;2212.0598745533166;2217.8891055447243;2218.3234113595345;2234.5866014787316;2192.56148770245;2214.2250212425683;2261.1294651559106;2269.738980017286;2271.6819645249598;2240.596692595332;2277.4078739527677;2282.760310167425;2286.7598902115205;2289.107248173214;7457.962710186469;7555.433342499335;7565.735199268;7565.886511702329;7589.178597136703;4485.865424037252;4531.252343363374;4566.383538222364;4567.634589232886;4574.679772415932;3010.9548356774667;3013.789034767567;3085.6605773364913;3096.5200393938976;3138.764592655537;1051.8632577764918;1066.6000249906285;1879.5301174706324;1903.5241189702574;1926.5376309685714;9931.65239216624;9959.601615935353;9975.850362244571;10068.798624027551;10097.848532272023;3872.2255548890334;3958.327084395602;4015.4980627421573;4024.3561030235023;4031.596840315945;8295.211954864279;8296.460730052528;8301.6679332826;8305.335573154132;8356.373272004625;4431.490378606437;4442.777861106932;4449.065696203834;4450.5104438511735;4456.041950980555;3600.4059330210744;3664.3221004114325;3959.8416063357718;4093.9795301023305;4124;3404.165979335029;3429.176997520577;3451.171718787473;3461.048211741741;3507.263474670348;1033;1042.9165666746642;1043.9112675422523;1044.9634262800917;1056.250062455665;1337.7926421404698;1342.9865701342862;1346.9663258418618;1349.3792855286679;1369.2400717601827;6702.396784289437;6816.4546836252985;6824.658767061726;6859.382655560924;7202.7118915243855;1099.9285046471953;1109.7946879827257;1120.7646394257133;1126.3692332293942;1135.9943200283947;5438.401775804658;5513.972430137904;5542.8337149884765;5545.667259964415;5569.470900264469;8818.955905220433;8861.202491775772;8919.152680495343;8961.193492585568;9135.680251191176;9083.04628014049;9095.727128186165;9177.954110229539;9191.586378612978;9205.677801276923;6929.618870962146;7029.543079699701;7109.862422012453;7150.821229469305;7153.141623005168;6881.4494840413645;6892.379685828299;6923.792286231421;6927;6951.895721564079;7796.10344810354;7990.9600451999695;8143.307818835466;8144.75565733029;8206.179382061746;8127.878081828895;8291.751247462586;8303.294219991127;8351.874721879298;8428.662853486037;5775.9133612996675;6076.483498902643;6193.628382296896;6490.188726409199;6617.43751781104;7031.718731250898;7113.644317784194;7130.607816570138;7133.251008644225;7138.64306784669;6446.129772480655;6719.059331693469;6754.5947243165565;6833.897491537531;6852.554583952027;6681.231658359351;6708.966455167693;6794.184697836291;6803.693833777591;6812.386885180357;6571.047198156336;6609.669516524251;6640.867182656417;6649.63427011519;6655.334466553306;6018.398160183947;6058.182145410313;6061.030235162353;6062.818115456544;6072.362401947908;6327.905081423874;6373.553851230555;6380.9361906380345;6383.170187875547;6388.329225431448 11:16:04 INFO - PROCESS | 18521 | |4;prototype.html;330.63795144316964;340.8738766656337;342.5529683762689;347.5395101490525;353.16300368127526;6279.937200627993;6295.874082518347;6323.936760632392;6335.429811316981;6426.710798014089;6171.660558669271;6292.5595208335435;6300.842478938017;6302.905456418157;6319.115323854664;4718.315844202597;4745.145873742725;4748.477667456595;4750.524947505239;4774.450938142123;4745.240761478164;4752.453467851206;4754.049190161964;4760.262159365304;4761.6904901181315;4632.722036677793;4704.247320428732;4723.10261050401;4725.17309470843;4739.123262196487;4679.274712419563;4687.7421741804355;4703.43558772946;4709.128811169944;4721.386219791422;4074.7147699661036;4077.3272410052305;4077.6941729370415;4081.755094694328;4085.4893138357706;5985.281766188042;5989.760409583611;6000.099985002241;6029.849253768647;6044.576879618428;5419.376771671269;5520.1443776214755;5522.530584900288;5527.695976721278;5535.6955367454775;6690.63201523916;6702.530822842403;6711.798646040626;6715.7985260442265;6727.159105111861;4497.662675299365;4504.864854054351;4516.254817955033;4520;4521.457425108975;6749.7300107995625;6873.175218973705;6928.688209030555;6973.546719463218;6986.825329366756;4708.293755936568;4709.152352576569;4710.458297295786;4715.646326525524;4718.622510199176;4775.71345719258;4777.092352453093;4783.808647654125;4788.808447662054;4795.976020119877;5472.370677372153;5499.092649712753;5501.367342755554;5502.889942201134;5507.430382341014;6562.982737675572;6688.29772873851;6705.295943925915;6722.361375669304;6738.326167383222;1603.7273663477238;1643.3590899549185;1647.6622292430022;1648.1512021309036;1661.3769836311383;1099.4063205868902;1117.3798541809374;1119.0432180485568;1123.3035517978742;1132.8300754886832;6252.5935814171935;6286.371362863769;6288.339724328971;6299.401556852092;6309.463695585835;6834.931650683529;6847.760328388483;6851.48613853963;6868.244493105854;6872.69072891711;6119.602225855305;6243;6256.43692067707;6275.843103922347;6306.085617585516;3717.5353080864893;3745.0637340664834;3749.4375843623675;3753.530808648919;3754.699624030071;7130.251323610946;7147.642617869085;7154.785356439315;7173.497855150194;7189.496735228484;6880.071190389233;6999.790006299819;7070.575765454089;7096.503244772816;7098.716051357991;7117.857642847218;7119.07452031243;7129.572225666477;7149.463790215651;7154.856902862018;6856.554323968926;6866;6873.656317184021;6873.862522749617;6895.379415852597;6666;6786.355296246848;6787.287334829969;6796.320367963164;6888.517803753689;7291.781246562611;7302.379297759538;7304.671289791866;7311.451641127043;7322.52403593786;4654.534546545318;4700.153972285021;4734.053189362073;4734.905301894012;4745.240761478147;6828.726850926106;6935.7225710971;7042.366187043191;7063.540869843444;7069.540479868792;6722.495812813961;6746.055552222595;6747.156605424322;6758;6763;6722.9663851680425;6737.898931515933;6751.189857216969;6757.391834734701;6758.3917447428;6491.967540162269;6646.667666616553;6674.632895190617;6699.162604674416;6713.227978782307;6816.216135144522;6828.556143850634;6857.348551887562;6866.690998904961;6870.27862074495;6639.767608133692;6677.565958212701;6696.899546506709;6702.095217145623;6708.362705542965 11:16:04 INFO - PROCESS | 18521 | |5;yui.html;707.7735124760077;749.3143773447296;751.902252707148;838.4508147163606;854.6196942360652;13563.254021028839;13684.726305473885;13750.243736594472;13771.65570860729;13779.242141682229;12387.752244955118;12790.552330668428;12978.41597128129;12985.740285194313;13004.34978251086;826.277007618334;837.2924878477677;837.7361131243639;839.2866063845744;840.1724301562956;820.5774026376421;821.4783612406105;825.6903661127077;825.7027470110755;832.0556168748453;865.7056600755742;868.3791089371099;869.1525762381659;871.9738407847743;874.3660845886745;863.7106569299292;864.3215076165243;865.0268447996004;866.0473479172922;869.1135042256894;634.3719717479662;635.8283263518824;639.9264084630281;642.9903551446732;644.687326646576;12324.81512777309;12351.814722779165;12387;12445.066620003536;12487.625371238877;11789.88210117905;11820.881791182064;11846.822297665542;12549.937250313782;13250.86749132506;10142.797144057151;10502.107320877734;10537;10609.575616975311;10990.725231869188;3635.381985062519;3670.4310831821113;3707.4253490708984;3716.201016781405;3807.4098514730263;44495.33257001147;44568.10863782738;44716.77641611804;44882.32676509855;44934.32598511025;9757.512124393752;9868.914419413859;9941.502924853728;10022.699319020441;10172.491375431347;17300.826991729922;17478;18592.53518662017;18634.906825465787;18641;6814.522983391115;7155.534890232118;7157;7186.784396468114;7238.203797582261;3847.96152038476;3906.980465097713;3911.2764138634443;3942.1721438498234;3948.3287841067086;3126.4841301185506;3142.1987393214586;3186.490161574137;3197.2326641606314;3198.4562624353916;571.8598943258845;578.4562511239421;585.4467528185909;586.5044037788062;588.0502987674874;558.4136656510648;592.3188333416606;616.9788999206321;624.5908929651085;673.71367168953;7395.889061664079;7935.365170786324;7961.920380796118;8038.959805200937;8141.307988821017;597.6533610505896;630.7445484578753;632.1592282264577;638.9041643753382;646.6637348578713;3673.2837096766407;3807.143392736612;3834.9233015339537;3858.0547765796996;3888.7277890547957;57937.13094303589;57952.420475795545;58253;58434.70782646145;59846.10230846541;48616.27075593869;50237.74881125571;50240;50475.747621262395;50598.74700626473;40397.394039089435;41477.58522414797;46710.299345509164;47744.7612761934;48137.75931120322;7934.56359900211;7954;8107.878381824159;8179.591020448835;8692.304615630861;30426;30762.69237307688;31064.378712425172;31874;33920.321593567496;42668.14663706771;43815;44804.32793508035;45446.54553454423;45549.77225113853;10663.093637040938;10694.679159625224;10738.516766745359;10764.623238186627;10820.621278255223;11717.472713728073;11730.178887477794;11933.462994165457;12003.819942700691;12244.142909996572;10587.523561439599;10659.25385223027;10753.946230268799;10855.348679079281;10914.072303854262;9533.427994320364;9868.210543156674;10473.476326183812;10532.842007369742;11039.172062095535;10132.240081994027;10176.592936282763;10254.384736915808;10326.948365258126;10504.319308910843;8967.775805604651;9137;9239.491827949527;9244.306676999118;9687.2734544908;8646.308295336485;8816.471011739317;8926.285897128344;9183.403078799856;9357.251419886528 11:16:04 INFO - PROCESS | 18521 | __end_tp_report 11:16:04 INFO - PROCESS | 18521 | __start_cc_report 11:16:04 INFO - PROCESS | 18521 | _x_x_mozilla_cycle_collect,310 11:16:04 INFO - PROCESS | 18521 | __end_cc_report 11:16:04 INFO - PROCESS | 18521 | __startTimestamp1451589364861__endTimestamp 11:16:04 INFO - PROCESS | 18521 | 11:16:04 INFO - PROCESS | 18521 | ------- Summary: start ------- 11:16:04 INFO - PROCESS | 18521 | Number of tests: 6 11:16:04 INFO - PROCESS | 18521 | 11:16:04 INFO - PROCESS | 18521 | [#0] dojo.html Cycles:165 Average:5415.16 Median:5619.27 stddev:596.41 (10.6%) stddev-sans-first:571.09 11:16:04 INFO - PROCESS | 18521 | Values: 3147.4 3197.2 3236.7 3239.2 3266.2 5306.0 5388.4 5419.2 5423.8 5425.0 5361.4 5369.2 5376.5 5464.0 5586.0 4927.4 4942.6 5101.9 5109.9 5114.4 4878.6 4978.2 5030.4 5049.9 5094.4 4890.8 4968.8 4983.0 4989.4 5012.4 4958.2 4974.8 4981.9 4995.7 5033.3 4864.4 4878.2 4961.2 4993.6 5019.2 5250.1 5250.8 5275.2 5316.8 5318.8 5840.2 5841.9 5845.4 5848.7 5849.3 5784.0 5850.1 5886.3 5886.7 5991.3 5463.2 5481.0 5481.1 5488.9 5493.2 5890.6 5919.4 5935.8 5937.1 5942.5 5666.9 5738.1 5806.2 5891.6 5908.3 5734.2 5784.3 5788.7 5796.9 5797.9 5696.4 5721.1 5761.8 5762.7 5773.3 5715.5 5773.6 5820.8 5839.2 5913.5 4517.4 4537.1 4550.4 4564.2 4591.9 3973.3 4023.0 4041.9 4053.5 4091.8 5414.3 5430.2 5456.8 5461.5 5523.5 5881.5 5895.9 5931.5 5934.9 5949.9 5217.7 5330.3 5479.9 5503.1 5535.6 4917.7 4994.3 5021.6 5030.1 5039.4 5964.3 6008.2 6009.7 6077.9 6105.0 5835.2 5846.0 5849.3 5850.5 5883.7 5844.3 5873.0 6049.8 6050.8 6081.3 5671.6 5705.7 5709.8 5716.9 5749.9 5845.4 5902.1 5904.9 5913.8 5914.1 5538.9 5585.5 5710.3 5740.5 5761.1 5652.0 5694.4 5700.4 5716.0 5736.9 5561.3 5572.5 5601.8 5609.4 5619.3 5579.8 5633.4 5704.3 5711.8 5751.0 5620.8 5658.6 5685.9 5686.7 5713.5 11:16:04 INFO - PROCESS | 18521 | 11:16:04 INFO - PROCESS | 18521 | [#1] ext.html Cycles:180 Average:46425.19 Median:35714.64 stddev:76891.10 (215.3%) stddev-sans-first:77029.52 11:16:04 INFO - PROCESS | 18521 | Values: 509.0 537.9 550.1 565.2 581.9 35026.8 35684.5 35744.8 35746.8 35862.6 38839.8 39444.8 39518.6 39645.8 39665.0 8472.0 8599.6 8646.4 8654.3 8663.1 8436.9 8460.9 8535.8 8749.9 8774.9 8611.1 8710.3 8751.4 8754.9 8784.9 8690.9 8735.9 8737.2 8751.3 8756.6 8567.4 8650.3 8689.7 8695.7 8702.7 38075.4 38461.4 38529.6 38732.4 38885.6 3232.4 3398.0 3489.2 3531.0 3681.6 28623.6 29068.3 29239.1 29304.4 29678.7 3800.6 3826.3 3892.8 3937.6 3967.4 270859.0 270954.0 271132.0 271145.6 271794.0 56002.7 56083.4 56145.7 56178.4 56202.0 58826.4 65268.7 65764.0 66178.3 66210.3 15369.4 15473.4 15495.2 15676.2 15698.1 11998.4 12050.5 12154.1 12167.5 12194.8 19430.2 19667.7 19682.1 19866.5 19887.8 8144.8 8319.1 8347.1 8413.5 8474.0 1008.0 1020.7 1076.8 1079.4 1087.9 28459.7 28495.4 28583.6 28593.6 28983.4 1044.6 1046.7 1089.8 1094.6 1108.4 14872.4 15014.6 15036.4 15203.0 15239.5 312497.0 313495.0 314538.0 314782.0 315726.0 50587.0 50841.7 50865.0 51050.0 51189.7 1374.0 1382.6 1382.7 1383.6 1389.7 27158.2 28317.4 28554.0 31001.7 31425.8 45285.5 45338.5 45652.3 45873.0 46121.5 292109.0 294736.0 296576.0 298990.0 299105.0 42093.6 42895.6 43020.4 43967.3 44230.8 38866.6 39086.2 39468.6 39863.6 39974.2 33063.7 33161.5 33939.3 33957.5 34391.3 33280.5 34172.0 34412.7 34497.1 34573.7 37520.1 37862.0 38296.4 38429.6 38462.6 30907.2 31037.5 33394.5 33554.0 33819.3 24681.9 24883.1 25163.2 25212.1 25408.7 11:16:04 INFO - PROCESS | 18521 | 11:16:04 INFO - PROCESS | 18521 | [#2] jquery.html Cycles:180 Average:27363.75 Median:22002.38 stddev:84215.80 (382.8%) stddev-sans-first:84427.59 11:16:04 INFO - PROCESS | 18521 | Values: 334.1 340.7 341.1 343.8 344.1 16109.0 16401.3 18047.7 18309.9 19027.6 9865.5 11001.8 15417.2 15426.6 15456.8 4839.3 5183.2 5336.7 5374.7 5381.6 4447.7 5295.4 5302.4 5311.4 5315.1 5035.2 5190.3 5196.1 5298.9 5305.7 5117.8 5154.4 5166.9 5171.3 5423.2 4947.6 4947.9 4953.8 4961.9 4963.4 13597.7 18886.7 19089.9 19590.5 19601.6 2061.9 2150.4 2158.2 2217.4 2290.1 9180.2 9491.0 9546.7 9788.0 9965.4 1721.8 1757.3 1768.7 1831.9 1892.7 58441.7 59569.4 60184.4 60891.4 61546.4 9170.3 9269.5 9284.2 9284.7 9369.0 12148.6 12175.7 12176.5 12185.3 12213.6 6857.2 7045.7 7263.8 7278.1 7317.3 7212.0 7216.6 7217.5 7266.9 7284.1 3928.3 3935.0 3938.0 3941.6 3941.8 1842.0 1863.0 1871.6 1880.6 1885.0 855.5 933.6 947.7 973.4 1007.3 16275.3 16545.9 16917.7 17376.3 18165.8 905.5 948.8 951.9 952.5 998.2 9399.7 9467.4 9600.7 9657.9 9720.6 493898.0 496838.0 497172.0 531462.0 554600.0 73779.5 74222.0 77142.6 77194.0 78541.6 1160.4 1166.4 1170.1 1173.6 1183.7 14779.9 14956.7 14974.6 15040.4 15156.6 31553.0 31785.0 32107.8 33905.7 34749.5 38288.0 40063.0 41080.8 41375.6 42687.1 8772.2 9478.3 9577.1 9661.4 9674.1 11661.4 11771.4 11821.8 11854.2 11859.6 12031.6 13048.6 13147.6 13310.5 14026.1 13655.5 13845.7 13856.3 13928.7 14297.8 13170.8 13813.7 14071.1 14113.6 14358.9 9218.5 9265.4 9280.6 9283.4 9541.0 11223.6 14271.0 14409.0 14631.9 14858.6 11:16:04 INFO - PROCESS | 18521 | 11:16:04 INFO - PROCESS | 18521 | [#3] mootools.html Cycles:180 Average:5233.95 Median:6061.92 stddev:2630.62 (43.4%) stddev-sans-first:2622.72 11:16:04 INFO - PROCESS | 18521 | Values: 1462.0 1464.8 1621.1 1747.7 1773.3 6541.6 6632.6 7427.5 7581.8 7636.9 7170.6 7240.2 7320.0 7476.2 7485.9 2229.3 2242.7 2265.6 2278.3 2281.7 2248.6 2258.5 2279.7 2308.3 2311.3 2184.4 2212.1 2217.9 2218.3 2234.6 2192.6 2214.2 2261.1 2269.7 2271.7 2240.6 2277.4 2282.8 2286.8 2289.1 7458.0 7555.4 7565.7 7565.9 7589.2 4485.9 4531.3 4566.4 4567.6 4574.7 3011.0 3013.8 3085.7 3096.5 3138.8 1051.9 1066.6 1879.5 1903.5 1926.5 9931.7 9959.6 9975.9 10068.8 10097.8 3872.2 3958.3 4015.5 4024.4 4031.6 8295.2 8296.5 8301.7 8305.3 8356.4 4431.5 4442.8 4449.1 4450.5 4456.0 3600.4 3664.3 3959.8 4094.0 4124.0 3404.2 3429.2 3451.2 3461.0 3507.3 1033.0 1042.9 1043.9 1045.0 1056.3 1337.8 1343.0 1347.0 1349.4 1369.2 6702.4 6816.5 6824.7 6859.4 7202.7 1099.9 1109.8 1120.8 1126.4 1136.0 5438.4 5514.0 5542.8 5545.7 5569.5 8819.0 8861.2 8919.2 8961.2 9135.7 9083.0 9095.7 9178.0 9191.6 9205.7 6929.6 7029.5 7109.9 7150.8 7153.1 6881.4 6892.4 6923.8 6927.0 6951.9 7796.1 7991.0 8143.3 8144.8 8206.2 8127.9 8291.8 8303.3 8351.9 8428.7 5775.9 6076.5 6193.6 6490.2 6617.4 7031.7 7113.6 7130.6 7133.3 7138.6 6446.1 6719.1 6754.6 6833.9 6852.6 6681.2 6709.0 6794.2 6803.7 6812.4 6571.0 6609.7 6640.9 6649.6 6655.3 6018.4 6058.2 6061.0 6062.8 6072.4 6327.9 6373.6 6380.9 6383.2 6388.3 11:16:04 INFO - PROCESS | 18521 | 11:16:04 INFO - PROCESS | 18521 | [#4] prototype.html Cycles:180 Average:5577.79 Median:6297.64 stddev:1708.95 (27.1%) stddev-sans-first:1667.75 11:16:04 INFO - PROCESS | 18521 | Values: 330.6 340.9 342.6 347.5 353.2 6279.9 6295.9 6323.9 6335.4 6426.7 6171.7 6292.6 6300.8 6302.9 6319.1 4718.3 4745.1 4748.5 4750.5 4774.5 4745.2 4752.5 4754.0 4760.3 4761.7 4632.7 4704.2 4723.1 4725.2 4739.1 4679.3 4687.7 4703.4 4709.1 4721.4 4074.7 4077.3 4077.7 4081.8 4085.5 5985.3 5989.8 6000.1 6029.8 6044.6 5419.4 5520.1 5522.5 5527.7 5535.7 6690.6 6702.5 6711.8 6715.8 6727.2 4497.7 4504.9 4516.3 4520.0 4521.5 6749.7 6873.2 6928.7 6973.5 6986.8 4708.3 4709.2 4710.5 4715.6 4718.6 4775.7 4777.1 4783.8 4788.8 4796.0 5472.4 5499.1 5501.4 5502.9 5507.4 6563.0 6688.3 6705.3 6722.4 6738.3 1603.7 1643.4 1647.7 1648.2 1661.4 1099.4 1117.4 1119.0 1123.3 1132.8 6252.6 6286.4 6288.3 6299.4 6309.5 6834.9 6847.8 6851.5 6868.2 6872.7 6119.6 6243.0 6256.4 6275.8 6306.1 3717.5 3745.1 3749.4 3753.5 3754.7 7130.3 7147.6 7154.8 7173.5 7189.5 6880.1 6999.8 7070.6 7096.5 7098.7 7117.9 7119.1 7129.6 7149.5 7154.9 6856.6 6866.0 6873.7 6873.9 6895.4 6666.0 6786.4 6787.3 6796.3 6888.5 7291.8 7302.4 7304.7 7311.5 7322.5 4654.5 4700.2 4734.1 4734.9 4745.2 6828.7 6935.7 7042.4 7063.5 7069.5 6722.5 6746.1 6747.2 6758.0 6763.0 6723.0 6737.9 6751.2 6757.4 6758.4 6492.0 6646.7 6674.6 6699.2 6713.2 6816.2 6828.6 6857.3 6866.7 6870.3 6639.8 6677.6 6696.9 6702.1 6708.4 11:16:04 INFO - PROCESS | 18521 | 11:16:04 INFO - PROCESS | 18521 | [#5] yui.html Cycles:180 Average:13352.03 Median:45498.16 stddev:15586.97 (34.3%) stddev-sans-first:15601.77 11:16:04 INFO - PROCESS | 18521 | Values: 707.8 749.3 751.9 838.5 854.6 13563.3 13684.7 13750.2 13771.7 13779.2 12387.8 12790.6 12978.4 12985.7 13004.3 826.3 837.3 837.7 839.3 840.2 820.6 821.5 825.7 825.7 832.1 865.7 868.4 869.2 872.0 874.4 863.7 864.3 865.0 866.0 869.1 634.4 635.8 639.9 643.0 644.7 12324.8 12351.8 12387.0 12445.1 12487.6 11789.9 11820.9 11846.8 12549.9 13250.9 10142.8 10502.1 10537.0 10609.6 10990.7 3635.4 3670.4 3707.4 3716.2 3807.4 44495.3 44568.1 44716.8 44882.3 44934.3 9757.5 9868.9 9941.5 10022.7 10172.5 17300.8 17478.0 18592.5 18634.9 18641.0 6814.5 7155.5 7157.0 7186.8 7238.2 3848.0 3907.0 3911.3 3942.2 3948.3 3126.5 3142.2 3186.5 3197.2 3198.5 571.9 578.5 585.4 586.5 588.1 558.4 592.3 617.0 624.6 673.7 7395.9 7935.4 7961.9 8039.0 8141.3 597.7 630.7 632.2 638.9 646.7 3673.3 3807.1 3834.9 3858.1 3888.7 57937.1 57952.4 58253.0 58434.7 59846.1 48616.3 50237.7 50240.0 50475.7 50598.7 40397.4 41477.6 46710.3 47744.8 48137.8 7934.6 7954.0 8107.9 8179.6 8692.3 30426.0 30762.7 31064.4 31874.0 33920.3 42668.1 43815.0 44804.3 45446.5 45549.8 10663.1 10694.7 10738.5 10764.6 10820.6 11717.5 11730.2 11933.5 12003.8 12244.1 10587.5 10659.3 10753.9 10855.3 10914.1 9533.4 9868.2 10473.5 10532.8 11039.2 10132.2 10176.6 10254.4 10326.9 10504.3 8967.8 9137.0 9239.5 9244.3 9687.3 8646.3 8816.5 8926.3 9183.4 9357.3 11:16:04 INFO - PROCESS | 18521 | -------- Summary: end -------- 11:16:04 INFO - PROCESS | 18521 | 11:16:05 INFO - TEST-INFO | 18521: exit 0 11:16:05 INFO - TEST-OK | dromaeo_css | took 1111249ms 11:16:05 INFO - TEST-START | kraken 11:16:05 INFO - operating with platform_type : linux_ 11:16:05 INFO - Initialising browser for kraken test... 11:16:05 INFO - TEST-INFO | started process 18756 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyOdBVV/profile http://localhost:47890/getInfo.html) 11:16:10 INFO - PROCESS | 18756 | __metrics Screen width/height:1600/1200 11:16:10 INFO - PROCESS | 18756 | colorDepth:24 11:16:10 INFO - PROCESS | 18756 | Browser inner width/height: 1024/697 11:16:10 INFO - PROCESS | 18756 | __metrics 11:16:10 INFO - PROCESS | 18756 | 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:16:11 INFO - TEST-INFO | 18756: exit 0 11:16:11 INFO - Browser initialized. 11:16:11 INFO - Running cycle 1/1 for kraken test... 11:16:11 INFO - TEST-INFO | started process 18877 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyOdBVV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:22 INFO - PROCESS | 18877 | RSS: Main: 150896640 11:16:22 INFO - PROCESS | 18877 | 11:16:25 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47890/tests/kraken/driver.html?testName=audio-beat-detection) 11:16:25 INFO - PROCESS | 18877 | RSS: Main: 151339008 11:16:25 INFO - PROCESS | 18877 | 11:16:28 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47890/tests/kraken/driver.html?testName=audio-dft) 11:16:29 INFO - PROCESS | 18877 | RSS: Main: 150056960 11:16:29 INFO - PROCESS | 18877 | 11:16:32 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47890/tests/kraken/driver.html?testName=audio-fft) 11:16:32 INFO - PROCESS | 18877 | RSS: Main: 145981440 11:16:32 INFO - PROCESS | 18877 | 11:16:34 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47890/tests/kraken/driver.html?testName=audio-oscillator) 11:16:35 INFO - PROCESS | 18877 | RSS: Main: 147099648 11:16:35 INFO - PROCESS | 18877 | 11:16:37 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47890/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:16:38 INFO - PROCESS | 18877 | RSS: Main: 147415040 11:16:38 INFO - PROCESS | 18877 | 11:16:41 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47890/tests/kraken/driver.html?testName=imaging-darkroom) 11:16:41 INFO - PROCESS | 18877 | RSS: Main: 147042304 11:16:41 INFO - PROCESS | 18877 | 11:16:45 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47890/tests/kraken/driver.html?testName=imaging-desaturate) 11:16:45 INFO - PROCESS | 18877 | RSS: Main: 148652032 11:16:45 INFO - PROCESS | 18877 | 11:16:48 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47890/tests/kraken/driver.html?testName=json-parse-financial) 11:16:49 INFO - PROCESS | 18877 | RSS: Main: 149123072 11:16:49 INFO - PROCESS | 18877 | 11:16:50 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47890/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:16:51 INFO - PROCESS | 18877 | RSS: Main: 149229568 11:16:51 INFO - PROCESS | 18877 | 11:16:53 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47890/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:16:53 INFO - PROCESS | 18877 | RSS: Main: 148832256 11:16:53 INFO - PROCESS | 18877 | 11:16:55 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47890/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:16:56 INFO - PROCESS | 18877 | RSS: Main: 149114880 11:16:56 INFO - PROCESS | 18877 | 11:16:59 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47890/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:16:59 INFO - PROCESS | 18877 | RSS: Main: 149221376 11:16:59 INFO - PROCESS | 18877 | 11:17:02 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47890/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:17:02 INFO - PROCESS | 18877 | RSS: Main: 148570112 11:17:02 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:47890/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47890/tests/kraken/driver.html?testName=ai-astar) 11:17:04 INFO - PROCESS | 18877 | RSS: Main: 148590592 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | __start_tp_report 11:17:04 INFO - PROCESS | 18877 | _x_x_mozilla_page_load 11:17:04 INFO - PROCESS | 18877 | _x_x_mozilla_page_load_details 11:17:04 INFO - PROCESS | 18877 | |i|pagename|runs| 11:17:04 INFO - PROCESS | 18877 | |0;ai-astar;113;106;112;112;111;122;111;110;114;110 11:17:04 INFO - PROCESS | 18877 | |1;audio-beat-detection;162;136;161;160;125;158;156;133;167;124 11:17:04 INFO - PROCESS | 18877 | |2;audio-dft;164;163;163;163;164;163;163;166;169;164 11:17:04 INFO - PROCESS | 18877 | |3;audio-fft;72;76;74;72;74;74;76;133;74;74 11:17:04 INFO - PROCESS | 18877 | |4;audio-oscillator;95;98;142;95;97;97;142;96;97;148 11:17:04 INFO - PROCESS | 18877 | |5;imaging-gaussian-blur;110;110;110;109;110;110;110;110;110;110 11:17:04 INFO - PROCESS | 18877 | |6;imaging-darkroom;147;146;147;147;147;146;147;147;147;146 11:17:04 INFO - PROCESS | 18877 | |7;imaging-desaturate;97;101;96;96;96;96;96;96;97;96 11:17:04 INFO - PROCESS | 18877 | |8;json-parse-financial;60;62;61;59;63;59;59;59;57;62 11:17:04 INFO - PROCESS | 18877 | |9;json-stringify-tinderbox;67;68;68;67;68;68;68;67;68;68 11:17:04 INFO - PROCESS | 18877 | |10;stanford-crypto-aes;87;88;89;87;86;94;89;94;86;87 11:17:04 INFO - PROCESS | 18877 | |11;stanford-crypto-ccm;120;117;121;127;123;120;127;120;126;120 11:17:04 INFO - PROCESS | 18877 | |12;stanford-crypto-pbkdf2;141;152;152;160;154;142;154;146;147;145 11:17:04 INFO - PROCESS | 18877 | |13;stanford-crypto-sha256-iterative;71;71;69;72;77;70;67;68;67;68 11:17:04 INFO - PROCESS | 18877 | __end_tp_report 11:17:04 INFO - PROCESS | 18877 | __start_cc_report 11:17:04 INFO - PROCESS | 18877 | _x_x_mozilla_cycle_collect,746 11:17:04 INFO - PROCESS | 18877 | __end_cc_report 11:17:04 INFO - PROCESS | 18877 | __startTimestamp1451589424764__endTimestamp 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | ------- Summary: start ------- 11:17:04 INFO - PROCESS | 18877 | Number of tests: 14 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:4.09 (3.7%) stddev-sans-first:4.33 11:17:04 INFO - PROCESS | 18877 | Values: 113.0 106.0 112.0 112.0 111.0 122.0 111.0 110.0 114.0 110.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:159.00 stddev:16.69 (10.5%) stddev-sans-first:16.94 11:17:04 INFO - PROCESS | 18877 | Values: 162.0 136.0 161.0 160.0 125.0 158.0 156.0 133.0 167.0 124.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:1.93 (1.2%) stddev-sans-first:2.05 11:17:04 INFO - PROCESS | 18877 | Values: 164.0 163.0 163.0 163.0 164.0 163.0 163.0 166.0 169.0 164.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#3] audio-fft Cycles:10 Average:79.90 Median:74.00 stddev:18.71 (25.3%) stddev-sans-first:19.62 11:17:04 INFO - PROCESS | 18877 | Values: 72.0 76.0 74.0 72.0 74.0 74.0 76.0 133.0 74.0 74.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:96.50 stddev:23.06 (23.9%) stddev-sans-first:23.74 11:17:04 INFO - PROCESS | 18877 | Values: 95.0 98.0 142.0 95.0 97.0 97.0 142.0 96.0 97.0 148.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:17:04 INFO - PROCESS | 18877 | Values: 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 11:17:04 INFO - PROCESS | 18877 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.57 (1.6%) stddev-sans-first:1.66 11:17:04 INFO - PROCESS | 18877 | Values: 97.0 101.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:60.50 stddev:1.85 (3.1%) stddev-sans-first:1.96 11:17:04 INFO - PROCESS | 18877 | Values: 60.0 62.0 61.0 59.0 63.0 59.0 59.0 59.0 57.0 62.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 11:17:04 INFO - PROCESS | 18877 | Values: 67.0 68.0 68.0 67.0 68.0 68.0 68.0 67.0 68.0 68.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:88.50 stddev:2.98 (3.4%) stddev-sans-first:3.10 11:17:04 INFO - PROCESS | 18877 | Values: 87.0 88.0 89.0 87.0 86.0 94.0 89.0 94.0 86.0 87.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:122.00 stddev:3.48 (2.9%) stddev-sans-first:3.61 11:17:04 INFO - PROCESS | 18877 | Values: 120.0 117.0 121.0 127.0 123.0 120.0 127.0 120.0 126.0 120.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:152.00 stddev:6.06 (4.0%) stddev-sans-first:5.63 11:17:04 INFO - PROCESS | 18877 | Values: 141.0 152.0 152.0 160.0 154.0 142.0 154.0 146.0 147.0 145.0 11:17:04 INFO - PROCESS | 18877 | 11:17:04 INFO - PROCESS | 18877 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:3.02 (4.3%) stddev-sans-first:3.18 11:17:04 INFO - PROCESS | 18877 | Values: 71.0 71.0 69.0 72.0 77.0 70.0 67.0 68.0 67.0 68.0 11:17:04 INFO - PROCESS | 18877 | -------- Summary: end -------- 11:17:04 INFO - PROCESS | 18877 | 11:17:05 INFO - TEST-INFO | 18877: exit 0 11:17:05 INFO - TEST-OK | kraken | took 60131ms 11:17:05 INFO - TEST-START | v8_7 11:17:05 INFO - operating with platform_type : linux_ 11:17:05 INFO - Initialising browser for v8_7 test... 11:17:05 INFO - TEST-INFO | started process 19170 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpimHUBX/profile http://localhost:47890/getInfo.html) 11:17:10 INFO - PROCESS | 19170 | __metrics Screen width/height:1600/1200 11:17:10 INFO - PROCESS | 19170 | colorDepth:24 11:17:10 INFO - PROCESS | 19170 | Browser inner width/height: 1024/697 11:17:10 INFO - PROCESS | 19170 | __metrics 11:17:10 INFO - PROCESS | 19170 | 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:17:11 INFO - TEST-INFO | 19170: exit 0 11:17:11 INFO - Browser initialized. 11:17:11 INFO - Running cycle 1/1 for v8_7 test... 11:17:11 INFO - TEST-INFO | started process 19290 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpimHUBX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:23 INFO - PROCESS | 19290 | RSS: Main: 150835200 11:17:23 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | Cycle 1(1): loaded http://localhost:47890/tests/v8_7/run.html (next: http://localhost:47890/tests/v8_7/run.html) 11:17:44 INFO - PROCESS | 19290 | RSS: Main: 147378176 11:17:44 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | __start_tp_report 11:17:44 INFO - PROCESS | 19290 | _x_x_mozilla_page_load 11:17:44 INFO - PROCESS | 19290 | _x_x_mozilla_page_load_details 11:17:44 INFO - PROCESS | 19290 | |i|pagename|runs| 11:17:44 INFO - PROCESS | 19290 | |0;Richards;169.72165648336727 11:17:44 INFO - PROCESS | 19290 | |1;DeltaBlue;190.11406844106463 11:17:44 INFO - PROCESS | 19290 | |2;Encrypt;279.01785714285717 11:17:44 INFO - PROCESS | 19290 | |3;Decrypt;5202.072538860104 11:17:44 INFO - PROCESS | 19290 | |4;RayTrace;1064.9627263045793 11:17:44 INFO - PROCESS | 19290 | |5;Earley;738.7453874538745 11:17:44 INFO - PROCESS | 19290 | |6;Boyer;12407.407407407407 11:17:44 INFO - PROCESS | 19290 | |7;RegExp;25300 11:17:44 INFO - PROCESS | 19290 | |8;Splay;596.793349168646 11:17:44 INFO - PROCESS | 19290 | |9;NavierStokes;4830.917874396136 11:17:44 INFO - PROCESS | 19290 | __end_tp_report 11:17:44 INFO - PROCESS | 19290 | __startTimestamp1451589464891__endTimestamp 11:17:44 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | ------- Summary: start ------- 11:17:44 INFO - PROCESS | 19290 | Number of tests: 10 11:17:44 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | [#0] Richards Cycles:1 Average:169.72 Median:169.72 stddev:0.00 (0.0%) 11:17:44 INFO - PROCESS | 19290 | Values: 169.7 11:17:44 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | [#1] DeltaBlue Cycles:1 Average:190.11 Median:190.11 stddev:0.00 (0.0%) 11:17:44 INFO - PROCESS | 19290 | Values: 190.1 11:17:44 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 11:17:44 INFO - PROCESS | 19290 | Values: 279.0 11:17:44 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 11:17:44 INFO - PROCESS | 19290 | Values: 5202.1 11:17:44 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | [#4] RayTrace Cycles:1 Average:1064.96 Median:1064.96 stddev:0.00 (0.0%) 11:17:44 INFO - PROCESS | 19290 | Values: 1065.0 11:17:44 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | [#5] Earley Cycles:1 Average:738.75 Median:738.75 stddev:0.00 (0.0%) 11:17:44 INFO - PROCESS | 19290 | Values: 738.7 11:17:44 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 11:17:44 INFO - PROCESS | 19290 | Values: 12407.4 11:17:44 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | [#7] RegExp Cycles:1 Average:25300.00 Median:25300.00 stddev:0.00 (0.0%) 11:17:44 INFO - PROCESS | 19290 | Values: 25300.0 11:17:44 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | [#8] Splay Cycles:1 Average:596.79 Median:596.79 stddev:0.00 (0.0%) 11:17:44 INFO - PROCESS | 19290 | Values: 596.8 11:17:44 INFO - PROCESS | 19290 | 11:17:44 INFO - PROCESS | 19290 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:17:44 INFO - PROCESS | 19290 | Values: 4830.9 11:17:44 INFO - PROCESS | 19290 | -------- Summary: end -------- 11:17:44 INFO - PROCESS | 19290 | 11:17:45 INFO - TEST-INFO | 19290: exit 0 11:17:45 INFO - TEST-OK | v8_7 | took 40112ms 11:17:45 INFO - SUITE-END | took 1211s 11:17:45 INFO - Completed test suite (00:20:11) 11:17:45 INFO - Working with test: dromaeo_css 11:17:45 INFO - Generating results file: dromaeo_css 11:17:45 INFO - Working with test: kraken 11:17:45 INFO - Generating results file: kraken 11:17:45 INFO - javascript benchmark 11:17:45 INFO - Working with test: v8_7 11:17:45 INFO - Generating results file: v8_7 11:17:45 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:17:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:17:46 INFO - process_Request line: dromaeo_css 6965.64 graph.html#tests=[[72,64,43]] 11:17:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:17:46 INFO - process_Request line: kraken 1526.30 graph.html#tests=[[232,64,43]] 11:17:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:17:46 INFO - process_Request line: v8_7 21240.50 graph.html#tests=[[230,64,43]] 11:17:46 INFO - RETURN: dromaeo_css: 6965.64 11:17:46 INFO - RETURN: kraken: 1526.30 11:17:46 INFO - RETURN: v8_7: 21240.50 11:17:46 INFO - javascript benchmark 11:17:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3147.386259679363, 3197.184717896936, 3236.70869621734, 3239.1740106272896, 3266.2487627845594, 5306.0, 5388.40727519973, 5419.241306217123, 5423.755930983105, 5424.972875135623, 5361.383440904287, 5369.221462887879, 5376.462353764621, 5463.96184724902, 5586.0, 4927.408710954691, 4942.6293028022865, 5101.897962040775, 5109.923351149736, 5114.386273647167, 4878.560929516343, 4978.153713868633, 5030.446650868402, 5049.899002019957, 5094.388673359202, 4890.755462226893, 4968.751562421864, 4982.975085124551, 4989.426215985171, 5012.423571289312, 4958.157113290749, 4974.801007959677, 4981.850544483671, 4995.675281106753, 5033.3205017322925, 4864.391951006124, 4878.219484882437, 4961.156603377434, 4993.575546078588, 5019.171836646949, 5250.107481728115, 5250.81622143227, 5275.155975044013, 5316.787328506855, 5318.787248510055, 5840.240768700041, 5841.912371314434, 5845.357010728816, 5848.707564621752, 5849.2980842298775, 5783.9710801446145, 5850.0932355484965, 5886.323072846634, 5886.735096920649, 5991.2510936132985, 5463.2078348639625, 5481.040817856859, 5481.068218402881, 5488.862778430571, 5493.2034854946205, 5890.587658863838, 5919.437653422918, 5935.821925342247, 5937.050071988461, 5942.465178133989, 5666.886662266732, 5738.110592858114, 5806.187133801272, 5891.558133140032, 5908.291005079418, 5734.16854556087, 5784.334801497797, 5788.681622510718, 5796.94203057964, 5797.855053623609, 5696.430356964271, 5721.113227449752, 5761.827145185651, 5762.74067666956, 5773.336066352424, 5715.5427565794635, 5773.595848290579, 5820.82537523875, 5839.182514447981, 5913.46778789911, 4517.435320584927, 4537.0925814837165, 4550.362949187116, 4564.178447879347, 4591.931121033187, 3973.344398174269, 4022.9798851006144, 4041.8585349512628, 4053.493313335833, 4091.8363265469643, 5414.3232095988005, 5430.239766432703, 5456.8090116846515, 5461.453854614507, 5523.502884740312, 5881.529477641779, 5895.882082358415, 5931.466168044811, 5934.8813023739285, 5949.881002379928, 5217.660852044605, 5330.253764472977, 5479.917801232985, 5503.064479038573, 5535.58483113768, 4917.680350777188, 4994.2508623706735, 5021.623378246573, 5030.144875371123, 5039.370078740158, 5964.343922168558, 6008.24896887889, 6009.669468179205, 6077.939220607737, 6105.0, 5835.241418615553, 5846.0, 5849.327327357409, 5850.473457388855, 5883.735231914488, 5844.26946631671, 5873.03094989322, 6049.758009679564, 6050.818475445743, 6081.27024757032, 5671.631343962629, 5705.7147142643535, 5709.800156994485, 5716.885662286648, 5749.91375129365, 5845.3570107289015, 5902.1441890926435, 5904.881902362014, 5913.763449461973, 5914.053751399755, 5538.889222215453, 5585.469380408855, 5710.2862142232225, 5740.540756739368, 5761.07822748375, 5651.971740141273, 5694.373618901835, 5700.372958974593, 5716.0, 5736.913946290892, 5561.304836895388, 5572.4706152915405, 5601.80393686219, 5609.411011843697, 5619.269494965628, 5579.832605021694, 5633.352164501135, 5704.286964129484, 5711.8000869969355, 5751.022326204639, 5620.803271885465, 5658.603897727119, 5685.8862822742485, 5686.715664216856, 5713.485786279255], "unit": "score", "name": "dojo.html", "value": 5376.5152953969}, {"lowerIsBetter": false, "replicates": [509.03537795876815, 537.9085555455573, 550.0593984286869, 565.2369301443052, 581.9156222347759, 35026.824865875664, 35684.464733029025, 35744.82127589365, 35746.8212658937, 35862.64137358626, 38839.80580097096, 39444.80277598615, 39518.60481395185, 39645.80177099118, 39665.0, 8472.0, 8599.61301741423, 8646.437981531211, 8654.264387527037, 8663.133686631318, 8436.873446898302, 8460.915390846074, 8535.829283414329, 8749.868751968726, 8774.868376974318, 8611.13888611137, 8710.303175745925, 8751.3874028818, 8754.86867696985, 8784.912150878474, 8690.86963695542, 8735.912640873605, 8737.169968852948, 8751.299896008304, 8756.649734010696, 8567.443116197428, 8650.264727498106, 8689.69586064491, 8695.652173913037, 8702.695405660772, 38075.428868566996, 38461.42307865384, 38529.61470385316, 38732.41901371482, 38885.611143888484, 3232.402005628966, 3397.96602033979, 3489.1626009757474, 3531.0113168312914, 3681.6134305897763, 28623.57064644032, 29068.27329316763, 29239.122826315244, 29304.41391172186, 29678.70321296781, 3800.5629352624524, 3826.2730081284467, 3892.785896775676, 3937.586553411908, 3967.3652215645357, 270859.0, 270954.0, 271132.0, 271145.64427177934, 271794.0, 56002.719986400625, 56083.43916560864, 56145.719271404196, 56178.43821561814, 56202.0, 58826.411735882946, 65268.673656631414, 65764.0, 66178.33821661818, 66210.33789662042, 15369.385224591115, 15473.381064757283, 15495.225238738018, 15676.216189190494, 15698.136602486973, 11998.400079995965, 12050.51797928073, 12154.088443366783, 12167.452464639113, 12194.75610487803, 19430.22279108848, 19667.73821010602, 19682.11430485603, 19866.50333741668, 19887.801121988596, 8144.837103257902, 8319.084900660922, 8347.12355202695, 8413.537255451009, 8474.0, 1007.9748006299754, 1020.6937918624383, 1076.8115579773507, 1079.4171147580375, 1087.907527860125, 28459.715402845708, 28495.369911364174, 28583.571246431322, 28593.57109643357, 28983.420331593672, 1044.556063672936, 1046.7016900183412, 1089.7983872983523, 1094.6223552874246, 1108.3516143056402, 14872.405103795727, 15014.624634384229, 15036.398544058335, 15203.0, 15239.466618668293, 312497.0, 313495.0, 314538.0, 314782.0, 315726.0, 50587.0, 50841.745791270805, 50865.0, 51050.0, 51189.720256993125, 1373.986260137406, 1382.571402865095, 1382.6958069224754, 1383.5918404071024, 1389.715108402775, 27158.1852544424, 28317.433651327272, 28554.0, 31001.68998309988, 31425.8428707855, 45285.54714452814, 45338.54661453475, 45652.315215271134, 45873.0, 46121.53878461172, 292109.0, 294736.0, 296576.0, 298990.0, 299105.0, 42093.57906420896, 42895.57104429041, 43020.35469467898, 43967.340489893315, 44230.77884610685, 38866.6113338863, 39086.2182756349, 39468.60531394764, 39863.60136398599, 39974.20051598894, 33063.669363307024, 33161.50257746087, 33939.321213575095, 33957.49063763996, 34391.31217375689, 33280.50079248765, 34172.0, 34412.655873441945, 34497.137571559906, 34573.65426345805, 37520.061998450255, 37862.0, 38296.42555361616, 38429.61570384372, 38462.6153738459, 30907.227319317197, 31037.534436983915, 33394.4990825133, 33554.0, 33819.32361352808, 24681.876590616932, 24883.12909048247, 25163.24510264695, 25212.059882734575, 25408.74591254064], "unit": "score", "name": "ext.html", "value": 18547.73182307623}, {"lowerIsBetter": false, "replicates": [334.1029336232218, 340.7291203493223, 341.13692358333424, 343.7731097475665, 344.0778713049028, 16109.0, 16401.261943212554, 18047.729284060733, 18309.908450457762, 19027.619447611076, 9865.457399843006, 11001.779964400726, 15417.152056636909, 15426.61433464164, 15456.845431545682, 4839.274108883669, 5183.196604526304, 5336.67979921206, 5374.731263436813, 5381.569474442035, 4447.710898791568, 5295.443978382272, 5302.3902251241025, 5311.389190243133, 5315.123004704219, 5035.194368900977, 5190.299309593213, 5196.142636464979, 5298.92051619226, 5305.708186049766, 5117.795288188468, 5154.407243167027, 5166.896662066775, 5171.301874246966, 5423.2136340230445, 4947.604191664658, 4947.901041979177, 4953.826616068421, 4961.925571116436, 4963.4292056413615, 13597.728045439135, 18886.716699249522, 19089.9045504773, 19590.51023724404, 19601.607967840708, 2061.9070149662516, 2150.3871396652034, 2158.2338269914267, 2217.3569664797187, 2290.095412312144, 9180.17378435944, 9490.952545237298, 9546.713598591983, 9787.951060244724, 9965.35225210359, 1721.8364255395718, 1757.2970811675432, 1768.6639538487645, 1831.8534517238588, 1892.6593213221615, 58441.707791461195, 59569.40430595682, 60184.39815601832, 60891.39108608902, 61546.38453615451, 9170.266378689688, 9269.490178040272, 9284.210842078499, 9284.675036373694, 9368.95315523418, 12148.635540933787, 12175.695607609881, 12176.452059657337, 12185.329806860707, 12213.633590992284, 6857.177138743383, 7045.718171273092, 7263.782086537412, 7278.09023872016, 7317.26827317264, 7212.0, 7216.5670059796585, 7217.530860494051, 7266.890996635055, 7284.053073100463, 3928.3125453045604, 3934.9803250983564, 3938.0, 3941.586133456003, 3941.763494190358, 1841.986907201034, 1862.981370186308, 1871.5788947486706, 1880.61447403282, 1884.9717254240923, 855.5251835231506, 933.6452148183647, 947.673052796784, 973.4110862927827, 1007.3452256033637, 16275.348986040663, 16545.91727041357, 16917.7462338065, 17376.3049478022, 18165.818341816677, 905.4765927840253, 948.800751842107, 951.8952915179325, 952.538019060755, 998.1665309466676, 9399.671011514563, 9467.431954082776, 9600.66397676092, 9657.90342096584, 9720.562574684156, 493898.0, 496838.0, 497172.0, 531462.0, 554600.0, 73779.46654000971, 74222.0, 77142.6142869282, 77194.0, 78541.60729196317, 1160.3965937712342, 1166.393475392791, 1170.104869774623, 1173.647905628308, 1183.7395772929942, 14779.852201477848, 14956.700865982402, 14974.625634358792, 15040.398384064514, 15156.621084472976, 31553.0, 31785.0, 32107.83946080255, 33905.66094339025, 34749.47875781916, 38288.0, 40063.0, 41080.794596026826, 41375.58624413717, 42687.14625707406, 8772.166644168794, 9478.336516443782, 9577.138057574852, 9661.420314781135, 9674.1135478581, 11661.416929153338, 11771.352575608424, 11821.76356472883, 11854.229475084092, 11859.644210673694, 12031.578894738643, 13048.608541743763, 13147.60557183286, 13310.534131305358, 14026.08830426019, 13655.453781848615, 13845.653858653212, 13856.307184640526, 13928.721425571635, 14297.785533217218, 13170.802437963246, 13813.654658633615, 14071.085379450304, 14113.647158821112, 14358.928205358907, 9218.539073046186, 9265.397749146285, 9280.62877484893, 9283.442993420416, 9540.95229523848, 11223.55105795759, 14271.0, 14409.0, 14631.853681463475, 14858.554243372717], "unit": "score", "name": "jquery.html", "value": 8468.775353749654}, {"lowerIsBetter": false, "replicates": [1462.0423622527244, 1464.8022516960207, 1621.1407953784492, 1747.7028905086133, 1773.255232802222, 6541.57479763815, 6632.60204387737, 7427.480076394654, 7581.810454738635, 7636.923630763691, 7170.569765814055, 7240.167380751215, 7320.048393708824, 7476.21499742526, 7485.925140748591, 2229.3391423389558, 2242.6523888797265, 2265.569541787055, 2278.2823410625683, 2281.7261928568596, 2248.6289762189217, 2258.4579700871836, 2279.658051292303, 2308.272894038381, 2311.3181611424584, 2184.4429670434015, 2212.0598745533166, 2217.8891055447243, 2218.3234113595345, 2234.5866014787316, 2192.56148770245, 2214.2250212425683, 2261.1294651559106, 2269.738980017286, 2271.6819645249598, 2240.596692595332, 2277.4078739527677, 2282.760310167425, 2286.7598902115205, 2289.107248173214, 7457.962710186469, 7555.433342499335, 7565.735199268, 7565.886511702329, 7589.178597136703, 4485.865424037252, 4531.252343363374, 4566.383538222364, 4567.634589232886, 4574.679772415932, 3010.9548356774667, 3013.789034767567, 3085.6605773364913, 3096.5200393938976, 3138.764592655537, 1051.8632577764918, 1066.6000249906285, 1879.5301174706324, 1903.5241189702574, 1926.5376309685714, 9931.65239216624, 9959.601615935353, 9975.850362244571, 10068.798624027551, 10097.848532272023, 3872.2255548890334, 3958.327084395602, 4015.4980627421573, 4024.3561030235023, 4031.596840315945, 8295.211954864279, 8296.460730052528, 8301.6679332826, 8305.335573154132, 8356.373272004625, 4431.490378606437, 4442.777861106932, 4449.065696203834, 4450.5104438511735, 4456.041950980555, 3600.4059330210744, 3664.3221004114325, 3959.8416063357718, 4093.9795301023305, 4124.0, 3404.165979335029, 3429.176997520577, 3451.171718787473, 3461.048211741741, 3507.263474670348, 1033.0, 1042.9165666746642, 1043.9112675422523, 1044.9634262800917, 1056.250062455665, 1337.7926421404698, 1342.9865701342862, 1346.9663258418618, 1349.3792855286679, 1369.2400717601827, 6702.396784289437, 6816.4546836252985, 6824.658767061726, 6859.382655560924, 7202.7118915243855, 1099.9285046471953, 1109.7946879827257, 1120.7646394257133, 1126.3692332293942, 1135.9943200283947, 5438.401775804658, 5513.972430137904, 5542.8337149884765, 5545.667259964415, 5569.470900264469, 8818.955905220433, 8861.202491775772, 8919.152680495343, 8961.193492585568, 9135.680251191176, 9083.04628014049, 9095.727128186165, 9177.954110229539, 9191.586378612978, 9205.677801276923, 6929.618870962146, 7029.543079699701, 7109.862422012453, 7150.821229469305, 7153.141623005168, 6881.4494840413645, 6892.379685828299, 6923.792286231421, 6927.0, 6951.895721564079, 7796.10344810354, 7990.9600451999695, 8143.307818835466, 8144.75565733029, 8206.179382061746, 8127.878081828895, 8291.751247462586, 8303.294219991127, 8351.874721879298, 8428.662853486037, 5775.9133612996675, 6076.483498902643, 6193.628382296896, 6490.188726409199, 6617.43751781104, 7031.718731250898, 7113.644317784194, 7130.607816570138, 7133.251008644225, 7138.64306784669, 6446.129772480655, 6719.059331693469, 6754.5947243165565, 6833.897491537531, 6852.554583952027, 6681.231658359351, 6708.966455167693, 6794.184697836291, 6803.693833777591, 6812.386885180357, 6571.047198156336, 6609.669516524251, 6640.867182656417, 6649.63427011519, 6655.334466553306, 6018.398160183947, 6058.182145410313, 6061.030235162353, 6062.818115456544, 6072.362401947908, 6327.905081423874, 6373.553851230555, 6380.9361906380345, 6383.170187875547, 6388.329225431448], "unit": "score", "name": "mootools.html", "value": 4388.427982997927}, {"lowerIsBetter": false, "replicates": [330.63795144316964, 340.8738766656337, 342.5529683762689, 347.5395101490525, 353.16300368127526, 6279.937200627993, 6295.874082518347, 6323.936760632392, 6335.429811316981, 6426.710798014089, 6171.660558669271, 6292.5595208335435, 6300.842478938017, 6302.905456418157, 6319.115323854664, 4718.315844202597, 4745.145873742725, 4748.477667456595, 4750.524947505239, 4774.450938142123, 4745.240761478164, 4752.453467851206, 4754.049190161964, 4760.262159365304, 4761.6904901181315, 4632.722036677793, 4704.247320428732, 4723.10261050401, 4725.17309470843, 4739.123262196487, 4679.274712419563, 4687.7421741804355, 4703.43558772946, 4709.128811169944, 4721.386219791422, 4074.7147699661036, 4077.3272410052305, 4077.6941729370415, 4081.755094694328, 4085.4893138357706, 5985.281766188042, 5989.760409583611, 6000.099985002241, 6029.849253768647, 6044.576879618428, 5419.376771671269, 5520.1443776214755, 5522.530584900288, 5527.695976721278, 5535.6955367454775, 6690.63201523916, 6702.530822842403, 6711.798646040626, 6715.7985260442265, 6727.159105111861, 4497.662675299365, 4504.864854054351, 4516.254817955033, 4520.0, 4521.457425108975, 6749.7300107995625, 6873.175218973705, 6928.688209030555, 6973.546719463218, 6986.825329366756, 4708.293755936568, 4709.152352576569, 4710.458297295786, 4715.646326525524, 4718.622510199176, 4775.71345719258, 4777.092352453093, 4783.808647654125, 4788.808447662054, 4795.976020119877, 5472.370677372153, 5499.092649712753, 5501.367342755554, 5502.889942201134, 5507.430382341014, 6562.982737675572, 6688.29772873851, 6705.295943925915, 6722.361375669304, 6738.326167383222, 1603.7273663477238, 1643.3590899549185, 1647.6622292430022, 1648.1512021309036, 1661.3769836311383, 1099.4063205868902, 1117.3798541809374, 1119.0432180485568, 1123.3035517978742, 1132.8300754886832, 6252.5935814171935, 6286.371362863769, 6288.339724328971, 6299.401556852092, 6309.463695585835, 6834.931650683529, 6847.760328388483, 6851.48613853963, 6868.244493105854, 6872.69072891711, 6119.602225855305, 6243.0, 6256.43692067707, 6275.843103922347, 6306.085617585516, 3717.5353080864893, 3745.0637340664834, 3749.4375843623675, 3753.530808648919, 3754.699624030071, 7130.251323610946, 7147.642617869085, 7154.785356439315, 7173.497855150194, 7189.496735228484, 6880.071190389233, 6999.790006299819, 7070.575765454089, 7096.503244772816, 7098.716051357991, 7117.857642847218, 7119.07452031243, 7129.572225666477, 7149.463790215651, 7154.856902862018, 6856.554323968926, 6866.0, 6873.656317184021, 6873.862522749617, 6895.379415852597, 6666.0, 6786.355296246848, 6787.287334829969, 6796.320367963164, 6888.517803753689, 7291.781246562611, 7302.379297759538, 7304.671289791866, 7311.451641127043, 7322.52403593786, 4654.534546545318, 4700.153972285021, 4734.053189362073, 4734.905301894012, 4745.240761478147, 6828.726850926106, 6935.7225710971, 7042.366187043191, 7063.540869843444, 7069.540479868792, 6722.495812813961, 6746.055552222595, 6747.156605424322, 6758.0, 6763.0, 6722.9663851680425, 6737.898931515933, 6751.189857216969, 6757.391834734701, 6758.3917447428, 6491.967540162269, 6646.667666616553, 6674.632895190617, 6699.162604674416, 6713.227978782307, 6816.216135144522, 6828.556143850634, 6857.348551887562, 6866.690998904961, 6870.27862074495, 6639.767608133692, 6677.565958212701, 6696.899546506709, 6702.095217145623, 6708.362705542965], "unit": "score", "name": "prototype.html", "value": 5016.932016503745}, {"lowerIsBetter": false, "replicates": [707.7735124760077, 749.3143773447296, 751.902252707148, 838.4508147163606, 854.6196942360652, 13563.254021028839, 13684.726305473885, 13750.243736594472, 13771.65570860729, 13779.242141682229, 12387.752244955118, 12790.552330668428, 12978.41597128129, 12985.740285194313, 13004.34978251086, 826.277007618334, 837.2924878477677, 837.7361131243639, 839.2866063845744, 840.1724301562956, 820.5774026376421, 821.4783612406105, 825.6903661127077, 825.7027470110755, 832.0556168748453, 865.7056600755742, 868.3791089371099, 869.1525762381659, 871.9738407847743, 874.3660845886745, 863.7106569299292, 864.3215076165243, 865.0268447996004, 866.0473479172922, 869.1135042256894, 634.3719717479662, 635.8283263518824, 639.9264084630281, 642.9903551446732, 644.687326646576, 12324.81512777309, 12351.814722779165, 12387.0, 12445.066620003536, 12487.625371238877, 11789.88210117905, 11820.881791182064, 11846.822297665542, 12549.937250313782, 13250.86749132506, 10142.797144057151, 10502.107320877734, 10537.0, 10609.575616975311, 10990.725231869188, 3635.381985062519, 3670.4310831821113, 3707.4253490708984, 3716.201016781405, 3807.4098514730263, 44495.33257001147, 44568.10863782738, 44716.77641611804, 44882.32676509855, 44934.32598511025, 9757.512124393752, 9868.914419413859, 9941.502924853728, 10022.699319020441, 10172.491375431347, 17300.826991729922, 17478.0, 18592.53518662017, 18634.906825465787, 18641.0, 6814.522983391115, 7155.534890232118, 7157.0, 7186.784396468114, 7238.203797582261, 3847.96152038476, 3906.980465097713, 3911.2764138634443, 3942.1721438498234, 3948.3287841067086, 3126.4841301185506, 3142.1987393214586, 3186.490161574137, 3197.2326641606314, 3198.4562624353916, 571.8598943258845, 578.4562511239421, 585.4467528185909, 586.5044037788062, 588.0502987674874, 558.4136656510648, 592.3188333416606, 616.9788999206321, 624.5908929651085, 673.71367168953, 7395.889061664079, 7935.365170786324, 7961.920380796118, 8038.959805200937, 8141.307988821017, 597.6533610505896, 630.7445484578753, 632.1592282264577, 638.9041643753382, 646.6637348578713, 3673.2837096766407, 3807.143392736612, 3834.9233015339537, 3858.0547765796996, 3888.7277890547957, 57937.13094303589, 57952.420475795545, 58253.0, 58434.70782646145, 59846.10230846541, 48616.27075593869, 50237.74881125571, 50240.0, 50475.747621262395, 50598.74700626473, 40397.394039089435, 41477.58522414797, 46710.299345509164, 47744.7612761934, 48137.75931120322, 7934.56359900211, 7954.0, 8107.878381824159, 8179.591020448835, 8692.304615630861, 30426.0, 30762.69237307688, 31064.378712425172, 31874.0, 33920.321593567496, 42668.14663706771, 43815.0, 44804.32793508035, 45446.54553454423, 45549.77225113853, 10663.093637040938, 10694.679159625224, 10738.516766745359, 10764.623238186627, 10820.621278255223, 11717.472713728073, 11730.178887477794, 11933.462994165457, 12003.819942700691, 12244.142909996572, 10587.523561439599, 10659.25385223027, 10753.946230268799, 10855.348679079281, 10914.072303854262, 9533.427994320364, 9868.210543156674, 10473.476326183812, 10532.842007369742, 11039.172062095535, 10132.240081994027, 10176.592936282763, 10254.384736915808, 10326.948365258126, 10504.319308910843, 8967.775805604651, 9137.0, 9239.491827949527, 9244.306676999118, 9687.2734544908, 8646.308295336485, 8816.471011739317, 8926.285897128344, 9183.403078799856, 9357.251419886528], "unit": "score", "name": "yui.html", "value": 6142.825080752152}], "name": "dromaeo_css", "value": 6965.637587653045}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 112.0, 112.0, 111.0, 122.0, 111.0, 110.0, 114.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [162.0, 136.0, 161.0, 160.0, 125.0, 158.0, 156.0, 133.0, 167.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 163.0, 163.0, 164.0, 163.0, 163.0, 166.0, 169.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 74.0, 72.0, 74.0, 74.0, 76.0, 133.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 142.0, 95.0, 97.0, 97.0, 142.0, 96.0, 97.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [97.0, 101.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 62.0, 61.0, 59.0, 63.0, 59.0, 59.0, 59.0, 57.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 89.0, 87.0, 86.0, 94.0, 89.0, 94.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.7}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 121.0, 127.0, 123.0, 120.0, 127.0, 120.0, 126.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.1}, {"lowerIsBetter": true, "replicates": [141.0, 152.0, 152.0, 160.0, 154.0, 142.0, 154.0, 146.0, 147.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 69.0, 72.0, 77.0, 70.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1526.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.72165648336727], "unit": "score", "name": "Richards", "value": 207.99938400000008}, {"lowerIsBetter": false, "replicates": [190.11406844106463], "unit": "score", "name": "DeltaBlue", "value": 347.7806799999999}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1064.9627263045793], "unit": "score", "name": "RayTrace", "value": 694.8496709999997}, {"lowerIsBetter": false, "replicates": [738.7453874538745], "unit": "score", "name": "Earley", "value": 902.1552097902103}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [25300.0], "unit": "score", "name": "RegExp", "value": 36.007312252964404}, {"lowerIsBetter": false, "replicates": [596.793349168646], "unit": "score", "name": "Splay", "value": 136.548103482587}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21240.49731606455}]} 11:17:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21240.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1526.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6965.64"}}} 11:17:46 INFO - Return code: 0 11:17:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:17:46 INFO - # TBPL SUCCESS # 11:17:46 INFO - Running post-action listener: _resource_record_post_action 11:17:46 INFO - Running post-run listener: _resource_record_post_run 11:17:47 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 554905600; Read time: 0; Write time: 451204 11:17:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235610112; Read time: 0; Write time: 250916 11:17:47 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 319295488; Read time: 0; Write time: 200288 11:17:47 INFO - Running post-run listener: _upload_blobber_files 11:17:47 INFO - Blob upload gear active. 11:17:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:17:47 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:17:47 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:17:47 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:17:47 INFO - (blobuploader) - INFO - Open directory for files ... 11:17:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:17:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:17:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:48 INFO - (blobuploader) - INFO - Done attempting. 11:17:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:17:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:17:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:49 INFO - (blobuploader) - INFO - Done attempting. 11:17:49 INFO - (blobuploader) - INFO - Iteration through files over. 11:17:49 INFO - Return code: 0 11:17:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:17:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:17:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d405cf9886ed170a2fd7b55ccb7098bdc48b8118162ba461594b6c762d2930ebc918c6320a0d09665017bba35d0e1e62a22fe9a6be48954cba122133b917ecc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dfa7cf25a748790a9748cc5eef4467d5dbd3802081b34e67c2d9eb64f1d547357bbe66f09e8f04cb4a18ba4af91351410aea2090f49f0722a74a68ea840a96e"} 11:17:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:17:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:17:49 INFO - Contents: 11:17:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d405cf9886ed170a2fd7b55ccb7098bdc48b8118162ba461594b6c762d2930ebc918c6320a0d09665017bba35d0e1e62a22fe9a6be48954cba122133b917ecc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dfa7cf25a748790a9748cc5eef4467d5dbd3802081b34e67c2d9eb64f1d547357bbe66f09e8f04cb4a18ba4af91351410aea2090f49f0722a74a68ea840a96e"} 11:17:49 INFO - Copying logs to upload dir... 11:17:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1282.764217 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-31 11:17:48.908347) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 11:17:48.911436) ========= 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=447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133 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/d405cf9886ed170a2fd7b55ccb7098bdc48b8118162ba461594b6c762d2930ebc918c6320a0d09665017bba35d0e1e62a22fe9a6be48954cba122133b917ecc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dfa7cf25a748790a9748cc5eef4467d5dbd3802081b34e67c2d9eb64f1d547357bbe66f09e8f04cb4a18ba4af91351410aea2090f49f0722a74a68ea840a96e"} build_url:https://queue.taskcluster.net/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/C5ah4D-kTbyYe2ZC3SfHZQ/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/d405cf9886ed170a2fd7b55ccb7098bdc48b8118162ba461594b6c762d2930ebc918c6320a0d09665017bba35d0e1e62a22fe9a6be48954cba122133b917ecc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dfa7cf25a748790a9748cc5eef4467d5dbd3802081b34e67c2d9eb64f1d547357bbe66f09e8f04cb4a18ba4af91351410aea2090f49f0722a74a68ea840a96e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 11:17:48.936962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 11:17:48.937375) ========= 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=447a3abc0420b6a47dd38cba000001bf-1451584559.269433-220178133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 11:17:49.022861) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 11:17:49.023203) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 11:17:49.023517) ========= ========= Total master_lag: 0.27 =========