builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1452729833.06 results: success (0) buildid: 20160113133021 builduid: 52d7106af359473791d44483469beb5d revision: ad1f85f172b7302bef0fa9780df8e2b962780ac6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.063736) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.064181) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.064553) ========= 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=8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004109 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.080935) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.081258) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.092097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.092524) ========= 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=8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.142402) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.142713) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.143058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.143339) ========= 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=8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 16:03:53-- 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% 35.6M=0s 2016-01-13 16:03:53 (35.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148826 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.305263) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.305596) ========= 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=8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019475 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.355348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.355710) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ad1f85f172b7302bef0fa9780df8e2b962780ac6 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ad1f85f172b7302bef0fa9780df8e2b962780ac6 --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=8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 16:03:54,074 truncating revision to first 12 chars 2016-01-13 16:03:54,074 Setting DEBUG logging. 2016-01-13 16:03:54,074 attempt 1/10 2016-01-13 16:03:54,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ad1f85f172b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 16:03:54,341 unpacking tar archive at: mozilla-central-ad1f85f172b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.580768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.952580) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.952972) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.963642) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.964034) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 16:03:53.964548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-13 16:03:53.964862) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:03:54 INFO - MultiFileLogger online at 20160113 16:03:54 in /builds/slave/test-pgo 16:03:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:03:54 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:03:54 INFO - {'append_to_log': False, 16:03:54 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:03:54 INFO - 'blob_upload_branch': 'Firefox', 16:03:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:03:54 INFO - 'branch': 'Firefox', 16:03:54 INFO - 'buildbot_json_path': 'buildprops.json', 16:03:54 INFO - 'config_files': ('talos/linux_config.py',), 16:03:54 INFO - 'default_actions': ('clobber', 16:03:54 INFO - 'read-buildbot-config', 16:03:54 INFO - 'download-and-extract', 16:03:54 INFO - 'populate-webroot', 16:03:54 INFO - 'create-virtualenv', 16:03:54 INFO - 'install', 16:03:54 INFO - 'run-tests'), 16:03:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:03:54 INFO - 'download_minidump_stackwalk': True, 16:03:54 INFO - 'download_symbols': 'ondemand', 16:03:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:03:54 INFO - 'tooltool.py': '/tools/tooltool.py', 16:03:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:03:54 INFO - '/tools/misc-python/virtualenv.py')}, 16:03:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:03:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:03:54 INFO - 'installer_path': 'installer.exe', 16:03:54 INFO - 'log_level': 'info', 16:03:54 INFO - 'log_name': 'talos', 16:03:54 INFO - 'log_to_console': True, 16:03:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:03:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:03:54 INFO - 'opt_config_files': (), 16:03:54 INFO - 'pip_index': False, 16:03:54 INFO - 'sps_profile': False, 16:03:54 INFO - 'sps_profile_interval': 0, 16:03:54 INFO - 'suite': 'dromaeojs', 16:03:54 INFO - 'system_bits': '32', 16:03:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:03:54 INFO - 'title': 'talos-linux64-ix-038', 16:03:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:03:54 INFO - 'use_talos_json': True, 16:03:54 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:03:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:03:54 INFO - 'work_dir': 'build'} 16:03:54 INFO - ##### 16:03:54 INFO - ##### Running clobber step. 16:03:54 INFO - ##### 16:03:54 INFO - Running pre-action listener: _resource_record_pre_action 16:03:54 INFO - Running main action method: clobber 16:03:54 INFO - rmtree: /builds/slave/test-pgo/build 16:03:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:03:55 INFO - Running post-action listener: _resource_record_post_action 16:03:55 INFO - ##### 16:03:55 INFO - ##### Running read-buildbot-config step. 16:03:55 INFO - ##### 16:03:55 INFO - Running pre-action listener: _resource_record_pre_action 16:03:55 INFO - Running main action method: read_buildbot_config 16:03:55 INFO - Using buildbot properties: 16:03:55 INFO - { 16:03:55 INFO - "project": "", 16:03:55 INFO - "product": "firefox", 16:03:55 INFO - "script_repo_revision": "production", 16:03:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:03:55 INFO - "repository": "", 16:03:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:03:55 INFO - "buildid": "20160113133021", 16:03:55 INFO - "pgo_build": "True", 16:03:55 INFO - "basedir": "/builds/slave/test-pgo", 16:03:55 INFO - "buildnumber": 158, 16:03:55 INFO - "slavename": "talos-linux64-ix-038", 16:03:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:03:55 INFO - "platform": "ubuntu64_hw", 16:03:55 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:03:55 INFO - "branch": "mozilla-central", 16:03:55 INFO - "repo_path": "mozilla-central", 16:03:55 INFO - "revision": "ad1f85f172b7302bef0fa9780df8e2b962780ac6", 16:03:55 INFO - "stage_platform": "linux64-pgo", 16:03:55 INFO - "builduid": "52d7106af359473791d44483469beb5d", 16:03:55 INFO - "slavebuilddir": "test" 16:03:55 INFO - } 16:03:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:03:55 INFO - Running post-action listener: _resource_record_post_action 16:03:55 INFO - ##### 16:03:55 INFO - ##### Running download-and-extract step. 16:03:55 INFO - ##### 16:03:55 INFO - Running pre-action listener: _resource_record_pre_action 16:03:55 INFO - Running main action method: download_and_extract 16:03:55 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:55 INFO - https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:03:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/test_packages.json 16:03:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/test_packages.json 16:03:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:03:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:03:56 INFO - Downloaded 1448 bytes. 16:03:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:03:56 INFO - Using the following test package requirements: 16:03:56 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:03:56 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:03:56 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:03:56 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:56 INFO - u'jsshell-linux-x86_64.zip'], 16:03:56 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:03:56 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:03:56 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:03:56 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:03:56 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:03:56 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:03:56 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:03:56 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:03: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')]} 16:03:56 INFO - https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:03:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:03:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:03:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/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 16:03:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/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 16:04:01 INFO - Downloaded 24028875 bytes. 16:04:01 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 16:04:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:04:01 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 16:04:02 INFO - Return code: 0 16:04:02 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 16:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:02 INFO - https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:04:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:04:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:04:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/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 16:04:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/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 16:04:06 INFO - Downloaded 24028875 bytes. 16:04:06 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 16:04:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:04:06 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 16:04:07 INFO - Return code: 0 16:04:07 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')]} 16:04:07 INFO - https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:04:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:04:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:04:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/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 16:04:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/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 16:04:09 INFO - Downloaded 11132279 bytes. 16:04:09 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 16:04:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:04:09 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 16:04:10 INFO - Return code: 0 16:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:10 INFO - https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:04:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:04:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:04:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/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 16:04:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/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 16:04:13 INFO - Downloaded 55875934 bytes. 16:04:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:04:13 INFO - mkdir: /builds/slave/test-pgo/properties 16:04:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:04:13 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:04:13 INFO - Contents: 16:04:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:04:13 INFO - Running post-action listener: _resource_record_post_action 16:04:13 INFO - Running post-action listener: set_extra_try_arguments 16:04:13 INFO - ##### 16:04:13 INFO - ##### Running populate-webroot step. 16:04:13 INFO - ##### 16:04:13 INFO - Running pre-action listener: _resource_record_pre_action 16:04:13 INFO - Running main action method: populate_webroot 16:04:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:04:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:04:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:04:13 INFO - '--tppagecycles', 16:04:13 INFO - '7'], 16:04:13 INFO - 'tests': ['tsvgm']}}, 16:04:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:04:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:04:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:04:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:04:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:04:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:04:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:04:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:13 INFO - 'talos_options': ['--e10s'], 16:04:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:04:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:13 INFO - 'tests': ['damp', 'tps']}, 16:04:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:13 INFO - 'talos_options': ['--e10s'], 16:04:13 INFO - 'tests': ['damp', 'tps']}, 16:04:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:04:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:04:13 INFO - 'other': {'tests': ['a11yr', 16:04:13 INFO - 'ts_paint', 16:04:13 INFO - 'tpaint', 16:04:13 INFO - 'sessionrestore', 16:04:13 INFO - 'sessionrestore_no_auto_restore']}, 16:04:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:04:13 INFO - 'tests': ['a11yr', 16:04:13 INFO - 'ts_paint', 16:04:13 INFO - 'tpaint', 16:04:13 INFO - 'sessionrestore', 16:04:13 INFO - 'sessionrestore_no_auto_restore']}, 16:04:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:04:13 INFO - 'tests': ['a11yr', 16:04:13 INFO - 'ts_paint', 16:04:13 INFO - 'tpaint', 16:04:13 INFO - 'sessionrestore', 16:04:13 INFO - 'sessionrestore_no_auto_restore']}, 16:04:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:04:13 INFO - 'tests': ['a11yr', 16:04:13 INFO - 'ts_paint', 16:04:13 INFO - 'tpaint', 16:04:13 INFO - 'sessionrestore', 16:04:13 INFO - 'sessionrestore_no_auto_restore']}, 16:04:13 INFO - 'other_l64': {'tests': ['a11yr', 16:04:13 INFO - 'ts_paint', 16:04:13 INFO - 'tpaint', 16:04:13 INFO - 'sessionrestore', 16:04:13 INFO - 'sessionrestore_no_auto_restore']}, 16:04:13 INFO - 'other_nol64': {'tests': ['a11yr', 16:04:13 INFO - 'ts_paint', 16:04:13 INFO - 'tpaint', 16:04:13 INFO - 'sessionrestore', 16:04:13 INFO - 'sessionrestore_no_auto_restore']}, 16:04:13 INFO - 'svgr': {'tests': ['tsvgx', 16:04:13 INFO - 'tsvgr_opacity', 16:04:13 INFO - 'tart', 16:04:13 INFO - 'tscrollx', 16:04:13 INFO - 'cart']}, 16:04:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:04:13 INFO - 'tests': ['tsvgx', 16:04:13 INFO - 'tsvgr_opacity', 16:04:13 INFO - 'tart', 16:04:13 INFO - 'tscrollx', 16:04:13 INFO - 'cart']}, 16:04:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:13 INFO - 'tests': ['tp5o']}, 16:04:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:13 INFO - 'talos_options': ['--e10s'], 16:04:13 INFO - 'tests': ['tp5o']}, 16:04:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:13 INFO - 'talos_options': ['--xperf_path', 16:04:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:13 INFO - 'tests': ['tp5n']}, 16:04:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:13 INFO - 'talos_options': ['--e10s', 16:04:13 INFO - '--xperf_path', 16:04:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:13 INFO - 'tests': ['tp5n']}}, 16:04:13 INFO - 'talos.zip': {'path': '', 16:04:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:04:13 INFO - Running post-action listener: _resource_record_post_action 16:04:13 INFO - ##### 16:04:13 INFO - ##### Running create-virtualenv step. 16:04:13 INFO - ##### 16:04:13 INFO - Running pre-action listener: _resource_record_pre_action 16:04:13 INFO - Running main action method: create_virtualenv 16:04:13 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:04:13 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 16:04:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:04:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:04:13 INFO - Using real prefix '/usr' 16:04:13 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:04:13 INFO - Installing distribute.............................................................................................................................................................................................done. 16:04:15 INFO - Installing pip.................done. 16:04:15 INFO - Return code: 0 16:04:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:04:15 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')]} 16:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:15 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')]} 16:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:15 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 0x7f735131df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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 0x124f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124fb60>, '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': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', '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 16:04:15 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 16:04:15 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 16:04:15 INFO - Using env: {'DISPLAY': ':0', 16:04:15 INFO - 'HOME': '/home/cltbld', 16:04:15 INFO - 'LANG': 'en_US.UTF-8', 16:04:15 INFO - 'LANGUAGE': 'en_US:en', 16:04:15 INFO - 'LOGNAME': 'cltbld', 16:04:15 INFO - 'MAIL': '/var/mail/cltbld', 16:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:15 INFO - 'MOZ_NO_REMOTE': '1', 16:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:15 INFO - 'NO_EM_RESTART': '1', 16:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:04:15 INFO - 'PWD': '/builds/slave/test-pgo', 16:04:15 INFO - 'SHELL': '/bin/bash', 16:04:15 INFO - 'SHLVL': '1', 16:04:15 INFO - 'TERM': 'linux', 16:04:15 INFO - 'TMOUT': '86400', 16:04:15 INFO - 'USER': 'cltbld', 16:04:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', 16:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:15 INFO - '_': '/tools/buildbot/bin/python'} 16:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:16 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 16:04:16 INFO - Cleaning up... 16:04:16 INFO - Return code: 0 16:04:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:04:16 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')]} 16:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:16 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')]} 16:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:16 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 0x7f735131df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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 0x124f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124fb60>, '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': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', '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 16:04:16 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 16:04:16 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 16:04:16 INFO - Using env: {'DISPLAY': ':0', 16:04:16 INFO - 'HOME': '/home/cltbld', 16:04:16 INFO - 'LANG': 'en_US.UTF-8', 16:04:16 INFO - 'LANGUAGE': 'en_US:en', 16:04:16 INFO - 'LOGNAME': 'cltbld', 16:04:16 INFO - 'MAIL': '/var/mail/cltbld', 16:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:16 INFO - 'MOZ_NO_REMOTE': '1', 16:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:16 INFO - 'NO_EM_RESTART': '1', 16:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:04:16 INFO - 'PWD': '/builds/slave/test-pgo', 16:04:16 INFO - 'SHELL': '/bin/bash', 16:04:16 INFO - 'SHLVL': '1', 16:04:16 INFO - 'TERM': 'linux', 16:04:16 INFO - 'TMOUT': '86400', 16:04:16 INFO - 'USER': 'cltbld', 16:04:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', 16:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:16 INFO - '_': '/tools/buildbot/bin/python'} 16:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:16 INFO - Downloading/unpacking psutil>=0.7.1 16:04: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 16:04: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 16:04: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 16:04: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 16:04: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 16:04: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 16:04:17 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:04:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:04:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:04:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:18 INFO - Installing collected packages: psutil 16:04:18 INFO - Running setup.py install for psutil 16:04:18 INFO - building 'psutil._psutil_linux' extension 16:04:18 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 16:04:18 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 16:04:18 INFO - building 'psutil._psutil_posix' extension 16:04:18 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 16:04:18 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 16:04:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:18 INFO - Successfully installed psutil 16:04:18 INFO - Cleaning up... 16:04:18 INFO - Return code: 0 16:04:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:04:18 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')]} 16:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:18 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')]} 16:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:18 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 0x7f735131df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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 0x124f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124fb60>, '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': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', '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 16:04:18 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 16:04:18 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 16:04:18 INFO - Using env: {'DISPLAY': ':0', 16:04:18 INFO - 'HOME': '/home/cltbld', 16:04:18 INFO - 'LANG': 'en_US.UTF-8', 16:04:18 INFO - 'LANGUAGE': 'en_US:en', 16:04:18 INFO - 'LOGNAME': 'cltbld', 16:04:18 INFO - 'MAIL': '/var/mail/cltbld', 16:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:18 INFO - 'MOZ_NO_REMOTE': '1', 16:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:18 INFO - 'NO_EM_RESTART': '1', 16:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:04:18 INFO - 'PWD': '/builds/slave/test-pgo', 16:04:18 INFO - 'SHELL': '/bin/bash', 16:04:18 INFO - 'SHLVL': '1', 16:04:18 INFO - 'TERM': 'linux', 16:04:18 INFO - 'TMOUT': '86400', 16:04:18 INFO - 'USER': 'cltbld', 16:04:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', 16:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:18 INFO - '_': '/tools/buildbot/bin/python'} 16:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:04:18 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 16:04:18 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 16:04:18 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 16:04:18 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 16:04:18 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 16:04:18 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 16:04:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:04:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:04:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:04:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:04:20 INFO - Installing collected packages: mozsystemmonitor 16:04:20 INFO - Running setup.py install for mozsystemmonitor 16:04:20 INFO - Successfully installed mozsystemmonitor 16:04:20 INFO - Cleaning up... 16:04:20 INFO - Return code: 0 16:04:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:04:20 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')]} 16:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:20 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')]} 16:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:20 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 0x7f735131df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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 0x124f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124fb60>, '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': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', '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 16:04:20 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 16:04:20 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 16:04:20 INFO - Using env: {'DISPLAY': ':0', 16:04:20 INFO - 'HOME': '/home/cltbld', 16:04:20 INFO - 'LANG': 'en_US.UTF-8', 16:04:20 INFO - 'LANGUAGE': 'en_US:en', 16:04:20 INFO - 'LOGNAME': 'cltbld', 16:04:20 INFO - 'MAIL': '/var/mail/cltbld', 16:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:20 INFO - 'MOZ_NO_REMOTE': '1', 16:04:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:20 INFO - 'NO_EM_RESTART': '1', 16:04:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:04:20 INFO - 'PWD': '/builds/slave/test-pgo', 16:04:20 INFO - 'SHELL': '/bin/bash', 16:04:20 INFO - 'SHLVL': '1', 16:04:20 INFO - 'TERM': 'linux', 16:04:20 INFO - 'TMOUT': '86400', 16:04:20 INFO - 'USER': 'cltbld', 16:04:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', 16:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:20 INFO - '_': '/tools/buildbot/bin/python'} 16:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:20 INFO - Downloading/unpacking blobuploader==1.2.4 16:04:20 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 16:04:20 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 16:04:20 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 16:04:20 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 16:04:20 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 16:04:20 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 16:04:22 INFO - Downloading blobuploader-1.2.4.tar.gz 16:04:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:04:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:04:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:04:22 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 16:04:22 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 16:04:22 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 16:04:22 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 16:04:22 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 16:04:22 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 16:04:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:04:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:04:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:04:23 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 16:04:23 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 16:04:23 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 16:04:23 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 16:04:23 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 16:04:23 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 16:04:23 INFO - Downloading docopt-0.6.1.tar.gz 16:04:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:04:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:04:23 INFO - Installing collected packages: blobuploader, requests, docopt 16:04:23 INFO - Running setup.py install for blobuploader 16:04:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:04:23 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:04:23 INFO - Running setup.py install for requests 16:04:23 INFO - Running setup.py install for docopt 16:04:23 INFO - Successfully installed blobuploader requests docopt 16:04:23 INFO - Cleaning up... 16:04:23 INFO - Return code: 0 16:04:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:04:23 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')]} 16:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:23 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')]} 16:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:23 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 0x7f735131df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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 0x124f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124fb60>, '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': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', '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 16:04:23 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 16:04:23 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 16:04:23 INFO - Using env: {'DISPLAY': ':0', 16:04:23 INFO - 'HOME': '/home/cltbld', 16:04:23 INFO - 'LANG': 'en_US.UTF-8', 16:04:23 INFO - 'LANGUAGE': 'en_US:en', 16:04:23 INFO - 'LOGNAME': 'cltbld', 16:04:23 INFO - 'MAIL': '/var/mail/cltbld', 16:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:23 INFO - 'MOZ_NO_REMOTE': '1', 16:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:23 INFO - 'NO_EM_RESTART': '1', 16:04:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:04:23 INFO - 'PWD': '/builds/slave/test-pgo', 16:04:23 INFO - 'SHELL': '/bin/bash', 16:04:23 INFO - 'SHLVL': '1', 16:04:23 INFO - 'TERM': 'linux', 16:04:23 INFO - 'TMOUT': '86400', 16:04:23 INFO - 'USER': 'cltbld', 16:04:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', 16:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:23 INFO - '_': '/tools/buildbot/bin/python'} 16:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:04:24 INFO - Running setup.py (path:/tmp/pip-CtJM0x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:04:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:04:24 INFO - Running setup.py (path:/tmp/pip-dfRUbi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:04:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:04:24 INFO - Running setup.py (path:/tmp/pip-8kS1na-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:04:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:04:24 INFO - Running setup.py (path:/tmp/pip-J2ExgX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:04:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:04:24 INFO - Running setup.py (path:/tmp/pip-gRXlsE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:04:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:04:24 INFO - Running setup.py (path:/tmp/pip-ry4aHs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:04:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:04:24 INFO - Running setup.py (path:/tmp/pip-8Rizey-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:04:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:04:24 INFO - Running setup.py (path:/tmp/pip-XWhqEr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:04:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:04:24 INFO - Running setup.py (path:/tmp/pip-qhBrrC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:04:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:04:24 INFO - Running setup.py (path:/tmp/pip-TanT76-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:04:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:04:24 INFO - Running setup.py (path:/tmp/pip-YUHqJS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:04:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:04:24 INFO - Running setup.py (path:/tmp/pip-oIn_hv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:04:25 INFO - Running setup.py (path:/tmp/pip-8lGn6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:04:25 INFO - Running setup.py (path:/tmp/pip-RvW4Z0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:04:25 INFO - Running setup.py (path:/tmp/pip-cenKSb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:04:25 INFO - Running setup.py (path:/tmp/pip-xqnrCG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:04:25 INFO - Running setup.py (path:/tmp/pip-PC7O0O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:04:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:04:25 INFO - Running setup.py install for manifestparser 16:04:25 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:04:25 INFO - Running setup.py install for mozcrash 16:04:25 INFO - Running setup.py install for mozdebug 16:04:25 INFO - Running setup.py install for mozdevice 16:04:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:04:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:04:25 INFO - Running setup.py install for mozfile 16:04:25 INFO - Running setup.py install for mozhttpd 16:04:26 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:04:26 INFO - Running setup.py install for mozinfo 16:04:26 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:04:26 INFO - Running setup.py install for mozInstall 16:04:26 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:04:26 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:04:26 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:04:26 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:04:26 INFO - Running setup.py install for mozleak 16:04:26 INFO - Running setup.py install for mozlog 16:04:26 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:04:26 INFO - Running setup.py install for moznetwork 16:04:26 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:04:26 INFO - Running setup.py install for mozprocess 16:04:26 INFO - Running setup.py install for mozprofile 16:04:26 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:04:26 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:04:26 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:04:26 INFO - Running setup.py install for mozrunner 16:04:26 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:04:26 INFO - Running setup.py install for mozscreenshot 16:04:26 INFO - Running setup.py install for moztest 16:04:27 INFO - Running setup.py install for mozversion 16:04:27 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:04:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:04:27 INFO - Cleaning up... 16:04:27 INFO - Return code: 0 16:04:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:04: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')]} 16:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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')]} 16:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:27 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 0x7f735131df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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 0x124f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124fb60>, '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': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', '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 16:04:27 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 16:04:27 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 16:04:27 INFO - Using env: {'DISPLAY': ':0', 16:04:27 INFO - 'HOME': '/home/cltbld', 16:04:27 INFO - 'LANG': 'en_US.UTF-8', 16:04:27 INFO - 'LANGUAGE': 'en_US:en', 16:04:27 INFO - 'LOGNAME': 'cltbld', 16:04:27 INFO - 'MAIL': '/var/mail/cltbld', 16:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:27 INFO - 'MOZ_NO_REMOTE': '1', 16:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:27 INFO - 'NO_EM_RESTART': '1', 16:04:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:04:27 INFO - 'PWD': '/builds/slave/test-pgo', 16:04:27 INFO - 'SHELL': '/bin/bash', 16:04:27 INFO - 'SHLVL': '1', 16:04:27 INFO - 'TERM': 'linux', 16:04:27 INFO - 'TMOUT': '86400', 16:04:27 INFO - 'USER': 'cltbld', 16:04:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', 16:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:27 INFO - '_': '/tools/buildbot/bin/python'} 16:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:04:27 INFO - Running setup.py (path:/tmp/pip-llIMiB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:04:27 INFO - Running setup.py (path:/tmp/pip-ePyrDf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:04:27 INFO - Running setup.py (path:/tmp/pip-P1_yvp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:04:27 INFO - Running setup.py (path:/tmp/pip-wdYJS1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:04:27 INFO - Running setup.py (path:/tmp/pip-tguR5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:04:27 INFO - Running setup.py (path:/tmp/pip-2lEdRQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:04:27 INFO - Running setup.py (path:/tmp/pip-GfvZrz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:04:27 INFO - Running setup.py (path:/tmp/pip-SATpKO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:04:27 INFO - Running setup.py (path:/tmp/pip-oVaVtk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:04:28 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)) 16:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:04:28 INFO - Running setup.py (path:/tmp/pip-Fwzj4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:04:28 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)) 16:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:04:28 INFO - Running setup.py (path:/tmp/pip-d0eHYn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:04:28 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)) 16:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:04:28 INFO - Running setup.py (path:/tmp/pip-vns1Sm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:04:28 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)) 16:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:04:28 INFO - Running setup.py (path:/tmp/pip-FyjRDj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:04:28 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)) 16:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:04:28 INFO - Running setup.py (path:/tmp/pip-5Cwybm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:04:28 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)) 16:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:04:28 INFO - Running setup.py (path:/tmp/pip-ro9XTJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:04:28 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)) 16:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:04:28 INFO - Running setup.py (path:/tmp/pip-Ql7iLr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:04:28 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)) 16:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:04:28 INFO - Running setup.py (path:/tmp/pip-YV08nE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:04:28 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)) 16:04:28 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)) 16:04:28 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)) 16:04:28 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)) 16:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:04:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:04:28 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 16:04:28 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 16:04:28 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 16:04:28 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 16:04:28 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 16:04:28 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 16:04:30 INFO - Downloading blessings-1.5.1.tar.gz 16:04:30 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 16:04:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:04:30 INFO - Installing collected packages: blessings 16:04:30 INFO - Running setup.py install for blessings 16:04:30 INFO - Successfully installed blessings 16:04:30 INFO - Cleaning up... 16:04:30 INFO - Return code: 0 16:04:30 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:04:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:04:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:04:30 INFO - Reading from file tmpfile_stdout 16:04:30 INFO - Current package versions: 16:04:30 INFO - argparse == 1.2.1 16:04:30 INFO - blessings == 1.5.1 16:04:30 INFO - blobuploader == 1.2.4 16:04:30 INFO - docopt == 0.6.1 16:04:30 INFO - manifestparser == 1.1 16:04:30 INFO - mozInstall == 1.12 16:04:30 INFO - mozcrash == 0.16 16:04:30 INFO - mozdebug == 0.1 16:04:30 INFO - mozdevice == 0.48 16:04:30 INFO - mozfile == 1.2 16:04:30 INFO - mozhttpd == 0.7 16:04:30 INFO - mozinfo == 0.9 16:04:30 INFO - mozleak == 0.1 16:04:30 INFO - mozlog == 3.1 16:04:30 INFO - moznetwork == 0.27 16:04:30 INFO - mozprocess == 0.22 16:04:30 INFO - mozprofile == 0.28 16:04:30 INFO - mozrunner == 6.11 16:04:30 INFO - mozscreenshot == 0.1 16:04:30 INFO - mozsystemmonitor == 0.0 16:04:30 INFO - moztest == 0.7 16:04:30 INFO - mozversion == 1.4 16:04:30 INFO - psutil == 3.1.1 16:04:30 INFO - requests == 1.2.3 16:04:30 INFO - wsgiref == 0.1.2 16:04:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:04:30 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')]} 16:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:30 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')]} 16:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:30 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 0x7f735131df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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 0x124f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124fb60>, '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': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', '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 16:04:30 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 16:04:30 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 16:04:30 INFO - Using env: {'DISPLAY': ':0', 16:04:30 INFO - 'HOME': '/home/cltbld', 16:04:30 INFO - 'LANG': 'en_US.UTF-8', 16:04:30 INFO - 'LANGUAGE': 'en_US:en', 16:04:30 INFO - 'LOGNAME': 'cltbld', 16:04:30 INFO - 'MAIL': '/var/mail/cltbld', 16:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:30 INFO - 'MOZ_NO_REMOTE': '1', 16:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:30 INFO - 'NO_EM_RESTART': '1', 16:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:04:30 INFO - 'PWD': '/builds/slave/test-pgo', 16:04:30 INFO - 'SHELL': '/bin/bash', 16:04:30 INFO - 'SHLVL': '1', 16:04:30 INFO - 'TERM': 'linux', 16:04:30 INFO - 'TMOUT': '86400', 16:04:30 INFO - 'USER': 'cltbld', 16:04:30 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', 16:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:30 INFO - '_': '/tools/buildbot/bin/python'} 16:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:31 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)) 16:04:31 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)) 16:04:31 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)) 16:04:31 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)) 16:04:31 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)) 16:04:31 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)) 16:04:31 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)) 16:04:31 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)) 16:04:31 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)) 16:04:31 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)) 16:04:31 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)) 16:04:31 INFO - Cleaning up... 16:04:31 INFO - Return code: 0 16:04:31 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:31 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 0x7f735131df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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 0x124f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124fb60>, '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': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', '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 16:04:31 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 16:04:31 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 16:04:31 INFO - Using env: {'DISPLAY': ':0', 16:04:31 INFO - 'HOME': '/home/cltbld', 16:04:31 INFO - 'LANG': 'en_US.UTF-8', 16:04:31 INFO - 'LANGUAGE': 'en_US:en', 16:04:31 INFO - 'LOGNAME': 'cltbld', 16:04:31 INFO - 'MAIL': '/var/mail/cltbld', 16:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:31 INFO - 'MOZ_NO_REMOTE': '1', 16:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:31 INFO - 'NO_EM_RESTART': '1', 16:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:04:31 INFO - 'PWD': '/builds/slave/test-pgo', 16:04:31 INFO - 'SHELL': '/bin/bash', 16:04:31 INFO - 'SHLVL': '1', 16:04:31 INFO - 'TERM': 'linux', 16:04:31 INFO - 'TMOUT': '86400', 16:04:31 INFO - 'USER': 'cltbld', 16:04:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', 16:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:31 INFO - '_': '/tools/buildbot/bin/python'} 16:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:31 INFO - Downloading/unpacking jsonschema 16:04:31 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 16:04:31 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 16:04:31 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 16:04:31 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 16:04:31 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 16:04:31 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 16:04:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:04:32 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 16:04:32 INFO - Downloading/unpacking functools32 (from jsonschema) 16:04:32 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 16:04:32 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 16:04:32 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 16:04:32 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 16:04:32 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 16:04:32 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 16:04:33 INFO - Downloading functools32-3.2.3-2.tar.gz 16:04:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:04:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:04:33 INFO - warning: no files found matching '*.txt' 16:04:33 INFO - no previously-included directories found matching 'build' 16:04:33 INFO - no previously-included directories found matching 'dist' 16:04:33 INFO - no previously-included directories found matching '.git*' 16:04:33 INFO - Installing collected packages: jsonschema, functools32 16:04:33 INFO - Running setup.py install for functools32 16:04:33 INFO - warning: no files found matching '*.txt' 16:04:33 INFO - no previously-included directories found matching 'build' 16:04:33 INFO - no previously-included directories found matching 'dist' 16:04:33 INFO - no previously-included directories found matching '.git*' 16:04:33 INFO - Successfully installed jsonschema functools32 16:04:33 INFO - Cleaning up... 16:04:33 INFO - Return code: 0 16:04:33 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:04: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')]} 16:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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')]} 16:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:33 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 0x7f735131df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e2840>, '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 0x124f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124fb60>, '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': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', '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 16:04:33 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 16:04:33 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 16:04:33 INFO - Using env: {'DISPLAY': ':0', 16:04:33 INFO - 'HOME': '/home/cltbld', 16:04:33 INFO - 'LANG': 'en_US.UTF-8', 16:04:33 INFO - 'LANGUAGE': 'en_US:en', 16:04:33 INFO - 'LOGNAME': 'cltbld', 16:04:33 INFO - 'MAIL': '/var/mail/cltbld', 16:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:33 INFO - 'MOZ_NO_REMOTE': '1', 16:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:33 INFO - 'NO_EM_RESTART': '1', 16:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:04:33 INFO - 'PWD': '/builds/slave/test-pgo', 16:04:33 INFO - 'SHELL': '/bin/bash', 16:04:33 INFO - 'SHLVL': '1', 16:04:33 INFO - 'TERM': 'linux', 16:04:33 INFO - 'TMOUT': '86400', 16:04:33 INFO - 'USER': 'cltbld', 16:04:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', 16:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:33 INFO - '_': '/tools/buildbot/bin/python'} 16:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:33 INFO - Downloading/unpacking flake8 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 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 16:04:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:04:35 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 16:04:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:04:35 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 16:04:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 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 16:04:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:04:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:04:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:04:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:04:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:04:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:04:36 INFO - no previously-included directories found matching 'docs/_build' 16:04:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:04:36 INFO - Running setup.py install for pep8 16:04:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:04:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:04:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:04:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:04:36 INFO - no previously-included directories found matching 'docs/_build' 16:04:36 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:04:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:04:36 INFO - Cleaning up... 16:04:36 INFO - Return code: 0 16:04:36 INFO - Running post-action listener: _resource_record_post_action 16:04:36 INFO - Running post-action listener: _start_resource_monitoring 16:04:36 INFO - Starting resource monitoring. 16:04:36 INFO - ##### 16:04:36 INFO - ##### Running install step. 16:04:36 INFO - ##### 16:04:36 INFO - Running pre-action listener: _resource_record_pre_action 16:04:36 INFO - Running main action method: install 16:04:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:04:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:04:36 INFO - Reading from file tmpfile_stdout 16:04:36 INFO - Detecting whether we're running mozinstall >=1.0... 16:04:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:04:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:04:36 INFO - Reading from file tmpfile_stdout 16:04:36 INFO - Output received: 16:04:36 INFO - Usage: mozinstall [options] installer 16:04:36 INFO - Options: 16:04:36 INFO - -h, --help show this help message and exit 16:04:36 INFO - -d DEST, --destination=DEST 16:04:36 INFO - Directory to install application into. [default: 16:04:36 INFO - "/builds/slave/test-pgo"] 16:04:36 INFO - --app=APP Application being installed. [default: firefox] 16:04:36 INFO - mkdir: /builds/slave/test-pgo/build/application 16:04:36 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'] 16:04:36 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 16:04:52 INFO - Reading from file tmpfile_stdout 16:04:52 INFO - Output received: 16:04:52 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:04:52 INFO - Running post-action listener: _resource_record_post_action 16:04:52 INFO - ##### 16:04:52 INFO - ##### Running run-tests step. 16:04:52 INFO - ##### 16:04:52 INFO - Running pre-action listener: _resource_record_pre_action 16:04:52 INFO - Running main action method: run_tests 16:04:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:04:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:04:52 INFO - Python 2.7.3 16:04:52 INFO - Return code: 0 16:04:52 INFO - grabbing minidump binary from tooltool 16:04: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')]} 16:04:52 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 0x12e2840>, '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 0x124f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:04:52 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 16:04:52 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 16:04:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:04:52 INFO - Return code: 0 16:04:52 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:04:52 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:04:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:04:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:04:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:04:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:04:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:04:53 INFO - Return code: 0 16:04:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 16:04:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 16:04:53 INFO - Using env: {'DISPLAY': ':0', 16:04:53 INFO - 'HOME': '/home/cltbld', 16:04:53 INFO - 'LANG': 'en_US.UTF-8', 16:04:53 INFO - 'LANGUAGE': 'en_US:en', 16:04:53 INFO - 'LOGNAME': 'cltbld', 16:04:53 INFO - 'MAIL': '/var/mail/cltbld', 16:04:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:04:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:53 INFO - 'MOZ_NO_REMOTE': '1', 16:04:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:53 INFO - 'NO_EM_RESTART': '1', 16:04:53 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:04:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:04:53 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:04:53 INFO - 'SHELL': '/bin/bash', 16:04:53 INFO - 'SHLVL': '1', 16:04:53 INFO - 'TERM': 'linux', 16:04:53 INFO - 'TMOUT': '86400', 16:04:53 INFO - 'USER': 'cltbld', 16:04:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513', 16:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:53 INFO - '_': '/tools/buildbot/bin/python'} 16:04:53 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:04:53 INFO - mozversion application_buildid: 20160113133021 16:04:53 INFO - mozversion application_changeset: ad1f85f172b7302bef0fa9780df8e2b962780ac6 16:04:53 INFO - mozversion application_display_name: Nightly 16:04:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:04:53 INFO - mozversion application_name: Firefox 16:04:53 INFO - mozversion application_remotingname: firefox 16:04:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:04:53 INFO - mozversion application_vendor: Mozilla 16:04:53 INFO - mozversion application_version: 46.0a1 16:04:53 INFO - mozversion platform_buildid: 20160113133021 16:04:53 INFO - mozversion platform_changeset: ad1f85f172b7302bef0fa9780df8e2b962780ac6 16:04:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:04:53 INFO - mozversion platform_version: 46.0a1 16:04:53 INFO - using testdate: 1452729893 16:04:53 INFO - actual date: 1452729893 16:04:53 INFO - starting webserver on 'localhost:55384' 16:04:53 INFO - SUITE-START | Running 3 tests 16:04:53 INFO - TEST-START | dromaeo_css 16:04:53 INFO - operating with platform_type : linux_ 16:04:53 INFO - Initialising browser for dromaeo_css test... 16:04:53 INFO - TEST-INFO | started process 14501 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxMTFxg/profile http://localhost:55384/getInfo.html) 16:04:57 INFO - PROCESS | 14501 | __metrics Screen width/height:1600/1200 16:04:57 INFO - PROCESS | 14501 | colorDepth:24 16:04:57 INFO - PROCESS | 14501 | Browser inner width/height: 1024/697 16:04:57 INFO - PROCESS | 14501 | __metrics 16:04:58 INFO - PROCESS | 14501 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:04:58 INFO - PROCESS | 14501 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:04:59 INFO - TEST-INFO | 14501: exit 0 16:04:59 INFO - Browser initialized. 16:04:59 INFO - Running cycle 1/1 for dromaeo_css test... 16:04:59 INFO - TEST-INFO | started process 14593 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxMTFxg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:05:10 INFO - PROCESS | 14593 | RSS: Main: 150458368 16:05:11 INFO - PROCESS | 14593 | 16:06:02 INFO - PROCESS | 14593 | 1452729962401 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] 16:08:10 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:55384/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55384/tests/dromaeo/cssquery-ext.html) 16:08:11 INFO - PROCESS | 14593 | RSS: Main: 229556224 16:08:11 INFO - PROCESS | 14593 | 16:11:13 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:55384/tests/dromaeo/cssquery-ext.html (next: http://localhost:55384/tests/dromaeo/cssquery-jquery.html) 16:11:14 INFO - PROCESS | 14593 | RSS: Main: 223109120 16:11:14 INFO - PROCESS | 14593 | 16:14:16 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:55384/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55384/tests/dromaeo/cssquery-mootools.html) 16:14:16 INFO - PROCESS | 14593 | RSS: Main: 229556224 16:14:16 INFO - PROCESS | 14593 | 16:17:18 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:55384/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55384/tests/dromaeo/cssquery-prototype.html) 16:17:19 INFO - PROCESS | 14593 | RSS: Main: 209752064 16:17:19 INFO - PROCESS | 14593 | 16:20:21 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:55384/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55384/tests/dromaeo/cssquery-yui.html) 16:20:22 INFO - PROCESS | 14593 | RSS: Main: 213233664 16:20:22 INFO - PROCESS | 14593 | 16:23:25 INFO - PROCESS | 14593 | Cycle 1(1): loaded http://localhost:55384/tests/dromaeo/cssquery-yui.html (next: http://localhost:55384/tests/dromaeo/cssquery-dojo.html) 16:23:25 INFO - PROCESS | 14593 | RSS: Main: 299552768 16:23:25 INFO - PROCESS | 14593 | 16:23:25 INFO - PROCESS | 14593 | __start_tp_report 16:23:25 INFO - PROCESS | 14593 | _x_x_mozilla_page_load 16:23:25 INFO - PROCESS | 14593 | _x_x_mozilla_page_load_details 16:23:25 INFO - PROCESS | 14593 | |i|pagename|runs| 16:23:25 INFO - PROCESS | 14593 | |0;dojo.html;3090.8300043497607;3099.8140111593293;3138.9641418331967;3139.9686003139964;3163.1775738308047;4916.87707807305;5018.7992480300745;5025.673331233472;5035.471275516073;5080.314157588725;5016;5060.089183946888;5089.567386772129;5095.694258344502;5095.745212739367;4437.179121862449;4571.291449825282;4612.607928326088;4694.061187762444;4726.574608285254;4561.29299958507;4685.672002959795;4698.154332220199;4704.364910737041;4769.165396055676;4598.563136502027;4611.861644150681;4616.584507394334;4631;4653.86038418848;4599.655025873039;4608.400907881954;4623.30650402439;4630.351750754897;4667.183242932473;4555.521670224612;4595.724256544585;4598.310253461974;4609.953900460986;4639.512851150648;4792.7843247053615;4867.537583929521;4889.926651100236;4906.141425250603;4915.803367865281;5382.4886635769535;5399.055165346088;5399.352077750695;5400.081986062379;5449.128139497701;5396.028714831329;5416.4312747161375;5421.539169170625;5455.263539422207;5513.476219759116;5023.924641130386;5135.486451354872;5181.145111056633;5197.974010129925;5219.8434046978655;5549.112142057252;5550.777968881281;5553.333599967949;5556.138798486241;5558.194061861008;5156.458571849977;5238.109521381374;5344.8663783404945;5358.571314294847;5360.544353729977;5298.046351656739;5332.200169974535;5334.59990500714;5335.253064570963;5381.515663590218;5311.070562651521;5325.920111198335;5331.120365139786;5348.331458567679;5381.704006279692;5250.527452529291;5354.9464505354445;5357.732113394315;5395.109806881821;5405.567554595623;4287.121140166259;4297.097609501977;4298.140371925628;4311.48262208537;4340.696151269444;3820.102275965146;3843;3846.2307538491855;3872.0707030312524;3875.670568001695;5014;5075.8984820303385;5085.364329458817;5092.28707980883;5145.511176438233;5369.543588794918;5387.3804512481565;5393.946060539422;5405.864853378697;5408.378036525771;5022.673526220784;5034.723090230073;5037.874053148701;5040.47075057121;5080;4608.470025946992;4620.168369693488;4658.743769092733;4681.95318046822;4683.718976861399;5631.267935168484;5659.518940889988;5660.603757737002;5664.20701101846;5667.858303542444;5402.054640437987;5433.483819037185;5439.619226654255;5440.782368705208;5458.972705136608;5545.667259964415;5550.361708403424;5627.015272327409;5633.324001119892;5674.659520428622;5223.45153758865;5229.26790249373;5231.189165679326;5241.790328386975;5247.816326428557;5271.499207575274;5308.283381743569;5323.148296272732;5331.840044798662;5372.811951581676;5193.298904647824;5248.76380562868;5290.470952904679;5319.042572336862;5366.141417373357;5270.631055826056;5271.841844744664;5274.340707411574;5276.920846187387;5280.656757310762;5105.897882042413;5187.636865419385;5197.0905091608065;5206.609504287269;5232.9738351308;5238.68567885928;5329.200619907045;5369.624126311121;5421.376541697755;5428.538574221236;5152.252923326172;5182.041322355376;5194;5197;5197.532222100029 16:23:25 INFO - PROCESS | 14593 | |1;ext.html;529.6901312732051;530.3000039947269;533.9880925645901;548.3940246028138;553.5184389581068;28352.716472835265;28757.85621071897;28762.712372876264;35294.8235258824;35529.644703552956;42017.369739453854;42549;42575.361369579405;42605.14789704204;42616.14767704644;8389.244967952884;8587.484750914933;8590.226879580836;8592.828143437127;8594.570271486433;8537.445066070717;8656.307495400353;8669.133086691343;8669.913300866974;8679.17547832958;8632.741017769476;8692.47845129291;8710.172533609297;8721.869171962426;8731.214190722834;8611.526366049864;8691.95654021729;8695.608697608623;8701.69544065961;8706.347023973196;8504.149585041447;8652.307815374756;8662.696805611837;8663.047064822927;8667.653293868238;39335;39808;39841.80079099615;39842.60157398418;39881;3175.2061984503875;3339.448990916496;3469.3581687387664;3718.1076541630086;3918.2147261227665;29447.411051778843;29860.10419687413;30181.396372072435;30224.546631800542;30561.388772224433;3777.2067865748227;3795.5065841440714;3826.368649172883;3844.2888065707934;3874.9612503874882;270939;274981;275805;276193.61903190555;276675;50689.23966140511;51429.48570514247;51451.228231576555;56166;56463.71768141133;45921.77039114783;46058.30912536314;60706;61327.08009379773;61444.692776535834;14445;14504;14559.126452412676;14632.341544630517;14677.77983330251;10407.94796026015;11041.779164416826;11073.446327683745;11148.498317575728;11208.439578021067;16723.414680486123;19192.232310707415;19537.60924781525;19644.607107857762;19683.31108411199;6808.5914845109455;6886.10480637514;6994.475414343945;7036.859262814715;7214.927850721426;797.696875187425;837.8826964225013;849.723839752083;868.2446271743623;888.4092078767547;26745.33136671599;26803.195904122516;26849.597256041176;27055.729442705713;27139.592906106423;1071.1537885070863;1073.0771536478621;1078.4769386847372;1116.7319843237565;1119.3843386137592;14667.85332146665;14709.632259193606;14724.705505890037;15097.924510377597;15168.848311516964;329382;332786;333333;334192;334746;51516.227256591184;51871.74064129731;51872.481275186765;51970.740146299024;51986.740066299426;1219.500004997929;1221.712897469094;1260.464302671361;1282.6472720001887;1301.1802564384377;27076.1877143686;27617.309567260978;27912.441751164457;28197;28283.15150545487;40801.387979179744;41075.7946210279;41113.17773644451;41188.58811411847;41200.38199427071;307600;309438;310946;311489;312037;30610.540841887836;31135.377292454476;31513;32090;32306.515402268513;36614;37021;37036;37223;37906.43140352842;31186.22034449157;31505.21236969094;31774.364512709155;31904.202394940312;32138.83930580332;33445;33754.63346888223;34417.82791086029;34552.30895382129;34703.65296347004;33023.339533208724;33410.16474588155;33550.49674254839;33684.49473257854;33863.66136338704;29117.272068198465;30382.84808575943;30837.229069273446;31074.37851242917;31123.84438077795;24009.639855401834;24207.394815129763;24415.755842441347;24847.500594153615;25920.61119083253 16:23:25 INFO - PROCESS | 14593 | |2;jquery.html;327.9262166012649;349.87404534367624;351.30266421154005;358.94974703541527;360.713232979781;13117.54088606899;16014;17001.57496062599;18013.549661258443;18035;15730.213489325544;15773.290201940912;16570.088645124513;16575.50273491794;16765.497035088938;3992.2015596880597;4154.31453810121;5258.0535503609235;5440.646357986738;5729.39841316662;5665.150227465892;5851.356350801409;5862.501687356558;5901.409859014086;5925.585209035369;5824.155497452867;5825.650460972334;5840.328362238354;5841.824745257649;5844.327902291248;5626.324841019084;5805.10020946754;5806.245188125559;5822.010258256107;5824.0390335594575;5145.125328694131;5164.870878228036;5229.633925625208;5242.8689282767855;5249.028929648028;19666;19746.605067898705;19766.20935162592;19969.301074462324;20072.89963550173;2015.586804705032;2059.3204242600054;2160.146742036902;2170.045180120758;2192.397090800027;12469.563565275263;12735.617931462071;12989.090763646549;13259.602211933658;13351.465941362334;1816.1554876982134;1840.7514985477058;1885.3118611706766;1885.820847019531;1888.6222755448828;55169;56103.71948140274;56200.54868593689;57220.427795721924;57782.42217577813;9652;9810.362326448758;9946.659082176966;10006.54970526328;10111.191104711605;12774;12911.35443227835;12923.22460652364;12950.740985180431;12985.480580776852;7504.399648028145;7529.322360987538;7565.394768418513;7568.735094271674;7575.6969721211635;7305.671244793997;7307.926920730831;7309.159446663702;7326.67029983652;7370.189279179286;5291.444398338119;5520.751566179531;5620.213170156181;5790.36306006339;5811.3316968548315;1703.269839052471;1739.6083133493155;1744.7906251249678;1754.8157443468508;1766.3464518128376;762.06646857599;773.6634563964693;905.1943770044666;984.9852252216223;998.4508520313798;13628.795568066487;14687.853121468648;14832.184229867245;14939.775903361458;15189.544313670607;862.4135587800231;898.4384759525296;900.8468560344758;924.5007695844168;972.1639390124487;7782.688692452239;8665.913340866637;9113.544322783835;9618.278629102846;9624.60063897772;499122;509379;525549;533189;539930;73384.63307683427;73730.63134684293;73818.26181738114;74511;74638.62680686562;1109.7447587055024;1111.9388433636227;1117.3463523838645;1119.0152665654334;1125.9887401126048;15064.623384415478;15250.542483725507;15304.387824486896;15348.30932608013;15612.141332226836;32097.197570060936;34967.475487867196;34971.47542786809;35083.47374789431;35591.46612800862;39816;41310.586894130676;42545.78727106345;43413.782931085145;44525.55474445214;6937.202221744564;7010.088688470671;7099.219085900443;7317.26827317264;7350.595717235603;10446.63436779709;10689.94655026751;11046.281991670516;11150.99641032311;11271.098312134845;9158.725238242863;9695.536800941878;9764.170045546209;9848.458334791656;9944.502774861083;9485.383450075724;9820.214382849212;9836.360636558888;9837.163841073589;10176.64381746665;9792.804143917225;10047.397156170653;10066.245031622511;10098.19214462856;10170.440625765654;5774.913376299275;6631.33686631333;6903.378695917391;7435.739749108755;7524;9306.674266400643;9637.843458784992;9648.131668149901;10004.499775011365;10217.591296348062 16:23:25 INFO - PROCESS | 14593 | |3;mootools.html;1323.7021670124218;1418.538974833179;1431.3129697745082;1535.854093861083;1719.7764290642208;6727.192736871576;7391.22392148824;7511.474196806212;7513.624318784066;7526.13449453313;7382;7527.247275272483;7553.357964573018;7554.622268886561;7558.584277864716;1994.7706013808381;2046.0383619698719;2047.907844147017;2310.214527060799;2341.098677009355;2296.59809533331;2355.2580937004873;2355.316958082154;2355.49356888269;2356.493353928905;2259.9322020339414;2282.9726623019624;2299.8620082795;2303.0442366417915;2303.735070466901;2235.6311208650554;2235.8434909556418;2250.3698964290024;2308.6883270758567;2311.15642790382;2251.223327951854;2282.315305408371;2288.187693368863;2290.4846409557717;2297.471581536256;7683.30850223477;7698.344855855962;7721.420893432959;7723.150453450116;7742.225777422269;4452.487963884162;4564.748938808364;4569.543045695437;4570.497245303014;4575.290829921334;2886.336142687194;2925.88296468141;2967.080205136393;2973.122928736028;3019.2602812310906;916.1571354353944;918.2332752151962;952.4044999381877;975.9609615615367;977.3207620703614;10083.899161008369;10092.34399764013;10092.798144037079;10109.848352274721;10137.239707021929;4165.208610364021;4179.791010449465;4234.364845273172;4263.744175349489;4286.742795432284;8826.646934122564;8848.91151088481;8857.64569417229;8867.201951824367;8874.86687699685;4753.762311884392;4756;4756.405449318835;4759.024399997992;4765.285207218945;4272.145570885836;4303.462067241595;4332.415123958225;4333.956660433419;4340.262155433584;3491.581010278732;3515.4375299951885;3663.139162296858;3695.9445608315896;3733.8133093345223;1188.857337119534;1238.4427007846325;1238.504598160743;1245.339969815999;1249.731307768816;1257.503286201945;1262.5202423079172;1268.2960956668953;1269.593730006389;1291.1284882704138;7117;7141.321574450419;7155.427565794724;7180.31786980236;7219.855602887913;1087.49975011494;1106.5463160104318;1108.1744100645071;1109.6338208391212;1126.6169502369235;5443.591730620219;5464.23500709901;5545.7781688732;5555.138953462219;5561.555075593943;8660.39377243587;8943.955280223558;8957.731268061969;9076.273898088137;9329.860052099224;8821.867671984925;8973.910260897437;8979.057198994142;8988;9018.09819018093;7230.710771569078;7251.673674684546;7397.297256760599;7421.888671669929;7444.106707195171;7257.709691612276;7347.595882226529;7359.77920662381;7366.447516436396;7375.151857536237;8073.87889181651;8368.288695460955;8418.200270974248;8471.788205294917;8478.321734261368;8392.20274073962;8603.053664096818;8608.956955215433;8738.650453981769;8759.255463285437;6431.324710905287;6532.020196970492;6554.230357803271;6556.934430655823;6980.720771169096;6720.1599800025;6864.6910889011115;6880.827979300558;7107.538010029331;7114.324139206767;6713.423357409524;6809.863802724017;6875.656217189021;6913.827154321182;6953.617551034742;6364.6181229126405;6672.065910772592;6696.296888826798;6761.763338283136;6843.178818541807;6665.466762659073;6678.298778628174;6686.398224159849;6692;6696.430803381767;6318.526110541636;6378.425941665272;6383.648899310582;6417.03744438338;6423.64669943139;6294.087357333253;6300.21247344082;6328.620282782864;6336.651484168415;6339.683015849281 16:23:25 INFO - PROCESS | 14593 | |4;prototype.html;327.89999050289657;328.1337269608233;334.6937552139792;336.52717931306523;336.5960846983619;5724.828255152342;5865.8826823463505;5870.148828419877;5886.882262354756;5903;5661.773529058843;5749.166370876231;5751;5757.395473475288;5774.220480235177;4465.24090904547;4481.910361792762;4501.279795232764;4502.729836209822;4506.639468842484;4352.020795321059;4405.16301902639;4472.955270447303;4482.618977386926;4510.616597589193;4463.799129039201;4485.170243504946;4495.483019452756;4496.145732310867;4504.0316331988615;4471.28459446487;4484.955150448486;4495.415595972535;4499.775011249457;4512.210363186429;3957.584453632385;3958.2875082485143;3964.0882597002565;3969.64273215412;3969.702272329558;5444.482774136451;5578.163275508666;5588.385277619459;5599.832005039855;5659.830205093854;5169.586433085344;5178.14560597501;5181.689098654093;5183.870403239912;5184.066867963765;5918.940810591882;6262.843428914268;6267.686615669244;6275.497960163221;6277.278113017016;4190.099128687347;4270.081932384521;4280.6361459275995;4280.6789490788005;4282.42187304713;6404.071409645622;6572.737090516373;6582.703778329987;6588.978708300221;6597.571157874723;4357.193919124972;4358.389825424443;4363.127374525107;4365.9126817463475;4366.759828209415;4318.9352159717;4409.140217657526;4414.889627759332;4415.183191109655;4432.578905004019;5167.974160129175;5188.766505507186;5195.324607801037;5196.168613021899;5202.713850738246;6277.937220627827;6294.181756371642;6298.275698294755;6307.117003619497;6308.274548426898;1544.1121355220794;1577.5346272849538;1578.179346739689;1578.6132397562442;1579.0288972281965;1002.3885429887763;1013.0325539110132;1024.3495380433478;1033.8035773203067;1054.3831858362944;5840.8539786504825;5843.328017277982;5855.970720146457;5859.355470898197;5860.912086318709;6320.367963203643;6334.208223972004;6334.904976425358;6343.302236753953;6347.428731414195;5840.474357307863;5840.94159058404;5843.152742852262;5846.093855452412;5853.473187413153;3369.949450758241;3473.9404481633346;3479.4780782882262;3486.6687664671817;3488.145404375944;6659.433948114464;6696.0960270362875;6728.764493242713;6758.222804377461;6759.459243260626;6575.605463672195;6578.934210657832;6586.077949087132;6588.901166482507;6591.901121483182;6526.575772574767;6605.30644282353;6635.502337324623;6638.83402914931;6657.533972621967;6199.256089269136;6294.496440284858;6391.4247717703765;6415.615063096229;6418;6272.717727702173;6384.106225128393;6419.582727122722;6421.614703117828;6445.452136568444;6677.465802735673;6715.395614394728;6727.495437842083;6728.3271672832325;6730.899036514554;4459.219636563654;4485.820567177407;4537.659675524283;4538.659600529907;4538.774530876711;6407.679616019087;6425.5502114851515;6425.646589437626;6429.421352078335;6434.388733070351;6243.125962365363;6257.937420625917;6260.154879091265;6261.436470717657;6265.185525881606;6136.478399336106;6174.320824709368;6216.44052035319;6238.968805155945;6244.5316601256;6091.664958427329;6093.451589356979;6106.2061931948565;6109.480694141048;6117.724702388314;6229.470495007975;6257.687115644108;6267.059941008885;6272.843178920563;6287;5999.5800293979;6110.480609148094;6129.3564175762685;6132.846678833065;6136.8772624548155 16:23:25 INFO - PROCESS | 14593 | |5;yui.html;697.6720941157654;762.8207371267748;764.8623247815394;809.6235250608465;836.3810780022785;13782.379792909318;13843.861561384383;13890.791638125436;13913.095648782835;13936.581902542926;11936.343501107436;12558;12885.355732213398;12939;12969.157004794683;773.0452890680006;780.9453338266323;789.2699253190805;789.4947233770391;789.8973133492638;785.968561257549;786.8032991752062;790.723246863596;790.8892755014302;791.0823444804029;818.6725309876067;822.6503735912244;822.8889099971517;823.4153750836913;823.6458322921142;814.3973459639883;817.6361519123992;817.8037271054934;818.382121498268;818.6397984886631;602.1509671363357;602.5270162922085;603.0772917436329;604.6583680220705;604.7883240865706;12520.123591348609;12625.747485050248;12629.305388203646;12631.873681263161;12632.30522321272;10845.186611004126;11032.172587056002;11069.114470842313;11238.550457981672;11532.135089868294;9615.90384096164;9842.507874606312;9983.800323993479;10116.54475548602;10228;3575.856965721394;3596.604373518911;3598.604153543108;3621.8370173342;3730.7015438764834;44786.77606611979;44928;47945;48342.51657483415;50942.99999999963;9104.13510716494;9255.06665140732;9961.601535938482;10087.798244035079;10289.639862604772;18131.818681813013;18386.172622231763;18406.539836503925;18427.078646067912;18457.353992610195;7316.268373162748;7328.853422931512;7401.185869554345;7516.511426757353;7530.736424225235;4210.978945105255;4228.725132866354;4228.9577104228565;4265.0830071534765;4282.186384586918;3125.87496500142;3145.653978062411;3150.8582113804932;3156.479180935166;3157.41587806252;554.1798138754585;579.495838620403;580.7009390164069;581.5870731780399;589.3311091910713;487.11102238414327;557.239368262319;570.139089974142;571.6912867051745;586.6450797267677;7651.923480765121;7994.360451163893;8179.263866252066;8262.42163048593;8454.87317690235;438.5110601679105;485.2624011502567;494.94308154562685;530.6789392417609;537.6505271573509;3910.3743401055694;3911.647951684362;3979.5821438749094;4026.9194616107516;4182.163567286494;62702.686486568186;63364;63420.36579634237;63425;63595;51291.48708512867;51678;51815.22277165845;52120.73939630278;53106.73446632742;41829.58170418257;47394;48411.5158848407;48486.75756621265;49558.504414956835;8126.471779334324;8154.673813047411;8177.34581233488;8441.788955276168;8484.363672724447;36147.819260903525;36814.44778328274;37018.62981370152;37161.256774864894;37320.44019339766;46229;46433.30350044819;46556;47090;47117.52882471131;9618.759531011781;9820.950895245478;9857.852132217879;10013.849792253268;10056.145227655732;11441.713957151138;11890.194057875684;11945.581904633296;11999.820002699791;12036.63890083299;11072.280301780358;11278.830817537908;11400.429978501208;11412;11736.823947640622;9887.901120988698;10198.082172604501;10378.273520853469;10486.632967846088;10508.894911051097;10264.230182736474;10382;10544.472776361305;10560.155187584822;10578.365298082139;9154.313426493172;9176.95411522938;9365.765855853659;9378.718638440858;9610.615575376907;8608.225259726654;8984.640614375352;9549.809003820024;9843.360181588174;9846.163076138608 16:23:25 INFO - PROCESS | 14593 | __end_tp_report 16:23:25 INFO - PROCESS | 14593 | __start_cc_report 16:23:25 INFO - PROCESS | 14593 | _x_x_mozilla_cycle_collect,689 16:23:25 INFO - PROCESS | 14593 | __end_cc_report 16:23:25 INFO - PROCESS | 14593 | __startTimestamp1452731005394__endTimestamp 16:23:25 INFO - PROCESS | 14593 | 16:23:25 INFO - PROCESS | 14593 | ------- Summary: start ------- 16:23:25 INFO - PROCESS | 14593 | Number of tests: 6 16:23:25 INFO - PROCESS | 14593 | 16:23:25 INFO - PROCESS | 14593 | [#0] dojo.html Cycles:165 Average:5029.35 Median:5197.53 stddev:522.91 (10.1%) stddev-sans-first:501.91 16:23:25 INFO - PROCESS | 14593 | Values: 3090.8 3099.8 3139.0 3140.0 3163.2 4916.9 5018.8 5025.7 5035.5 5080.3 5016.0 5060.1 5089.6 5095.7 5095.7 4437.2 4571.3 4612.6 4694.1 4726.6 4561.3 4685.7 4698.2 4704.4 4769.2 4598.6 4611.9 4616.6 4631.0 4653.9 4599.7 4608.4 4623.3 4630.4 4667.2 4555.5 4595.7 4598.3 4610.0 4639.5 4792.8 4867.5 4889.9 4906.1 4915.8 5382.5 5399.1 5399.4 5400.1 5449.1 5396.0 5416.4 5421.5 5455.3 5513.5 5023.9 5135.5 5181.1 5198.0 5219.8 5549.1 5550.8 5553.3 5556.1 5558.2 5156.5 5238.1 5344.9 5358.6 5360.5 5298.0 5332.2 5334.6 5335.3 5381.5 5311.1 5325.9 5331.1 5348.3 5381.7 5250.5 5354.9 5357.7 5395.1 5405.6 4287.1 4297.1 4298.1 4311.5 4340.7 3820.1 3843.0 3846.2 3872.1 3875.7 5014.0 5075.9 5085.4 5092.3 5145.5 5369.5 5387.4 5393.9 5405.9 5408.4 5022.7 5034.7 5037.9 5040.5 5080.0 4608.5 4620.2 4658.7 4682.0 4683.7 5631.3 5659.5 5660.6 5664.2 5667.9 5402.1 5433.5 5439.6 5440.8 5459.0 5545.7 5550.4 5627.0 5633.3 5674.7 5223.5 5229.3 5231.2 5241.8 5247.8 5271.5 5308.3 5323.1 5331.8 5372.8 5193.3 5248.8 5290.5 5319.0 5366.1 5270.6 5271.8 5274.3 5276.9 5280.7 5105.9 5187.6 5197.1 5206.6 5233.0 5238.7 5329.2 5369.6 5421.4 5428.5 5152.3 5182.0 5194.0 5197.0 5197.5 16:23:25 INFO - PROCESS | 14593 | 16:23:25 INFO - PROCESS | 14593 | [#1] ext.html Cycles:180 Average:46155.83 Median:33809.15 stddev:80442.98 (237.9%) stddev-sans-first:80595.70 16:23:25 INFO - PROCESS | 14593 | Values: 529.7 530.3 534.0 548.4 553.5 28352.7 28757.9 28762.7 35294.8 35529.6 42017.4 42549.0 42575.4 42605.1 42616.1 8389.2 8587.5 8590.2 8592.8 8594.6 8537.4 8656.3 8669.1 8669.9 8679.2 8632.7 8692.5 8710.2 8721.9 8731.2 8611.5 8692.0 8695.6 8701.7 8706.3 8504.1 8652.3 8662.7 8663.0 8667.7 39335.0 39808.0 39841.8 39842.6 39881.0 3175.2 3339.4 3469.4 3718.1 3918.2 29447.4 29860.1 30181.4 30224.5 30561.4 3777.2 3795.5 3826.4 3844.3 3875.0 270939.0 274981.0 275805.0 276193.6 276675.0 50689.2 51429.5 51451.2 56166.0 56463.7 45921.8 46058.3 60706.0 61327.1 61444.7 14445.0 14504.0 14559.1 14632.3 14677.8 10407.9 11041.8 11073.4 11148.5 11208.4 16723.4 19192.2 19537.6 19644.6 19683.3 6808.6 6886.1 6994.5 7036.9 7214.9 797.7 837.9 849.7 868.2 888.4 26745.3 26803.2 26849.6 27055.7 27139.6 1071.2 1073.1 1078.5 1116.7 1119.4 14667.9 14709.6 14724.7 15097.9 15168.8 329382.0 332786.0 333333.0 334192.0 334746.0 51516.2 51871.7 51872.5 51970.7 51986.7 1219.5 1221.7 1260.5 1282.6 1301.2 27076.2 27617.3 27912.4 28197.0 28283.2 40801.4 41075.8 41113.2 41188.6 41200.4 307600.0 309438.0 310946.0 311489.0 312037.0 30610.5 31135.4 31513.0 32090.0 32306.5 36614.0 37021.0 37036.0 37223.0 37906.4 31186.2 31505.2 31774.4 31904.2 32138.8 33445.0 33754.6 34417.8 34552.3 34703.7 33023.3 33410.2 33550.5 33684.5 33863.7 29117.3 30382.8 30837.2 31074.4 31123.8 24009.6 24207.4 24415.8 24847.5 25920.6 16:23:25 INFO - PROCESS | 14593 | 16:23:25 INFO - PROCESS | 14593 | [#2] jquery.html Cycles:180 Average:27148.68 Median:5236.25 stddev:85230.07 (1627.7%) stddev-sans-first:85445.36 16:23:25 INFO - PROCESS | 14593 | Values: 327.9 349.9 351.3 358.9 360.7 13117.5 16014.0 17001.6 18013.5 18035.0 15730.2 15773.3 16570.1 16575.5 16765.5 3992.2 4154.3 5258.1 5440.6 5729.4 5665.2 5851.4 5862.5 5901.4 5925.6 5824.2 5825.7 5840.3 5841.8 5844.3 5626.3 5805.1 5806.2 5822.0 5824.0 5145.1 5164.9 5229.6 5242.9 5249.0 19666.0 19746.6 19766.2 19969.3 20072.9 2015.6 2059.3 2160.1 2170.0 2192.4 12469.6 12735.6 12989.1 13259.6 13351.5 1816.2 1840.8 1885.3 1885.8 1888.6 55169.0 56103.7 56200.5 57220.4 57782.4 9652.0 9810.4 9946.7 10006.5 10111.2 12774.0 12911.4 12923.2 12950.7 12985.5 7504.4 7529.3 7565.4 7568.7 7575.7 7305.7 7307.9 7309.2 7326.7 7370.2 5291.4 5520.8 5620.2 5790.4 5811.3 1703.3 1739.6 1744.8 1754.8 1766.3 762.1 773.7 905.2 985.0 998.5 13628.8 14687.9 14832.2 14939.8 15189.5 862.4 898.4 900.8 924.5 972.2 7782.7 8665.9 9113.5 9618.3 9624.6 499122.0 509379.0 525549.0 533189.0 539930.0 73384.6 73730.6 73818.3 74511.0 74638.6 1109.7 1111.9 1117.3 1119.0 1126.0 15064.6 15250.5 15304.4 15348.3 15612.1 32097.2 34967.5 34971.5 35083.5 35591.5 39816.0 41310.6 42545.8 43413.8 44525.6 6937.2 7010.1 7099.2 7317.3 7350.6 10446.6 10689.9 11046.3 11151.0 11271.1 9158.7 9695.5 9764.2 9848.5 9944.5 9485.4 9820.2 9836.4 9837.2 10176.6 9792.8 10047.4 10066.2 10098.2 10170.4 5774.9 6631.3 6903.4 7435.7 7524.0 9306.7 9637.8 9648.1 10004.5 10217.6 16:23:25 INFO - PROCESS | 14593 | 16:23:25 INFO - PROCESS | 14593 | [#3] mootools.html Cycles:180 Average:5335.41 Median:6352.15 stddev:2716.57 (42.8%) stddev-sans-first:2707.45 16:23:25 INFO - PROCESS | 14593 | Values: 1323.7 1418.5 1431.3 1535.9 1719.8 6727.2 7391.2 7511.5 7513.6 7526.1 7382.0 7527.2 7553.4 7554.6 7558.6 1994.8 2046.0 2047.9 2310.2 2341.1 2296.6 2355.3 2355.3 2355.5 2356.5 2259.9 2283.0 2299.9 2303.0 2303.7 2235.6 2235.8 2250.4 2308.7 2311.2 2251.2 2282.3 2288.2 2290.5 2297.5 7683.3 7698.3 7721.4 7723.2 7742.2 4452.5 4564.7 4569.5 4570.5 4575.3 2886.3 2925.9 2967.1 2973.1 3019.3 916.2 918.2 952.4 976.0 977.3 10083.9 10092.3 10092.8 10109.8 10137.2 4165.2 4179.8 4234.4 4263.7 4286.7 8826.6 8848.9 8857.6 8867.2 8874.9 4753.8 4756.0 4756.4 4759.0 4765.3 4272.1 4303.5 4332.4 4334.0 4340.3 3491.6 3515.4 3663.1 3695.9 3733.8 1188.9 1238.4 1238.5 1245.3 1249.7 1257.5 1262.5 1268.3 1269.6 1291.1 7117.0 7141.3 7155.4 7180.3 7219.9 1087.5 1106.5 1108.2 1109.6 1126.6 5443.6 5464.2 5545.8 5555.1 5561.6 8660.4 8944.0 8957.7 9076.3 9329.9 8821.9 8973.9 8979.1 8988.0 9018.1 7230.7 7251.7 7397.3 7421.9 7444.1 7257.7 7347.6 7359.8 7366.4 7375.2 8073.9 8368.3 8418.2 8471.8 8478.3 8392.2 8603.1 8609.0 8738.7 8759.3 6431.3 6532.0 6554.2 6556.9 6980.7 6720.2 6864.7 6880.8 7107.5 7114.3 6713.4 6809.9 6875.7 6913.8 6953.6 6364.6 6672.1 6696.3 6761.8 6843.2 6665.5 6678.3 6686.4 6692.0 6696.4 6318.5 6378.4 6383.6 6417.0 6423.6 6294.1 6300.2 6328.6 6336.7 6339.7 16:23:25 INFO - PROCESS | 14593 | 16:23:25 INFO - PROCESS | 14593 | [#4] prototype.html Cycles:180 Average:5198.20 Median:5844.71 stddev:1570.67 (26.9%) stddev-sans-first:1531.95 16:23:25 INFO - PROCESS | 14593 | Values: 327.9 328.1 334.7 336.5 336.6 5724.8 5865.9 5870.1 5886.9 5903.0 5661.8 5749.2 5751.0 5757.4 5774.2 4465.2 4481.9 4501.3 4502.7 4506.6 4352.0 4405.2 4473.0 4482.6 4510.6 4463.8 4485.2 4495.5 4496.1 4504.0 4471.3 4485.0 4495.4 4499.8 4512.2 3957.6 3958.3 3964.1 3969.6 3969.7 5444.5 5578.2 5588.4 5599.8 5659.8 5169.6 5178.1 5181.7 5183.9 5184.1 5918.9 6262.8 6267.7 6275.5 6277.3 4190.1 4270.1 4280.6 4280.7 4282.4 6404.1 6572.7 6582.7 6589.0 6597.6 4357.2 4358.4 4363.1 4365.9 4366.8 4318.9 4409.1 4414.9 4415.2 4432.6 5168.0 5188.8 5195.3 5196.2 5202.7 6277.9 6294.2 6298.3 6307.1 6308.3 1544.1 1577.5 1578.2 1578.6 1579.0 1002.4 1013.0 1024.3 1033.8 1054.4 5840.9 5843.3 5856.0 5859.4 5860.9 6320.4 6334.2 6334.9 6343.3 6347.4 5840.5 5840.9 5843.2 5846.1 5853.5 3369.9 3473.9 3479.5 3486.7 3488.1 6659.4 6696.1 6728.8 6758.2 6759.5 6575.6 6578.9 6586.1 6588.9 6591.9 6526.6 6605.3 6635.5 6638.8 6657.5 6199.3 6294.5 6391.4 6415.6 6418.0 6272.7 6384.1 6419.6 6421.6 6445.5 6677.5 6715.4 6727.5 6728.3 6730.9 4459.2 4485.8 4537.7 4538.7 4538.8 6407.7 6425.6 6425.6 6429.4 6434.4 6243.1 6257.9 6260.2 6261.4 6265.2 6136.5 6174.3 6216.4 6239.0 6244.5 6091.7 6093.5 6106.2 6109.5 6117.7 6229.5 6257.7 6267.1 6272.8 6287.0 5999.6 6110.5 6129.4 6132.8 6136.9 16:23:25 INFO - PROCESS | 14593 | 16:23:25 INFO - PROCESS | 14593 | [#5] yui.html Cycles:180 Average:13871.31 Median:491.03 stddev:16699.02 (3400.8%) stddev-sans-first:16716.56 16:23:25 INFO - PROCESS | 14593 | Values: 697.7 762.8 764.9 809.6 836.4 13782.4 13843.9 13890.8 13913.1 13936.6 11936.3 12558.0 12885.4 12939.0 12969.2 773.0 780.9 789.3 789.5 789.9 786.0 786.8 790.7 790.9 791.1 818.7 822.7 822.9 823.4 823.6 814.4 817.6 817.8 818.4 818.6 602.2 602.5 603.1 604.7 604.8 12520.1 12625.7 12629.3 12631.9 12632.3 10845.2 11032.2 11069.1 11238.6 11532.1 9615.9 9842.5 9983.8 10116.5 10228.0 3575.9 3596.6 3598.6 3621.8 3730.7 44786.8 44928.0 47945.0 48342.5 50943.0 9104.1 9255.1 9961.6 10087.8 10289.6 18131.8 18386.2 18406.5 18427.1 18457.4 7316.3 7328.9 7401.2 7516.5 7530.7 4211.0 4228.7 4229.0 4265.1 4282.2 3125.9 3145.7 3150.9 3156.5 3157.4 554.2 579.5 580.7 581.6 589.3 487.1 557.2 570.1 571.7 586.6 7651.9 7994.4 8179.3 8262.4 8454.9 438.5 485.3 494.9 530.7 537.7 3910.4 3911.6 3979.6 4026.9 4182.2 62702.7 63364.0 63420.4 63425.0 63595.0 51291.5 51678.0 51815.2 52120.7 53106.7 41829.6 47394.0 48411.5 48486.8 49558.5 8126.5 8154.7 8177.3 8441.8 8484.4 36147.8 36814.4 37018.6 37161.3 37320.4 46229.0 46433.3 46556.0 47090.0 47117.5 9618.8 9821.0 9857.9 10013.8 10056.1 11441.7 11890.2 11945.6 11999.8 12036.6 11072.3 11278.8 11400.4 11412.0 11736.8 9887.9 10198.1 10378.3 10486.6 10508.9 10264.2 10382.0 10544.5 10560.2 10578.4 9154.3 9177.0 9365.8 9378.7 9610.6 8608.2 8984.6 9549.8 9843.4 9846.2 16:23:25 INFO - PROCESS | 14593 | -------- Summary: end -------- 16:23:25 INFO - PROCESS | 14593 | 16:23:26 INFO - TEST-INFO | 14593: exit 0 16:23:26 INFO - TEST-OK | dromaeo_css | took 1112231ms 16:23:26 INFO - TEST-START | kraken 16:23:26 INFO - operating with platform_type : linux_ 16:23:26 INFO - Initialising browser for kraken test... 16:23:26 INFO - TEST-INFO | started process 14784 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsCU3Lp/profile http://localhost:55384/getInfo.html) 16:23:30 INFO - PROCESS | 14784 | __metrics Screen width/height:1600/1200 16:23:30 INFO - PROCESS | 14784 | colorDepth:24 16:23:30 INFO - PROCESS | 14784 | Browser inner width/height: 1024/697 16:23:30 INFO - PROCESS | 14784 | __metrics 16:23:30 INFO - PROCESS | 14784 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:23:30 INFO - PROCESS | 14784 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:23:31 INFO - TEST-INFO | 14784: exit 0 16:23:31 INFO - Browser initialized. 16:23:31 INFO - Running cycle 1/1 for kraken test... 16:23:31 INFO - TEST-INFO | started process 14868 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsCU3Lp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:43 INFO - PROCESS | 14868 | RSS: Main: 150097920 16:23:43 INFO - PROCESS | 14868 | 16:23:45 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55384/tests/kraken/driver.html?testName=audio-beat-detection) 16:23:46 INFO - PROCESS | 14868 | RSS: Main: 188227584 16:23:46 INFO - PROCESS | 14868 | 16:23:49 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55384/tests/kraken/driver.html?testName=audio-dft) 16:23:49 INFO - PROCESS | 14868 | RSS: Main: 179662848 16:23:49 INFO - PROCESS | 14868 | 16:23:52 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55384/tests/kraken/driver.html?testName=audio-fft) 16:23:53 INFO - PROCESS | 14868 | RSS: Main: 160342016 16:23:53 INFO - PROCESS | 14868 | 16:23:54 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55384/tests/kraken/driver.html?testName=audio-oscillator) 16:23:55 INFO - PROCESS | 14868 | RSS: Main: 164274176 16:23:55 INFO - PROCESS | 14868 | 16:23:57 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55384/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:23:58 INFO - PROCESS | 14868 | RSS: Main: 164843520 16:23:58 INFO - PROCESS | 14868 | 16:24:01 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55384/tests/kraken/driver.html?testName=imaging-darkroom) 16:24:01 INFO - PROCESS | 14868 | RSS: Main: 166936576 16:24:01 INFO - PROCESS | 14868 | 16:24:05 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55384/tests/kraken/driver.html?testName=imaging-desaturate) 16:24:05 INFO - PROCESS | 14868 | RSS: Main: 168034304 16:24:05 INFO - PROCESS | 14868 | 16:24:08 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55384/tests/kraken/driver.html?testName=json-parse-financial) 16:24:09 INFO - PROCESS | 14868 | RSS: Main: 166711296 16:24:09 INFO - PROCESS | 14868 | 16:24:10 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55384/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:24:11 INFO - PROCESS | 14868 | RSS: Main: 177471488 16:24:11 INFO - PROCESS | 14868 | 16:24:12 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55384/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:24:13 INFO - PROCESS | 14868 | RSS: Main: 176263168 16:24:13 INFO - PROCESS | 14868 | 16:24:15 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55384/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:24:16 INFO - PROCESS | 14868 | RSS: Main: 185499648 16:24:16 INFO - PROCESS | 14868 | 16:24:18 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:24:19 INFO - PROCESS | 14868 | RSS: Main: 190451712 16:24:19 INFO - PROCESS | 14868 | 16:24:21 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:24:22 INFO - PROCESS | 14868 | RSS: Main: 188051456 16:24:22 INFO - PROCESS | 14868 | 16:24:23 INFO - PROCESS | 14868 | Cycle 1(1): loaded http://localhost:55384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55384/tests/kraken/driver.html?testName=ai-astar) 16:24:24 INFO - PROCESS | 14868 | RSS: Main: 247070720 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | __start_tp_report 16:24:24 INFO - PROCESS | 14868 | _x_x_mozilla_page_load 16:24:24 INFO - PROCESS | 14868 | _x_x_mozilla_page_load_details 16:24:24 INFO - PROCESS | 14868 | |i|pagename|runs| 16:24:24 INFO - PROCESS | 14868 | |0;ai-astar;110;111;107;112;111;110;103;112;111;110 16:24:24 INFO - PROCESS | 14868 | |1;audio-beat-detection;162;126;154;168;124;145;149;123;160;128 16:24:24 INFO - PROCESS | 14868 | |2;audio-dft;160;161;161;159;160;161;159;164;161;163 16:24:24 INFO - PROCESS | 14868 | |3;audio-fft;72;73;97;90;74;71;71;101;96;72 16:24:24 INFO - PROCESS | 14868 | |4;audio-oscillator;96;97;149;99;95;96;138;95;96;138 16:24:24 INFO - PROCESS | 14868 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;108;109 16:24:24 INFO - PROCESS | 14868 | |6;imaging-darkroom;147;145;145;147;146;145;147;145;146;145 16:24:24 INFO - PROCESS | 14868 | |7;imaging-desaturate;96;95;95;96;95;96;95;96;96;96 16:24:24 INFO - PROCESS | 14868 | |8;json-parse-financial;55;59;56;56;56;56;55;64;53;54 16:24:24 INFO - PROCESS | 14868 | |9;json-stringify-tinderbox;68;69;68;68;69;69;70;70;68;76 16:24:24 INFO - PROCESS | 14868 | |10;stanford-crypto-aes;80;81;82;82;81;84;81;83;81;84 16:24:24 INFO - PROCESS | 14868 | |11;stanford-crypto-ccm;114;121;129;116;114;121;122;126;115;129 16:24:24 INFO - PROCESS | 14868 | |12;stanford-crypto-pbkdf2;134;138;143;140;141;133;152;140;141;144 16:24:24 INFO - PROCESS | 14868 | |13;stanford-crypto-sha256-iterative;67;66;68;69;67;65;67;69;66;67 16:24:24 INFO - PROCESS | 14868 | __end_tp_report 16:24:24 INFO - PROCESS | 14868 | __start_cc_report 16:24:24 INFO - PROCESS | 14868 | _x_x_mozilla_cycle_collect,964 16:24:24 INFO - PROCESS | 14868 | __end_cc_report 16:24:24 INFO - PROCESS | 14868 | __startTimestamp1452731064201__endTimestamp 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | ------- Summary: start ------- 16:24:24 INFO - PROCESS | 14868 | Number of tests: 14 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:2.75 (2.5%) stddev-sans-first:2.92 16:24:24 INFO - PROCESS | 14868 | Values: 110.0 111.0 107.0 112.0 111.0 110.0 103.0 112.0 111.0 110.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:151.50 stddev:17.33 (11.4%) stddev-sans-first:17.10 16:24:24 INFO - PROCESS | 14868 | Values: 162.0 126.0 154.0 168.0 124.0 145.0 149.0 123.0 160.0 128.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.60 (1.0%) stddev-sans-first:1.66 16:24:24 INFO - PROCESS | 14868 | Values: 160.0 161.0 161.0 159.0 160.0 161.0 159.0 164.0 161.0 163.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#3] audio-fft Cycles:10 Average:81.70 Median:73.50 stddev:12.61 (17.2%) stddev-sans-first:12.88 16:24:24 INFO - PROCESS | 14868 | Values: 72.0 73.0 97.0 90.0 74.0 71.0 71.0 101.0 96.0 72.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.00 stddev:22.15 (23.1%) stddev-sans-first:22.92 16:24:24 INFO - PROCESS | 14868 | Values: 96.0 97.0 149.0 99.0 95.0 96.0 138.0 95.0 96.0 138.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:24:24 INFO - PROCESS | 14868 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 108.0 109.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 16:24:24 INFO - PROCESS | 14868 | Values: 147.0 145.0 145.0 147.0 146.0 145.0 147.0 145.0 146.0 145.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:24:24 INFO - PROCESS | 14868 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:3.10 (5.5%) stddev-sans-first:3.24 16:24:24 INFO - PROCESS | 14868 | Values: 55.0 59.0 56.0 56.0 56.0 56.0 55.0 64.0 53.0 54.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.00 stddev:2.42 (3.5%) stddev-sans-first:2.50 16:24:24 INFO - PROCESS | 14868 | Values: 68.0 69.0 68.0 68.0 69.0 69.0 70.0 70.0 68.0 76.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:1.37 (1.7%) stddev-sans-first:1.27 16:24:24 INFO - PROCESS | 14868 | Values: 80.0 81.0 82.0 82.0 81.0 84.0 81.0 83.0 81.0 84.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:121.50 stddev:5.89 (4.8%) stddev-sans-first:5.73 16:24:24 INFO - PROCESS | 14868 | Values: 114.0 121.0 129.0 116.0 114.0 121.0 122.0 126.0 115.0 129.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.60 Median:141.00 stddev:5.34 (3.8%) stddev-sans-first:5.10 16:24:24 INFO - PROCESS | 14868 | Values: 134.0 138.0 143.0 140.0 141.0 133.0 152.0 140.0 141.0 144.0 16:24:24 INFO - PROCESS | 14868 | 16:24:24 INFO - PROCESS | 14868 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.29 (1.9%) stddev-sans-first:1.36 16:24:24 INFO - PROCESS | 14868 | Values: 67.0 66.0 68.0 69.0 67.0 65.0 67.0 69.0 66.0 67.0 16:24:24 INFO - PROCESS | 14868 | -------- Summary: end -------- 16:24:24 INFO - PROCESS | 14868 | 16:24:25 INFO - TEST-INFO | 14868: exit 0 16:24:25 INFO - TEST-OK | kraken | took 59021ms 16:24:25 INFO - TEST-START | v8_7 16:24:25 INFO - operating with platform_type : linux_ 16:24:25 INFO - Initialising browser for v8_7 test... 16:24:25 INFO - TEST-INFO | started process 15116 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYPyqJw/profile http://localhost:55384/getInfo.html) 16:24:29 INFO - PROCESS | 15116 | __metrics Screen width/height:1600/1200 16:24:29 INFO - PROCESS | 15116 | colorDepth:24 16:24:29 INFO - PROCESS | 15116 | Browser inner width/height: 1024/697 16:24:29 INFO - PROCESS | 15116 | __metrics 16:24:29 INFO - PROCESS | 15116 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:24:29 INFO - PROCESS | 15116 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:24:30 INFO - TEST-INFO | 15116: exit 0 16:24:30 INFO - Browser initialized. 16:24:30 INFO - Running cycle 1/1 for v8_7 test... 16:24:30 INFO - TEST-INFO | started process 15198 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYPyqJw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:24:42 INFO - PROCESS | 15198 | RSS: Main: 150425600 16:24:42 INFO - PROCESS | 15198 | 16:25:04 INFO - PROCESS | 15198 | Cycle 1(1): loaded http://localhost:55384/tests/v8_7/run.html (next: http://localhost:55384/tests/v8_7/run.html) 16:25:05 INFO - PROCESS | 15198 | RSS: Main: 577847296 16:25:05 INFO - PROCESS | 15198 | 16:25:05 INFO - PROCESS | 15198 | __start_tp_report 16:25:05 INFO - PROCESS | 15198 | _x_x_mozilla_page_load 16:25:05 INFO - PROCESS | 15198 | _x_x_mozilla_page_load_details 16:25:05 INFO - PROCESS | 15198 | |i|pagename|runs| 16:25:05 INFO - PROCESS | 15198 | |0;Richards;167.50418760469012 16:25:05 INFO - PROCESS | 15198 | |1;DeltaBlue;187.89928598271325 16:25:05 INFO - PROCESS | 15198 | |2;Encrypt;282.0078962210942 16:25:05 INFO - PROCESS | 15198 | |3;Decrypt;5164.948453608247 16:25:05 INFO - PROCESS | 15198 | |4;RayTrace;1974.3589743589744 16:25:05 INFO - PROCESS | 15198 | |5;Earley;802.5682182985554 16:25:05 INFO - PROCESS | 15198 | |6;Boyer;12543.20987654321 16:25:05 INFO - PROCESS | 15198 | |7;RegExp;42645.833333333336 16:25:05 INFO - PROCESS | 15198 | |8;Splay;638.1620931716656 16:25:05 INFO - PROCESS | 15198 | |9;NavierStokes;4822.115384615385 16:25:05 INFO - PROCESS | 15198 | __end_tp_report 16:25:05 INFO - PROCESS | 15198 | __startTimestamp1452731105160__endTimestamp 16:25:05 INFO - PROCESS | 15198 | 16:25:05 INFO - PROCESS | 15198 | ------- Summary: start ------- 16:25:05 INFO - PROCESS | 15198 | Number of tests: 10 16:25:05 INFO - PROCESS | 15198 | 16:25:05 INFO - PROCESS | 15198 | [#0] Richards Cycles:1 Average:167.50 Median:167.50 stddev:0.00 (0.0%) 16:25:05 INFO - PROCESS | 15198 | Values: 167.5 16:25:05 INFO - PROCESS | 15198 | 16:25:05 INFO - PROCESS | 15198 | [#1] DeltaBlue Cycles:1 Average:187.90 Median:187.90 stddev:0.00 (0.0%) 16:25:05 INFO - PROCESS | 15198 | Values: 187.9 16:25:05 INFO - PROCESS | 15198 | 16:25:05 INFO - PROCESS | 15198 | [#2] Encrypt Cycles:1 Average:282.01 Median:282.01 stddev:0.00 (0.0%) 16:25:05 INFO - PROCESS | 15198 | Values: 282.0 16:25:05 INFO - PROCESS | 15198 | 16:25:05 INFO - PROCESS | 15198 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 16:25:05 INFO - PROCESS | 15198 | Values: 5164.9 16:25:05 INFO - PROCESS | 15198 | 16:25:05 INFO - PROCESS | 15198 | [#4] RayTrace Cycles:1 Average:1974.36 Median:1974.36 stddev:0.00 (0.0%) 16:25:05 INFO - PROCESS | 15198 | Values: 1974.4 16:25:05 INFO - PROCESS | 15198 | 16:25:05 INFO - PROCESS | 15198 | [#5] Earley Cycles:1 Average:802.57 Median:802.57 stddev:0.00 (0.0%) 16:25:05 INFO - PROCESS | 15198 | Values: 802.6 16:25:05 INFO - PROCESS | 15198 | 16:25:05 INFO - PROCESS | 15198 | [#6] Boyer Cycles:1 Average:12543.21 Median:12543.21 stddev:0.00 (0.0%) 16:25:05 INFO - PROCESS | 15198 | Values: 12543.2 16:25:05 INFO - PROCESS | 15198 | 16:25:05 INFO - PROCESS | 15198 | [#7] RegExp Cycles:1 Average:42645.83 Median:42645.83 stddev:0.00 (0.0%) 16:25:05 INFO - PROCESS | 15198 | Values: 42645.8 16:25:05 INFO - PROCESS | 15198 | 16:25:05 INFO - PROCESS | 15198 | [#8] Splay Cycles:1 Average:638.16 Median:638.16 stddev:0.00 (0.0%) 16:25:05 INFO - PROCESS | 15198 | Values: 638.2 16:25:05 INFO - PROCESS | 15198 | 16:25:05 INFO - PROCESS | 15198 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 16:25:05 INFO - PROCESS | 15198 | Values: 4822.1 16:25:05 INFO - PROCESS | 15198 | -------- Summary: end -------- 16:25:05 INFO - PROCESS | 15198 | 16:25:06 INFO - TEST-INFO | 15198: exit 0 16:25:06 INFO - TEST-OK | v8_7 | took 40933ms 16:25:06 INFO - SUITE-END | took 1212s 16:25:06 INFO - Completed test suite (00:20:12) 16:25:06 INFO - Working with test: dromaeo_css 16:25:06 INFO - Generating results file: dromaeo_css 16:25:06 INFO - Working with test: kraken 16:25:06 INFO - Generating results file: kraken 16:25:06 INFO - javascript benchmark 16:25:06 INFO - Working with test: v8_7 16:25:06 INFO - Generating results file: v8_7 16:25:06 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:25:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 16:25:07 INFO - process_Request line: dromaeo_css 6724.10 graph.html#tests=[[72,1,35]] 16:25:07 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:25:07 INFO - process_Request line: kraken 1492.60 graph.html#tests=[[232,1,35]] 16:25:07 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:25:07 INFO - process_Request line: v8_7 18720.03 graph.html#tests=[[230,1,35]] 16:25:07 INFO - RETURN: dromaeo_css: 6724.10 16:25:07 INFO - RETURN: kraken: 1492.60 16:25:07 INFO - RETURN: v8_7: 18720.03 16:25:07 INFO - javascript benchmark 16:25:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3090.8300043497607, 3099.8140111593293, 3138.9641418331967, 3139.9686003139964, 3163.1775738308047, 4916.87707807305, 5018.7992480300745, 5025.673331233472, 5035.471275516073, 5080.314157588725, 5016.0, 5060.089183946888, 5089.567386772129, 5095.694258344502, 5095.745212739367, 4437.179121862449, 4571.291449825282, 4612.607928326088, 4694.061187762444, 4726.574608285254, 4561.29299958507, 4685.672002959795, 4698.154332220199, 4704.364910737041, 4769.165396055676, 4598.563136502027, 4611.861644150681, 4616.584507394334, 4631.0, 4653.86038418848, 4599.655025873039, 4608.400907881954, 4623.30650402439, 4630.351750754897, 4667.183242932473, 4555.521670224612, 4595.724256544585, 4598.310253461974, 4609.953900460986, 4639.512851150648, 4792.7843247053615, 4867.537583929521, 4889.926651100236, 4906.141425250603, 4915.803367865281, 5382.4886635769535, 5399.055165346088, 5399.352077750695, 5400.081986062379, 5449.128139497701, 5396.028714831329, 5416.4312747161375, 5421.539169170625, 5455.263539422207, 5513.476219759116, 5023.924641130386, 5135.486451354872, 5181.145111056633, 5197.974010129925, 5219.8434046978655, 5549.112142057252, 5550.777968881281, 5553.333599967949, 5556.138798486241, 5558.194061861008, 5156.458571849977, 5238.109521381374, 5344.8663783404945, 5358.571314294847, 5360.544353729977, 5298.046351656739, 5332.200169974535, 5334.59990500714, 5335.253064570963, 5381.515663590218, 5311.070562651521, 5325.920111198335, 5331.120365139786, 5348.331458567679, 5381.704006279692, 5250.527452529291, 5354.9464505354445, 5357.732113394315, 5395.109806881821, 5405.567554595623, 4287.121140166259, 4297.097609501977, 4298.140371925628, 4311.48262208537, 4340.696151269444, 3820.102275965146, 3843.0, 3846.2307538491855, 3872.0707030312524, 3875.670568001695, 5014.0, 5075.8984820303385, 5085.364329458817, 5092.28707980883, 5145.511176438233, 5369.543588794918, 5387.3804512481565, 5393.946060539422, 5405.864853378697, 5408.378036525771, 5022.673526220784, 5034.723090230073, 5037.874053148701, 5040.47075057121, 5080.0, 4608.470025946992, 4620.168369693488, 4658.743769092733, 4681.95318046822, 4683.718976861399, 5631.267935168484, 5659.518940889988, 5660.603757737002, 5664.20701101846, 5667.858303542444, 5402.054640437987, 5433.483819037185, 5439.619226654255, 5440.782368705208, 5458.972705136608, 5545.667259964415, 5550.361708403424, 5627.015272327409, 5633.324001119892, 5674.659520428622, 5223.45153758865, 5229.26790249373, 5231.189165679326, 5241.790328386975, 5247.816326428557, 5271.499207575274, 5308.283381743569, 5323.148296272732, 5331.840044798662, 5372.811951581676, 5193.298904647824, 5248.76380562868, 5290.470952904679, 5319.042572336862, 5366.141417373357, 5270.631055826056, 5271.841844744664, 5274.340707411574, 5276.920846187387, 5280.656757310762, 5105.897882042413, 5187.636865419385, 5197.0905091608065, 5206.609504287269, 5232.9738351308, 5238.68567885928, 5329.200619907045, 5369.624126311121, 5421.376541697755, 5428.538574221236, 5152.252923326172, 5182.041322355376, 5194.0, 5197.0, 5197.532222100029], "unit": "score", "name": "dojo.html", "value": 4997.9945960978075}, {"lowerIsBetter": false, "replicates": [529.6901312732051, 530.3000039947269, 533.9880925645901, 548.3940246028138, 553.5184389581068, 28352.716472835265, 28757.85621071897, 28762.712372876264, 35294.8235258824, 35529.644703552956, 42017.369739453854, 42549.0, 42575.361369579405, 42605.14789704204, 42616.14767704644, 8389.244967952884, 8587.484750914933, 8590.226879580836, 8592.828143437127, 8594.570271486433, 8537.445066070717, 8656.307495400353, 8669.133086691343, 8669.913300866974, 8679.17547832958, 8632.741017769476, 8692.47845129291, 8710.172533609297, 8721.869171962426, 8731.214190722834, 8611.526366049864, 8691.95654021729, 8695.608697608623, 8701.69544065961, 8706.347023973196, 8504.149585041447, 8652.307815374756, 8662.696805611837, 8663.047064822927, 8667.653293868238, 39335.0, 39808.0, 39841.80079099615, 39842.60157398418, 39881.0, 3175.2061984503875, 3339.448990916496, 3469.3581687387664, 3718.1076541630086, 3918.2147261227665, 29447.411051778843, 29860.10419687413, 30181.396372072435, 30224.546631800542, 30561.388772224433, 3777.2067865748227, 3795.5065841440714, 3826.368649172883, 3844.2888065707934, 3874.9612503874882, 270939.0, 274981.0, 275805.0, 276193.61903190555, 276675.0, 50689.23966140511, 51429.48570514247, 51451.228231576555, 56166.0, 56463.71768141133, 45921.77039114783, 46058.30912536314, 60706.0, 61327.08009379773, 61444.692776535834, 14445.0, 14504.0, 14559.126452412676, 14632.341544630517, 14677.77983330251, 10407.94796026015, 11041.779164416826, 11073.446327683745, 11148.498317575728, 11208.439578021067, 16723.414680486123, 19192.232310707415, 19537.60924781525, 19644.607107857762, 19683.31108411199, 6808.5914845109455, 6886.10480637514, 6994.475414343945, 7036.859262814715, 7214.927850721426, 797.696875187425, 837.8826964225013, 849.723839752083, 868.2446271743623, 888.4092078767547, 26745.33136671599, 26803.195904122516, 26849.597256041176, 27055.729442705713, 27139.592906106423, 1071.1537885070863, 1073.0771536478621, 1078.4769386847372, 1116.7319843237565, 1119.3843386137592, 14667.85332146665, 14709.632259193606, 14724.705505890037, 15097.924510377597, 15168.848311516964, 329382.0, 332786.0, 333333.0, 334192.0, 334746.0, 51516.227256591184, 51871.74064129731, 51872.481275186765, 51970.740146299024, 51986.740066299426, 1219.500004997929, 1221.712897469094, 1260.464302671361, 1282.6472720001887, 1301.1802564384377, 27076.1877143686, 27617.309567260978, 27912.441751164457, 28197.0, 28283.15150545487, 40801.387979179744, 41075.7946210279, 41113.17773644451, 41188.58811411847, 41200.38199427071, 307600.0, 309438.0, 310946.0, 311489.0, 312037.0, 30610.540841887836, 31135.377292454476, 31513.0, 32090.0, 32306.515402268513, 36614.0, 37021.0, 37036.0, 37223.0, 37906.43140352842, 31186.22034449157, 31505.21236969094, 31774.364512709155, 31904.202394940312, 32138.83930580332, 33445.0, 33754.63346888223, 34417.82791086029, 34552.30895382129, 34703.65296347004, 33023.339533208724, 33410.16474588155, 33550.49674254839, 33684.49473257854, 33863.66136338704, 29117.272068198465, 30382.84808575943, 30837.229069273446, 31074.37851242917, 31123.84438077795, 24009.639855401834, 24207.394815129763, 24415.755842441347, 24847.500594153615, 25920.61119083253], "unit": "score", "name": "ext.html", "value": 17715.162186658876}, {"lowerIsBetter": false, "replicates": [327.9262166012649, 349.87404534367624, 351.30266421154005, 358.94974703541527, 360.713232979781, 13117.54088606899, 16014.0, 17001.57496062599, 18013.549661258443, 18035.0, 15730.213489325544, 15773.290201940912, 16570.088645124513, 16575.50273491794, 16765.497035088938, 3992.2015596880597, 4154.31453810121, 5258.0535503609235, 5440.646357986738, 5729.39841316662, 5665.150227465892, 5851.356350801409, 5862.501687356558, 5901.409859014086, 5925.585209035369, 5824.155497452867, 5825.650460972334, 5840.328362238354, 5841.824745257649, 5844.327902291248, 5626.324841019084, 5805.10020946754, 5806.245188125559, 5822.010258256107, 5824.0390335594575, 5145.125328694131, 5164.870878228036, 5229.633925625208, 5242.8689282767855, 5249.028929648028, 19666.0, 19746.605067898705, 19766.20935162592, 19969.301074462324, 20072.89963550173, 2015.586804705032, 2059.3204242600054, 2160.146742036902, 2170.045180120758, 2192.397090800027, 12469.563565275263, 12735.617931462071, 12989.090763646549, 13259.602211933658, 13351.465941362334, 1816.1554876982134, 1840.7514985477058, 1885.3118611706766, 1885.820847019531, 1888.6222755448828, 55169.0, 56103.71948140274, 56200.54868593689, 57220.427795721924, 57782.42217577813, 9652.0, 9810.362326448758, 9946.659082176966, 10006.54970526328, 10111.191104711605, 12774.0, 12911.35443227835, 12923.22460652364, 12950.740985180431, 12985.480580776852, 7504.399648028145, 7529.322360987538, 7565.394768418513, 7568.735094271674, 7575.6969721211635, 7305.671244793997, 7307.926920730831, 7309.159446663702, 7326.67029983652, 7370.189279179286, 5291.444398338119, 5520.751566179531, 5620.213170156181, 5790.36306006339, 5811.3316968548315, 1703.269839052471, 1739.6083133493155, 1744.7906251249678, 1754.8157443468508, 1766.3464518128376, 762.06646857599, 773.6634563964693, 905.1943770044666, 984.9852252216223, 998.4508520313798, 13628.795568066487, 14687.853121468648, 14832.184229867245, 14939.775903361458, 15189.544313670607, 862.4135587800231, 898.4384759525296, 900.8468560344758, 924.5007695844168, 972.1639390124487, 7782.688692452239, 8665.913340866637, 9113.544322783835, 9618.278629102846, 9624.60063897772, 499122.0, 509379.0, 525549.0, 533189.0, 539930.0, 73384.63307683427, 73730.63134684293, 73818.26181738114, 74511.0, 74638.62680686562, 1109.7447587055024, 1111.9388433636227, 1117.3463523838645, 1119.0152665654334, 1125.9887401126048, 15064.623384415478, 15250.542483725507, 15304.387824486896, 15348.30932608013, 15612.141332226836, 32097.197570060936, 34967.475487867196, 34971.47542786809, 35083.47374789431, 35591.46612800862, 39816.0, 41310.586894130676, 42545.78727106345, 43413.782931085145, 44525.55474445214, 6937.202221744564, 7010.088688470671, 7099.219085900443, 7317.26827317264, 7350.595717235603, 10446.63436779709, 10689.94655026751, 11046.281991670516, 11150.99641032311, 11271.098312134845, 9158.725238242863, 9695.536800941878, 9764.170045546209, 9848.458334791656, 9944.502774861083, 9485.383450075724, 9820.214382849212, 9836.360636558888, 9837.163841073589, 10176.64381746665, 9792.804143917225, 10047.397156170653, 10066.245031622511, 10098.19214462856, 10170.440625765654, 5774.913376299275, 6631.33686631333, 6903.378695917391, 7435.739749108755, 7524.0, 9306.674266400643, 9637.843458784992, 9648.131668149901, 10004.499775011365, 10217.591296348062], "unit": "score", "name": "jquery.html", "value": 8244.299696754113}, {"lowerIsBetter": false, "replicates": [1323.7021670124218, 1418.538974833179, 1431.3129697745082, 1535.854093861083, 1719.7764290642208, 6727.192736871576, 7391.22392148824, 7511.474196806212, 7513.624318784066, 7526.13449453313, 7382.0, 7527.247275272483, 7553.357964573018, 7554.622268886561, 7558.584277864716, 1994.7706013808381, 2046.0383619698719, 2047.907844147017, 2310.214527060799, 2341.098677009355, 2296.59809533331, 2355.2580937004873, 2355.316958082154, 2355.49356888269, 2356.493353928905, 2259.9322020339414, 2282.9726623019624, 2299.8620082795, 2303.0442366417915, 2303.735070466901, 2235.6311208650554, 2235.8434909556418, 2250.3698964290024, 2308.6883270758567, 2311.15642790382, 2251.223327951854, 2282.315305408371, 2288.187693368863, 2290.4846409557717, 2297.471581536256, 7683.30850223477, 7698.344855855962, 7721.420893432959, 7723.150453450116, 7742.225777422269, 4452.487963884162, 4564.748938808364, 4569.543045695437, 4570.497245303014, 4575.290829921334, 2886.336142687194, 2925.88296468141, 2967.080205136393, 2973.122928736028, 3019.2602812310906, 916.1571354353944, 918.2332752151962, 952.4044999381877, 975.9609615615367, 977.3207620703614, 10083.899161008369, 10092.34399764013, 10092.798144037079, 10109.848352274721, 10137.239707021929, 4165.208610364021, 4179.791010449465, 4234.364845273172, 4263.744175349489, 4286.742795432284, 8826.646934122564, 8848.91151088481, 8857.64569417229, 8867.201951824367, 8874.86687699685, 4753.762311884392, 4756.0, 4756.405449318835, 4759.024399997992, 4765.285207218945, 4272.145570885836, 4303.462067241595, 4332.415123958225, 4333.956660433419, 4340.262155433584, 3491.581010278732, 3515.4375299951885, 3663.139162296858, 3695.9445608315896, 3733.8133093345223, 1188.857337119534, 1238.4427007846325, 1238.504598160743, 1245.339969815999, 1249.731307768816, 1257.503286201945, 1262.5202423079172, 1268.2960956668953, 1269.593730006389, 1291.1284882704138, 7117.0, 7141.321574450419, 7155.427565794724, 7180.31786980236, 7219.855602887913, 1087.49975011494, 1106.5463160104318, 1108.1744100645071, 1109.6338208391212, 1126.6169502369235, 5443.591730620219, 5464.23500709901, 5545.7781688732, 5555.138953462219, 5561.555075593943, 8660.39377243587, 8943.955280223558, 8957.731268061969, 9076.273898088137, 9329.860052099224, 8821.867671984925, 8973.910260897437, 8979.057198994142, 8988.0, 9018.09819018093, 7230.710771569078, 7251.673674684546, 7397.297256760599, 7421.888671669929, 7444.106707195171, 7257.709691612276, 7347.595882226529, 7359.77920662381, 7366.447516436396, 7375.151857536237, 8073.87889181651, 8368.288695460955, 8418.200270974248, 8471.788205294917, 8478.321734261368, 8392.20274073962, 8603.053664096818, 8608.956955215433, 8738.650453981769, 8759.255463285437, 6431.324710905287, 6532.020196970492, 6554.230357803271, 6556.934430655823, 6980.720771169096, 6720.1599800025, 6864.6910889011115, 6880.827979300558, 7107.538010029331, 7114.324139206767, 6713.423357409524, 6809.863802724017, 6875.656217189021, 6913.827154321182, 6953.617551034742, 6364.6181229126405, 6672.065910772592, 6696.296888826798, 6761.763338283136, 6843.178818541807, 6665.466762659073, 6678.298778628174, 6686.398224159849, 6692.0, 6696.430803381767, 6318.526110541636, 6378.425941665272, 6383.648899310582, 6417.03744438338, 6423.64669943139, 6294.087357333253, 6300.21247344082, 6328.620282782864, 6336.651484168415, 6339.683015849281], "unit": "score", "name": "mootools.html", "value": 4414.197252639707}, {"lowerIsBetter": false, "replicates": [327.89999050289657, 328.1337269608233, 334.6937552139792, 336.52717931306523, 336.5960846983619, 5724.828255152342, 5865.8826823463505, 5870.148828419877, 5886.882262354756, 5903.0, 5661.773529058843, 5749.166370876231, 5751.0, 5757.395473475288, 5774.220480235177, 4465.24090904547, 4481.910361792762, 4501.279795232764, 4502.729836209822, 4506.639468842484, 4352.020795321059, 4405.16301902639, 4472.955270447303, 4482.618977386926, 4510.616597589193, 4463.799129039201, 4485.170243504946, 4495.483019452756, 4496.145732310867, 4504.0316331988615, 4471.28459446487, 4484.955150448486, 4495.415595972535, 4499.775011249457, 4512.210363186429, 3957.584453632385, 3958.2875082485143, 3964.0882597002565, 3969.64273215412, 3969.702272329558, 5444.482774136451, 5578.163275508666, 5588.385277619459, 5599.832005039855, 5659.830205093854, 5169.586433085344, 5178.14560597501, 5181.689098654093, 5183.870403239912, 5184.066867963765, 5918.940810591882, 6262.843428914268, 6267.686615669244, 6275.497960163221, 6277.278113017016, 4190.099128687347, 4270.081932384521, 4280.6361459275995, 4280.6789490788005, 4282.42187304713, 6404.071409645622, 6572.737090516373, 6582.703778329987, 6588.978708300221, 6597.571157874723, 4357.193919124972, 4358.389825424443, 4363.127374525107, 4365.9126817463475, 4366.759828209415, 4318.9352159717, 4409.140217657526, 4414.889627759332, 4415.183191109655, 4432.578905004019, 5167.974160129175, 5188.766505507186, 5195.324607801037, 5196.168613021899, 5202.713850738246, 6277.937220627827, 6294.181756371642, 6298.275698294755, 6307.117003619497, 6308.274548426898, 1544.1121355220794, 1577.5346272849538, 1578.179346739689, 1578.6132397562442, 1579.0288972281965, 1002.3885429887763, 1013.0325539110132, 1024.3495380433478, 1033.8035773203067, 1054.3831858362944, 5840.8539786504825, 5843.328017277982, 5855.970720146457, 5859.355470898197, 5860.912086318709, 6320.367963203643, 6334.208223972004, 6334.904976425358, 6343.302236753953, 6347.428731414195, 5840.474357307863, 5840.94159058404, 5843.152742852262, 5846.093855452412, 5853.473187413153, 3369.949450758241, 3473.9404481633346, 3479.4780782882262, 3486.6687664671817, 3488.145404375944, 6659.433948114464, 6696.0960270362875, 6728.764493242713, 6758.222804377461, 6759.459243260626, 6575.605463672195, 6578.934210657832, 6586.077949087132, 6588.901166482507, 6591.901121483182, 6526.575772574767, 6605.30644282353, 6635.502337324623, 6638.83402914931, 6657.533972621967, 6199.256089269136, 6294.496440284858, 6391.4247717703765, 6415.615063096229, 6418.0, 6272.717727702173, 6384.106225128393, 6419.582727122722, 6421.614703117828, 6445.452136568444, 6677.465802735673, 6715.395614394728, 6727.495437842083, 6728.3271672832325, 6730.899036514554, 4459.219636563654, 4485.820567177407, 4537.659675524283, 4538.659600529907, 4538.774530876711, 6407.679616019087, 6425.5502114851515, 6425.646589437626, 6429.421352078335, 6434.388733070351, 6243.125962365363, 6257.937420625917, 6260.154879091265, 6261.436470717657, 6265.185525881606, 6136.478399336106, 6174.320824709368, 6216.44052035319, 6238.968805155945, 6244.5316601256, 6091.664958427329, 6093.451589356979, 6106.2061931948565, 6109.480694141048, 6117.724702388314, 6229.470495007975, 6257.687115644108, 6267.059941008885, 6272.843178920563, 6287.0, 5999.5800293979, 6110.480609148094, 6129.3564175762685, 6132.846678833065, 6136.8772624548155], "unit": "score", "name": "prototype.html", "value": 4686.539089472128}, {"lowerIsBetter": false, "replicates": [697.6720941157654, 762.8207371267748, 764.8623247815394, 809.6235250608465, 836.3810780022785, 13782.379792909318, 13843.861561384383, 13890.791638125436, 13913.095648782835, 13936.581902542926, 11936.343501107436, 12558.0, 12885.355732213398, 12939.0, 12969.157004794683, 773.0452890680006, 780.9453338266323, 789.2699253190805, 789.4947233770391, 789.8973133492638, 785.968561257549, 786.8032991752062, 790.723246863596, 790.8892755014302, 791.0823444804029, 818.6725309876067, 822.6503735912244, 822.8889099971517, 823.4153750836913, 823.6458322921142, 814.3973459639883, 817.6361519123992, 817.8037271054934, 818.382121498268, 818.6397984886631, 602.1509671363357, 602.5270162922085, 603.0772917436329, 604.6583680220705, 604.7883240865706, 12520.123591348609, 12625.747485050248, 12629.305388203646, 12631.873681263161, 12632.30522321272, 10845.186611004126, 11032.172587056002, 11069.114470842313, 11238.550457981672, 11532.135089868294, 9615.90384096164, 9842.507874606312, 9983.800323993479, 10116.54475548602, 10228.0, 3575.856965721394, 3596.604373518911, 3598.604153543108, 3621.8370173342, 3730.7015438764834, 44786.77606611979, 44928.0, 47945.0, 48342.51657483415, 50942.99999999963, 9104.13510716494, 9255.06665140732, 9961.601535938482, 10087.798244035079, 10289.639862604772, 18131.818681813013, 18386.172622231763, 18406.539836503925, 18427.078646067912, 18457.353992610195, 7316.268373162748, 7328.853422931512, 7401.185869554345, 7516.511426757353, 7530.736424225235, 4210.978945105255, 4228.725132866354, 4228.9577104228565, 4265.0830071534765, 4282.186384586918, 3125.87496500142, 3145.653978062411, 3150.8582113804932, 3156.479180935166, 3157.41587806252, 554.1798138754585, 579.495838620403, 580.7009390164069, 581.5870731780399, 589.3311091910713, 487.11102238414327, 557.239368262319, 570.139089974142, 571.6912867051745, 586.6450797267677, 7651.923480765121, 7994.360451163893, 8179.263866252066, 8262.42163048593, 8454.87317690235, 438.5110601679105, 485.2624011502567, 494.94308154562685, 530.6789392417609, 537.6505271573509, 3910.3743401055694, 3911.647951684362, 3979.5821438749094, 4026.9194616107516, 4182.163567286494, 62702.686486568186, 63364.0, 63420.36579634237, 63425.0, 63595.0, 51291.48708512867, 51678.0, 51815.22277165845, 52120.73939630278, 53106.73446632742, 41829.58170418257, 47394.0, 48411.5158848407, 48486.75756621265, 49558.504414956835, 8126.471779334324, 8154.673813047411, 8177.34581233488, 8441.788955276168, 8484.363672724447, 36147.819260903525, 36814.44778328274, 37018.62981370152, 37161.256774864894, 37320.44019339766, 46229.0, 46433.30350044819, 46556.0, 47090.0, 47117.52882471131, 9618.759531011781, 9820.950895245478, 9857.852132217879, 10013.849792253268, 10056.145227655732, 11441.713957151138, 11890.194057875684, 11945.581904633296, 11999.820002699791, 12036.63890083299, 11072.280301780358, 11278.830817537908, 11400.429978501208, 11412.0, 11736.823947640622, 9887.901120988698, 10198.082172604501, 10378.273520853469, 10486.632967846088, 10508.894911051097, 10264.230182736474, 10382.0, 10544.472776361305, 10560.155187584822, 10578.365298082139, 9154.313426493172, 9176.95411522938, 9365.765855853659, 9378.718638440858, 9610.615575376907, 8608.225259726654, 8984.640614375352, 9549.809003820024, 9843.360181588174, 9846.163076138608], "unit": "score", "name": "yui.html", "value": 6120.250026893578}], "name": "dromaeo_css", "value": 6724.103647919678}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 112.0, 111.0, 110.0, 103.0, 112.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [162.0, 126.0, 154.0, 168.0, 124.0, 145.0, 149.0, 123.0, 160.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 143.9}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 159.0, 160.0, 161.0, 159.0, 164.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 97.0, 90.0, 74.0, 71.0, 71.0, 101.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 149.0, 99.0, 95.0, 96.0, 138.0, 95.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 147.0, 146.0, 145.0, 147.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [55.0, 59.0, 56.0, 56.0, 56.0, 56.0, 55.0, 64.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 70.0, 70.0, 68.0, 76.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 82.0, 82.0, 81.0, 84.0, 81.0, 83.0, 81.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [114.0, 121.0, 129.0, 116.0, 114.0, 121.0, 122.0, 126.0, 115.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [134.0, 138.0, 143.0, 140.0, 141.0, 133.0, 152.0, 140.0, 141.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.6}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 69.0, 67.0, 65.0, 67.0, 69.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1492.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.50418760469012], "unit": "score", "name": "Richards", "value": 210.75293999999994}, {"lowerIsBetter": false, "replicates": [187.89928598271325], "unit": "score", "name": "DeltaBlue", "value": 351.879996}, {"lowerIsBetter": false, "replicates": [282.0078962210942], "unit": "score", "name": "Encrypt", "value": 943.8778259999998}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1974.3589743589744], "unit": "score", "name": "RayTrace", "value": 374.7996233766234}, {"lowerIsBetter": false, "replicates": [802.5682182985554], "unit": "score", "name": "Earley", "value": 830.4128980000002}, {"lowerIsBetter": false, "replicates": [12543.20987654321], "unit": "score", "name": "Boyer", "value": 53.133369094488174}, {"lowerIsBetter": false, "replicates": [42645.833333333336], "unit": "score", "name": "RegExp", "value": 21.361641426477778}, {"lowerIsBetter": false, "replicates": [638.1620931716656], "unit": "score", "name": "Splay", "value": 127.69639699999996}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 18720.029211741537}]} 16:25:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18720.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1492.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6724.10"}}} 16:25:07 INFO - Return code: 0 16:25:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:25:07 INFO - # TBPL SUCCESS # 16:25:07 INFO - Running post-action listener: _resource_record_post_action 16:25:07 INFO - Running post-run listener: _resource_record_post_run 16:25:08 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 541859840; Read time: 0; Write time: 1019788 16:25:08 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 239316992; Read time: 0; Write time: 581792 16:25:08 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 302542848; Read time: 0; Write time: 437996 16:25:08 INFO - Running post-run listener: _upload_blobber_files 16:25:08 INFO - Blob upload gear active. 16:25:08 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:25:08 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 16:25:08 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:25:08 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:25:09 INFO - (blobuploader) - INFO - Open directory for files ... 16:25:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:25:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:25:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:09 INFO - (blobuploader) - INFO - Done attempting. 16:25:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:25:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:25:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:10 INFO - (blobuploader) - INFO - Done attempting. 16:25:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:25:10 INFO - Return code: 0 16:25:10 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:25:10 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:25:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c5bab27e9eedaed1eb29dd7a64bc5f8eb989b9506f77daf3df4bb0ac6f0a9a32300f7158afe15d3213edfe4c9bd1bea27507247aa71f975ef241b05062ab887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba2f6532c194e5b1081c618dbb931bbad6d6b3036e3caeea69d1cee209a5fadffe5d7e244572877cf24a990df96b4c909f321d0b342de088fca697bfa874d5ad"} 16:25:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:25:10 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:25:10 INFO - Contents: 16:25:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c5bab27e9eedaed1eb29dd7a64bc5f8eb989b9506f77daf3df4bb0ac6f0a9a32300f7158afe15d3213edfe4c9bd1bea27507247aa71f975ef241b05062ab887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba2f6532c194e5b1081c618dbb931bbad6d6b3036e3caeea69d1cee209a5fadffe5d7e244572877cf24a990df96b4c909f321d0b342de088fca697bfa874d5ad"} 16:25:10 INFO - Copying logs to upload dir... 16:25:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.300125 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-13 16:25:10.285285) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 16:25:10.288880) ========= 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=8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c5bab27e9eedaed1eb29dd7a64bc5f8eb989b9506f77daf3df4bb0ac6f0a9a32300f7158afe15d3213edfe4c9bd1bea27507247aa71f975ef241b05062ab887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba2f6532c194e5b1081c618dbb931bbad6d6b3036e3caeea69d1cee209a5fadffe5d7e244572877cf24a990df96b4c909f321d0b342de088fca697bfa874d5ad"} build_url:https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/Srhxfb-AQWaRYzvvI8Lf4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c5bab27e9eedaed1eb29dd7a64bc5f8eb989b9506f77daf3df4bb0ac6f0a9a32300f7158afe15d3213edfe4c9bd1bea27507247aa71f975ef241b05062ab887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba2f6532c194e5b1081c618dbb931bbad6d6b3036e3caeea69d1cee209a5fadffe5d7e244572877cf24a990df96b4c909f321d0b342de088fca697bfa874d5ad"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 16:25:10.317883) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:25:10.318462) ========= 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=8783db0840cc980e80bb0bd400000236-1452729808.606658-1722684513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:25:10.403311) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 16:25:10.404039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 16:25:10.404841) ========= ========= Total master_lag: 0.24 =========